builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-028 starttime: 1504185823.71 results: success (0) revision: c9079d347aaa559beecf0db6e5414f92ef043485 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-31 06:23:43.708640) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-31 06:23:43.709067) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-31 06:23:43.709343) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-31 06:23:43.720412) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 06:23:43.720668) ========= 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=836cfdc75598d54cb747368e000001a9-1504185822.842904-1174744033 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-31 06:23:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.5M=0s 2017-08-31 06:23:43 (37.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.115354 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 06:23:43.848626) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 06:23:43.848931) ========= 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=836cfdc75598d54cb747368e000001a9-1504185822.842904-1174744033 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020864 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 06:23:43.901568) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 06:23:43.901869) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c9079d347aaa559beecf0db6e5414f92ef043485 --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 c9079d347aaa559beecf0db6e5414f92ef043485 --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=836cfdc75598d54cb747368e000001a9-1504185822.842904-1174744033 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-31 06:23:43,939 truncating revision to first 12 chars 2017-08-31 06:23:43,939 Setting DEBUG logging. 2017-08-31 06:23:43,939 attempt 1/10 2017-08-31 06:23:43,939 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c9079d347aaa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-31 06:23:44,553 unpacking tar archive at: mozilla-central-c9079d347aaa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.956371 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 06:23:44.875505) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-31 06:23:44.875821) ========= script_repo_revision: c9079d347aaa559beecf0db6e5414f92ef043485 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-31 06:23:44.879218) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-31 06:23:44.879492) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-31 06:23:44.891534) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-08-31 06:23:44.891818) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1504185822.842904-1174744033 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:23:45 INFO - MultiFileLogger online at 20170831 06:23:45 in /builds/slave/test 06:23:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:23:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:23:45 INFO - {'append_to_log': False, 06:23:45 INFO - 'base_work_dir': '/builds/slave/test', 06:23:45 INFO - 'blob_upload_branch': 'Firefox', 06:23:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:23:45 INFO - 'branch': 'Firefox', 06:23:45 INFO - 'buildbot_json_path': 'buildprops.json', 06:23:45 INFO - 'code_coverage': False, 06:23:45 INFO - 'config_files': ('talos/linux_config.py',), 06:23:45 INFO - 'default_actions': ('clobber', 06:23:45 INFO - 'read-buildbot-config', 06:23:45 INFO - 'download-and-extract', 06:23:45 INFO - 'populate-webroot', 06:23:45 INFO - 'create-virtualenv', 06:23:45 INFO - 'install', 06:23:45 INFO - 'setup-mitmproxy', 06:23:45 INFO - 'run-tests'), 06:23:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:23:45 INFO - 'disable_ccov_upload': False, 06:23:45 INFO - 'disable_stylo': False, 06:23:45 INFO - 'download_minidump_stackwalk': True, 06:23:45 INFO - 'download_symbols': 'ondemand', 06:23:45 INFO - 'enable_stylo': False, 06:23:45 INFO - 'enable_webrender': False, 06:23:45 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 06:23:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:23:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:23:45 INFO - 'gecko_profile': False, 06:23:45 INFO - 'gecko_profile_interval': 0, 06:23:45 INFO - 'installer_path': 'installer.exe', 06:23:45 INFO - 'log_level': 'info', 06:23:45 INFO - 'log_name': 'talos', 06:23:45 INFO - 'log_to_console': True, 06:23:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:23:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:23:45 INFO - 'opt_config_files': (), 06:23:45 INFO - 'pip_index': False, 06:23:45 INFO - 'suite': 'dromaeojs-e10s', 06:23:45 INFO - 'system_bits': '32', 06:23:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:23:45 INFO - 'title': 'talos-linux64-ix-028', 06:23:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:23:45 INFO - 'use_talos_json': True, 06:23:45 INFO - 'verify': 'False', 06:23:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:23:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:23:45 INFO - 'work_dir': 'build'} 06:23:45 INFO - [mozharness: 2017-08-31 13:23:45.069141Z] Running clobber step. 06:23:45 INFO - Running pre-action listener: _resource_record_pre_action 06:23:45 INFO - Running main action method: clobber 06:23:45 INFO - rmtree: /builds/slave/test/build 06:23:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:23:46 INFO - Running post-action listener: _resource_record_post_action 06:23:46 INFO - [mozharness: 2017-08-31 13:23:46.583111Z] Finished clobber step (success) 06:23:46 INFO - [mozharness: 2017-08-31 13:23:46.583209Z] Running read-buildbot-config step. 06:23:46 INFO - Running pre-action listener: _resource_record_pre_action 06:23:46 INFO - Running main action method: read_buildbot_config 06:23:46 INFO - Using buildbot properties: 06:23:46 INFO - { 06:23:46 INFO - "project": "", 06:23:46 INFO - "product": "firefox", 06:23:46 INFO - "who": "archaeopteryx@coole-files.de", 06:23:46 INFO - "installer_path": "public/build/target.tar.bz2", 06:23:46 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 06:23:46 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 06:23:46 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 06:23:46 INFO - "stage_platform": "linux64-qr", 06:23:46 INFO - "basedir": "/builds/slave/test", 06:23:46 INFO - "buildnumber": 26, 06:23:46 INFO - "platform": "ubuntu64_hw_qr", 06:23:46 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:23:46 INFO - "slavebuilddir": "test", 06:23:46 INFO - "taskId": "KamSDdPkS66Ahz9z4RVkSg", 06:23:46 INFO - "branch": "mozilla-central", 06:23:46 INFO - "script_repo_revision": "production", 06:23:46 INFO - "revision": "c9079d347aaa559beecf0db6e5414f92ef043485", 06:23:46 INFO - "slavename": "talos-linux64-ix-028", 06:23:46 INFO - "repo_path": "mozilla-central" 06:23:46 INFO - } 06:23:46 INFO - Finding installer, test and symbols from parent task. 06:23:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KamSDdPkS66Ahz9z4RVkSg'}, attempt #1 06:23:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KamSDdPkS66Ahz9z4RVkSg'}, attempt #1 06:23:47 INFO - Task dependencies: ccktewOdQ72Ms1acZ9Ljrg 06:23:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ccktewOdQ72Ms1acZ9Ljrg'}, attempt #1 06:23:47 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ccktewOdQ72Ms1acZ9Ljrg/artifacts/public/build/target.tar.bz2 06:23:47 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/ccktewOdQ72Ms1acZ9Ljrg/artifacts/public/build/target.test_packages.json 06:23:47 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ccktewOdQ72Ms1acZ9Ljrg/artifacts/public/build/target.crashreporter-symbols.zip 06:23:47 INFO - Running post-action listener: _resource_record_post_action 06:23:47 INFO - [mozharness: 2017-08-31 13:23:47.964317Z] Finished read-buildbot-config step (success) 06:23:47 INFO - [mozharness: 2017-08-31 13:23:47.964532Z] Running download-and-extract step. 06:23:47 INFO - Running pre-action listener: _resource_record_pre_action 06:23:47 INFO - Running main action method: download_and_extract 06:23:47 INFO - mkdir: /builds/slave/test/build/tests 06:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:47 INFO - trying https://queue.taskcluster.net/v1/task/ccktewOdQ72Ms1acZ9Ljrg/artifacts/public/build/target.test_packages.json 06:23:47 INFO - Downloading https://queue.taskcluster.net/v1/task/ccktewOdQ72Ms1acZ9Ljrg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:23:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ccktewOdQ72Ms1acZ9Ljrg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:23:48 INFO - Downloaded 989 bytes. 06:23:48 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:23:48 INFO - Using the following test package requirements: 06:23:48 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 06:23:48 INFO - u'common': [u'target.common.tests.zip'], 06:23:48 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:23:48 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:23:48 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:23:48 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:23:48 INFO - u'mozbase': [u'target.common.tests.zip'], 06:23:48 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:23:48 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:23:48 INFO - u'web-platform': [u'target.common.tests.zip', 06:23:48 INFO - u'target.web-platform.tests.tar.gz'], 06:23:48 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:23:48 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:23:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ccktewOdQ72Ms1acZ9Ljrg/artifacts/public/build/target.common.tests.zip 06:23:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ccktewOdQ72Ms1acZ9Ljrg/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:23:48 INFO - Fetch https://queue.taskcluster.net/v1/task/ccktewOdQ72Ms1acZ9Ljrg/artifacts/public/build/target.common.tests.zip into memory 06:23:49 INFO - Content-Length response header: 54933027 06:23:49 INFO - Bytes received: 54933027 06:24:00 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:24:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ccktewOdQ72Ms1acZ9Ljrg/artifacts/public/build/target.common.tests.zip 06:24:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ccktewOdQ72Ms1acZ9Ljrg/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:24:00 INFO - Fetch https://queue.taskcluster.net/v1/task/ccktewOdQ72Ms1acZ9Ljrg/artifacts/public/build/target.common.tests.zip into memory 06:24:01 INFO - Content-Length response header: 54933027 06:24:01 INFO - Bytes received: 54933027 06:24:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ccktewOdQ72Ms1acZ9Ljrg/artifacts/public/build/target.talos.tests.zip 06:24:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ccktewOdQ72Ms1acZ9Ljrg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:24:14 INFO - Fetch https://queue.taskcluster.net/v1/task/ccktewOdQ72Ms1acZ9Ljrg/artifacts/public/build/target.talos.tests.zip into memory 06:24:15 INFO - Content-Length response header: 14496650 06:24:15 INFO - Bytes received: 14496650 06:24:15 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:24:15 INFO - trying https://queue.taskcluster.net/v1/task/ccktewOdQ72Ms1acZ9Ljrg/artifacts/public/build/target.tar.bz2 06:24:15 INFO - Downloading https://queue.taskcluster.net/v1/task/ccktewOdQ72Ms1acZ9Ljrg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:24:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ccktewOdQ72Ms1acZ9Ljrg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:24:16 INFO - Downloaded 62614856 bytes. 06:24:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ccktewOdQ72Ms1acZ9Ljrg/artifacts/public/build/target.tar.bz2 06:24:16 INFO - mkdir: /builds/slave/test/properties 06:24:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:24:16 INFO - Writing to file /builds/slave/test/properties/build_url 06:24:16 INFO - Contents: 06:24:16 INFO - build_url:https://queue.taskcluster.net/v1/task/ccktewOdQ72Ms1acZ9Ljrg/artifacts/public/build/target.tar.bz2 06:24:16 INFO - Running post-action listener: _resource_record_post_action 06:24:16 INFO - Running post-action listener: find_tests_for_verification 06:24:16 INFO - Running post-action listener: set_extra_try_arguments 06:24:16 INFO - [mozharness: 2017-08-31 13:24:16.564034Z] Finished download-and-extract step (success) 06:24:16 INFO - [mozharness: 2017-08-31 13:24:16.564130Z] Running populate-webroot step. 06:24:16 INFO - Running pre-action listener: _resource_record_pre_action 06:24:16 INFO - Running main action method: populate_webroot 06:24:16 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:24:16 INFO - 'chromez-stylo-e10s': {'talos_options': ['--enable-stylo'], 06:24:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:24:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:24:16 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--enable-stylo'], 06:24:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:24:16 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:24:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:24:16 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 06:24:16 INFO - 'talos_options': ['--enable-stylo'], 06:24:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:24:16 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:24:16 INFO - 'tests': ['damp', 'tps']}, 06:24:16 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 06:24:16 INFO - 'talos_options': ['--enable-stylo'], 06:24:16 INFO - 'tests': ['damp', 'tps']}, 06:24:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:24:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 06:24:16 INFO - 'g4-stylo-e10s': {'talos_options': ['--enable-stylo'], 06:24:16 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 06:24:16 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 06:24:16 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 06:24:16 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 06:24:16 INFO - 'talos_options': ['--enable-stylo'], 06:24:16 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 06:24:16 INFO - 'other-e10s': {'tests': ['a11yr', 06:24:16 INFO - 'ts_paint', 06:24:16 INFO - 'tpaint', 06:24:16 INFO - 'sessionrestore', 06:24:16 INFO - 'sessionrestore_many_windows', 06:24:16 INFO - 'sessionrestore_no_auto_restore', 06:24:16 INFO - 'tabpaint']}, 06:24:16 INFO - 'other-stylo-e10s': {'talos_options': ['--enable-stylo'], 06:24:16 INFO - 'tests': ['a11yr', 06:24:16 INFO - 'ts_paint', 06:24:16 INFO - 'tpaint', 06:24:16 INFO - 'sessionrestore', 06:24:16 INFO - 'sessionrestore_many_windows', 06:24:16 INFO - 'sessionrestore_no_auto_restore', 06:24:16 INFO - 'tabpaint']}, 06:24:16 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 06:24:16 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 06:24:16 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--enable-stylo'], 06:24:16 INFO - 'tests': ['bloom_basic_singleton']}, 06:24:16 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--enable-stylo'], 06:24:16 INFO - 'tests': ['bloom_basic']}, 06:24:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:24:16 INFO - 'tsvgr_opacity', 06:24:16 INFO - 'tart', 06:24:16 INFO - 'tscrollx', 06:24:16 INFO - 'tsvg_static']}, 06:24:16 INFO - 'svgr-stylo-e10s': {'talos_options': ['--enable-stylo'], 06:24:16 INFO - 'tests': ['tsvgx', 06:24:16 INFO - 'tsvgr_opacity', 06:24:16 INFO - 'tart', 06:24:16 INFO - 'tscrollx', 06:24:16 INFO - 'tsvg_static']}, 06:24:16 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:24:16 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 06:24:16 INFO - 'talos_options': ['--enable-stylo'], 06:24:16 INFO - 'tests': ['tp5o']}, 06:24:16 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 06:24:16 INFO - 'talos_options': ['--mitmproxy', 06:24:16 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 06:24:16 INFO - '--firstNonBlankPaint'], 06:24:16 INFO - 'tests': ['tp6_google', 06:24:16 INFO - 'tp6_youtube', 06:24:16 INFO - 'tp6_amazon', 06:24:16 INFO - 'tp6_facebook']}, 06:24:16 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 06:24:16 INFO - 'talos_options': ['--enable-stylo', 06:24:16 INFO - '--mitmproxy', 06:24:16 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 06:24:16 INFO - '--firstNonBlankPaint'], 06:24:16 INFO - 'tests': ['tp6_google', 06:24:16 INFO - 'tp6_youtube', 06:24:16 INFO - 'tp6_amazon', 06:24:16 INFO - 'tp6_facebook']}, 06:24:16 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 06:24:16 INFO - 'talos_options': ['--enable-stylo', 06:24:16 INFO - '--stylo-threads=1', 06:24:16 INFO - '--mitmproxy', 06:24:16 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 06:24:16 INFO - '--firstNonBlankPaint'], 06:24:16 INFO - 'tests': ['tp6_google', 06:24:16 INFO - 'tp6_youtube', 06:24:16 INFO - 'tp6_amazon', 06:24:16 INFO - 'tp6_facebook']}, 06:24:16 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:24:16 INFO - 'talos_options': ['--xperf_path', 06:24:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:24:16 INFO - 'tests': ['tp5n']}, 06:24:16 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 06:24:16 INFO - 'talos_options': ['--enable-stylo', 06:24:16 INFO - '--xperf_path', 06:24:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:24:16 INFO - 'tests': ['tp5n']}}} 06:24:16 INFO - Running post-action listener: _resource_record_post_action 06:24:16 INFO - [mozharness: 2017-08-31 13:24:16.578422Z] Finished populate-webroot step (success) 06:24:16 INFO - [mozharness: 2017-08-31 13:24:16.578512Z] Running create-virtualenv step. 06:24:16 INFO - Running pre-action listener: _resource_record_pre_action 06:24:16 INFO - Running main action method: create_virtualenv 06:24:16 INFO - Creating virtualenv /builds/slave/test/build/venv 06:24:16 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:24:16 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 06:24:16 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 06:24:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:24:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:24:17 INFO - Installing distribute.............................................................................................................................................................................................done. 06:24:17 INFO - Installing pip...............done. 06:24:17 INFO - Return code: 0 06:24:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:24:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:24:17 INFO - Reading from file tmpfile_stdout 06:24:17 INFO - Output received: 06:24:17 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 06:24:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:24:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:24:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20faa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a1b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229e580>, '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 0x229f480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229f910>, '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': '836cfdc75598d54cb747368e000001a9-1504185822.842904-1174744033', '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:24:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:24:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:24:17 INFO - Using env: {'DISPLAY': ':0', 06:24:17 INFO - 'HOME': '/home/cltbld', 06:24:17 INFO - 'LANG': 'en_US.UTF-8', 06:24:17 INFO - 'LANGUAGE': 'en_US:en', 06:24:17 INFO - 'LOGNAME': 'cltbld', 06:24:17 INFO - 'MAIL': '/var/mail/cltbld', 06:24:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:17 INFO - 'MOZ_NO_REMOTE': '1', 06:24:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:24:17 INFO - 'NO_EM_RESTART': '1', 06:24:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:24:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:17 INFO - 'PWD': '/builds/slave/test', 06:24:17 INFO - 'SHELL': '/bin/bash', 06:24:17 INFO - 'SHLVL': '1', 06:24:17 INFO - 'TERM': 'linux', 06:24:17 INFO - 'TMOUT': '86400', 06:24:17 INFO - 'USER': 'cltbld', 06:24:17 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1504185822.842904-1174744033', 06:24:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:17 INFO - '_': '/tools/buildbot/bin/python'} 06:24:18 INFO - Ignoring indexes: http://pypi.python.org/simple/ 06:24:18 INFO - Downloading/unpacking pip>=1.5 06:24:18 INFO - Running setup.py egg_info for package pip 06:24:18 INFO - warning: no files found matching 'pip/cacert.pem' 06:24:18 INFO - warning: no files found matching '*.html' under directory 'docs' 06:24:18 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 06:24:18 INFO - no previously-included directories found matching 'docs/_build/_sources' 06:24:18 INFO - Installing collected packages: pip 06:24:18 INFO - Found existing installation: pip 1.1 06:24:18 INFO - Uninstalling pip: 06:24:18 INFO - Successfully uninstalled pip 06:24:18 INFO - Running setup.py install for pip 06:24:18 INFO - warning: no files found matching 'pip/cacert.pem' 06:24:18 INFO - warning: no files found matching '*.html' under directory 'docs' 06:24:18 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 06:24:18 INFO - no previously-included directories found matching 'docs/_build/_sources' 06:24:18 INFO - Installing pip script to /builds/slave/test/build/venv/bin 06:24:18 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 06:24:18 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 06:24:18 INFO - Successfully installed pip 06:24:18 INFO - Cleaning up... 06:24:18 INFO - Return code: 0 06:24:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:24:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:24:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20faa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a1b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229e580>, '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 0x229f480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229f910>, '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': '836cfdc75598d54cb747368e000001a9-1504185822.842904-1174744033', '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:24:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:24:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:24:18 INFO - Using env: {'DISPLAY': ':0', 06:24:18 INFO - 'HOME': '/home/cltbld', 06:24:18 INFO - 'LANG': 'en_US.UTF-8', 06:24:18 INFO - 'LANGUAGE': 'en_US:en', 06:24:18 INFO - 'LOGNAME': 'cltbld', 06:24:18 INFO - 'MAIL': '/var/mail/cltbld', 06:24:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:18 INFO - 'MOZ_NO_REMOTE': '1', 06:24:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:24:18 INFO - 'NO_EM_RESTART': '1', 06:24:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:24:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:18 INFO - 'PWD': '/builds/slave/test', 06:24:18 INFO - 'SHELL': '/bin/bash', 06:24:18 INFO - 'SHLVL': '1', 06:24:18 INFO - 'TERM': 'linux', 06:24:18 INFO - 'TMOUT': '86400', 06:24:18 INFO - 'USER': 'cltbld', 06:24:18 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1504185822.842904-1174744033', 06:24:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:18 INFO - '_': '/tools/buildbot/bin/python'} 06:24:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:18 INFO - Downloading/unpacking psutil>=3.1.1 06:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:24:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:24:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:24:20 INFO - Installing collected packages: psutil 06:24:20 INFO - Running setup.py install for psutil 06:24:20 INFO - building 'psutil._psutil_linux' extension 06:24:20 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:24:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:24:20 INFO - building 'psutil._psutil_posix' extension 06:24:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:24:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:24:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:24:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:24:20 INFO - Successfully installed psutil 06:24:20 INFO - Cleaning up... 06:24:20 INFO - Return code: 0 06:24:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:24:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:24:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:24:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20faa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a1b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229e580>, '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 0x229f480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229f910>, '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': '836cfdc75598d54cb747368e000001a9-1504185822.842904-1174744033', '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:24:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:24:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:24:20 INFO - Using env: {'DISPLAY': ':0', 06:24:20 INFO - 'HOME': '/home/cltbld', 06:24:20 INFO - 'LANG': 'en_US.UTF-8', 06:24:20 INFO - 'LANGUAGE': 'en_US:en', 06:24:20 INFO - 'LOGNAME': 'cltbld', 06:24:20 INFO - 'MAIL': '/var/mail/cltbld', 06:24:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:20 INFO - 'MOZ_NO_REMOTE': '1', 06:24:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:24:20 INFO - 'NO_EM_RESTART': '1', 06:24:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:24:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:20 INFO - 'PWD': '/builds/slave/test', 06:24:20 INFO - 'SHELL': '/bin/bash', 06:24:20 INFO - 'SHLVL': '1', 06:24:20 INFO - 'TERM': 'linux', 06:24:20 INFO - 'TMOUT': '86400', 06:24:20 INFO - 'USER': 'cltbld', 06:24:20 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1504185822.842904-1174744033', 06:24:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:20 INFO - '_': '/tools/buildbot/bin/python'} 06:24:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:24:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:24:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:24:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:24:22 INFO - Installing collected packages: mozsystemmonitor 06:24:22 INFO - Running setup.py install for mozsystemmonitor 06:24:22 INFO - Successfully installed mozsystemmonitor 06:24:22 INFO - Cleaning up... 06:24:22 INFO - Return code: 0 06:24:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:24:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20faa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a1b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229e580>, '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 0x229f480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229f910>, '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': '836cfdc75598d54cb747368e000001a9-1504185822.842904-1174744033', '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:24:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:24:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:24:22 INFO - Using env: {'DISPLAY': ':0', 06:24:22 INFO - 'HOME': '/home/cltbld', 06:24:22 INFO - 'LANG': 'en_US.UTF-8', 06:24:22 INFO - 'LANGUAGE': 'en_US:en', 06:24:22 INFO - 'LOGNAME': 'cltbld', 06:24:22 INFO - 'MAIL': '/var/mail/cltbld', 06:24:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:22 INFO - 'MOZ_NO_REMOTE': '1', 06:24:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:24:22 INFO - 'NO_EM_RESTART': '1', 06:24:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:24:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:22 INFO - 'PWD': '/builds/slave/test', 06:24:22 INFO - 'SHELL': '/bin/bash', 06:24:22 INFO - 'SHLVL': '1', 06:24:22 INFO - 'TERM': 'linux', 06:24:22 INFO - 'TMOUT': '86400', 06:24:22 INFO - 'USER': 'cltbld', 06:24:22 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1504185822.842904-1174744033', 06:24:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:22 INFO - '_': '/tools/buildbot/bin/python'} 06:24:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:22 INFO - Downloading/unpacking jsonschema==2.5.1 06:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:24:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:23 INFO - Downloading functools32-3.2.3-2.tar.gz 06:24:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:24:23 INFO - warning: no files found matching '*.txt' 06:24:23 INFO - no previously-included directories found matching 'build' 06:24:23 INFO - no previously-included directories found matching 'dist' 06:24:23 INFO - no previously-included directories found matching '.git*' 06:24:23 INFO - Installing collected packages: jsonschema, functools32 06:24:23 INFO - Running setup.py install for functools32 06:24:23 INFO - warning: no files found matching '*.txt' 06:24:23 INFO - no previously-included directories found matching 'build' 06:24:23 INFO - no previously-included directories found matching 'dist' 06:24:23 INFO - no previously-included directories found matching '.git*' 06:24:23 INFO - Successfully installed jsonschema functools32 06:24:23 INFO - Cleaning up... 06:24:23 INFO - Return code: 0 06:24:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:24:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:24:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1f321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20faa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a1b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229e580>, '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 0x229f480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229f910>, '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': '836cfdc75598d54cb747368e000001a9-1504185822.842904-1174744033', '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:24:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:24:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:24:23 INFO - Using env: {'DISPLAY': ':0', 06:24:23 INFO - 'HOME': '/home/cltbld', 06:24:23 INFO - 'LANG': 'en_US.UTF-8', 06:24:23 INFO - 'LANGUAGE': 'en_US:en', 06:24:23 INFO - 'LOGNAME': 'cltbld', 06:24:23 INFO - 'MAIL': '/var/mail/cltbld', 06:24:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:23 INFO - 'MOZ_NO_REMOTE': '1', 06:24:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:24:23 INFO - 'NO_EM_RESTART': '1', 06:24:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:24:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:23 INFO - 'PWD': '/builds/slave/test', 06:24:23 INFO - 'SHELL': '/bin/bash', 06:24:23 INFO - 'SHLVL': '1', 06:24:23 INFO - 'TERM': 'linux', 06:24:23 INFO - 'TMOUT': '86400', 06:24:23 INFO - 'USER': 'cltbld', 06:24:23 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1504185822.842904-1174744033', 06:24:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:23 INFO - '_': '/tools/buildbot/bin/python'} 06:24:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:24:24 INFO - Cleaning up... 06:24:24 INFO - Return code: 0 06:24:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:24:24 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:24:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:24 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:24:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:24 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 0x1f321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20faa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a1b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229e580>, '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 0x229f480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229f910>, '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': '836cfdc75598d54cb747368e000001a9-1504185822.842904-1174744033', '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:24:24 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:24:24 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:24:24 INFO - Using env: {'DISPLAY': ':0', 06:24:24 INFO - 'HOME': '/home/cltbld', 06:24:24 INFO - 'LANG': 'en_US.UTF-8', 06:24:24 INFO - 'LANGUAGE': 'en_US:en', 06:24:24 INFO - 'LOGNAME': 'cltbld', 06:24:24 INFO - 'MAIL': '/var/mail/cltbld', 06:24:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:24 INFO - 'MOZ_NO_REMOTE': '1', 06:24:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:24:24 INFO - 'NO_EM_RESTART': '1', 06:24:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:24:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:24 INFO - 'PWD': '/builds/slave/test', 06:24:24 INFO - 'SHELL': '/bin/bash', 06:24:24 INFO - 'SHLVL': '1', 06:24:24 INFO - 'TERM': 'linux', 06:24:24 INFO - 'TMOUT': '86400', 06:24:24 INFO - 'USER': 'cltbld', 06:24:24 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1504185822.842904-1174744033', 06:24:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:24 INFO - '_': '/tools/buildbot/bin/python'} 06:24:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:24 INFO - Downloading/unpacking blobuploader==1.2.4 06:24:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:25 INFO - Downloading blobuploader-1.2.4.tar.gz 06:24:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:24:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:24:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:25 INFO - Downloading docopt-0.6.1.tar.gz 06:24:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:24:26 INFO - Installing collected packages: blobuploader, requests, docopt 06:24:26 INFO - Running setup.py install for blobuploader 06:24:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:24:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:24:26 INFO - Running setup.py install for requests 06:24:26 INFO - Running setup.py install for docopt 06:24:26 INFO - Successfully installed blobuploader requests docopt 06:24:26 INFO - Cleaning up... 06:24:26 INFO - Return code: 0 06:24:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:24:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:24:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:26 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 0x1f321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20faa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a1b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229e580>, '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 0x229f480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229f910>, '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': '836cfdc75598d54cb747368e000001a9-1504185822.842904-1174744033', '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:24:26 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:24:26 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:24:26 INFO - Using env: {'DISPLAY': ':0', 06:24:26 INFO - 'HOME': '/home/cltbld', 06:24:26 INFO - 'LANG': 'en_US.UTF-8', 06:24:26 INFO - 'LANGUAGE': 'en_US:en', 06:24:26 INFO - 'LOGNAME': 'cltbld', 06:24:26 INFO - 'MAIL': '/var/mail/cltbld', 06:24:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:26 INFO - 'MOZ_NO_REMOTE': '1', 06:24:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:24:26 INFO - 'NO_EM_RESTART': '1', 06:24:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:24:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:26 INFO - 'PWD': '/builds/slave/test', 06:24:26 INFO - 'SHELL': '/bin/bash', 06:24:26 INFO - 'SHLVL': '1', 06:24:26 INFO - 'TERM': 'linux', 06:24:26 INFO - 'TMOUT': '86400', 06:24:26 INFO - 'USER': 'cltbld', 06:24:26 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1504185822.842904-1174744033', 06:24:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:26 INFO - '_': '/tools/buildbot/bin/python'} 06:24:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:24:26 INFO - Running setup.py (path:/tmp/pip-opFmlB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:24:26 INFO - Running setup.py (path:/tmp/pip-BjHJg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:24:27 INFO - Running setup.py (path:/tmp/pip-w0bbf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:24:27 INFO - Running setup.py (path:/tmp/pip-bszsUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:24:27 INFO - Running setup.py (path:/tmp/pip-ucerPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:24:27 INFO - Running setup.py (path:/tmp/pip-LClQTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:24:27 INFO - Running setup.py (path:/tmp/pip-9ugXhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:24:27 INFO - Running setup.py (path:/tmp/pip-K5xnrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:24:27 INFO - Running setup.py (path:/tmp/pip-wiM1W3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:24:27 INFO - Running setup.py (path:/tmp/pip-WtGeXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:24:27 INFO - Running setup.py (path:/tmp/pip-wZcMLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:24:27 INFO - Running setup.py (path:/tmp/pip-xYSPP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:24:27 INFO - Running setup.py (path:/tmp/pip-ewb3Iv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:24:27 INFO - Running setup.py (path:/tmp/pip-VGxF0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:24:27 INFO - Running setup.py (path:/tmp/pip-8oagsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:24:27 INFO - Running setup.py (path:/tmp/pip-LxWJUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:24:27 INFO - Running setup.py (path:/tmp/pip-2kTabi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:24:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:24:28 INFO - Running setup.py install for manifestparser 06:24:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:24:28 INFO - Running setup.py install for mozcrash 06:24:28 INFO - Running setup.py install for mozdebug 06:24:28 INFO - Running setup.py install for mozdevice 06:24:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:24:28 INFO - Running setup.py install for mozfile 06:24:28 INFO - Running setup.py install for mozhttpd 06:24:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:24:28 INFO - Running setup.py install for mozinfo 06:24:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:24:28 INFO - Running setup.py install for mozInstall 06:24:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:24:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:24:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:24:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:24:28 INFO - Running setup.py install for mozleak 06:24:28 INFO - Running setup.py install for mozlog 06:24:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:24:29 INFO - Running setup.py install for moznetwork 06:24:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:24:29 INFO - Running setup.py install for mozprocess 06:24:29 INFO - Running setup.py install for mozprofile 06:24:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:24:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:24:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:24:29 INFO - Running setup.py install for mozrunner 06:24:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:24:29 INFO - Running setup.py install for mozscreenshot 06:24:29 INFO - Running setup.py install for moztest 06:24:29 INFO - Running setup.py install for mozversion 06:24:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:24:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:24:29 INFO - Cleaning up... 06:24:29 INFO - Return code: 0 06:24:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:24:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:24:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:29 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 0x1f321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20faa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a1b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229e580>, '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 0x229f480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229f910>, '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': '836cfdc75598d54cb747368e000001a9-1504185822.842904-1174744033', '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:24:29 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:24:29 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:24:29 INFO - Using env: {'DISPLAY': ':0', 06:24:29 INFO - 'HOME': '/home/cltbld', 06:24:29 INFO - 'LANG': 'en_US.UTF-8', 06:24:29 INFO - 'LANGUAGE': 'en_US:en', 06:24:29 INFO - 'LOGNAME': 'cltbld', 06:24:29 INFO - 'MAIL': '/var/mail/cltbld', 06:24:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:29 INFO - 'MOZ_NO_REMOTE': '1', 06:24:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:24:29 INFO - 'NO_EM_RESTART': '1', 06:24:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:24:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:29 INFO - 'PWD': '/builds/slave/test', 06:24:29 INFO - 'SHELL': '/bin/bash', 06:24:29 INFO - 'SHLVL': '1', 06:24:29 INFO - 'TERM': 'linux', 06:24:29 INFO - 'TMOUT': '86400', 06:24:29 INFO - 'USER': 'cltbld', 06:24:29 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1504185822.842904-1174744033', 06:24:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:29 INFO - '_': '/tools/buildbot/bin/python'} 06:24:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:24:30 INFO - Running setup.py (path:/tmp/pip-jERd4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:24:30 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:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:24:30 INFO - Running setup.py (path:/tmp/pip-37PicX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:24:30 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:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:24:30 INFO - Running setup.py (path:/tmp/pip-cCvGyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:24:30 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:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:24:30 INFO - Running setup.py (path:/tmp/pip-UFwK5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:24:30 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:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:24:30 INFO - Running setup.py (path:/tmp/pip-VyP93V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:24:30 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:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:24:30 INFO - Running setup.py (path:/tmp/pip-jZ9fQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:24:30 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:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:24:30 INFO - Running setup.py (path:/tmp/pip-0zLVFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:24:30 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:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:24:30 INFO - Running setup.py (path:/tmp/pip-2ka3nB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:24:30 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:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:24:30 INFO - Running setup.py (path:/tmp/pip-89bPVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:24:30 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:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:24:30 INFO - Running setup.py (path:/tmp/pip-4gKg8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:24:30 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:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:24:30 INFO - Running setup.py (path:/tmp/pip-V_Exly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:24:30 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:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:24:30 INFO - Running setup.py (path:/tmp/pip-qILbQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:24:30 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:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:24:30 INFO - Running setup.py (path:/tmp/pip-CkNHsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:24:31 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:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:24:31 INFO - Running setup.py (path:/tmp/pip-JCzzC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:24:31 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:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:24:31 INFO - Running setup.py (path:/tmp/pip-5_ra73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:24:31 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:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:24:31 INFO - Running setup.py (path:/tmp/pip-w_a1qK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:24:31 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:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:24:31 INFO - Running setup.py (path:/tmp/pip-U1S8t6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:24:31 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:24:31 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:24:31 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:24:31 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:24:31 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:24:31 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:24:31 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:24:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:32 INFO - Downloading blessings-1.6.tar.gz 06:24:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:24:32 INFO - Installing collected packages: blessings 06:24:32 INFO - Running setup.py install for blessings 06:24:32 INFO - Successfully installed blessings 06:24:32 INFO - Cleaning up... 06:24:32 INFO - Return code: 0 06:24:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:24:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:24:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:24:32 INFO - Reading from file tmpfile_stdout 06:24:32 INFO - Current package versions: 06:24:32 INFO - argparse == 1.2.1 06:24:32 INFO - blessings == 1.6 06:24:32 INFO - blobuploader == 1.2.4 06:24:32 INFO - docopt == 0.6.1 06:24:32 INFO - functools32 == 3.2.3-2 06:24:32 INFO - jsonschema == 2.5.1 06:24:32 INFO - manifestparser == 1.1 06:24:32 INFO - mozInstall == 1.13 06:24:32 INFO - mozcrash == 1.0 06:24:32 INFO - mozdebug == 0.1 06:24:32 INFO - mozdevice == 0.51 06:24:32 INFO - mozfile == 1.2 06:24:32 INFO - mozhttpd == 0.7 06:24:32 INFO - mozinfo == 0.10 06:24:32 INFO - mozleak == 0.1 06:24:32 INFO - mozlog == 3.5 06:24:32 INFO - moznetwork == 0.27 06:24:32 INFO - mozprocess == 0.25 06:24:32 INFO - mozprofile == 0.28 06:24:32 INFO - mozrunner == 6.13 06:24:32 INFO - mozscreenshot == 0.1 06:24:32 INFO - mozsystemmonitor == 0.3 06:24:32 INFO - moztest == 0.8 06:24:32 INFO - mozversion == 1.4 06:24:32 INFO - psutil == 3.1.1 06:24:32 INFO - requests == 1.2.3 06:24:32 INFO - wsgiref == 0.1.2 06:24:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:24:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:24:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:24:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:32 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 0x1f321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20faa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a1b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229e580>, '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 0x229f480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229f910>, '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': '836cfdc75598d54cb747368e000001a9-1504185822.842904-1174744033', '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:24:32 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:24:32 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:24:32 INFO - Using env: {'DISPLAY': ':0', 06:24:32 INFO - 'HOME': '/home/cltbld', 06:24:32 INFO - 'LANG': 'en_US.UTF-8', 06:24:32 INFO - 'LANGUAGE': 'en_US:en', 06:24:32 INFO - 'LOGNAME': 'cltbld', 06:24:32 INFO - 'MAIL': '/var/mail/cltbld', 06:24:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:32 INFO - 'MOZ_NO_REMOTE': '1', 06:24:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:24:32 INFO - 'NO_EM_RESTART': '1', 06:24:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:24:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:32 INFO - 'PWD': '/builds/slave/test', 06:24:32 INFO - 'SHELL': '/bin/bash', 06:24:32 INFO - 'SHLVL': '1', 06:24:32 INFO - 'TERM': 'linux', 06:24:32 INFO - 'TMOUT': '86400', 06:24:32 INFO - 'USER': 'cltbld', 06:24:32 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1504185822.842904-1174744033', 06:24:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:32 INFO - '_': '/tools/buildbot/bin/python'} 06:24:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:33 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:24:33 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:24:33 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:24:33 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:24:33 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:24:33 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:24:33 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:24:33 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:24:33 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:24:33 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 06:24:33 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:24:33 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:24:33 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:24:33 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:24:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 06:24:34 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:24:34 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:24:34 INFO - Installing collected packages: simplejson 06:24:34 INFO - Running setup.py install for simplejson 06:24:34 INFO - building 'simplejson._speedups' extension 06:24:34 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:24:35 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:24:35 INFO - Successfully installed simplejson 06:24:35 INFO - Cleaning up... 06:24:35 INFO - Return code: 0 06:24:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:24:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:35 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 0x1f321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20faa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a1b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229e580>, '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 0x229f480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229f910>, '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': '836cfdc75598d54cb747368e000001a9-1504185822.842904-1174744033', '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:24:35 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:24:35 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:24:35 INFO - Using env: {'DISPLAY': ':0', 06:24:35 INFO - 'HOME': '/home/cltbld', 06:24:35 INFO - 'LANG': 'en_US.UTF-8', 06:24:35 INFO - 'LANGUAGE': 'en_US:en', 06:24:35 INFO - 'LOGNAME': 'cltbld', 06:24:35 INFO - 'MAIL': '/var/mail/cltbld', 06:24:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:35 INFO - 'MOZ_NO_REMOTE': '1', 06:24:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:24:35 INFO - 'NO_EM_RESTART': '1', 06:24:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:24:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:35 INFO - 'PWD': '/builds/slave/test', 06:24:35 INFO - 'SHELL': '/bin/bash', 06:24:35 INFO - 'SHLVL': '1', 06:24:35 INFO - 'TERM': 'linux', 06:24:35 INFO - 'TMOUT': '86400', 06:24:35 INFO - 'USER': 'cltbld', 06:24:35 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1504185822.842904-1174744033', 06:24:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:35 INFO - '_': '/tools/buildbot/bin/python'} 06:24:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:24:35 INFO - Cleaning up... 06:24:35 INFO - Return code: 0 06:24:35 INFO - Running post-action listener: _resource_record_post_action 06:24:35 INFO - Running post-action listener: _start_resource_monitoring 06:24:35 INFO - Starting resource monitoring. 06:24:35 INFO - [mozharness: 2017-08-31 13:24:35.556126Z] Finished create-virtualenv step (success) 06:24:35 INFO - [mozharness: 2017-08-31 13:24:35.556591Z] Running install step. 06:24:35 INFO - Running pre-action listener: _resource_record_pre_action 06:24:35 INFO - Running main action method: install 06:24:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:24:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:24:35 INFO - Reading from file tmpfile_stdout 06:24:35 INFO - Detecting whether we're running mozinstall >=1.0... 06:24:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:24:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:24:35 INFO - Reading from file tmpfile_stdout 06:24:35 INFO - Output received: 06:24:35 INFO - Usage: mozinstall [options] installer 06:24:35 INFO - Options: 06:24:35 INFO - -h, --help show this help message and exit 06:24:35 INFO - -d DEST, --destination=DEST 06:24:35 INFO - Directory to install application into. [default: 06:24:35 INFO - "/builds/slave/test"] 06:24:35 INFO - --app=APP Application being installed. [default: firefox] 06:24:35 INFO - mkdir: /builds/slave/test/build/application 06:24:35 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:24:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:24:53 INFO - Reading from file tmpfile_stdout 06:24:53 INFO - Output received: 06:24:53 INFO - /builds/slave/test/build/application/firefox/firefox 06:24:53 INFO - Running post-action listener: _resource_record_post_action 06:24:53 INFO - [mozharness: 2017-08-31 13:24:53.210835Z] Finished install step (success) 06:24:53 INFO - [mozharness: 2017-08-31 13:24:53.211180Z] Running setup-mitmproxy step. 06:24:53 INFO - Running pre-action listener: _resource_record_pre_action 06:24:53 INFO - Running main action method: setup_mitmproxy 06:24:53 INFO - Skipping: mitmproxy is not required 06:24:53 INFO - Running post-action listener: _resource_record_post_action 06:24:53 INFO - [mozharness: 2017-08-31 13:24:53.212303Z] Finished setup-mitmproxy step (success) 06:24:53 INFO - [mozharness: 2017-08-31 13:24:53.212523Z] Running run-tests step. 06:24:53 INFO - Running pre-action listener: _resource_record_pre_action 06:24:53 INFO - Running pre-action listener: _set_gcov_prefix 06:24:53 INFO - Running main action method: run_tests 06:24:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:24:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:24:53 INFO - Python 2.7.3 06:24:53 INFO - Return code: 0 06:24:53 INFO - grabbing minidump binary from tooltool 06:24: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:24:53 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 0x229e580>, '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 0x229f480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229f910>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:24:53 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:24:53 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:24:53 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:24:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:24:53 INFO - Return code: 0 06:24:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:24:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:24:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:24:53 INFO - ENV: RUST_BACKTRACE is now full 06:24:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:24:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:24:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ccktewOdQ72Ms1acZ9Ljrg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:24:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ccktewOdQ72Ms1acZ9Ljrg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-028 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:24:53 INFO - Using env: {'DISPLAY': ':0', 06:24:53 INFO - 'HOME': '/home/cltbld', 06:24:53 INFO - 'LANG': 'en_US.UTF-8', 06:24:53 INFO - 'LANGUAGE': 'en_US:en', 06:24:53 INFO - 'LOGNAME': 'cltbld', 06:24:53 INFO - 'MAIL': '/var/mail/cltbld', 06:24:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:24:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:24:53 INFO - 'MOZ_ACCELERATED': '1', 06:24:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:53 INFO - 'MOZ_NO_REMOTE': '1', 06:24:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:24:53 INFO - 'MOZ_WEBRENDER': '1', 06:24:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:24:53 INFO - 'NO_EM_RESTART': '1', 06:24:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:24:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:53 INFO - 'PWD': '/builds/slave/test', 06:24:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:24:53 INFO - 'RUST_BACKTRACE': 'full', 06:24:53 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 06:24:53 INFO - 'SHELL': '/bin/bash', 06:24:53 INFO - 'SHLVL': '1', 06:24:53 INFO - 'TERM': 'linux', 06:24:53 INFO - 'TMOUT': '86400', 06:24:53 INFO - 'USER': 'cltbld', 06:24:53 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1504185822.842904-1174744033', 06:24:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:53 INFO - '_': '/tools/buildbot/bin/python'} 06:24:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ccktewOdQ72Ms1acZ9Ljrg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:24:53 INFO - mozversion application_buildid: 20170831123523 06:24:53 INFO - mozversion application_changeset: c9079d347aaa559beecf0db6e5414f92ef043485 06:24:53 INFO - mozversion application_display_name: Nightly 06:24:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:24:53 INFO - mozversion application_name: Firefox 06:24:53 INFO - mozversion application_remotingname: firefox 06:24:53 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:24:53 INFO - mozversion application_vendor: Mozilla 06:24:53 INFO - mozversion application_version: 57.0a1 06:24:53 INFO - mozversion platform_buildid: 20170831123523 06:24:53 INFO - mozversion platform_changeset: c9079d347aaa559beecf0db6e5414f92ef043485 06:24:53 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:24:53 INFO - mozversion platform_version: 57.0a1 06:24:53 INFO - using testdate: 1504185893 06:24:53 INFO - actual date: 1504185893 06:24:53 INFO - starting webserver on 'localhost:46416' 06:24:53 INFO - SUITE-START | Running 2 tests 06:24:53 INFO - TEST-START | dromaeo_css 06:24:53 INFO - Initialising browser for dromaeo_css test... 06:24:53 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46416/getInfo.html -profile /tmp/tmpjfleh1/profile 06:24:53 INFO - TEST-INFO | started process 8182 (/builds/slave/test/build/application/firefox/firefox http://localhost:46416/getInfo.html) 06:25:01 INFO - TEST-INFO | 8182: exit 0 06:25:01 INFO - Browser initialized. 06:25:01 INFO - Running cycle 1/1 for dromaeo_css test... 06:25:01 INFO - Using env: {'DISPLAY': ':0', 06:25:01 INFO - 'HOME': '/home/cltbld', 06:25:01 INFO - 'JSGC_DISABLE_POISONING': '1', 06:25:01 INFO - 'LANG': 'en_US.UTF-8', 06:25:01 INFO - 'LANGUAGE': 'en_US:en', 06:25:01 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 06:25:01 INFO - 'LOGNAME': 'cltbld', 06:25:01 INFO - 'MAIL': '/var/mail/cltbld', 06:25:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:25:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:25:01 INFO - 'MOZ_ACCELERATED': '1', 06:25:01 INFO - 'MOZ_CRASHREPORTER': '1', 06:25:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:01 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 06:25:01 INFO - 'MOZ_NO_REMOTE': '1', 06:25:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:25:01 INFO - 'MOZ_WEBRENDER': '1', 06:25:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:01 INFO - 'NO_EM_RESTART': '1', 06:25:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:01 INFO - 'PWD': '/builds/slave/test', 06:25:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:25:01 INFO - 'RUST_BACKTRACE': 'full', 06:25:01 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 06:25:01 INFO - 'SHELL': '/bin/bash', 06:25:01 INFO - 'SHLVL': '1', 06:25:01 INFO - 'TERM': 'linux', 06:25:01 INFO - 'TMOUT': '86400', 06:25:01 INFO - 'USER': 'cltbld', 06:25:01 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1504185822.842904-1174744033', 06:25:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:01 INFO - '_': '/tools/buildbot/bin/python'} 06:25:01 INFO - TEST-INFO | started process 8384 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjfleh1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 06:25:02 INFO - PID 8384 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 06:25:02 INFO - PID 8384 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 06:25:02 INFO - PID 8384 | 06:25:02 INFO - PID 8384 | (/builds/slave/test/build/application/firefox/firefox:8446): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 06:25:02 INFO - PID 8384 | 06:25:13 INFO - PID 8384 | RSS: Main: 202301440 06:25:13 INFO - PID 8384 | 06:25:16 INFO - PID 8384 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 06:28:12 INFO - PID 8384 | Cycle 1(1): loaded http://localhost:46416/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46416/tests/dromaeo/cssquery-ext.html) 06:28:13 INFO - PID 8384 | RSS: Main: 215859200 06:28:13 INFO - PID 8384 | 06:31:15 INFO - PID 8384 | Cycle 1(1): loaded http://localhost:46416/tests/dromaeo/cssquery-ext.html (next: http://localhost:46416/tests/dromaeo/cssquery-jquery.html) 06:31:16 INFO - PID 8384 | RSS: Main: 214175744 06:31:16 INFO - PID 8384 | 06:34:18 INFO - PID 8384 | Cycle 1(1): loaded http://localhost:46416/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46416/tests/dromaeo/cssquery-mootools.html) 06:34:19 INFO - PID 8384 | RSS: Main: 216694784 06:34:19 INFO - PID 8384 | 06:37:21 INFO - PID 8384 | Cycle 1(1): loaded http://localhost:46416/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46416/tests/dromaeo/cssquery-prototype.html) 06:37:21 INFO - PID 8384 | RSS: Main: 214614016 06:37:21 INFO - PID 8384 | 06:40:25 INFO - PID 8384 | Cycle 1(1): loaded http://localhost:46416/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46416/tests/dromaeo/cssquery-yui.html) 06:40:26 INFO - PID 8384 | RSS: Main: 217358336 06:40:26 INFO - PID 8384 | 06:43:28 INFO - PID 8384 | Cycle 1(1): loaded http://localhost:46416/tests/dromaeo/cssquery-yui.html (next: http://localhost:46416/tests/dromaeo/cssquery-dojo.html) 06:43:28 INFO - PID 8384 | RSS: Main: 221224960 06:43:28 INFO - PID 8384 | 06:43:28 INFO - PID 8384 | __start_tp_report 06:43:28 INFO - PID 8384 | _x_x_mozilla_page_load 06:43:28 INFO - PID 8384 | _x_x_mozilla_page_load_details 06:43:28 INFO - PID 8384 | |i|pagename|runs| 06:43:28 INFO - PID 8384 | |0;dojo.html;3314.4199765041126;3356.63077061523;3366.511855780911;3374.1227280906965;3407.9148021299466;6368.840778980528;6379.872402551946;6392.264889537704;6408.8077357679285;6594.901076483857;6444.838879028027;6478.255000674923;6514.153160089182;6531.118299029629;6574.178227721535;5679.772809087632;5828.795992140276;5941.88116237675;5967.8209653710455;5987.4311940365815;5826.475617194452;5838.4453476919625;5983.132445795357;5984.431479009487;6008.279006519224;5900.675462849542;5909.970450147744;5935.139404786303;5944.316403613597;5990.820275391745;5854.648721076749;5946.464818166342;5952.315483719384;5969.552283578749;6033.276006879159;5768.682722450264;5792.073268277098;5851.590388672795;5880.735366908457;5914.792982245601;6416;6439.678016099177;6456.2575303840185;6497.285298617148;6515.641639709814;6842.828929276759;6927.861442771116;6981.301869813029;7025.297470252985;7027.5080744347915;6873.793786186422;7004.229534751174;7009.05377773999;7084.787456376317;7101.147862256562;6366.076918846741;6410.967945160244;6413.647249401328;6423.807285781434;6430.3891130342545;6977.860442791116;7007.159140903124;7065.328793764585;7103.644817759091;7108.964455177691;6761.4590832733265;6764.154480689914;6789.219239787488;6800.251972283045;6803.2856550062525;6892.551984121016;6896.896546551806;6898.517103802686;6911.03245545624;6914.0666010089;6786.253512113663;6834.179898412222;6847.863042739117;6855.280195579492;6933.791986240421;6940.583564986117;6947.965260173667;6959.8956015659805;7000.894986575206;7023.473239507058;5333.946660533423;5407.297051383295;5416.539594134542;5498.010358135494;5501.037318469252;4660.557247061523;4698.107359601733;4759.952400476021;4760.714357138583;4786.234202527578;5994.07091900756;6022.09668549721;6046.3651316612;6070.544709146831;6095.634261944298;6964.582125072512;6978.232394436608;7062.505624606331;7063.1524217094275;7067.399271061914;5856.765729370863;5964.850878728066;6013.30846952606;6019.789307374221;6098.481629061579;6019.4883434908525;6032.758689652453;6035.758569657252;6036.849078773066;6040.154378387029;6717.361850624183;6748.763793267212;6752.898706519406;6772.051912732123;6790.558613690095;6950.513464057467;7033.085698859116;7036.050133231948;7045.682944267623;7050.435965122881;6659.267480577229;6693.263740988585;6746.932530674827;6793.184817821893;6798.76204332846;6799.762008329685;6841.486888483284;6865.450763938973;6900.965495172492;6940.236573976757;6802.693878775566;6999.230084690782;7098.503104782616;7098.787036388917;7101.254368291255;6814.625195614289;6832.624205668537;6837.726490940307;6839.760608378683;6842.965785171242;6707.564008339442;6807.795766127024;6843.041974123527;6843.555168914005;6845.041694162921;6682.465402767864;6686;6754.5947243165565;6765.560238584476;6777.423918966943;6781.525293229427;6805.251422343439;6837.589744615339;6850.0752398425575;6946.131733533309;6405.8718825624155;6437.1631687882145;6570.934290657032;6650.700718467778;6687 06:43:28 INFO - PID 8384 | |1;ext.html;810.9837803243935;819.8483280593088;837.3803385494734;866.4671227195277;873.8077622922955;39453.80273098634;40038.39942400866;40250.7987460063;40286.798566007164;40330.39504407429;37249.44125838114;37339.253214935685;37407.4388884167;37743.245135097284;37806.43290350647;7006.859862802741;7113.85772284554;7117.217106118323;7129.964350178242;7135.42916566676;6948.270431604659;7009.2289848116925;7022.543534670255;7056.470764692643;7071.575705457663;7019.806632872398;7027.89458158128;7736;7925.722599709012;7929.881051784228;7809.531428114303;7877.212278772135;7882.054153501588;7884.724034658817;7892.56590887501;7625.428092892999;7702.268284512962;7710.7686769397005;7725.034370703662;7734;37843;38388;39233;39276.803615982026;39333.40999885004;3554.20030493137;3586.55168103987;3606.1525541497726;3611.133328001261;3628.9274214515826;32318.35363292721;32357.029289121365;32420.351592968007;32470;32538;5240.764165612557;5241.764120614582;5246.3704355477585;5280.2079688046715;5310.0441920454305;174062;179965;185043;185078;192659;47873.281900771515;48135.518644813805;48267.275990860166;48579.757101214265;48715;50700.23949640759;50859.745701271255;50937.23594146091;50966.74516627393;50978;15899.364025439085;16044.598885027734;16081.839181608268;16087.919560402122;16256.51230463088;13416.597502074954;13474.258915759727;13589.59231223045;13594.320283985959;13598.524051658145;13999.16005039701;14004.719905602034;14084.507042253472;14195.929020354832;14284.357203925849;5721.284839395075;5751.281089863767;5803.88392232153;5831.183634291203;5877;996.6611352140162;1004.2016596805557;1006.6663015717261;1009.9091081802673;1023.5905637744961;22219.888900555394;22363;22461.88769056144;22771.31686049421;23073.653895191586;1110.2894147745449;1111.4165063341648;1119.138263537072;1121.955121795119;1125.128025780027;11729.530818767324;11900.928916397392;11944;11945.953781785764;11948.581799636971;216990;218420;218866;219397;219506;50515.49484505181;51094.48905510972;51365.22952155721;51431;51519.48480515147;1386.9306534673226;1449.6086056764825;1450.0647082631644;1452.9927350363391;1482.6960473102988;21740.89129554342;22172.667409988542;22229.444263893532;22644.66033009473;22648.207312743976;35958.101047474025;36018.4597231047;36025.27949441049;36050.27899441944;36093.27813443769;187534;187992;188574;188642;189623;31847.840760796047;33002.339953201285;33152.83423582867;33239.33521329608;33307.16732081717;41786.791066044476;41916.37125443182;42950.570494294654;45194.54805451904;45699.771501142284;32349.676503234667;32634.673653263162;32674.673253267163;32904.34191316208;33239.66760332366;31782.205444864063;31791.205219869687;31934.6806531941;32036.35927281488;32068.19829504281;36428.81785591055;37307.626923730415;38221;38694.41958370683;38793.418098729104;32733.67266327306;32848;32905.67094329122;33159.834200829806;33206.33587328192;23650.881745591163;23842.405763309802;24022.51954960856;24094.879525602963;24096.27711168668 06:43:28 INFO - PID 8384 | |2;jquery.html;553.3698934986486;565.7680351056068;572.4104172702118;575.6229669566434;580.4891695308128;22099.889500552494;22653.660195097065;22820.315390538268;22827.429314267152;22947.196848110318;23677.526449471;24675.259742207716;25784.613230801508;25858.870705646445;26037;6662.966685166567;6819.24988251292;6823.931760682404;6836.350546698056;6836.623985680785;6275.560710750249;6673.532852700313;6717.63053032083;6727.899081513781;6728.158980127484;6363.7454501819875;6371.936280637204;6377.713002914857;6442.065900444432;6516.804495865108;6447.7743278985245;6461.903071453932;6464.773732919349;6529.085927970088;6531.05299731541;5954.612950158225;6044.395560443964;6052.455279024909;6055.939440605625;6057.545684073668;26118.216453506426;26214.344641383927;26719.73280267192;26758.33104172392;30184.396312073855;2068.2864411777914;2072.036503026085;2088.7806780288156;2103.064136459276;2104.947376315589;19497.610047799106;20072.799272007385;20136.295229667037;20139;20209.29267475646;2402.3994001499627;2432.6351047342864;2497.8626175560516;2503.9374015649573;2516.509280690266;121448;126216.36891815483;126247;129001;132000.3399982994;14132;14848.925755371154;15021.549353519413;15095.622609434633;15253.847461525243;22916.770832291797;22973.88513057424;22988.65517017246;23113.19103831358;23125.7687423127;9397.201237894855;9405.811883762286;9431.151196392357;9432.575534100983;9654.179394751525;8590.1839325264;8619.741407757778;8694.478331300143;8800.559972001374;8803.603837827313;8668.436551624125;8878.135591525723;8891.688790892287;9169.908300916906;9271.814563708687;2675.411409489909;2722.91831245063;2724.2916841620927;2785.6935737068907;2875.1230874583034;943.6272672294406;975.197154016466;978.6819283732673;986.9605215791431;990.9058639429243;19198.520036998907;19607;19673.311434099738;19926.70109948352;20238.494037649176;1015.7810627247333;1039.184240371305;1040.5785656809005;1047.863777708893;1056.6460235821087;10842.891571084188;11179.720506987227;11254.22781829601;11257.774844503065;11286.604968826052;452944;463737;466214;467690;470902;132672;137500;137780;139080;139086;1198.2031948753981;1219.3110892345796;1253.6865783554113;1277.9552715654906;1279;19941.401757947286;20863.478413039797;21481.355559333246;21597;22446.32661020172;59802.70098649479;60220.69889650524;61861;61968.69015654893;63838;72906;73267;73623.63188184025;73916;74568.25431745613;16381.262843172324;19144;19871.900640496704;20087.698684520037;20241;21613.675794862775;21985.560288794455;23660.408489787893;23831.52336953286;23832.761672383054;16736.41422550205;16749;16902.90131141472;17077.40229091976;18783.248670053046;15699.607509812346;17038.659226815147;17315.65368692594;17494.475165744538;17751.378701745376;19286.22855085837;19426.708599370737;19473.513162170493;19474.221031158595;19623.215071396986;20163.899180504002;20235.291764788162;20252.69620955716;20270.493237669176;20454;17645.73531397056;17945.192466338784;17995.730064049312;18134.30076255016;18150 06:43:28 INFO - PID 8384 | |3;mootools.html;1347.7169794343188;1377.8071070050194;1388.9513867014657;1394.595567285487;1407.0361802165512;14757.18835464049;15396.307166177521;15415.22923853807;15438.228088595553;15465.922670386632;15424.845751542482;16035.919820400912;16173.676526469464;16190.514284571482;16196.75704864428;2713.2538551898188;2795.7903157263186;2799.0623141247706;2800.901968431105;2810.3676672748675;2587.1721049264243;2689.9596506052426;2773.8058335916494;2776.41695243998;2778.1804367711475;2751.9862400688066;2786.540220863565;2792.6229958955482;2800.075974928269;2801.8599070046516;2666.066876593206;2689.1260340389454;2722.714115017924;2733.8359698418158;2795.664520257562;2620.8296460729994;2624.3439140214946;2642.841429514235;2648.47030593882;2655.1636234586235;14733.631659208499;14947.476838310715;14991.475298364614;15128.924355378153;15168.696626067527;7709.653065612005;7899.605019749047;7952.324052455549;7994.2805147537;7997.240262175084;5182.7408629568745;5215.217717342391;5260;5291.444398338158;5351.652142610717;1856.3131641292807;1858.869879108463;1866.5893503429224;1891.4420246027455;1899.8765080269739;26212.99999999981;26229.475410491876;26401.07596234142;26402.075927342645;26438.07466738655;6371.139896113966;6506;6608.768693095719;6945.201301850352;6996.510244282953;17509.474715758548;17546.122693865254;17570.472885813448;17576.209070591853;18089.185986630633;7649.847003060019;7910.327622152066;7912.564808935564;7913.960430197927;7921.564313962787;7146.892796607951;7266.564006159648;7272.818179545554;7319.670614822346;7386.224446433047;5273.2617433559335;5404.91892621611;5443.401225865152;5444.373897001817;5448.782048718086;1567.866731327827;1572.8820338474432;1581.8576328130523;1586.571625661088;1588.849059339361;885.4775682347446;915.6291701860757;928.03020843219;931.8602209668468;932.3939439364467;7548.698052077965;7618.5809780461495;7652.540847549165;7680.5391676499585;7689.807754806175;728.8068661804626;729.5367441674468;729.9963500182465;731.5866535407478;739.6782399656059;4575.473820510684;5072.898542029138;5105.463926287761;5303.231031500488;5351.384590772111;21599;22214.333569992927;22224.888875555844;22448.551028979655;22448.887755561445;20733.377998660064;21762.12951481923;22218.777967211634;22367.328980130624;22384.55230895373;11302.830457543143;11533.769324613628;11543.365114918592;11580;11629.47667354971;8146;8406.201410865959;8737.43206691563;8846.955765221133;8925.553722313729;19001.334953276568;19177.712334314718;19378.418647440598;19630.312939047064;19646.607067858276;19833.504162396057;19846.702299465807;19848.305309314106;19999.20003199914;20066.698999515313;11621.360825154698;11680.824787628022;11690.590829320932;11736.237144585575;11765.352905589933;13551.119177253448;13651.726965460834;13717.725645486835;13727.970402219673;13729.107608005448;10734.409607471664;10884.836727449254;10897.891021089688;10980.231383803057;11246.493907774333;10255.897441025792;10618;10864.456777160953;11070.778584428428;11098.05666518355;9574.808503829745;9728.075832795874;9736.464494452874;9736.75658108553;9741.464219467998;6530.771423000362;6605.5376123670885;6873.312668733087;6874.828129296808;7092.361687447948;6886.896696549656;6955.6869940851775;6978.616176110363;7013.544119632207;7081.893771593327 06:43:28 INFO - PID 8384 | |4;prototype.html;496.35226030030816;498.74065485947284;534.2120372450638;542.5957661542151;548.4405905975905;6268.874622507547;6383.489320854332;6438.227412710476;6444.548881578291;6466;6115.969420152893;6126.938730612693;6221.937780622193;6230.127782110497;6328.670979094384;4955.513345996204;5035.672681275705;5053.469385714502;5086.491350864902;5093.962415033998;4869.951300487003;5055.721935293557;5073.670211436263;5102.234664800291;5123.974380128094;5035.597152227831;5065.366829146356;5069.822556210515;5084.847454576368;5114.6164037697135;4976.701397916137;4989.501049895;5054.797808087709;5055.848324550269;5101.464346243647;4455.955440445587;4470.75410852403;4490.528494508062;4530.954690453119;4539.591436770674;6111.991521398963;6203.658798766066;6244.781432649836;6295.937040629627;6300.716467758962;5686.232358631573;5718.714064296769;5775.509081728058;5783.621232254002;5807.199768071911;6568.507361947825;6578.519833037576;6643.867122657568;6688.81616747025;6724.899126513106;4815.446223684286;4828.299896515021;4886.144924638174;4916.926246106311;4941.135301322254;6989.405900498464;7037.648117594151;7074.257202993715;7102.254263302382;7167.462440316997;5072.923906141411;5075.619328550373;5101.107306221396;5124.8206312778875;5139.254808052886;5104.132297509433;5109.901371205208;5123.948760512421;5218.686878787209;5235.816746413857;5610.579206559442;5705.4579814917515;5747.614739882985;5755.539556835443;5796.275465566804;6707.228668703162;6718.193816741925;6728.360805723449;6742.797716068526;6813.454923606099;1697.9981810731726;1728.4468969929753;1737.5656085978505;1778.5642517583276;1798.2627122879558;1197.4671271284194;1225.1668865171769;1229.8524177098805;1248.1762037055682;1252.5428218700108;5910.822675319747;5929.6145750526075;5930.318013428425;5998.310194327621;6007.098935159674;6594.274629790815;6647.368499992493;6692.464602831762;6706.329367063255;6752.561083529555;5777.162311464814;5866.765329386777;5941.524678025748;5946.572822522563;6015.338312785678;3584.010873964922;3604.5133906922756;3611.223586928823;3635.8547057676747;3685.8157092145284;6502.187226596676;6609.603423794588;6630.668466576652;6715.5299129060495;6717.052054904121;6845.931540684629;6930.896036559456;6961.380082357247;6973.93026069743;7088.610126443095;6519.641419721961;6547.101340611264;6622.569532980341;6636.601803891782;6709.758694641409;6788.287229840993;6858.3141685831015;6895.655347207246;6925.238223795479;6927.307269273032;6693.259752464492;6734.158230221223;6758.898616520854;6831.658417079226;6855.828604284733;6496;6584.868302634016;6624.30444803308;6661.933380666132;6685.498587606046;4963.329950456642;5005.34930459038;5011.9498805012945;5032.314174751353;5037.345145131109;6698.866022679422;6828.658567071726;6853.554518956252;6862.553933994274;6911.17065952089;6643.46852251809;6653.900191497229;6709.295523969913;6719.361660642231;6743.9325606743305;6619.238787539494;6638.734450621921;6648.667566621746;6658;6673.1992160941;6266.650006247657;6479.5788273762055;6521.315261897622;6535.5425120241125;6540.934590654033;6431.517636177399;6555.147830781968;6649.368310010541;6653.667316634246;6811.216710078206;6430.807075787734;6438.195225596801;6490.286068532552;6501.512386570931;6548.315190771761 06:43:28 INFO - PID 8384 | |5;yui.html;867.5098569308344;892.2861710631494;903.8237543678981;908.1690253418122;909.5361365703492;16253.349866005361;17173.398931037416;17231.569210769736;17237.22432490538;17251.568710782238;15270.847291527081;16548.586285342873;16729.079900605462;16877.15614219287;16916.74624880625;943.6225509796085;962.1677249179444;963.3352986439335;963.57602654832;968.5399435268226;895.7312806158159;984.7685793838442;984.9359791613522;993.940363578184;998.8551660009294;1041.4376236832102;1045.618349302503;1049.9737506562358;1050.3435352904435;1051.8001579699871;1037.222083437422;1044.2429238801883;1044.9425281609508;1045.5869931377101;1047.1831971062584;773.443120952913;776.8368642585064;777.6034222546485;779.0573406178531;779.1701837542998;17457.56356091108;17854.821451785447;18256;18352.174152163185;18614.720779188323;19579.608407831765;19653.41039768809;20076.899615501974;20240.291589794433;20345.491362715904;14613.97702160849;14835.293941196793;14990.100593964396;15032.774508382274;15132.470363537333;3664.358737220976;3678.70570354371;3683.650053244964;3702.648248416396;3702.9259414811554;124009;126946.73053269442;127480;129013.35493322567;129307;14820.703585928437;14901.850981490263;15062.548123556311;15230.543083707507;15457.5362739118;27475.076744628084;28182.2954426141;28481.287967800556;28502;28680.569791453145;8341.666333346599;8548.187922147386;8571.271441927505;8578.313734901192;8616.052234254226;4268.615824575803;4388.736675799462;4405;4408.625266852354;4413.558644135625;4421.646268298528;4455.198064348384;4660.231061874821;4737.4788773235605;5125.692458452505;1058.433737950193;1086.6033897627467;1086.8369744538224;1086.8641419822522;1090.3566895531674;560.935492418369;572.6134858970179;583.7110630237975;588.4762561320429;589.548995018811;10534.894651053544;11029.724256893642;11035.779284414428;11613.477393517313;11680;609.2506217352593;620.4044117647019;622.6917675750533;637.6238019568477;639.2648454277618;5497.422770609029;5501.889962200814;5574.9721251393485;5646.153077038477;5832.591718579659;106313;106504.40243396355;108643.45678271558;109183;109704.4514777421;95899.52050239705;96313.51843240739;96883.51558242163;99072;100810.4959475198;84809.57595211985;88544;88767.55616221878;89047;90943.09056909478;11320.716982075513;11469.598564050551;11593.594224202112;11627.360495172847;11708;39033.80483097566;39174.804125979186;39474.80262598669;40058.19883602254;40131.799341003105;65501.34498654953;65742.34257657362;68295;68459.3154068453;68612;14706.264686765406;15781.605459863595;15980.360785568448;16040.839591604401;16914.746278805582;17040.82959170442;17140.40008599693;17259.568510787332;17313.480595582154;17571.736423953396;15405;15871;16552.917235413744;16772.832271677125;16878.156092195586;15762.369505219664;15814.209289535247;16028.599285017968;16167;16187.10970896612;15752.76370854461;15953.601159971093;16475.176241188132;16524.421645242357;16623.750643740113;12096.758064838477;12570.182938108994;12601.11792174539;12701.682457938625;12861.807072893727;12520;12747.936260318638;13010.869891300967;13145.539906103622;13641.113327633671 06:43:28 INFO - PID 8384 | __end_tp_report 06:43:28 INFO - PID 8384 | __start_cc_report 06:43:28 INFO - PID 8384 | _x_x_mozilla_cycle_collect,372 06:43:28 INFO - PID 8384 | __end_cc_report 06:43:28 INFO - PID 8384 | __startTimestamp1504187008516__endTimestamp 06:43:28 INFO - PID 8384 | 06:43:28 INFO - PID 8384 | ------- Summary: start ------- 06:43:28 INFO - PID 8384 | Number of tests: 6 06:43:28 INFO - PID 8384 | 06:43:28 INFO - PID 8384 | [#0] dojo.html Cycles:165 Average:6384.64 Median:6687.00 stddev:762.52 (11.4%) stddev-sans-first:725.82 06:43:28 INFO - PID 8384 | Values: 3314.4 3356.6 3366.5 3374.1 3407.9 6368.8 6379.9 6392.3 6408.8 6594.9 6444.8 6478.3 6514.2 6531.1 6574.2 5679.8 5828.8 5941.9 5967.8 5987.4 5826.5 5838.4 5983.1 5984.4 6008.3 5900.7 5910.0 5935.1 5944.3 5990.8 5854.6 5946.5 5952.3 5969.6 6033.3 5768.7 5792.1 5851.6 5880.7 5914.8 6416.0 6439.7 6456.3 6497.3 6515.6 6842.8 6927.9 6981.3 7025.3 7027.5 6873.8 7004.2 7009.1 7084.8 7101.1 6366.1 6411.0 6413.6 6423.8 6430.4 6977.9 7007.2 7065.3 7103.6 7109.0 6761.5 6764.2 6789.2 6800.3 6803.3 6892.6 6896.9 6898.5 6911.0 6914.1 6786.3 6834.2 6847.9 6855.3 6933.8 6940.6 6948.0 6959.9 7000.9 7023.5 5333.9 5407.3 5416.5 5498.0 5501.0 4660.6 4698.1 4760.0 4760.7 4786.2 5994.1 6022.1 6046.4 6070.5 6095.6 6964.6 6978.2 7062.5 7063.2 7067.4 5856.8 5964.9 6013.3 6019.8 6098.5 6019.5 6032.8 6035.8 6036.8 6040.2 6717.4 6748.8 6752.9 6772.1 6790.6 6950.5 7033.1 7036.1 7045.7 7050.4 6659.3 6693.3 6746.9 6793.2 6798.8 6799.8 6841.5 6865.5 6901.0 6940.2 6802.7 6999.2 7098.5 7098.8 7101.3 6814.6 6832.6 6837.7 6839.8 6843.0 6707.6 6807.8 6843.0 6843.6 6845.0 6682.5 6686.0 6754.6 6765.6 6777.4 6781.5 6805.3 6837.6 6850.1 6946.1 6405.9 6437.2 6570.9 6650.7 6687.0 06:43:28 INFO - PID 8384 | 06:43:28 INFO - PID 8384 | [#1] ext.html Cycles:180 Average:36621.61 Median:19772.33 stddev:51086.16 (258.4%) stddev-sans-first:51158.70 06:43:28 INFO - PID 8384 | Values: 811.0 819.8 837.4 866.5 873.8 39453.8 40038.4 40250.8 40286.8 40330.4 37249.4 37339.3 37407.4 37743.2 37806.4 7006.9 7113.9 7117.2 7130.0 7135.4 6948.3 7009.2 7022.5 7056.5 7071.6 7019.8 7027.9 7736.0 7925.7 7929.9 7809.5 7877.2 7882.1 7884.7 7892.6 7625.4 7702.3 7710.8 7725.0 7734.0 37843.0 38388.0 39233.0 39276.8 39333.4 3554.2 3586.6 3606.2 3611.1 3628.9 32318.4 32357.0 32420.4 32470.0 32538.0 5240.8 5241.8 5246.4 5280.2 5310.0 174062.0 179965.0 185043.0 185078.0 192659.0 47873.3 48135.5 48267.3 48579.8 48715.0 50700.2 50859.7 50937.2 50966.7 50978.0 15899.4 16044.6 16081.8 16087.9 16256.5 13416.6 13474.3 13589.6 13594.3 13598.5 13999.2 14004.7 14084.5 14195.9 14284.4 5721.3 5751.3 5803.9 5831.2 5877.0 996.7 1004.2 1006.7 1009.9 1023.6 22219.9 22363.0 22461.9 22771.3 23073.7 1110.3 1111.4 1119.1 1122.0 1125.1 11729.5 11900.9 11944.0 11946.0 11948.6 216990.0 218420.0 218866.0 219397.0 219506.0 50515.5 51094.5 51365.2 51431.0 51519.5 1386.9 1449.6 1450.1 1453.0 1482.7 21740.9 22172.7 22229.4 22644.7 22648.2 35958.1 36018.5 36025.3 36050.3 36093.3 187534.0 187992.0 188574.0 188642.0 189623.0 31847.8 33002.3 33152.8 33239.3 33307.2 41786.8 41916.4 42950.6 45194.5 45699.8 32349.7 32634.7 32674.7 32904.3 33239.7 31782.2 31791.2 31934.7 32036.4 32068.2 36428.8 37307.6 38221.0 38694.4 38793.4 32733.7 32848.0 32905.7 33159.8 33206.3 23650.9 23842.4 24022.5 24094.9 24096.3 06:43:28 INFO - PID 8384 | 06:43:28 INFO - PID 8384 | [#2] jquery.html Cycles:180 Average:34822.91 Median:23119.48 stddev:78965.23 (341.6%) stddev-sans-first:79144.82 06:43:28 INFO - PID 8384 | Values: 553.4 565.8 572.4 575.6 580.5 22099.9 22653.7 22820.3 22827.4 22947.2 23677.5 24675.3 25784.6 25858.9 26037.0 6663.0 6819.2 6823.9 6836.4 6836.6 6275.6 6673.5 6717.6 6727.9 6728.2 6363.7 6371.9 6377.7 6442.1 6516.8 6447.8 6461.9 6464.8 6529.1 6531.1 5954.6 6044.4 6052.5 6055.9 6057.5 26118.2 26214.3 26719.7 26758.3 30184.4 2068.3 2072.0 2088.8 2103.1 2104.9 19497.6 20072.8 20136.3 20139.0 20209.3 2402.4 2432.6 2497.9 2503.9 2516.5 121448.0 126216.4 126247.0 129001.0 132000.3 14132.0 14848.9 15021.5 15095.6 15253.8 22916.8 22973.9 22988.7 23113.2 23125.8 9397.2 9405.8 9431.2 9432.6 9654.2 8590.2 8619.7 8694.5 8800.6 8803.6 8668.4 8878.1 8891.7 9169.9 9271.8 2675.4 2722.9 2724.3 2785.7 2875.1 943.6 975.2 978.7 987.0 990.9 19198.5 19607.0 19673.3 19926.7 20238.5 1015.8 1039.2 1040.6 1047.9 1056.6 10842.9 11179.7 11254.2 11257.8 11286.6 452944.0 463737.0 466214.0 467690.0 470902.0 132672.0 137500.0 137780.0 139080.0 139086.0 1198.2 1219.3 1253.7 1278.0 1279.0 19941.4 20863.5 21481.4 21597.0 22446.3 59802.7 60220.7 61861.0 61968.7 63838.0 72906.0 73267.0 73623.6 73916.0 74568.3 16381.3 19144.0 19871.9 20087.7 20241.0 21613.7 21985.6 23660.4 23831.5 23832.8 16736.4 16749.0 16902.9 17077.4 18783.2 15699.6 17038.7 17315.7 17494.5 17751.4 19286.2 19426.7 19473.5 19474.2 19623.2 20163.9 20235.3 20252.7 20270.5 20454.0 17645.7 17945.2 17995.7 18134.3 18150.0 06:43:28 INFO - PID 8384 | 06:43:28 INFO - PID 8384 | [#3] mootools.html Cycles:180 Average:9378.61 Median:2660.62 stddev:6817.90 (256.3%) stddev-sans-first:6810.32 06:43:28 INFO - PID 8384 | Values: 1347.7 1377.8 1389.0 1394.6 1407.0 14757.2 15396.3 15415.2 15438.2 15465.9 15424.8 16035.9 16173.7 16190.5 16196.8 2713.3 2795.8 2799.1 2800.9 2810.4 2587.2 2690.0 2773.8 2776.4 2778.2 2752.0 2786.5 2792.6 2800.1 2801.9 2666.1 2689.1 2722.7 2733.8 2795.7 2620.8 2624.3 2642.8 2648.5 2655.2 14733.6 14947.5 14991.5 15128.9 15168.7 7709.7 7899.6 7952.3 7994.3 7997.2 5182.7 5215.2 5260.0 5291.4 5351.7 1856.3 1858.9 1866.6 1891.4 1899.9 26213.0 26229.5 26401.1 26402.1 26438.1 6371.1 6506.0 6608.8 6945.2 6996.5 17509.5 17546.1 17570.5 17576.2 18089.2 7649.8 7910.3 7912.6 7914.0 7921.6 7146.9 7266.6 7272.8 7319.7 7386.2 5273.3 5404.9 5443.4 5444.4 5448.8 1567.9 1572.9 1581.9 1586.6 1588.8 885.5 915.6 928.0 931.9 932.4 7548.7 7618.6 7652.5 7680.5 7689.8 728.8 729.5 730.0 731.6 739.7 4575.5 5072.9 5105.5 5303.2 5351.4 21599.0 22214.3 22224.9 22448.6 22448.9 20733.4 21762.1 22218.8 22367.3 22384.6 11302.8 11533.8 11543.4 11580.0 11629.5 8146.0 8406.2 8737.4 8847.0 8925.6 19001.3 19177.7 19378.4 19630.3 19646.6 19833.5 19846.7 19848.3 19999.2 20066.7 11621.4 11680.8 11690.6 11736.2 11765.4 13551.1 13651.7 13717.7 13728.0 13729.1 10734.4 10884.8 10897.9 10980.2 11246.5 10255.9 10618.0 10864.5 11070.8 11098.1 9574.8 9728.1 9736.5 9736.8 9741.5 6530.8 6605.5 6873.3 6874.8 7092.4 6886.9 6955.7 6978.6 7013.5 7081.9 06:43:28 INFO - PID 8384 | 06:43:28 INFO - PID 8384 | [#4] prototype.html Cycles:180 Average:5597.15 Median:6237.45 stddev:1578.57 (25.3%) stddev-sans-first:1535.87 06:43:28 INFO - PID 8384 | Values: 496.4 498.7 534.2 542.6 548.4 6268.9 6383.5 6438.2 6444.5 6466.0 6116.0 6126.9 6221.9 6230.1 6328.7 4955.5 5035.7 5053.5 5086.5 5094.0 4870.0 5055.7 5073.7 5102.2 5124.0 5035.6 5065.4 5069.8 5084.8 5114.6 4976.7 4989.5 5054.8 5055.8 5101.5 4456.0 4470.8 4490.5 4531.0 4539.6 6112.0 6203.7 6244.8 6295.9 6300.7 5686.2 5718.7 5775.5 5783.6 5807.2 6568.5 6578.5 6643.9 6688.8 6724.9 4815.4 4828.3 4886.1 4916.9 4941.1 6989.4 7037.6 7074.3 7102.3 7167.5 5072.9 5075.6 5101.1 5124.8 5139.3 5104.1 5109.9 5123.9 5218.7 5235.8 5610.6 5705.5 5747.6 5755.5 5796.3 6707.2 6718.2 6728.4 6742.8 6813.5 1698.0 1728.4 1737.6 1778.6 1798.3 1197.5 1225.2 1229.9 1248.2 1252.5 5910.8 5929.6 5930.3 5998.3 6007.1 6594.3 6647.4 6692.5 6706.3 6752.6 5777.2 5866.8 5941.5 5946.6 6015.3 3584.0 3604.5 3611.2 3635.9 3685.8 6502.2 6609.6 6630.7 6715.5 6717.1 6845.9 6930.9 6961.4 6973.9 7088.6 6519.6 6547.1 6622.6 6636.6 6709.8 6788.3 6858.3 6895.7 6925.2 6927.3 6693.3 6734.2 6758.9 6831.7 6855.8 6496.0 6584.9 6624.3 6661.9 6685.5 4963.3 5005.3 5011.9 5032.3 5037.3 6698.9 6828.7 6853.6 6862.6 6911.2 6643.5 6653.9 6709.3 6719.4 6743.9 6619.2 6638.7 6648.7 6658.0 6673.2 6266.7 6479.6 6521.3 6535.5 6540.9 6431.5 6555.1 6649.4 6653.7 6811.2 6430.8 6438.2 6490.3 6501.5 6548.3 06:43:28 INFO - PID 8384 | 06:43:28 INFO - PID 8384 | [#5] yui.html Cycles:180 Average:22868.73 Median:17514.65 stddev:32232.74 (184.0%) stddev-sans-first:32280.83 06:43:28 INFO - PID 8384 | Values: 867.5 892.3 903.8 908.2 909.5 16253.3 17173.4 17231.6 17237.2 17251.6 15270.8 16548.6 16729.1 16877.2 16916.7 943.6 962.2 963.3 963.6 968.5 895.7 984.8 984.9 993.9 998.9 1041.4 1045.6 1050.0 1050.3 1051.8 1037.2 1044.2 1044.9 1045.6 1047.2 773.4 776.8 777.6 779.1 779.2 17457.6 17854.8 18256.0 18352.2 18614.7 19579.6 19653.4 20076.9 20240.3 20345.5 14614.0 14835.3 14990.1 15032.8 15132.5 3664.4 3678.7 3683.7 3702.6 3702.9 124009.0 126946.7 127480.0 129013.4 129307.0 14820.7 14901.9 15062.5 15230.5 15457.5 27475.1 28182.3 28481.3 28502.0 28680.6 8341.7 8548.2 8571.3 8578.3 8616.1 4268.6 4388.7 4405.0 4408.6 4413.6 4421.6 4455.2 4660.2 4737.5 5125.7 1058.4 1086.6 1086.8 1086.9 1090.4 560.9 572.6 583.7 588.5 589.5 10534.9 11029.7 11035.8 11613.5 11680.0 609.3 620.4 622.7 637.6 639.3 5497.4 5501.9 5575.0 5646.2 5832.6 106313.0 106504.4 108643.5 109183.0 109704.5 95899.5 96313.5 96883.5 99072.0 100810.5 84809.6 88544.0 88767.6 89047.0 90943.1 11320.7 11469.6 11593.6 11627.4 11708.0 39033.8 39174.8 39474.8 40058.2 40131.8 65501.3 65742.3 68295.0 68459.3 68612.0 14706.3 15781.6 15980.4 16040.8 16914.7 17040.8 17140.4 17259.6 17313.5 17571.7 15405.0 15871.0 16552.9 16772.8 16878.2 15762.4 15814.2 16028.6 16167.0 16187.1 15752.8 15953.6 16475.2 16524.4 16623.8 12096.8 12570.2 12601.1 12701.7 12861.8 12520.0 12747.9 13010.9 13145.5 13641.1 06:43:28 INFO - PID 8384 | -------- Summary: end -------- 06:43:28 INFO - PID 8384 | 06:43:29 INFO - TEST-INFO | 8384: exit 0 06:43:29 INFO - TEST-OK | dromaeo_css | took 1115911ms 06:43:29 INFO - TEST-START | kraken 06:43:29 INFO - Initialising browser for kraken test... 06:43:29 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46416/getInfo.html -profile /tmp/tmpY3Abpa/profile 06:43:29 INFO - TEST-INFO | started process 8775 (/builds/slave/test/build/application/firefox/firefox http://localhost:46416/getInfo.html) 06:43:35 INFO - TEST-INFO | 8775: exit 0 06:43:35 INFO - Browser initialized. 06:43:35 INFO - Running cycle 1/1 for kraken test... 06:43:35 INFO - Using env: {'DISPLAY': ':0', 06:43:35 INFO - 'HOME': '/home/cltbld', 06:43:35 INFO - 'JSGC_DISABLE_POISONING': '1', 06:43:35 INFO - 'LANG': 'en_US.UTF-8', 06:43:35 INFO - 'LANGUAGE': 'en_US:en', 06:43:35 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 06:43:35 INFO - 'LOGNAME': 'cltbld', 06:43:35 INFO - 'MAIL': '/var/mail/cltbld', 06:43:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:43:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:43:35 INFO - 'MOZ_ACCELERATED': '1', 06:43:35 INFO - 'MOZ_CRASHREPORTER': '1', 06:43:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:35 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 06:43:35 INFO - 'MOZ_NO_REMOTE': '1', 06:43:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:43:35 INFO - 'MOZ_WEBRENDER': '1', 06:43:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:43:35 INFO - 'NO_EM_RESTART': '1', 06:43:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:43:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:35 INFO - 'PWD': '/builds/slave/test', 06:43:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:43:35 INFO - 'RUST_BACKTRACE': 'full', 06:43:35 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 06:43:35 INFO - 'SHELL': '/bin/bash', 06:43:35 INFO - 'SHLVL': '1', 06:43:35 INFO - 'TERM': 'linux', 06:43:35 INFO - 'TMOUT': '86400', 06:43:35 INFO - 'USER': 'cltbld', 06:43:35 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1504185822.842904-1174744033', 06:43:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:35 INFO - '_': '/tools/buildbot/bin/python'} 06:43:35 INFO - TEST-INFO | started process 8974 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY3Abpa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 06:43:36 INFO - PID 8974 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 06:43:36 INFO - PID 8974 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 06:43:37 INFO - PID 8974 | 06:43:37 INFO - PID 8974 | (/builds/slave/test/build/application/firefox/firefox:9036): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 06:43:37 INFO - PID 8974 | 06:43:47 INFO - PID 8974 | RSS: Main: 205975552 06:43:47 INFO - PID 8974 | 06:43:50 INFO - PID 8974 | Cycle 1(1): loaded http://localhost:46416/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46416/tests/kraken/driver.html?testName=audio-beat-detection) 06:43:51 INFO - PID 8974 | RSS: Main: 212217856 06:43:51 INFO - PID 8974 | 06:43:53 INFO - PID 8974 | Cycle 1(1): loaded http://localhost:46416/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46416/tests/kraken/driver.html?testName=audio-dft) 06:43:54 INFO - PID 8974 | RSS: Main: 212869120 06:43:54 INFO - PID 8974 | 06:43:57 INFO - PID 8974 | Cycle 1(1): loaded http://localhost:46416/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46416/tests/kraken/driver.html?testName=audio-fft) 06:43:58 INFO - PID 8974 | RSS: Main: 206364672 06:43:58 INFO - PID 8974 | 06:44:00 INFO - PID 8974 | Cycle 1(1): loaded http://localhost:46416/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46416/tests/kraken/driver.html?testName=audio-oscillator) 06:44:00 INFO - PID 8974 | RSS: Main: 207527936 06:44:00 INFO - PID 8974 | 06:44:03 INFO - PID 8974 | Cycle 1(1): loaded http://localhost:46416/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46416/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:44:03 INFO - PID 8974 | RSS: Main: 209272832 06:44:03 INFO - PID 8974 | 06:44:06 INFO - PID 8974 | Cycle 1(1): loaded http://localhost:46416/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46416/tests/kraken/driver.html?testName=imaging-darkroom) 06:44:07 INFO - PID 8974 | RSS: Main: 211521536 06:44:07 INFO - PID 8974 | 06:44:11 INFO - PID 8974 | Cycle 1(1): loaded http://localhost:46416/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46416/tests/kraken/driver.html?testName=imaging-desaturate) 06:44:11 INFO - PID 8974 | RSS: Main: 208867328 06:44:11 INFO - PID 8974 | 06:44:14 INFO - PID 8974 | Cycle 1(1): loaded http://localhost:46416/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46416/tests/kraken/driver.html?testName=json-parse-financial) 06:44:15 INFO - PID 8974 | RSS: Main: 211279872 06:44:15 INFO - PID 8974 | 06:44:16 INFO - PID 8974 | Cycle 1(1): loaded http://localhost:46416/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46416/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:44:17 INFO - PID 8974 | RSS: Main: 211333120 06:44:17 INFO - PID 8974 | 06:44:19 INFO - PID 8974 | Cycle 1(1): loaded http://localhost:46416/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46416/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:44:19 INFO - PID 8974 | RSS: Main: 208814080 06:44:19 INFO - PID 8974 | 06:44:22 INFO - PID 8974 | Cycle 1(1): loaded http://localhost:46416/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46416/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:44:22 INFO - PID 8974 | RSS: Main: 209645568 06:44:22 INFO - PID 8974 | 06:44:25 INFO - PID 8974 | Cycle 1(1): loaded http://localhost:46416/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46416/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:44:26 INFO - PID 8974 | RSS: Main: 209866752 06:44:26 INFO - PID 8974 | 06:44:29 INFO - PID 8974 | Cycle 1(1): loaded http://localhost:46416/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46416/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:44:29 INFO - PID 8974 | RSS: Main: 209166336 06:44:29 INFO - PID 8974 | 06:44:31 INFO - PID 8974 | Cycle 1(1): loaded http://localhost:46416/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46416/tests/kraken/driver.html?testName=ai-astar) 06:44:31 INFO - PID 8974 | RSS: Main: 210837504 06:44:31 INFO - PID 8974 | 06:44:31 INFO - PID 8974 | __start_tp_report 06:44:31 INFO - PID 8974 | _x_x_mozilla_page_load 06:44:31 INFO - PID 8974 | _x_x_mozilla_page_load_details 06:44:31 INFO - PID 8974 | |i|pagename|runs| 06:44:31 INFO - PID 8974 | |0;ai-astar;106;121;95;117;106;111;111;109;115;114 06:44:31 INFO - PID 8974 | |1;audio-beat-detection;155;123;156;175;124;157;161;125;172;127 06:44:31 INFO - PID 8974 | |2;audio-dft;165;164;165;170;164;166;166;168;166;165 06:44:31 INFO - PID 8974 | |3;audio-fft;75;75;74;166;79;73;73;88;98;77 06:44:31 INFO - PID 8974 | |4;audio-oscillator;88;81;128;80;78;87;122;84;79;127 06:44:31 INFO - PID 8974 | |5;imaging-gaussian-blur;116;114;116;116;124;114;123;118;114;119 06:44:31 INFO - PID 8974 | |6;imaging-darkroom;152;152;150;152;148;154;156;157;151;154 06:44:31 INFO - PID 8974 | |7;imaging-desaturate;101;99;97;99;95;100;98;98;94;95 06:44:31 INFO - PID 8974 | |8;json-parse-financial;53;58;53;53;53;53;60;56;54;53 06:44:31 INFO - PID 8974 | |9;json-stringify-tinderbox;45;39;38;42;38;40;48;38;42;39 06:44:31 INFO - PID 8974 | |10;stanford-crypto-aes;81;84;79;77;78;75;87;75;74;83 06:44:31 INFO - PID 8974 | |11;stanford-crypto-ccm;130;123;136;126;126;118;133;125;124;158 06:44:31 INFO - PID 8974 | |12;stanford-crypto-pbkdf2;181;178;169;170;174;185;166;170;171;171 06:44:31 INFO - PID 8974 | |13;stanford-crypto-sha256-iterative;66;64;68;64;65;67;63;67;65;64 06:44:31 INFO - PID 8974 | __end_tp_report 06:44:31 INFO - PID 8974 | __start_cc_report 06:44:31 INFO - PID 8974 | _x_x_mozilla_cycle_collect,936 06:44:31 INFO - PID 8974 | __end_cc_report 06:44:31 INFO - PID 8974 | __startTimestamp1504187071891__endTimestamp 06:44:31 INFO - PID 8974 | 06:44:31 INFO - PID 8974 | ------- Summary: start ------- 06:44:31 INFO - PID 8974 | Number of tests: 14 06:44:31 INFO - PID 8974 | 06:44:31 INFO - PID 8974 | [#0] ai-astar Cycles:10 Average:110.50 Median:114.50 stddev:7.21 (6.3%) stddev-sans-first:7.47 06:44:31 INFO - PID 8974 | Values: 106.0 121.0 95.0 117.0 106.0 111.0 111.0 109.0 115.0 114.0 06:44:31 INFO - PID 8974 | 06:44:31 INFO - PID 8974 | [#1] audio-beat-detection Cycles:10 Average:147.50 Median:156.50 stddev:20.65 (13.2%) stddev-sans-first:21.72 06:44:31 INFO - PID 8974 | Values: 155.0 123.0 156.0 175.0 124.0 157.0 161.0 125.0 172.0 127.0 06:44:31 INFO - PID 8974 | 06:44:31 INFO - PID 8974 | [#2] audio-dft Cycles:10 Average:165.90 Median:166.00 stddev:1.85 (1.1%) stddev-sans-first:1.94 06:44:31 INFO - PID 8974 | Values: 165.0 164.0 165.0 170.0 164.0 166.0 166.0 168.0 166.0 165.0 06:44:31 INFO - PID 8974 | 06:44:31 INFO - PID 8974 | [#3] audio-fft Cycles:10 Average:87.80 Median:76.00 stddev:28.62 (37.7%) stddev-sans-first:29.97 06:44:31 INFO - PID 8974 | Values: 75.0 75.0 74.0 166.0 79.0 73.0 73.0 88.0 98.0 77.0 06:44:31 INFO - PID 8974 | 06:44:31 INFO - PID 8974 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:80.50 stddev:21.19 (26.3%) stddev-sans-first:22.30 06:44:31 INFO - PID 8974 | Values: 88.0 81.0 128.0 80.0 78.0 87.0 122.0 84.0 79.0 127.0 06:44:31 INFO - PID 8974 | 06:44:31 INFO - PID 8974 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:3.63 (3.1%) stddev-sans-first:3.81 06:44:31 INFO - PID 8974 | Values: 116.0 114.0 116.0 116.0 124.0 114.0 123.0 118.0 114.0 119.0 06:44:31 INFO - PID 8974 | 06:44:31 INFO - PID 8974 | [#6] imaging-darkroom Cycles:10 Average:152.60 Median:153.00 stddev:2.72 (1.8%) stddev-sans-first:2.87 06:44:31 INFO - PID 8974 | Values: 152.0 152.0 150.0 152.0 148.0 154.0 156.0 157.0 151.0 154.0 06:44:31 INFO - PID 8974 | 06:44:31 INFO - PID 8974 | [#7] imaging-desaturate Cycles:10 Average:97.60 Median:97.50 stddev:2.32 (2.4%) stddev-sans-first:2.11 06:44:31 INFO - PID 8974 | Values: 101.0 99.0 97.0 99.0 95.0 100.0 98.0 98.0 94.0 95.0 06:44:31 INFO - PID 8974 | 06:44:31 INFO - PID 8974 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:53.50 stddev:2.55 (4.8%) stddev-sans-first:2.64 06:44:31 INFO - PID 8974 | Values: 53.0 58.0 53.0 53.0 53.0 53.0 60.0 56.0 54.0 53.0 06:44:31 INFO - PID 8974 | 06:44:31 INFO - PID 8974 | [#9] json-stringify-tinderbox Cycles:10 Average:40.90 Median:41.00 stddev:3.38 (8.2%) stddev-sans-first:3.24 06:44:31 INFO - PID 8974 | Values: 45.0 39.0 38.0 42.0 38.0 40.0 48.0 38.0 42.0 39.0 06:44:31 INFO - PID 8974 | 06:44:31 INFO - PID 8974 | [#10] stanford-crypto-aes Cycles:10 Average:79.30 Median:80.00 stddev:4.35 (5.4%) stddev-sans-first:4.57 06:44:31 INFO - PID 8974 | Values: 81.0 84.0 79.0 77.0 78.0 75.0 87.0 75.0 74.0 83.0 06:44:31 INFO - PID 8974 | 06:44:31 INFO - PID 8974 | [#11] stanford-crypto-ccm Cycles:10 Average:129.90 Median:128.00 stddev:11.13 (8.7%) stddev-sans-first:11.81 06:44:31 INFO - PID 8974 | Values: 130.0 123.0 136.0 126.0 126.0 118.0 133.0 125.0 124.0 158.0 06:44:31 INFO - PID 8974 | 06:44:31 INFO - PID 8974 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.50 Median:172.50 stddev:5.99 (3.5%) stddev-sans-first:5.70 06:44:31 INFO - PID 8974 | Values: 181.0 178.0 169.0 170.0 174.0 185.0 166.0 170.0 171.0 171.0 06:44:31 INFO - PID 8974 | 06:44:31 INFO - PID 8974 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.50 stddev:1.64 (2.5%) stddev-sans-first:1.72 06:44:31 INFO - PID 8974 | Values: 66.0 64.0 68.0 64.0 65.0 67.0 63.0 67.0 65.0 64.0 06:44:31 INFO - PID 8974 | -------- Summary: end -------- 06:44:31 INFO - PID 8974 | 06:44:32 INFO - PID 8974 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 06:44:32 INFO - TEST-INFO | 8974: exit 0 06:44:32 INFO - TEST-OK | kraken | took 63356ms 06:44:32 INFO - SUITE-END | took 1179s 06:44:33 INFO - Completed test suite (00:19:39) 06:44:33 INFO - javascript benchmark 06:44:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8534.193923097071, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3314.4199765041126, 3356.63077061523, 3366.511855780911, 3374.1227280906965, 3407.9148021299466, 6368.840778980528, 6379.872402551946, 6392.264889537704, 6408.8077357679285, 6594.901076483857, 6444.838879028027, 6478.255000674923, 6514.153160089182, 6531.118299029629, 6574.178227721535, 5679.772809087632, 5828.795992140276, 5941.88116237675, 5967.8209653710455, 5987.4311940365815, 5826.475617194452, 5838.4453476919625, 5983.132445795357, 5984.431479009487, 6008.279006519224, 5900.675462849542, 5909.970450147744, 5935.139404786303, 5944.316403613597, 5990.820275391745, 5854.648721076749, 5946.464818166342, 5952.315483719384, 5969.552283578749, 6033.276006879159, 5768.682722450264, 5792.073268277098, 5851.590388672795, 5880.735366908457, 5914.792982245601, 6416.0, 6439.678016099177, 6456.2575303840185, 6497.285298617148, 6515.641639709814, 6842.828929276759, 6927.861442771116, 6981.301869813029, 7025.297470252985, 7027.5080744347915, 6873.793786186422, 7004.229534751174, 7009.05377773999, 7084.787456376317, 7101.147862256562, 6366.076918846741, 6410.967945160244, 6413.647249401328, 6423.807285781434, 6430.3891130342545, 6977.860442791116, 7007.159140903124, 7065.328793764585, 7103.644817759091, 7108.964455177691, 6761.4590832733265, 6764.154480689914, 6789.219239787488, 6800.251972283045, 6803.2856550062525, 6892.551984121016, 6896.896546551806, 6898.517103802686, 6911.03245545624, 6914.0666010089, 6786.253512113663, 6834.179898412222, 6847.863042739117, 6855.280195579492, 6933.791986240421, 6940.583564986117, 6947.965260173667, 6959.8956015659805, 7000.894986575206, 7023.473239507058, 5333.946660533423, 5407.297051383295, 5416.539594134542, 5498.010358135494, 5501.037318469252, 4660.557247061523, 4698.107359601733, 4759.952400476021, 4760.714357138583, 4786.234202527578, 5994.07091900756, 6022.09668549721, 6046.3651316612, 6070.544709146831, 6095.634261944298, 6964.582125072512, 6978.232394436608, 7062.505624606331, 7063.1524217094275, 7067.399271061914, 5856.765729370863, 5964.850878728066, 6013.30846952606, 6019.789307374221, 6098.481629061579, 6019.4883434908525, 6032.758689652453, 6035.758569657252, 6036.849078773066, 6040.154378387029, 6717.361850624183, 6748.763793267212, 6752.898706519406, 6772.051912732123, 6790.558613690095, 6950.513464057467, 7033.085698859116, 7036.050133231948, 7045.682944267623, 7050.435965122881, 6659.267480577229, 6693.263740988585, 6746.932530674827, 6793.184817821893, 6798.76204332846, 6799.762008329685, 6841.486888483284, 6865.450763938973, 6900.965495172492, 6940.236573976757, 6802.693878775566, 6999.230084690782, 7098.503104782616, 7098.787036388917, 7101.254368291255, 6814.625195614289, 6832.624205668537, 6837.726490940307, 6839.760608378683, 6842.965785171242, 6707.564008339442, 6807.795766127024, 6843.041974123527, 6843.555168914005, 6845.041694162921, 6682.465402767864, 6686.0, 6754.5947243165565, 6765.560238584476, 6777.423918966943, 6781.525293229427, 6805.251422343439, 6837.589744615339, 6850.0752398425575, 6946.131733533309, 6405.8718825624155, 6437.1631687882145, 6570.934290657032, 6650.700718467778, 6687.0], "value": 6327.910509019997, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [810.9837803243935, 819.8483280593088, 837.3803385494734, 866.4671227195277, 873.8077622922955, 39453.80273098634, 40038.39942400866, 40250.7987460063, 40286.798566007164, 40330.39504407429, 37249.44125838114, 37339.253214935685, 37407.4388884167, 37743.245135097284, 37806.43290350647, 7006.859862802741, 7113.85772284554, 7117.217106118323, 7129.964350178242, 7135.42916566676, 6948.270431604659, 7009.2289848116925, 7022.543534670255, 7056.470764692643, 7071.575705457663, 7019.806632872398, 7027.89458158128, 7736.0, 7925.722599709012, 7929.881051784228, 7809.531428114303, 7877.212278772135, 7882.054153501588, 7884.724034658817, 7892.56590887501, 7625.428092892999, 7702.268284512962, 7710.7686769397005, 7725.034370703662, 7734.0, 37843.0, 38388.0, 39233.0, 39276.803615982026, 39333.40999885004, 3554.20030493137, 3586.55168103987, 3606.1525541497726, 3611.133328001261, 3628.9274214515826, 32318.35363292721, 32357.029289121365, 32420.351592968007, 32470.0, 32538.0, 5240.764165612557, 5241.764120614582, 5246.3704355477585, 5280.2079688046715, 5310.0441920454305, 174062.0, 179965.0, 185043.0, 185078.0, 192659.0, 47873.281900771515, 48135.518644813805, 48267.275990860166, 48579.757101214265, 48715.0, 50700.23949640759, 50859.745701271255, 50937.23594146091, 50966.74516627393, 50978.0, 15899.364025439085, 16044.598885027734, 16081.839181608268, 16087.919560402122, 16256.51230463088, 13416.597502074954, 13474.258915759727, 13589.59231223045, 13594.320283985959, 13598.524051658145, 13999.16005039701, 14004.719905602034, 14084.507042253472, 14195.929020354832, 14284.357203925849, 5721.284839395075, 5751.281089863767, 5803.88392232153, 5831.183634291203, 5877.0, 996.6611352140162, 1004.2016596805557, 1006.6663015717261, 1009.9091081802673, 1023.5905637744961, 22219.888900555394, 22363.0, 22461.88769056144, 22771.31686049421, 23073.653895191586, 1110.2894147745449, 1111.4165063341648, 1119.138263537072, 1121.955121795119, 1125.128025780027, 11729.530818767324, 11900.928916397392, 11944.0, 11945.953781785764, 11948.581799636971, 216990.0, 218420.0, 218866.0, 219397.0, 219506.0, 50515.49484505181, 51094.48905510972, 51365.22952155721, 51431.0, 51519.48480515147, 1386.9306534673226, 1449.6086056764825, 1450.0647082631644, 1452.9927350363391, 1482.6960473102988, 21740.89129554342, 22172.667409988542, 22229.444263893532, 22644.66033009473, 22648.207312743976, 35958.101047474025, 36018.4597231047, 36025.27949441049, 36050.27899441944, 36093.27813443769, 187534.0, 187992.0, 188574.0, 188642.0, 189623.0, 31847.840760796047, 33002.339953201285, 33152.83423582867, 33239.33521329608, 33307.16732081717, 41786.791066044476, 41916.37125443182, 42950.570494294654, 45194.54805451904, 45699.771501142284, 32349.676503234667, 32634.673653263162, 32674.673253267163, 32904.34191316208, 33239.66760332366, 31782.205444864063, 31791.205219869687, 31934.6806531941, 32036.35927281488, 32068.19829504281, 36428.81785591055, 37307.626923730415, 38221.0, 38694.41958370683, 38793.418098729104, 32733.67266327306, 32848.0, 32905.67094329122, 33159.834200829806, 33206.33587328192, 23650.881745591163, 23842.405763309802, 24022.51954960856, 24094.879525602963, 24096.27711168668], "value": 16963.55722712053, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.3698934986486, 565.7680351056068, 572.4104172702118, 575.6229669566434, 580.4891695308128, 22099.889500552494, 22653.660195097065, 22820.315390538268, 22827.429314267152, 22947.196848110318, 23677.526449471, 24675.259742207716, 25784.613230801508, 25858.870705646445, 26037.0, 6662.966685166567, 6819.24988251292, 6823.931760682404, 6836.350546698056, 6836.623985680785, 6275.560710750249, 6673.532852700313, 6717.63053032083, 6727.899081513781, 6728.158980127484, 6363.7454501819875, 6371.936280637204, 6377.713002914857, 6442.065900444432, 6516.804495865108, 6447.7743278985245, 6461.903071453932, 6464.773732919349, 6529.085927970088, 6531.05299731541, 5954.612950158225, 6044.395560443964, 6052.455279024909, 6055.939440605625, 6057.545684073668, 26118.216453506426, 26214.344641383927, 26719.73280267192, 26758.33104172392, 30184.396312073855, 2068.2864411777914, 2072.036503026085, 2088.7806780288156, 2103.064136459276, 2104.947376315589, 19497.610047799106, 20072.799272007385, 20136.295229667037, 20139.0, 20209.29267475646, 2402.3994001499627, 2432.6351047342864, 2497.8626175560516, 2503.9374015649573, 2516.509280690266, 121448.0, 126216.36891815483, 126247.0, 129001.0, 132000.3399982994, 14132.0, 14848.925755371154, 15021.549353519413, 15095.622609434633, 15253.847461525243, 22916.770832291797, 22973.88513057424, 22988.65517017246, 23113.19103831358, 23125.7687423127, 9397.201237894855, 9405.811883762286, 9431.151196392357, 9432.575534100983, 9654.179394751525, 8590.1839325264, 8619.741407757778, 8694.478331300143, 8800.559972001374, 8803.603837827313, 8668.436551624125, 8878.135591525723, 8891.688790892287, 9169.908300916906, 9271.814563708687, 2675.411409489909, 2722.91831245063, 2724.2916841620927, 2785.6935737068907, 2875.1230874583034, 943.6272672294406, 975.197154016466, 978.6819283732673, 986.9605215791431, 990.9058639429243, 19198.520036998907, 19607.0, 19673.311434099738, 19926.70109948352, 20238.494037649176, 1015.7810627247333, 1039.184240371305, 1040.5785656809005, 1047.863777708893, 1056.6460235821087, 10842.891571084188, 11179.720506987227, 11254.22781829601, 11257.774844503065, 11286.604968826052, 452944.0, 463737.0, 466214.0, 467690.0, 470902.0, 132672.0, 137500.0, 137780.0, 139080.0, 139086.0, 1198.2031948753981, 1219.3110892345796, 1253.6865783554113, 1277.9552715654906, 1279.0, 19941.401757947286, 20863.478413039797, 21481.355559333246, 21597.0, 22446.32661020172, 59802.70098649479, 60220.69889650524, 61861.0, 61968.69015654893, 63838.0, 72906.0, 73267.0, 73623.63188184025, 73916.0, 74568.25431745613, 16381.262843172324, 19144.0, 19871.900640496704, 20087.698684520037, 20241.0, 21613.675794862775, 21985.560288794455, 23660.408489787893, 23831.52336953286, 23832.761672383054, 16736.41422550205, 16749.0, 16902.90131141472, 17077.40229091976, 18783.248670053046, 15699.607509812346, 17038.659226815147, 17315.65368692594, 17494.475165744538, 17751.378701745376, 19286.22855085837, 19426.708599370737, 19473.513162170493, 19474.221031158595, 19623.215071396986, 20163.899180504002, 20235.291764788162, 20252.69620955716, 20270.493237669176, 20454.0, 17645.73531397056, 17945.192466338784, 17995.730064049312, 18134.30076255016, 18150.0], "value": 12239.08513304799, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1347.7169794343188, 1377.8071070050194, 1388.9513867014657, 1394.595567285487, 1407.0361802165512, 14757.18835464049, 15396.307166177521, 15415.22923853807, 15438.228088595553, 15465.922670386632, 15424.845751542482, 16035.919820400912, 16173.676526469464, 16190.514284571482, 16196.75704864428, 2713.2538551898188, 2795.7903157263186, 2799.0623141247706, 2800.901968431105, 2810.3676672748675, 2587.1721049264243, 2689.9596506052426, 2773.8058335916494, 2776.41695243998, 2778.1804367711475, 2751.9862400688066, 2786.540220863565, 2792.6229958955482, 2800.075974928269, 2801.8599070046516, 2666.066876593206, 2689.1260340389454, 2722.714115017924, 2733.8359698418158, 2795.664520257562, 2620.8296460729994, 2624.3439140214946, 2642.841429514235, 2648.47030593882, 2655.1636234586235, 14733.631659208499, 14947.476838310715, 14991.475298364614, 15128.924355378153, 15168.696626067527, 7709.653065612005, 7899.605019749047, 7952.324052455549, 7994.2805147537, 7997.240262175084, 5182.7408629568745, 5215.217717342391, 5260.0, 5291.444398338158, 5351.652142610717, 1856.3131641292807, 1858.869879108463, 1866.5893503429224, 1891.4420246027455, 1899.8765080269739, 26212.99999999981, 26229.475410491876, 26401.07596234142, 26402.075927342645, 26438.07466738655, 6371.139896113966, 6506.0, 6608.768693095719, 6945.201301850352, 6996.510244282953, 17509.474715758548, 17546.122693865254, 17570.472885813448, 17576.209070591853, 18089.185986630633, 7649.847003060019, 7910.327622152066, 7912.564808935564, 7913.960430197927, 7921.564313962787, 7146.892796607951, 7266.564006159648, 7272.818179545554, 7319.670614822346, 7386.224446433047, 5273.2617433559335, 5404.91892621611, 5443.401225865152, 5444.373897001817, 5448.782048718086, 1567.866731327827, 1572.8820338474432, 1581.8576328130523, 1586.571625661088, 1588.849059339361, 885.4775682347446, 915.6291701860757, 928.03020843219, 931.8602209668468, 932.3939439364467, 7548.698052077965, 7618.5809780461495, 7652.540847549165, 7680.5391676499585, 7689.807754806175, 728.8068661804626, 729.5367441674468, 729.9963500182465, 731.5866535407478, 739.6782399656059, 4575.473820510684, 5072.898542029138, 5105.463926287761, 5303.231031500488, 5351.384590772111, 21599.0, 22214.333569992927, 22224.888875555844, 22448.551028979655, 22448.887755561445, 20733.377998660064, 21762.12951481923, 22218.777967211634, 22367.328980130624, 22384.55230895373, 11302.830457543143, 11533.769324613628, 11543.365114918592, 11580.0, 11629.47667354971, 8146.0, 8406.201410865959, 8737.43206691563, 8846.955765221133, 8925.553722313729, 19001.334953276568, 19177.712334314718, 19378.418647440598, 19630.312939047064, 19646.607067858276, 19833.504162396057, 19846.702299465807, 19848.305309314106, 19999.20003199914, 20066.698999515313, 11621.360825154698, 11680.824787628022, 11690.590829320932, 11736.237144585575, 11765.352905589933, 13551.119177253448, 13651.726965460834, 13717.725645486835, 13727.970402219673, 13729.107608005448, 10734.409607471664, 10884.836727449254, 10897.891021089688, 10980.231383803057, 11246.493907774333, 10255.897441025792, 10618.0, 10864.456777160953, 11070.778584428428, 11098.05666518355, 9574.808503829745, 9728.075832795874, 9736.464494452874, 9736.75658108553, 9741.464219467998, 6530.771423000362, 6605.5376123670885, 6873.312668733087, 6874.828129296808, 7092.361687447948, 6886.896696549656, 6955.6869940851775, 6978.616176110363, 7013.544119632207, 7081.893771593327], "value": 6635.038748348574, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.35226030030816, 498.74065485947284, 534.2120372450638, 542.5957661542151, 548.4405905975905, 6268.874622507547, 6383.489320854332, 6438.227412710476, 6444.548881578291, 6466.0, 6115.969420152893, 6126.938730612693, 6221.937780622193, 6230.127782110497, 6328.670979094384, 4955.513345996204, 5035.672681275705, 5053.469385714502, 5086.491350864902, 5093.962415033998, 4869.951300487003, 5055.721935293557, 5073.670211436263, 5102.234664800291, 5123.974380128094, 5035.597152227831, 5065.366829146356, 5069.822556210515, 5084.847454576368, 5114.6164037697135, 4976.701397916137, 4989.501049895, 5054.797808087709, 5055.848324550269, 5101.464346243647, 4455.955440445587, 4470.75410852403, 4490.528494508062, 4530.954690453119, 4539.591436770674, 6111.991521398963, 6203.658798766066, 6244.781432649836, 6295.937040629627, 6300.716467758962, 5686.232358631573, 5718.714064296769, 5775.509081728058, 5783.621232254002, 5807.199768071911, 6568.507361947825, 6578.519833037576, 6643.867122657568, 6688.81616747025, 6724.899126513106, 4815.446223684286, 4828.299896515021, 4886.144924638174, 4916.926246106311, 4941.135301322254, 6989.405900498464, 7037.648117594151, 7074.257202993715, 7102.254263302382, 7167.462440316997, 5072.923906141411, 5075.619328550373, 5101.107306221396, 5124.8206312778875, 5139.254808052886, 5104.132297509433, 5109.901371205208, 5123.948760512421, 5218.686878787209, 5235.816746413857, 5610.579206559442, 5705.4579814917515, 5747.614739882985, 5755.539556835443, 5796.275465566804, 6707.228668703162, 6718.193816741925, 6728.360805723449, 6742.797716068526, 6813.454923606099, 1697.9981810731726, 1728.4468969929753, 1737.5656085978505, 1778.5642517583276, 1798.2627122879558, 1197.4671271284194, 1225.1668865171769, 1229.8524177098805, 1248.1762037055682, 1252.5428218700108, 5910.822675319747, 5929.6145750526075, 5930.318013428425, 5998.310194327621, 6007.098935159674, 6594.274629790815, 6647.368499992493, 6692.464602831762, 6706.329367063255, 6752.561083529555, 5777.162311464814, 5866.765329386777, 5941.524678025748, 5946.572822522563, 6015.338312785678, 3584.010873964922, 3604.5133906922756, 3611.223586928823, 3635.8547057676747, 3685.8157092145284, 6502.187226596676, 6609.603423794588, 6630.668466576652, 6715.5299129060495, 6717.052054904121, 6845.931540684629, 6930.896036559456, 6961.380082357247, 6973.93026069743, 7088.610126443095, 6519.641419721961, 6547.101340611264, 6622.569532980341, 6636.601803891782, 6709.758694641409, 6788.287229840993, 6858.3141685831015, 6895.655347207246, 6925.238223795479, 6927.307269273032, 6693.259752464492, 6734.158230221223, 6758.898616520854, 6831.658417079226, 6855.828604284733, 6496.0, 6584.868302634016, 6624.30444803308, 6661.933380666132, 6685.498587606046, 4963.329950456642, 5005.34930459038, 5011.9498805012945, 5032.314174751353, 5037.345145131109, 6698.866022679422, 6828.658567071726, 6853.554518956252, 6862.553933994274, 6911.17065952089, 6643.46852251809, 6653.900191497229, 6709.295523969913, 6719.361660642231, 6743.9325606743305, 6619.238787539494, 6638.734450621921, 6648.667566621746, 6658.0, 6673.1992160941, 6266.650006247657, 6479.5788273762055, 6521.315261897622, 6535.5425120241125, 6540.934590654033, 6431.517636177399, 6555.147830781968, 6649.368310010541, 6653.667316634246, 6811.216710078206, 6430.807075787734, 6438.195225596801, 6490.286068532552, 6501.512386570931, 6548.315190771761], "value": 5131.550737596665, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [867.5098569308344, 892.2861710631494, 903.8237543678981, 908.1690253418122, 909.5361365703492, 16253.349866005361, 17173.398931037416, 17231.569210769736, 17237.22432490538, 17251.568710782238, 15270.847291527081, 16548.586285342873, 16729.079900605462, 16877.15614219287, 16916.74624880625, 943.6225509796085, 962.1677249179444, 963.3352986439335, 963.57602654832, 968.5399435268226, 895.7312806158159, 984.7685793838442, 984.9359791613522, 993.940363578184, 998.8551660009294, 1041.4376236832102, 1045.618349302503, 1049.9737506562358, 1050.3435352904435, 1051.8001579699871, 1037.222083437422, 1044.2429238801883, 1044.9425281609508, 1045.5869931377101, 1047.1831971062584, 773.443120952913, 776.8368642585064, 777.6034222546485, 779.0573406178531, 779.1701837542998, 17457.56356091108, 17854.821451785447, 18256.0, 18352.174152163185, 18614.720779188323, 19579.608407831765, 19653.41039768809, 20076.899615501974, 20240.291589794433, 20345.491362715904, 14613.97702160849, 14835.293941196793, 14990.100593964396, 15032.774508382274, 15132.470363537333, 3664.358737220976, 3678.70570354371, 3683.650053244964, 3702.648248416396, 3702.9259414811554, 124009.0, 126946.73053269442, 127480.0, 129013.35493322567, 129307.0, 14820.703585928437, 14901.850981490263, 15062.548123556311, 15230.543083707507, 15457.5362739118, 27475.076744628084, 28182.2954426141, 28481.287967800556, 28502.0, 28680.569791453145, 8341.666333346599, 8548.187922147386, 8571.271441927505, 8578.313734901192, 8616.052234254226, 4268.615824575803, 4388.736675799462, 4405.0, 4408.625266852354, 4413.558644135625, 4421.646268298528, 4455.198064348384, 4660.231061874821, 4737.4788773235605, 5125.692458452505, 1058.433737950193, 1086.6033897627467, 1086.8369744538224, 1086.8641419822522, 1090.3566895531674, 560.935492418369, 572.6134858970179, 583.7110630237975, 588.4762561320429, 589.548995018811, 10534.894651053544, 11029.724256893642, 11035.779284414428, 11613.477393517313, 11680.0, 609.2506217352593, 620.4044117647019, 622.6917675750533, 637.6238019568477, 639.2648454277618, 5497.422770609029, 5501.889962200814, 5574.9721251393485, 5646.153077038477, 5832.591718579659, 106313.0, 106504.40243396355, 108643.45678271558, 109183.0, 109704.4514777421, 95899.52050239705, 96313.51843240739, 96883.51558242163, 99072.0, 100810.4959475198, 84809.57595211985, 88544.0, 88767.55616221878, 89047.0, 90943.09056909478, 11320.716982075513, 11469.598564050551, 11593.594224202112, 11627.360495172847, 11708.0, 39033.80483097566, 39174.804125979186, 39474.80262598669, 40058.19883602254, 40131.799341003105, 65501.34498654953, 65742.34257657362, 68295.0, 68459.3154068453, 68612.0, 14706.264686765406, 15781.605459863595, 15980.360785568448, 16040.839591604401, 16914.746278805582, 17040.82959170442, 17140.40008599693, 17259.568510787332, 17313.480595582154, 17571.736423953396, 15405.0, 15871.0, 16552.917235413744, 16772.832271677125, 16878.156092195586, 15762.369505219664, 15814.209289535247, 16028.599285017968, 16167.0, 16187.10970896612, 15752.76370854461, 15953.601159971093, 16475.176241188132, 16524.421645242357, 16623.750643740113, 12096.758064838477, 12570.182938108994, 12601.11792174539, 12701.682457938625, 12861.807072893727, 12520.0, 12747.936260318638, 13010.869891300967, 13145.539906103622, 13641.113327633671], "value": 8636.384850913702, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1518.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 121.0, 95.0, 117.0, 106.0, 111.0, 111.0, 109.0, 115.0, 114.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 123.0, 156.0, 175.0, 124.0, 157.0, 161.0, 125.0, 172.0, 127.0], "value": 147.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 165.0, 170.0, 164.0, 166.0, 166.0, 168.0, 166.0, 165.0], "value": 165.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 166.0, 79.0, 73.0, 73.0, 88.0, 98.0, 77.0], "value": 87.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 81.0, 128.0, 80.0, 78.0, 87.0, 122.0, 84.0, 79.0, 127.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 114.0, 116.0, 116.0, 124.0, 114.0, 123.0, 118.0, 114.0, 119.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 152.0, 150.0, 152.0, 148.0, 154.0, 156.0, 157.0, 151.0, 154.0], "value": 152.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 99.0, 97.0, 99.0, 95.0, 100.0, 98.0, 98.0, 94.0, 95.0], "value": 97.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 58.0, 53.0, 53.0, 53.0, 53.0, 60.0, 56.0, 54.0, 53.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 39.0, 38.0, 42.0, 38.0, 40.0, 48.0, 38.0, 42.0, 39.0], "value": 40.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 84.0, 79.0, 77.0, 78.0, 75.0, 87.0, 75.0, 74.0, 83.0], "value": 79.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 123.0, 136.0, 126.0, 126.0, 118.0, 133.0, 125.0, 124.0, 158.0], "value": 129.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 178.0, 169.0, 170.0, 174.0, 185.0, 166.0, 170.0, 171.0, 171.0], "value": 173.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 68.0, 64.0, 65.0, 67.0, 63.0, 67.0, 65.0, 64.0], "value": 65.3, "unit": "score"}]}]} 06:44:33 INFO - Return code: 0 06:44:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:44:33 INFO - # TBPL SUCCESS # 06:44:33 INFO - Running post-action listener: _package_coverage_data 06:44:33 INFO - Running post-action listener: _resource_record_post_action 06:44:33 INFO - [mozharness: 2017-08-31 13:44:33.204657Z] Finished run-tests step (success) 06:44:33 INFO - Running post-run listener: _resource_record_post_run 06:44:33 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4399104; Write bytes: 400617472; Read time: 4720; Write time: 522204 06:44:33 INFO - TinderboxPrint: CPU usage
13.3% 06:44:33 INFO - TinderboxPrint: I/O read bytes / time
4,399,104 / 4,720 06:44:33 INFO - TinderboxPrint: I/O write bytes / time
400,617,472 / 522,204 06:44:33 INFO - TinderboxPrint: CPU idle
8,270.5 (86.7%) 06:44:33 INFO - TinderboxPrint: CPU user
1,201.0 (12.6%) 06:44:33 INFO - TinderboxPrint: Swap in / out
0 / 0 06:44:33 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 119005184; Read time: 0; Write time: 170928 06:44:33 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 06:44:33 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4399104; Write bytes: 281612288; Read time: 4720; Write time: 351276 06:44:33 INFO - Running post-run listener: _upload_blobber_files 06:44:33 INFO - Blob upload gear active. 06:44:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:44:33 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 06:44:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:44:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:44:34 INFO - (blobuploader) - INFO - Open directory for files ... 06:44:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:44:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:44:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:44:35 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:44:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:44:35 INFO - (blobuploader) - INFO - Done attempting. 06:44:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:44:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:44:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:44:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:44:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:44:36 INFO - (blobuploader) - INFO - Done attempting. 06:44:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:44:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:44:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:44:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:44:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:44:39 INFO - (blobuploader) - INFO - Done attempting. 06:44:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:44:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:44:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:44:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:44:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:44:40 INFO - (blobuploader) - INFO - Done attempting. 06:44:40 INFO - (blobuploader) - INFO - Iteration through files over. 06:44:40 INFO - Return code: 0 06:44:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:44:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:44:40 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/585236efedf0c32e392b32ea64fedc0276e050e1a828daa2c0406420d6ecd2b0f98ad26df9b8e44ef4c8396584b8797383589fbf99c06f88a76a992535b9b25c", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9700785b5d6a0f3d40c6b85d37ba666dc9b7b5aab5c4179e66643e3e3bdda40156035206f2ba1ccadee1c9f6f3b371efc731cc231373da44b893ccd3fd46221", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75fd535f64f93c857e88ef07ee700f625602c371282852d4de7d4eff88baca8bc8d1f80ecd0c83632c284e917a5d655fe94d6214764802bb5e67606835ba1cb9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be8d8f404a5af5f7509899e406dacff7941b249f548a5ce00ff3d91d7b7e85cb9364a9afbc8fc7879326640e730095f4576c23c51ccf4ae4cec1ed7bd6fa98ca"} 06:44:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:44:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:44:40 INFO - Contents: 06:44:40 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/585236efedf0c32e392b32ea64fedc0276e050e1a828daa2c0406420d6ecd2b0f98ad26df9b8e44ef4c8396584b8797383589fbf99c06f88a76a992535b9b25c", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9700785b5d6a0f3d40c6b85d37ba666dc9b7b5aab5c4179e66643e3e3bdda40156035206f2ba1ccadee1c9f6f3b371efc731cc231373da44b893ccd3fd46221", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75fd535f64f93c857e88ef07ee700f625602c371282852d4de7d4eff88baca8bc8d1f80ecd0c83632c284e917a5d655fe94d6214764802bb5e67606835ba1cb9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be8d8f404a5af5f7509899e406dacff7941b249f548a5ce00ff3d91d7b7e85cb9364a9afbc8fc7879326640e730095f4576c23c51ccf4ae4cec1ed7bd6fa98ca"} 06:44:40 INFO - Running post-run listener: copy_logs_to_upload_dir 06:44:40 INFO - Copying logs to upload dir... 06:44:40 INFO - mkdir: /builds/slave/test/build/upload/logs 06:44:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.712780 ========= master_lag: -0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-08-31 06:44:40.542640) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-31 06:44:40.561282) ========= 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=836cfdc75598d54cb747368e000001a9-1504185822.842904-1174744033 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/585236efedf0c32e392b32ea64fedc0276e050e1a828daa2c0406420d6ecd2b0f98ad26df9b8e44ef4c8396584b8797383589fbf99c06f88a76a992535b9b25c", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9700785b5d6a0f3d40c6b85d37ba666dc9b7b5aab5c4179e66643e3e3bdda40156035206f2ba1ccadee1c9f6f3b371efc731cc231373da44b893ccd3fd46221", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75fd535f64f93c857e88ef07ee700f625602c371282852d4de7d4eff88baca8bc8d1f80ecd0c83632c284e917a5d655fe94d6214764802bb5e67606835ba1cb9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be8d8f404a5af5f7509899e406dacff7941b249f548a5ce00ff3d91d7b7e85cb9364a9afbc8fc7879326640e730095f4576c23c51ccf4ae4cec1ed7bd6fa98ca"} build_url:https://queue.taskcluster.net/v1/task/ccktewOdQ72Ms1acZ9Ljrg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011229 build_url: 'https://queue.taskcluster.net/v1/task/ccktewOdQ72Ms1acZ9Ljrg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/585236efedf0c32e392b32ea64fedc0276e050e1a828daa2c0406420d6ecd2b0f98ad26df9b8e44ef4c8396584b8797383589fbf99c06f88a76a992535b9b25c", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9700785b5d6a0f3d40c6b85d37ba666dc9b7b5aab5c4179e66643e3e3bdda40156035206f2ba1ccadee1c9f6f3b371efc731cc231373da44b893ccd3fd46221", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75fd535f64f93c857e88ef07ee700f625602c371282852d4de7d4eff88baca8bc8d1f80ecd0c83632c284e917a5d655fe94d6214764802bb5e67606835ba1cb9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be8d8f404a5af5f7509899e406dacff7941b249f548a5ce00ff3d91d7b7e85cb9364a9afbc8fc7879326640e730095f4576c23c51ccf4ae4cec1ed7bd6fa98ca"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-31 06:44:40.599672) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 06:44:40.600020) ========= 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=836cfdc75598d54cb747368e000001a9-1504185822.842904-1174744033 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004482 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 06:44:40.649669) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-31 06:44:40.649952) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-31 06:44:40.653256) ========= ========= Total master_lag: 0.07 =========