builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-016 starttime: 1504635912.2 results: success (0) revision: 973e8b890a62aee4b3170558ac3b608928162ef6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-05 11:25:12.200965) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-05 11:25:12.201691) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-05 11:25:12.201971) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-05 11:25:12.220714) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-05 11:25:12.220997) ========= 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=00204705a9daa57ed339a427000001b9-1504628098.915627-640288888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-05 11:25:12-- 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% 32.1M=0s 2017-09-05 11:25:12 (32.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123519 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-05 11:25:12.375834) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-05 11:25:12.376323) ========= 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=00204705a9daa57ed339a427000001b9-1504628098.915627-640288888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018921 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-05 11:25:12.429270) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-05 11:25:12.429648) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 973e8b890a62aee4b3170558ac3b608928162ef6 --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 973e8b890a62aee4b3170558ac3b608928162ef6 --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=00204705a9daa57ed339a427000001b9-1504628098.915627-640288888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-05 11:25:12,399 truncating revision to first 12 chars 2017-09-05 11:25:12,399 Setting DEBUG logging. 2017-09-05 11:25:12,399 attempt 1/10 2017-09-05 11:25:12,399 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/973e8b890a62?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-05 11:25:12,836 unpacking tar archive at: mozilla-central-973e8b890a62/testing/mozharness/ program finished with exit code 0 elapsedTime=0.800066 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-05 11:25:13.246109) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-05 11:25:13.246382) ========= script_repo_revision: 973e8b890a62aee4b3170558ac3b608928162ef6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-05 11:25:13.246778) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-05 11:25:13.247057) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-05 11:25:13.260468) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-09-05 11:25:13.260774) ========= /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=00204705a9daa57ed339a427000001b9-1504628098.915627-640288888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:25:13 INFO - MultiFileLogger online at 20170905 11:25:13 in /builds/slave/test 11:25:13 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 11:25:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:25:13 INFO - {'append_to_log': False, 11:25:13 INFO - 'base_work_dir': '/builds/slave/test', 11:25:13 INFO - 'blob_upload_branch': 'Firefox', 11:25:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:25:13 INFO - 'branch': 'Firefox', 11:25:13 INFO - 'buildbot_json_path': 'buildprops.json', 11:25:13 INFO - 'code_coverage': False, 11:25:13 INFO - 'config_files': ('talos/linux_config.py',), 11:25:13 INFO - 'default_actions': ('clobber', 11:25:13 INFO - 'read-buildbot-config', 11:25:13 INFO - 'download-and-extract', 11:25:13 INFO - 'populate-webroot', 11:25:13 INFO - 'create-virtualenv', 11:25:13 INFO - 'install', 11:25:13 INFO - 'setup-mitmproxy', 11:25:13 INFO - 'run-tests'), 11:25:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:25:13 INFO - 'disable_ccov_upload': False, 11:25:13 INFO - 'disable_stylo': False, 11:25:13 INFO - 'download_minidump_stackwalk': True, 11:25:13 INFO - 'download_symbols': 'ondemand', 11:25:13 INFO - 'enable_stylo': False, 11:25:13 INFO - 'enable_webrender': False, 11:25:13 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:25:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:25:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:25:13 INFO - 'gecko_profile': False, 11:25:13 INFO - 'gecko_profile_interval': 0, 11:25:13 INFO - 'installer_path': 'installer.exe', 11:25:13 INFO - 'log_level': 'info', 11:25:13 INFO - 'log_name': 'talos', 11:25:13 INFO - 'log_to_console': True, 11:25:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:25:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:25:13 INFO - 'opt_config_files': (), 11:25:13 INFO - 'pip_index': False, 11:25:13 INFO - 'suite': 'dromaeojs-e10s', 11:25:13 INFO - 'system_bits': '32', 11:25:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:25:13 INFO - 'title': 'talos-linux64-ix-016', 11:25:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:25:13 INFO - 'use_talos_json': True, 11:25:13 INFO - 'verify': 'False', 11:25:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:25:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:25:13 INFO - 'work_dir': 'build'} 11:25:13 INFO - [mozharness: 2017-09-05 18:25:13.369180Z] Running clobber step. 11:25:13 INFO - Running pre-action listener: _resource_record_pre_action 11:25:13 INFO - Running main action method: clobber 11:25:13 INFO - rmtree: /builds/slave/test/build 11:25:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:25:14 INFO - Running post-action listener: _resource_record_post_action 11:25:14 INFO - [mozharness: 2017-09-05 18:25:14.393684Z] Finished clobber step (success) 11:25:14 INFO - [mozharness: 2017-09-05 18:25:14.393781Z] Running read-buildbot-config step. 11:25:14 INFO - Running pre-action listener: _resource_record_pre_action 11:25:14 INFO - Running main action method: read_buildbot_config 11:25:14 INFO - Using buildbot properties: 11:25:14 INFO - { 11:25:14 INFO - "project": "", 11:25:14 INFO - "product": "firefox", 11:25:14 INFO - "who": "ffxbld@noreply.mozilla.org", 11:25:14 INFO - "installer_path": "public/build/target.tar.bz2", 11:25:14 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 11:25:14 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:25:14 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 11:25:14 INFO - "stage_platform": "linux64-stylo", 11:25:14 INFO - "basedir": "/builds/slave/test", 11:25:14 INFO - "buildnumber": 299, 11:25:14 INFO - "platform": "ubuntu64_hw_stylo", 11:25:14 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:25:14 INFO - "slavebuilddir": "test", 11:25:14 INFO - "taskId": "W_LrpE6TT4eiw34Z7SUMUg", 11:25:14 INFO - "branch": "mozilla-central", 11:25:14 INFO - "script_repo_revision": "production", 11:25:14 INFO - "revision": "973e8b890a62aee4b3170558ac3b608928162ef6", 11:25:14 INFO - "slavename": "talos-linux64-ix-016", 11:25:14 INFO - "repo_path": "mozilla-central" 11:25:14 INFO - } 11:25:14 INFO - Finding installer, test and symbols from parent task. 11:25:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W_LrpE6TT4eiw34Z7SUMUg'}, attempt #1 11:25:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W_LrpE6TT4eiw34Z7SUMUg'}, attempt #1 11:25:15 INFO - Task dependencies: TJbnw1eAT3m2u_5HiPuYfA 11:25:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA'}, attempt #1 11:25:15 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.tar.bz2 11:25:15 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.test_packages.json 11:25:15 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.crashreporter-symbols.zip 11:25:15 INFO - Running post-action listener: _resource_record_post_action 11:25:15 INFO - [mozharness: 2017-09-05 18:25:15.783237Z] Finished read-buildbot-config step (success) 11:25:15 INFO - [mozharness: 2017-09-05 18:25:15.783477Z] Running download-and-extract step. 11:25:15 INFO - Running pre-action listener: _resource_record_pre_action 11:25:15 INFO - Running main action method: download_and_extract 11:25:15 INFO - mkdir: /builds/slave/test/build/tests 11:25: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')]} 11:25:15 INFO - trying https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.test_packages.json 11:25:15 INFO - Downloading https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:25:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:25:16 INFO - Downloaded 989 bytes. 11:25:16 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:25:16 INFO - Using the following test package requirements: 11:25:16 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:25:16 INFO - u'common': [u'target.common.tests.zip'], 11:25:16 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:25:16 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:25:16 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:25:16 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:25:16 INFO - u'mozbase': [u'target.common.tests.zip'], 11:25:16 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:25:16 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:25:16 INFO - u'web-platform': [u'target.common.tests.zip', 11:25:16 INFO - u'target.web-platform.tests.tar.gz'], 11:25:16 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:25:16 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:25:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.common.tests.zip 11:25:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:25:16 INFO - Fetch https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.common.tests.zip into memory 11:25:17 INFO - Content-Length response header: 55022217 11:25:17 INFO - Bytes received: 55022217 11:25:28 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:25:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.common.tests.zip 11:25:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:25:28 INFO - Fetch https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.common.tests.zip into memory 11:25:29 INFO - Content-Length response header: 55022217 11:25:29 INFO - Bytes received: 55022217 11:25:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.talos.tests.zip 11:25:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:25:41 INFO - Fetch https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.talos.tests.zip into memory 11:25:42 INFO - Content-Length response header: 14496650 11:25:42 INFO - Bytes received: 14496650 11:25:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:42 INFO - trying https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.tar.bz2 11:25:42 INFO - Downloading https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:25:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:25:43 INFO - Downloaded 62644193 bytes. 11:25:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.tar.bz2 11:25:43 INFO - mkdir: /builds/slave/test/properties 11:25:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:25:43 INFO - Writing to file /builds/slave/test/properties/build_url 11:25:43 INFO - Contents: 11:25:43 INFO - build_url:https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.tar.bz2 11:25:43 INFO - Running post-action listener: _resource_record_post_action 11:25:43 INFO - Running post-action listener: find_tests_for_verification 11:25:43 INFO - Running post-action listener: set_extra_try_arguments 11:25:43 INFO - [mozharness: 2017-09-05 18:25:43.616531Z] Finished download-and-extract step (success) 11:25:43 INFO - [mozharness: 2017-09-05 18:25:43.616628Z] Running populate-webroot step. 11:25:43 INFO - Running pre-action listener: _resource_record_pre_action 11:25:43 INFO - Running main action method: populate_webroot 11:25:43 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:25:43 INFO - 'chromez-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:25:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:25:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:25:43 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:25:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:25:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:25:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:25:43 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:25:43 INFO - 'talos_options': ['--enable-stylo'], 11:25:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:25:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:25:43 INFO - 'tests': ['damp', 'tps']}, 11:25:43 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:25:43 INFO - 'talos_options': ['--enable-stylo'], 11:25:43 INFO - 'tests': ['damp', 'tps']}, 11:25:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:25:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:25:43 INFO - 'g4-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:25:43 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 11:25:43 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:25:43 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:25:43 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:25:43 INFO - 'talos_options': ['--enable-stylo'], 11:25:43 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:25:43 INFO - 'other-e10s': {'tests': ['a11yr', 11:25:43 INFO - 'ts_paint', 11:25:43 INFO - 'tpaint', 11:25:43 INFO - 'sessionrestore', 11:25:43 INFO - 'sessionrestore_many_windows', 11:25:43 INFO - 'sessionrestore_no_auto_restore', 11:25:43 INFO - 'tabpaint']}, 11:25:43 INFO - 'other-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:25:43 INFO - 'tests': ['a11yr', 11:25:43 INFO - 'ts_paint', 11:25:43 INFO - 'tpaint', 11:25:43 INFO - 'sessionrestore', 11:25:43 INFO - 'sessionrestore_many_windows', 11:25:43 INFO - 'sessionrestore_no_auto_restore', 11:25:43 INFO - 'tabpaint']}, 11:25:43 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:25:43 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:25:43 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:25:43 INFO - 'tests': ['bloom_basic_singleton']}, 11:25:43 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:25:43 INFO - 'tests': ['bloom_basic']}, 11:25:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:25:43 INFO - 'tsvgr_opacity', 11:25:43 INFO - 'tart', 11:25:43 INFO - 'tscrollx', 11:25:43 INFO - 'tsvg_static']}, 11:25:43 INFO - 'svgr-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:25:43 INFO - 'tests': ['tsvgx', 11:25:43 INFO - 'tsvgr_opacity', 11:25:43 INFO - 'tart', 11:25:43 INFO - 'tscrollx', 11:25:43 INFO - 'tsvg_static']}, 11:25:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:25:43 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:25:43 INFO - 'talos_options': ['--enable-stylo'], 11:25:43 INFO - 'tests': ['tp5o']}, 11:25:43 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:25:43 INFO - 'talos_options': ['--mitmproxy', 11:25:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:25:43 INFO - '--firstNonBlankPaint'], 11:25:43 INFO - 'tests': ['tp6_google', 11:25:43 INFO - 'tp6_youtube', 11:25:43 INFO - 'tp6_amazon', 11:25:43 INFO - 'tp6_facebook']}, 11:25:43 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:25:43 INFO - 'talos_options': ['--enable-stylo', 11:25:43 INFO - '--mitmproxy', 11:25:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:25:43 INFO - '--firstNonBlankPaint'], 11:25:43 INFO - 'tests': ['tp6_google', 11:25:43 INFO - 'tp6_youtube', 11:25:43 INFO - 'tp6_amazon', 11:25:43 INFO - 'tp6_facebook']}, 11:25:43 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:25:43 INFO - 'talos_options': ['--enable-stylo', 11:25:43 INFO - '--stylo-threads=1', 11:25:43 INFO - '--mitmproxy', 11:25:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:25:43 INFO - '--firstNonBlankPaint'], 11:25:43 INFO - 'tests': ['tp6_google', 11:25:43 INFO - 'tp6_youtube', 11:25:43 INFO - 'tp6_amazon', 11:25:43 INFO - 'tp6_facebook']}, 11:25:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:25:43 INFO - 'talos_options': ['--xperf_path', 11:25:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:25:43 INFO - 'tests': ['tp5n']}, 11:25:43 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:25:43 INFO - 'talos_options': ['--enable-stylo', 11:25:43 INFO - '--xperf_path', 11:25:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:25:43 INFO - 'tests': ['tp5n']}}} 11:25:43 INFO - Running post-action listener: _resource_record_post_action 11:25:43 INFO - [mozharness: 2017-09-05 18:25:43.630881Z] Finished populate-webroot step (success) 11:25:43 INFO - [mozharness: 2017-09-05 18:25:43.630970Z] Running create-virtualenv step. 11:25:43 INFO - Running pre-action listener: _resource_record_pre_action 11:25:43 INFO - Running main action method: create_virtualenv 11:25:43 INFO - Creating virtualenv /builds/slave/test/build/venv 11:25:43 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:25:43 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:25:43 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:25:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:25:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:25:44 INFO - Installing distribute.............................................................................................................................................................................................done. 11:25:44 INFO - Installing pip...............done. 11:25:44 INFO - Return code: 0 11:25:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:25:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:25:44 INFO - Reading from file tmpfile_stdout 11:25:44 INFO - Output received: 11:25:44 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:25:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:25:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1612a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1616090>, '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 0x1616d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1610f90>, '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': '00204705a9daa57ed339a427000001b9-1504628098.915627-640288888', '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 11:25:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:25:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:25:44 INFO - Using env: {'DISPLAY': ':0', 11:25:44 INFO - 'HOME': '/home/cltbld', 11:25:44 INFO - 'LANG': 'en_US.UTF-8', 11:25:44 INFO - 'LANGUAGE': 'en_US:en', 11:25:44 INFO - 'LOGNAME': 'cltbld', 11:25:44 INFO - 'MAIL': '/var/mail/cltbld', 11:25:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:44 INFO - 'MOZ_NO_REMOTE': '1', 11:25:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:44 INFO - 'NO_EM_RESTART': '1', 11:25:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:44 INFO - 'PWD': '/builds/slave/test', 11:25:44 INFO - 'SHELL': '/bin/bash', 11:25:44 INFO - 'SHLVL': '1', 11:25:44 INFO - 'TERM': 'linux', 11:25:44 INFO - 'TMOUT': '86400', 11:25:44 INFO - 'USER': 'cltbld', 11:25:44 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1504628098.915627-640288888', 11:25:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:44 INFO - '_': '/tools/buildbot/bin/python'} 11:25:45 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:25:45 INFO - Downloading/unpacking pip>=1.5 11:25:45 INFO - Running setup.py egg_info for package pip 11:25:45 INFO - warning: no files found matching 'pip/cacert.pem' 11:25:45 INFO - warning: no files found matching '*.html' under directory 'docs' 11:25:45 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:25:45 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:25:45 INFO - Installing collected packages: pip 11:25:45 INFO - Found existing installation: pip 1.1 11:25:45 INFO - Uninstalling pip: 11:25:45 INFO - Successfully uninstalled pip 11:25:45 INFO - Running setup.py install for pip 11:25:45 INFO - warning: no files found matching 'pip/cacert.pem' 11:25:45 INFO - warning: no files found matching '*.html' under directory 'docs' 11:25:45 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:25:45 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:25:45 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:25:45 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:25:45 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:25:45 INFO - Successfully installed pip 11:25:45 INFO - Cleaning up... 11:25:45 INFO - Return code: 0 11:25:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:25:45 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')]} 11:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:45 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')]} 11:25:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:45 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 0x12a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1612a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1616090>, '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 0x1616d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1610f90>, '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': '00204705a9daa57ed339a427000001b9-1504628098.915627-640288888', '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 11:25:45 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 11:25:45 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 11:25:45 INFO - Using env: {'DISPLAY': ':0', 11:25:45 INFO - 'HOME': '/home/cltbld', 11:25:45 INFO - 'LANG': 'en_US.UTF-8', 11:25:45 INFO - 'LANGUAGE': 'en_US:en', 11:25:45 INFO - 'LOGNAME': 'cltbld', 11:25:45 INFO - 'MAIL': '/var/mail/cltbld', 11:25:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:45 INFO - 'MOZ_NO_REMOTE': '1', 11:25:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:45 INFO - 'NO_EM_RESTART': '1', 11:25:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:45 INFO - 'PWD': '/builds/slave/test', 11:25:45 INFO - 'SHELL': '/bin/bash', 11:25:45 INFO - 'SHLVL': '1', 11:25:45 INFO - 'TERM': 'linux', 11:25:45 INFO - 'TMOUT': '86400', 11:25:45 INFO - 'USER': 'cltbld', 11:25:45 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1504628098.915627-640288888', 11:25:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:45 INFO - '_': '/tools/buildbot/bin/python'} 11:25:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:46 INFO - Downloading/unpacking psutil>=3.1.1 11:25:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:25:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:25:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:25:47 INFO - Installing collected packages: psutil 11:25:47 INFO - Running setup.py install for psutil 11:25:47 INFO - building 'psutil._psutil_linux' extension 11:25:47 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 11:25:47 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 11:25:47 INFO - building 'psutil._psutil_posix' extension 11:25:47 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 11:25:47 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 11:25:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:25:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:25:47 INFO - Successfully installed psutil 11:25:47 INFO - Cleaning up... 11:25:47 INFO - Return code: 0 11:25:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:25: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')]} 11:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25: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')]} 11:25:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:47 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 0x12a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1612a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1616090>, '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 0x1616d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1610f90>, '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': '00204705a9daa57ed339a427000001b9-1504628098.915627-640288888', '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 11:25:47 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 11:25:47 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 11:25:47 INFO - Using env: {'DISPLAY': ':0', 11:25:47 INFO - 'HOME': '/home/cltbld', 11:25:47 INFO - 'LANG': 'en_US.UTF-8', 11:25:47 INFO - 'LANGUAGE': 'en_US:en', 11:25:47 INFO - 'LOGNAME': 'cltbld', 11:25:47 INFO - 'MAIL': '/var/mail/cltbld', 11:25:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:47 INFO - 'MOZ_NO_REMOTE': '1', 11:25:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:47 INFO - 'NO_EM_RESTART': '1', 11:25:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:47 INFO - 'PWD': '/builds/slave/test', 11:25:47 INFO - 'SHELL': '/bin/bash', 11:25:47 INFO - 'SHLVL': '1', 11:25:47 INFO - 'TERM': 'linux', 11:25:47 INFO - 'TMOUT': '86400', 11:25:47 INFO - 'USER': 'cltbld', 11:25:47 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1504628098.915627-640288888', 11:25:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:47 INFO - '_': '/tools/buildbot/bin/python'} 11:25:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:25:48 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 11:25:48 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 11:25:48 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 11:25:48 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 11:25:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:25:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:25:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:25:49 INFO - Installing collected packages: mozsystemmonitor 11:25:49 INFO - Running setup.py install for mozsystemmonitor 11:25:49 INFO - Successfully installed mozsystemmonitor 11:25:49 INFO - Cleaning up... 11:25:49 INFO - Return code: 0 11:25:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:25:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x12a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1612a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1616090>, '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 0x1616d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1610f90>, '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': '00204705a9daa57ed339a427000001b9-1504628098.915627-640288888', '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 11:25:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:25:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:25:49 INFO - Using env: {'DISPLAY': ':0', 11:25:49 INFO - 'HOME': '/home/cltbld', 11:25:49 INFO - 'LANG': 'en_US.UTF-8', 11:25:49 INFO - 'LANGUAGE': 'en_US:en', 11:25:49 INFO - 'LOGNAME': 'cltbld', 11:25:49 INFO - 'MAIL': '/var/mail/cltbld', 11:25:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:49 INFO - 'MOZ_NO_REMOTE': '1', 11:25:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:49 INFO - 'NO_EM_RESTART': '1', 11:25:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:49 INFO - 'PWD': '/builds/slave/test', 11:25:49 INFO - 'SHELL': '/bin/bash', 11:25:49 INFO - 'SHLVL': '1', 11:25:49 INFO - 'TERM': 'linux', 11:25:49 INFO - 'TMOUT': '86400', 11:25:49 INFO - 'USER': 'cltbld', 11:25:49 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1504628098.915627-640288888', 11:25:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:49 INFO - '_': '/tools/buildbot/bin/python'} 11:25:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:49 INFO - Downloading/unpacking jsonschema==2.5.1 11:25:49 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 11:25:49 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 11:25:49 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 11:25:49 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 11:25:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:25:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:25:50 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 11:25:50 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 11:25:50 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 11:25:50 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 11:25:50 INFO - Downloading functools32-3.2.3-2.tar.gz 11:25:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:25:50 INFO - warning: no files found matching '*.txt' 11:25:50 INFO - no previously-included directories found matching 'build' 11:25:50 INFO - no previously-included directories found matching 'dist' 11:25:50 INFO - no previously-included directories found matching '.git*' 11:25:50 INFO - Installing collected packages: jsonschema, functools32 11:25:50 INFO - Running setup.py install for functools32 11:25:50 INFO - warning: no files found matching '*.txt' 11:25:50 INFO - no previously-included directories found matching 'build' 11:25:50 INFO - no previously-included directories found matching 'dist' 11:25:50 INFO - no previously-included directories found matching '.git*' 11:25:50 INFO - Successfully installed jsonschema functools32 11:25:50 INFO - Cleaning up... 11:25:50 INFO - Return code: 0 11:25:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:25:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:50 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 0x12a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1612a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1616090>, '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 0x1616d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1610f90>, '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': '00204705a9daa57ed339a427000001b9-1504628098.915627-640288888', '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 11:25:50 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 11:25:50 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 11:25:50 INFO - Using env: {'DISPLAY': ':0', 11:25:50 INFO - 'HOME': '/home/cltbld', 11:25:50 INFO - 'LANG': 'en_US.UTF-8', 11:25:50 INFO - 'LANGUAGE': 'en_US:en', 11:25:50 INFO - 'LOGNAME': 'cltbld', 11:25:50 INFO - 'MAIL': '/var/mail/cltbld', 11:25:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:50 INFO - 'MOZ_NO_REMOTE': '1', 11:25:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:50 INFO - 'NO_EM_RESTART': '1', 11:25:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:50 INFO - 'PWD': '/builds/slave/test', 11:25:50 INFO - 'SHELL': '/bin/bash', 11:25:50 INFO - 'SHLVL': '1', 11:25:50 INFO - 'TERM': 'linux', 11:25:50 INFO - 'TMOUT': '86400', 11:25:50 INFO - 'USER': 'cltbld', 11:25:50 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1504628098.915627-640288888', 11:25:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:50 INFO - '_': '/tools/buildbot/bin/python'} 11:25:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:25:51 INFO - Cleaning up... 11:25:51 INFO - Return code: 0 11:25:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:25:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x12a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1612a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1616090>, '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 0x1616d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1610f90>, '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': '00204705a9daa57ed339a427000001b9-1504628098.915627-640288888', '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 11:25:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:25:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:25:51 INFO - Using env: {'DISPLAY': ':0', 11:25:51 INFO - 'HOME': '/home/cltbld', 11:25:51 INFO - 'LANG': 'en_US.UTF-8', 11:25:51 INFO - 'LANGUAGE': 'en_US:en', 11:25:51 INFO - 'LOGNAME': 'cltbld', 11:25:51 INFO - 'MAIL': '/var/mail/cltbld', 11:25:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:51 INFO - 'MOZ_NO_REMOTE': '1', 11:25:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:51 INFO - 'NO_EM_RESTART': '1', 11:25:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:51 INFO - 'PWD': '/builds/slave/test', 11:25:51 INFO - 'SHELL': '/bin/bash', 11:25:51 INFO - 'SHLVL': '1', 11:25:51 INFO - 'TERM': 'linux', 11:25:51 INFO - 'TMOUT': '86400', 11:25:51 INFO - 'USER': 'cltbld', 11:25:51 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1504628098.915627-640288888', 11:25:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:51 INFO - '_': '/tools/buildbot/bin/python'} 11:25:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:51 INFO - Downloading/unpacking blobuploader==1.2.4 11:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:52 INFO - Downloading blobuploader-1.2.4.tar.gz 11:25:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:25:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:25:52 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 11:25:52 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 11:25:52 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 11:25:52 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 11:25:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:25:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:25:52 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 11:25:52 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 11:25:52 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 11:25:52 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 11:25:53 INFO - Downloading docopt-0.6.1.tar.gz 11:25:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:25:53 INFO - Installing collected packages: blobuploader, requests, docopt 11:25:53 INFO - Running setup.py install for blobuploader 11:25:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:25:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:25:53 INFO - Running setup.py install for requests 11:25:53 INFO - Running setup.py install for docopt 11:25:53 INFO - Successfully installed blobuploader requests docopt 11:25:53 INFO - Cleaning up... 11:25:53 INFO - Return code: 0 11:25:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25: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')]} 11:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25: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')]} 11:25:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:53 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 0x12a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1612a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1616090>, '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 0x1616d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1610f90>, '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': '00204705a9daa57ed339a427000001b9-1504628098.915627-640288888', '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 11:25:53 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 11:25:53 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 11:25:53 INFO - Using env: {'DISPLAY': ':0', 11:25:53 INFO - 'HOME': '/home/cltbld', 11:25:53 INFO - 'LANG': 'en_US.UTF-8', 11:25:53 INFO - 'LANGUAGE': 'en_US:en', 11:25:53 INFO - 'LOGNAME': 'cltbld', 11:25:53 INFO - 'MAIL': '/var/mail/cltbld', 11:25:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:53 INFO - 'MOZ_NO_REMOTE': '1', 11:25:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:53 INFO - 'NO_EM_RESTART': '1', 11:25:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:53 INFO - 'PWD': '/builds/slave/test', 11:25:53 INFO - 'SHELL': '/bin/bash', 11:25:53 INFO - 'SHLVL': '1', 11:25:53 INFO - 'TERM': 'linux', 11:25:53 INFO - 'TMOUT': '86400', 11:25:53 INFO - 'USER': 'cltbld', 11:25:53 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1504628098.915627-640288888', 11:25:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:53 INFO - '_': '/tools/buildbot/bin/python'} 11:25:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:25:53 INFO - Running setup.py (path:/tmp/pip-0oaNM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:25:53 INFO - Running setup.py (path:/tmp/pip-NZ2oPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:25:54 INFO - Running setup.py (path:/tmp/pip-wmUSjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:25:54 INFO - Running setup.py (path:/tmp/pip-lrXxLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:25:54 INFO - Running setup.py (path:/tmp/pip-f90qZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:25:54 INFO - Running setup.py (path:/tmp/pip-yKbOvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:25:54 INFO - Running setup.py (path:/tmp/pip-ebzP0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:25:54 INFO - Running setup.py (path:/tmp/pip-VBEFHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:25:54 INFO - Running setup.py (path:/tmp/pip-QlN4s4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:25:54 INFO - Running setup.py (path:/tmp/pip-Ns6GJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:25:54 INFO - Running setup.py (path:/tmp/pip-X7hA5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:25:54 INFO - Running setup.py (path:/tmp/pip-jSGixG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:25:54 INFO - Running setup.py (path:/tmp/pip-3jaqke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:25:54 INFO - Running setup.py (path:/tmp/pip-jU3eXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:54 INFO - Running setup.py (path:/tmp/pip-NJohjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:25:54 INFO - Running setup.py (path:/tmp/pip-iviz0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:25:55 INFO - Running setup.py (path:/tmp/pip-PfBdpV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:25:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:25:55 INFO - Running setup.py install for manifestparser 11:25:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:25:55 INFO - Running setup.py install for mozcrash 11:25:55 INFO - Running setup.py install for mozdebug 11:25:55 INFO - Running setup.py install for mozdevice 11:25:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:25:55 INFO - Running setup.py install for mozfile 11:25:55 INFO - Running setup.py install for mozhttpd 11:25:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:25:55 INFO - Running setup.py install for mozinfo 11:25:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:25:55 INFO - Running setup.py install for mozInstall 11:25:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:25:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:25:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:25:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:25:55 INFO - Running setup.py install for mozleak 11:25:55 INFO - Running setup.py install for mozlog 11:25:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:25:56 INFO - Running setup.py install for moznetwork 11:25:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:25:56 INFO - Running setup.py install for mozprocess 11:25:56 INFO - Running setup.py install for mozprofile 11:25:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:25:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:25:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:25:56 INFO - Running setup.py install for mozrunner 11:25:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:25:56 INFO - Running setup.py install for mozscreenshot 11:25:56 INFO - Running setup.py install for moztest 11:25:56 INFO - Running setup.py install for mozversion 11:25:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:25:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:25:56 INFO - Cleaning up... 11:25:56 INFO - Return code: 0 11:25:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:56 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 0x12a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1612a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1616090>, '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 0x1616d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1610f90>, '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': '00204705a9daa57ed339a427000001b9-1504628098.915627-640288888', '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 11:25:56 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 11:25:56 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 11:25:56 INFO - Using env: {'DISPLAY': ':0', 11:25:56 INFO - 'HOME': '/home/cltbld', 11:25:56 INFO - 'LANG': 'en_US.UTF-8', 11:25:56 INFO - 'LANGUAGE': 'en_US:en', 11:25:56 INFO - 'LOGNAME': 'cltbld', 11:25:56 INFO - 'MAIL': '/var/mail/cltbld', 11:25:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:56 INFO - 'MOZ_NO_REMOTE': '1', 11:25:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:56 INFO - 'NO_EM_RESTART': '1', 11:25:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:56 INFO - 'PWD': '/builds/slave/test', 11:25:56 INFO - 'SHELL': '/bin/bash', 11:25:56 INFO - 'SHLVL': '1', 11:25:56 INFO - 'TERM': 'linux', 11:25:56 INFO - 'TMOUT': '86400', 11:25:56 INFO - 'USER': 'cltbld', 11:25:56 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1504628098.915627-640288888', 11:25:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:56 INFO - '_': '/tools/buildbot/bin/python'} 11:25:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:25:57 INFO - Running setup.py (path:/tmp/pip-AWhxEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:25:57 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)) 11:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:25:57 INFO - Running setup.py (path:/tmp/pip-VCVv2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:25:57 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)) 11:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:25:57 INFO - Running setup.py (path:/tmp/pip-QRBVnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:25:57 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)) 11:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:25:57 INFO - Running setup.py (path:/tmp/pip-0Xch3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:25:57 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)) 11:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:25:57 INFO - Running setup.py (path:/tmp/pip-dlHV5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:25:57 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)) 11:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:25:57 INFO - Running setup.py (path:/tmp/pip-uiqpR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:25:57 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)) 11:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:25:57 INFO - Running setup.py (path:/tmp/pip-LW7DAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:25:57 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)) 11:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:25:57 INFO - Running setup.py (path:/tmp/pip-t13mTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:25:57 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)) 11:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:25:57 INFO - Running setup.py (path:/tmp/pip-L8Ucmw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:25:57 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)) 11:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:25:57 INFO - Running setup.py (path:/tmp/pip-zv8DlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:25:57 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)) 11:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:25:57 INFO - Running setup.py (path:/tmp/pip-cNr8a2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:25:57 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)) 11:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:25:57 INFO - Running setup.py (path:/tmp/pip-0C8pFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:25:57 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)) 11:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:25:57 INFO - Running setup.py (path:/tmp/pip-9b4CEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:25:58 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)) 11:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:25:58 INFO - Running setup.py (path:/tmp/pip-SrFAIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:25:58 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)) 11:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:58 INFO - Running setup.py (path:/tmp/pip-6YT7aT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:58 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)) 11:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:25:58 INFO - Running setup.py (path:/tmp/pip-7AgKTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:25:58 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)) 11:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:25:58 INFO - Running setup.py (path:/tmp/pip-yhv8mo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:25:58 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)) 11:25:58 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)) 11:25:58 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)) 11:25:58 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)) 11:25:58 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)) 11:25:58 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)) 11:25:58 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)) 11:25:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:59 INFO - Downloading blessings-1.6.tar.gz 11:25:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:25:59 INFO - Installing collected packages: blessings 11:25:59 INFO - Running setup.py install for blessings 11:25:59 INFO - Successfully installed blessings 11:25:59 INFO - Cleaning up... 11:25:59 INFO - Return code: 0 11:25:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:25:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:25:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:25:59 INFO - Reading from file tmpfile_stdout 11:25:59 INFO - Current package versions: 11:25:59 INFO - argparse == 1.2.1 11:25:59 INFO - blessings == 1.6 11:25:59 INFO - blobuploader == 1.2.4 11:25:59 INFO - docopt == 0.6.1 11:25:59 INFO - functools32 == 3.2.3-2 11:25:59 INFO - jsonschema == 2.5.1 11:25:59 INFO - manifestparser == 1.1 11:25:59 INFO - mozInstall == 1.13 11:25:59 INFO - mozcrash == 1.0 11:25:59 INFO - mozdebug == 0.1 11:25:59 INFO - mozdevice == 0.51 11:25:59 INFO - mozfile == 1.2 11:25:59 INFO - mozhttpd == 0.7 11:25:59 INFO - mozinfo == 0.10 11:25:59 INFO - mozleak == 0.1 11:25:59 INFO - mozlog == 3.5 11:25:59 INFO - moznetwork == 0.27 11:25:59 INFO - mozprocess == 0.25 11:25:59 INFO - mozprofile == 0.28 11:25:59 INFO - mozrunner == 6.13 11:25:59 INFO - mozscreenshot == 0.1 11:25:59 INFO - mozsystemmonitor == 0.3 11:25:59 INFO - moztest == 0.8 11:25:59 INFO - mozversion == 1.4 11:25:59 INFO - psutil == 3.1.1 11:25:59 INFO - requests == 1.2.3 11:25:59 INFO - wsgiref == 0.1.2 11:25:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25:59 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')]} 11:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:59 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')]} 11:25:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:59 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 0x12a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1612a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1616090>, '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 0x1616d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1610f90>, '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': '00204705a9daa57ed339a427000001b9-1504628098.915627-640288888', '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 11:25:59 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 11:25:59 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 11:25:59 INFO - Using env: {'DISPLAY': ':0', 11:25:59 INFO - 'HOME': '/home/cltbld', 11:25:59 INFO - 'LANG': 'en_US.UTF-8', 11:25:59 INFO - 'LANGUAGE': 'en_US:en', 11:25:59 INFO - 'LOGNAME': 'cltbld', 11:25:59 INFO - 'MAIL': '/var/mail/cltbld', 11:25:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:59 INFO - 'MOZ_NO_REMOTE': '1', 11:25:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:59 INFO - 'NO_EM_RESTART': '1', 11:25:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:59 INFO - 'PWD': '/builds/slave/test', 11:25:59 INFO - 'SHELL': '/bin/bash', 11:25:59 INFO - 'SHLVL': '1', 11:25:59 INFO - 'TERM': 'linux', 11:25:59 INFO - 'TMOUT': '86400', 11:25:59 INFO - 'USER': 'cltbld', 11:25:59 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1504628098.915627-640288888', 11:25:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:59 INFO - '_': '/tools/buildbot/bin/python'} 11:26:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:00 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)) 11:26:00 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)) 11:26:00 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)) 11:26:00 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)) 11:26:00 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)) 11:26:00 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)) 11:26:00 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)) 11:26:00 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)) 11:26:00 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)) 11:26:00 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:26:01 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)) 11:26:01 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)) 11:26:01 INFO - Installing collected packages: simplejson 11:26:01 INFO - Running setup.py install for simplejson 11:26:01 INFO - building 'simplejson._speedups' extension 11:26:01 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 11:26:02 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 11:26:02 INFO - Successfully installed simplejson 11:26:02 INFO - Cleaning up... 11:26:02 INFO - Return code: 0 11:26:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:26:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:02 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 0x12a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1612a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1616090>, '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 0x1616d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1610f90>, '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': '00204705a9daa57ed339a427000001b9-1504628098.915627-640288888', '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 11:26:02 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 11:26:02 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 11:26:02 INFO - Using env: {'DISPLAY': ':0', 11:26:02 INFO - 'HOME': '/home/cltbld', 11:26:02 INFO - 'LANG': 'en_US.UTF-8', 11:26:02 INFO - 'LANGUAGE': 'en_US:en', 11:26:02 INFO - 'LOGNAME': 'cltbld', 11:26:02 INFO - 'MAIL': '/var/mail/cltbld', 11:26:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:02 INFO - 'MOZ_NO_REMOTE': '1', 11:26:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:02 INFO - 'NO_EM_RESTART': '1', 11:26:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:02 INFO - 'PWD': '/builds/slave/test', 11:26:02 INFO - 'SHELL': '/bin/bash', 11:26:02 INFO - 'SHLVL': '1', 11:26:02 INFO - 'TERM': 'linux', 11:26:02 INFO - 'TMOUT': '86400', 11:26:02 INFO - 'USER': 'cltbld', 11:26:02 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1504628098.915627-640288888', 11:26:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:02 INFO - '_': '/tools/buildbot/bin/python'} 11:26:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:26:02 INFO - Cleaning up... 11:26:02 INFO - Return code: 0 11:26:02 INFO - Running post-action listener: _resource_record_post_action 11:26:02 INFO - Running post-action listener: _start_resource_monitoring 11:26:02 INFO - Starting resource monitoring. 11:26:02 INFO - [mozharness: 2017-09-05 18:26:02.544606Z] Finished create-virtualenv step (success) 11:26:02 INFO - [mozharness: 2017-09-05 18:26:02.545129Z] Running install step. 11:26:02 INFO - Running pre-action listener: _resource_record_pre_action 11:26:02 INFO - Running main action method: install 11:26:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:26:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:26:02 INFO - Reading from file tmpfile_stdout 11:26:02 INFO - Detecting whether we're running mozinstall >=1.0... 11:26:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:26:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:26:02 INFO - Reading from file tmpfile_stdout 11:26:02 INFO - Output received: 11:26:02 INFO - Usage: mozinstall [options] installer 11:26:02 INFO - Options: 11:26:02 INFO - -h, --help show this help message and exit 11:26:02 INFO - -d DEST, --destination=DEST 11:26:02 INFO - Directory to install application into. [default: 11:26:02 INFO - "/builds/slave/test"] 11:26:02 INFO - --app=APP Application being installed. [default: firefox] 11:26:02 INFO - mkdir: /builds/slave/test/build/application 11:26:02 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'] 11:26:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:26:19 INFO - Reading from file tmpfile_stdout 11:26:19 INFO - Output received: 11:26:19 INFO - /builds/slave/test/build/application/firefox/firefox 11:26:19 INFO - Running post-action listener: _resource_record_post_action 11:26:19 INFO - [mozharness: 2017-09-05 18:26:19.546647Z] Finished install step (success) 11:26:19 INFO - [mozharness: 2017-09-05 18:26:19.546901Z] Running setup-mitmproxy step. 11:26:19 INFO - Running pre-action listener: _resource_record_pre_action 11:26:19 INFO - Running main action method: setup_mitmproxy 11:26:19 INFO - Skipping: mitmproxy is not required 11:26:19 INFO - Running post-action listener: _resource_record_post_action 11:26:19 INFO - [mozharness: 2017-09-05 18:26:19.548034Z] Finished setup-mitmproxy step (success) 11:26:19 INFO - [mozharness: 2017-09-05 18:26:19.548320Z] Running run-tests step. 11:26:19 INFO - Running pre-action listener: _resource_record_pre_action 11:26:19 INFO - Running pre-action listener: _set_gcov_prefix 11:26:19 INFO - Running main action method: run_tests 11:26:19 WARNING - Try message not found. 11:26:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:26:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:26:19 INFO - Python 2.7.3 11:26:19 INFO - Return code: 0 11:26:19 INFO - grabbing minidump binary from tooltool 11:26:19 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')]} 11:26:19 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 0x1616090>, '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 0x1616d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1610f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:26:19 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 11:26:19 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 11:26:19 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 11:26:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:26:19 INFO - Return code: 0 11:26:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:26:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:26:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:26:19 INFO - ENV: RUST_BACKTRACE is now full 11:26:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:26:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:26:19 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/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 11:26:19 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/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 11:26:19 INFO - Using env: {'DISPLAY': ':0', 11:26:19 INFO - 'HOME': '/home/cltbld', 11:26:19 INFO - 'LANG': 'en_US.UTF-8', 11:26:19 INFO - 'LANGUAGE': 'en_US:en', 11:26:19 INFO - 'LOGNAME': 'cltbld', 11:26:19 INFO - 'MAIL': '/var/mail/cltbld', 11:26:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:26:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:26:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:19 INFO - 'MOZ_NO_REMOTE': '1', 11:26:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:26:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:19 INFO - 'NO_EM_RESTART': '1', 11:26:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:19 INFO - 'PWD': '/builds/slave/test', 11:26:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:26:19 INFO - 'RUST_BACKTRACE': 'full', 11:26:19 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:26:19 INFO - 'SHELL': '/bin/bash', 11:26:19 INFO - 'SHLVL': '1', 11:26:19 INFO - 'STYLO_FORCE_ENABLED': '1', 11:26:19 INFO - 'TERM': 'linux', 11:26:19 INFO - 'TMOUT': '86400', 11:26:19 INFO - 'USER': 'cltbld', 11:26:19 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1504628098.915627-640288888', 11:26:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:19 INFO - '_': '/tools/buildbot/bin/python'} 11:26:19 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/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 11:26:19 INFO - mozversion application_buildid: 20170905173605 11:26:19 INFO - mozversion application_changeset: 973e8b890a62aee4b3170558ac3b608928162ef6 11:26:19 INFO - mozversion application_display_name: Nightly 11:26:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:26:19 INFO - mozversion application_name: Firefox 11:26:19 INFO - mozversion application_remotingname: firefox 11:26:19 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:26:19 INFO - mozversion application_vendor: Mozilla 11:26:19 INFO - mozversion application_version: 57.0a1 11:26:19 INFO - mozversion platform_buildid: 20170905173605 11:26:19 INFO - mozversion platform_changeset: 973e8b890a62aee4b3170558ac3b608928162ef6 11:26:19 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:26:19 INFO - mozversion platform_version: 57.0a1 11:26:19 INFO - using testdate: 1504635979 11:26:19 INFO - actual date: 1504635979 11:26:19 INFO - starting webserver on 'localhost:55715' 11:26:19 INFO - SUITE-START | Running 2 tests 11:26:19 INFO - TEST-START | dromaeo_css 11:26:19 INFO - Initialising browser for dromaeo_css test... 11:26:19 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55715/getInfo.html -profile /tmp/tmpWbjvXJ/profile 11:26:19 INFO - TEST-INFO | started process 15613 (/builds/slave/test/build/application/firefox/firefox http://localhost:55715/getInfo.html) 11:26:25 INFO - TEST-INFO | 15613: exit 0 11:26:25 INFO - Browser initialized. 11:26:25 INFO - Running cycle 1/1 for dromaeo_css test... 11:26:25 INFO - Using env: {'DISPLAY': ':0', 11:26:25 INFO - 'HOME': '/home/cltbld', 11:26:25 INFO - 'JSGC_DISABLE_POISONING': '1', 11:26:25 INFO - 'LANG': 'en_US.UTF-8', 11:26:25 INFO - 'LANGUAGE': 'en_US:en', 11:26:25 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:26:25 INFO - 'LOGNAME': 'cltbld', 11:26:25 INFO - 'MAIL': '/var/mail/cltbld', 11:26:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:26:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:26:25 INFO - 'MOZ_CRASHREPORTER': '1', 11:26:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:25 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:26:25 INFO - 'MOZ_NO_REMOTE': '1', 11:26:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:26:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:25 INFO - 'NO_EM_RESTART': '1', 11:26:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:25 INFO - 'PWD': '/builds/slave/test', 11:26:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:26:25 INFO - 'RUST_BACKTRACE': 'full', 11:26:25 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:26:25 INFO - 'SHELL': '/bin/bash', 11:26:25 INFO - 'SHLVL': '1', 11:26:25 INFO - 'STYLO_FORCE_ENABLED': '1', 11:26:25 INFO - 'TERM': 'linux', 11:26:25 INFO - 'TMOUT': '86400', 11:26:25 INFO - 'USER': 'cltbld', 11:26:25 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1504628098.915627-640288888', 11:26:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:25 INFO - '_': '/tools/buildbot/bin/python'} 11:26:25 INFO - TEST-INFO | started process 15808 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWbjvXJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:26:26 INFO - PID 15808 | 11:26:26 INFO - PID 15808 | (/builds/slave/test/build/application/firefox/firefox:15860): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:26:26 INFO - PID 15808 | 11:26:36 INFO - PID 15808 | RSS: Main: 172544000 11:26:36 INFO - PID 15808 | 11:29:35 INFO - PID 15808 | Cycle 1(1): loaded http://localhost:55715/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55715/tests/dromaeo/cssquery-ext.html) 11:29:37 INFO - PID 15808 | RSS: Main: 175775744 11:29:37 INFO - PID 15808 | 11:32:39 INFO - PID 15808 | Cycle 1(1): loaded http://localhost:55715/tests/dromaeo/cssquery-ext.html (next: http://localhost:55715/tests/dromaeo/cssquery-jquery.html) 11:32:39 INFO - PID 15808 | RSS: Main: 171470848 11:32:39 INFO - PID 15808 | 11:35:41 INFO - PID 15808 | Cycle 1(1): loaded http://localhost:55715/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55715/tests/dromaeo/cssquery-mootools.html) 11:35:41 INFO - PID 15808 | RSS: Main: 174071808 11:35:41 INFO - PID 15808 | 11:38:43 INFO - PID 15808 | Cycle 1(1): loaded http://localhost:55715/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55715/tests/dromaeo/cssquery-prototype.html) 11:38:44 INFO - PID 15808 | RSS: Main: 172294144 11:38:44 INFO - PID 15808 | 11:41:48 INFO - PID 15808 | Cycle 1(1): loaded http://localhost:55715/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55715/tests/dromaeo/cssquery-yui.html) 11:41:48 INFO - PID 15808 | RSS: Main: 173973504 11:41:48 INFO - PID 15808 | 11:44:50 INFO - PID 15808 | Cycle 1(1): loaded http://localhost:55715/tests/dromaeo/cssquery-yui.html (next: http://localhost:55715/tests/dromaeo/cssquery-dojo.html) 11:44:50 INFO - PID 15808 | RSS: Main: 176844800 11:44:50 INFO - PID 15808 | 11:44:50 INFO - PID 15808 | __start_tp_report 11:44:50 INFO - PID 15808 | _x_x_mozilla_page_load 11:44:50 INFO - PID 15808 | _x_x_mozilla_page_load_details 11:44:50 INFO - PID 15808 | |i|pagename|runs| 11:44:50 INFO - PID 15808 | |0;dojo.html;3341.9331613367735;3368.5789276340456;3386.627470978193;3412.351653185893;3423.6576342365765;6432.195975503062;6484.675766211694;6491.058796474508;6553.705083271247;6554.508411869111;6301.621902685842;6354.110424540557;6421.197350331208;6430.324815894334;6440.903386449207;5794.971025144869;5962.642241465504;5993.130996005577;6030.939690603103;6039.909401358983;5940.584159108864;6019;6045.879082418349;6053.606515576495;6057;5797.449242321973;5819.447152520504;5855.326637436707;5915.438033386865;5958.076498142795;5882.0588705807295;5887.735051922631;5978.551608629326;5990.041593345044;5990.101484777275;5746.9712651436475;5830.125481177814;5830.3586605473365;5911.290645122613;5986.3714309997695;6391.776287829904;6432;6463.93536064638;6488.837779055514;6525.543211975164;6945.89581156283;6946.895796563055;7044.119485064367;7045.048918396003;7053.0830991971225;7040.577565346096;7059.470539709542;7107.2182059973875;7134.821629459305;7159.642017899137;6387.93612063878;6488.221413430371;6497.220333559956;6580.012998050331;6594.175728033996;7243.239459856744;7250.274972502708;7314.08573928259;7324.304191101837;7334.706611735577;6889.758858439931;6896.862062758817;6946.444284457332;6956.2000369958105;6981.197162326296;6836.179658440919;6934.722611095601;7030.3321184487395;7047.40097091753;7152.249013853574;6853.554518956252;6868.244493105754;6869.313068693091;6879.071325371011;6882.931170688329;6765.560238584476;6867.896981545281;6869.896951545731;6886;6889.0355350251;5406.567474602022;5428.891422171534;5501.9174712379345;5504.91742623861;5519.337679478408;4826.617609241797;4848.878778030577;4906.705597664151;4919.852404427873;4922.458529561745;6028.125921741411;6035.094735789579;6102.237220347457;6103.572749907553;6111.449969502677;6816;6857.314268573203;6909.067275917687;6940.167179938338;7049.29507049291;6028.849278767978;6038;6047.0627052806885;6080.996635555084;6097.908531372033;5887.558433117533;5966.820995370146;5973;5978.880422391528;5987.191729116601;6646.368594983469;6665.166854143232;6723.865522689519;6734.326567343226;6743.393094621508;6766.8646627068165;6907.620080895599;6966.582005079711;6985.650717464208;7048.682809273698;6736.93263067363;6771.966140169267;6779.220389655253;6795.762148324785;6802.489813263926;6775.085363476065;6796.490263230178;6816.113905192492;6836.931630683828;6867.656617169221;6868.896966545406;6900.7929762107215;6904.964255361736;6971.65141742921;6976.5814051157095;6628.602283862983;6628.7017084230365;6663.267040625624;6721.831954200989;6729.629870356982;6680.699368528525;6680.866382672417;6698.095757072733;6705.765298214539;6716.832079197864;6759.526833121831;6775.864482710417;6785.457163427012;6814.761483348258;6844.007618895332;6829.214640316229;6838.179418469816;6902.309769023058;6970.756023539152;6975;6573.1783527059115;6620.63586502747;6704.06143139951;6716.3955244028275;6716.798496045127 11:44:50 INFO - PID 15808 | |1;ext.html;840.9075001749807;863.2058506174319;887.6360692116237;890.5858775669315;1138.9487473063712;30897.691023089763;31371.84314078432;31481.370372592533;41669;41982.58017419825;42060.78969605155;42464.57535424645;42513.36229956545;43129.568704313024;43163.13673726524;7324;7930.405219608538;7978.2420670036545;8036.437449378546;8040.798980025517;7917.089534703525;7979.640916158758;8005.919940800605;8009.639566219505;8015.559144247064;7971.681132754683;8026.398020148483;8030.076541197778;8034;8040.959795201015;7964.8805267921025;7997.520148791091;7998.480098793589;8003.839923201504;8005.119436861912;7219.278072192791;7255.347018768336;7271.163816161156;7275.67259473325;7281.053463049822;38097.61902380968;38313.42529862055;38337.42493862594;38355.808220958716;38376.23247535062;3583.6953858922025;3592.2456284180353;3617.819109044537;3619.5294611700574;3623.1847834237087;31856.362872742648;31981.52027719563;32039;32048.839755801073;32057.51913721296;4978.377702787152;5054.494550544953;5156.819511317123;5194.194899790538;5209.661372010807;187732;189284;189499;189823.99999999863;189953;47842;47890.28164577534;47900.520994790306;47947.76026119847;48018.75990620095;50787.23819142716;50812.49187508078;50867;50927;51063;14432.783508247385;15272.236388180547;15505.689886202214;15522.5343239703;15535.300911459011;12008.879911200776;12328.445219965122;12674.746505069847;12690.682732931751;12773.361331933365;14118.71762564743;14177;14185.929070354583;14188.85811141896;14303;5642.887142257132;5685.545156387562;5762.481376676035;5768.077107662753;5860.472557469848;997.1574019953129;1006.2453160129902;1017.5217647705566;1020.1074060197327;1021.3514418344405;22628.434289142904;28663;28814.42371152565;28876.566851497246;28908.27729306784;1073.63496411219;1081.5835903177333;1091.252492042953;1099.796537640539;1103.773726386089;12012.519499219934;12160.331181785086;12245.510179592717;12280.754384912252;12445.875541244472;230850;232851;233162;233273;233323;46352.07295854064;46482.302765458546;46545.534544654794;46607;46621;1407.838098618672;1431.7637589797566;1445.6891768269873;1449.8332691740375;1454.763451066585;21890.23384181546;22249.777502225417;22420.439489012904;22472.32583022512;22861.31416057521;37424.438633421065;37511.81244093762;37521;37734.62265377421;37805;200902;202186;202959;203160;203292;33317.666823331456;36382.8180859094;38050;38361.808190958865;38433.2313353737;45134;45309;45383.319250211935;45686.77156614196;46188.53811461842;33876.49185262174;33883.15292117717;34038.14904627404;34198;34499.48250776291;32621;33111;33147.83426082854;33295.83352083224;33797.49303760396;37927.81036094802;38134.2373152541;38212.808935955145;38220.61779382282;38229.4265586022;32517.512237315987;33167.33665326728;33363;33410.33179336448;33440.66559334376;23226.187083451998;23585.882070589538;23729.16947906815;23857.52284954326;24078.157264495658 11:44:50 INFO - PID 15808 | |2;jquery.html;565.2143520506494;570.2273419516553;570.4751628501778;577.1746402644219;585.3619554685392;22426.55146897061;22608.321750347495;23489.177878774248;23527.64708529369;23557.882210588967;25513.872430637868;26104.60843087355;26107.086251981185;26233.606495902575;26292;6475.90286145707;6613.6693165341785;6621.139251897247;6632.336766323353;6641.169853768279;6391.616503009835;6540.93459065408;6583.934160658404;6625.370589793962;6687.665616719169;6630.4032637062655;6633.369829866155;6636;6638.236602790668;6668.76659316924;6653.068570400148;6653.534252602296;6654.334566543355;6655.600663960129;6655.966720166392;6131.233595800525;6159.5072394208355;6173.567850250484;6179;6181.07283907413;28890.27774305659;29266.70733292661;29758.256043598867;30285.545716814264;30594;2052.4560991337157;2090.602785470756;2091.1217288738767;2094.7695753467106;2095.612311722321;19090.904545477322;19676.901615491974;19701;19714;19729.605407891762;2393.628987506939;2429.5019520998153;2467.9012839486577;2474.072222916406;2485.7141428735745;140031.29984350014;141666.29166854202;142132;142524;143682;14449.277536123152;14588.854111458963;14722.852771472148;15003.474878379204;15182.013169143971;23091.88454057719;23288.4177895554;23293.301200963997;23309.18417855401;23323.06707731672;9094.181523662903;9120.543972801333;9224;9411.200047995997;9474.052594740471;8328.208820162075;8351.8329633407;8435.367347448842;8461.746147615582;8494.787630309293;7867.291943725092;9111.544422778834;9269.258459323239;9328.34701570897;9399.812003759887;2593.286846117295;2648.549746543092;2652;2671.6126161706834;2748.2717079973822;973.6251543155794;981.2052237687496;981.6809536900536;985.1626117799813;987.2250283527396;19065.714014289795;19107.016441825584;19228.327008554912;19882;19937.102830372667;1032.1587905856702;1037.9896201038043;1046.6336782126195;1048.6434612231878;1059.7850492470773;10406.739831504121;10902.236843420884;12908.483660653657;14054.789178162337;14206.85793142076;498192;505629;507910;508005;508497;126780;130541.34729326292;131430;131834.34082829524;133133.3373332528;1235.092207227687;1258.9118761686593;1284.7944328907518;1287.1955028107434;1288.6391810293132;20439.284625038053;20619.659722118013;20816.791832081486;20837.37487875366;20903.686444703646;54150.45849541454;59871.700641496514;60128.69935650294;60636.09045864228;62949;73063.63468182625;73445.6327718358;73612.63193683997;74065.62967185346;74326.62836685783;14251.57245282643;14374.784378234544;14912.179830109448;14914.85085149178;15071.773923391378;24016.63975040411;24231.273061808173;24262.15082472105;24403.877980609985;24469.877650612347;18775.436736897915;19125.139368728163;19325.903370483058;19372.4188274352;19451.51371215731;16507.422240221535;17035.659286814443;17403.912980435016;17447;17849.196786144916;16068.758968615246;16213.432529861399;16407;16410.589735256715;16413.58966025859;14651.853481465048;14661.340239689027;14734;14805.333759981042;14829.110253384832;16272.430464934145;16395.180240988142;16435.67128657444;16439.67120657604;17879.28482860671 11:44:50 INFO - PID 15808 | |3;mootools.html;1373.2241283674723;1398.8810951069158;1426.2227086238001;1434.1610158057536;1449.311577000924;12798;13386.263755493455;13388.7322253555;15625.453109141183;16001.83998160021;15332.540023799276;15748;15753.212339383013;15761.290741916613;15771.21143942801;2744.5745909384077;2801.523740964036;2861.1702606244266;2862.4275144970984;2864.183707643322;2757.5725762506845;2798.4263226038615;2804.957925631117;2823.4635419270376;2823.477656633519;2739.7260273972543;2753.490604238222;2774.611554382388;2774.8473833939124;2774.8473833939124;2663.8934442622367;2683.932901677464;2695.164499005295;2699.419624780662;2705.864706764664;2643.312738687955;2692.192342297303;2693.892244310225;2694.191742477249;2695.501332253539;15174.772378414333;15444.768328475082;15528.689426211526;15566.610834729108;15573;8087.838243235103;8402.663893444254;8407.915920840836;8408.2432581068;8414.326853851677;5065.214891691757;5639.971800141014;5670.149477578396;5785.739641716133;5788.913166302509;1866.4680566038749;1947.8799690178205;1950.2589016173763;1987.1058023889307;1987.8608497405187;26110.216693499224;26777;27478;27524.862375688193;27549.86225068882;6681.9331806682285;6721.764738234138;6785.660716964132;6831.6242606657115;6964.268751781091;16983.83016169847;17299.82700172982;17582.824171758373;17591.648167036587;17606.823931760773;7912.762617121495;8110.0673422557165;8132.146124656944;8167.224113709188;8172.6322315495945;7148.106486689164;7234.746783862644;7427.888581671279;7516.962415187999;7585.241475852371;5288.8413347599635;5369.570434365241;5393.110136827458;5401.513863752281;5428.050091234098;1520.6198450387403;1535.1710076558757;1540.822805377396;1551.945681901128;1553.5086317135451;860.1398601398602;878.9296856251484;888.2139306713605;898.4429653614801;904.2268860124499;7818.960905195438;7924.366050715929;8020.11778704342;8131.79670508242;8136.633851476698;706.7349743846057;710.8187412209853;719.4352433339908;720.9423246140296;722.7325889420948;4830.203016502238;4946.35697359341;5657.886842263131;5669.801556945487;5887.20522729426;20901.37295881126;21842.89078554597;22052.338429847132;22509.88745056264;22964.65553016706;20946.581068378546;21201.15195392167;22293.442663933532;22342.776572234394;22359.32922012342;11041.44792760375;11412.543498260142;11584.710382240342;11711.355875426763;11712.648620541397;8468.068512463748;8512.74461766148;8688.956555217184;8746.169113934166;8747.91252087471;17707.38024169148;17852;18078.09609519545;19128.904355478135;20131.798682013577;19281.5179620505;19765.308214212433;19832.305869294505;19860.50348741293;20016;11846;11913.404329783649;11960.58137965167;12054.698632534257;12093.09301802386;14193.219372934587;14328.498502552779;14334.856651433769;14352;14369.497067602584;11065.446727663746;11075.889241107487;11229.21395502307;11263.66209013731;11293.830592540955;10965.61620343284;10996.28524145928;11096.278741881752;11160.776784464102;11307.321560706056;10170.542325595217;10256.641017564349;10263.384196948207;10268;10273.02406271403;7126.964365178141;7154.856902861809;7222.6388680566815;7228.96385518069;7279.963600181965;6651.401373876374;6661.46708263328;6723.7646682365885;6756.898646520404;6769.627670478171 11:44:50 INFO - PID 15808 | |4;prototype.html;498.7630875334219;501.90584525733897;525.1885836382788;529.7774934527498;533.8932213557287;6305.432511074003;6338.936610633892;6345.842413579382;6409.711562979665;6418.775342863;6130.264368275802;6248.625082495054;6290.842728931779;6314.873702525947;6351.745930162788;5029.647924645276;5067.113255180348;5119.308893299412;5131.153359695646;5165.690058596496;4861.1492988727005;5041.344625198737;5087.313212716292;5102.107131252016;5117.283580298743;4910.140725373046;4943.0702591439895;5033.194688849785;5049.166887463564;5065.6200784941275;4923.950760492385;4967.0810899983435;4982.501749824988;5005.974970125162;5051.368578927634;4489.147062058199;4508.526604706524;4526.3210518422175;4526.615237704799;4574.336721175444;6226.003839385677;6262.96868515659;6285.937140628581;6298.716557754912;6360.363963603649;5692.316921969349;5734.512566431817;5767.942320576783;5788.913166302509;5819.970900145472;6548.476121910236;6562.770303039419;6563.146790917151;6581.374769396947;6623.238327592292;4879.39007624047;4903.141950158708;4913.656044076916;4930.534732633683;4964.205727083686;6905.620190889549;6933.757318493828;6963.224377783633;7059.258777828357;7066.858662826715;4980.626453016038;5039.672421292605;5046.571041461517;5053.393592768891;5054.368203974504;5109.667871588409;5111.211076123402;5145.434002259748;5150.97424512875;5187.247849061865;5736.1682556029145;5779.3642699303045;5808.94191058084;5822.184894114827;5849.268841394825;6551.9844424114335;6610.272869984298;6625.4037136657935;6633.2040155181685;6707.1616047994;1668.357682292302;1703.744438334235;1711.1016716224083;1714.6227829877407;1733.5232810977081;1423.4519709911551;1425.7647488164544;1430.370636919752;1460.4596299369302;1464.2605484230396;5769.68266745333;5782.595218334676;5817.127430885316;5817.272840894888;5860.824175274749;6566.376194261537;6578.440832529192;6637.86724265512;6675.59678515734;6712.765053223114;5803.82588522345;5803.912941305884;5880.441358070976;5888.057910734262;5906.49794767441;3539.911502212465;3577.624349443323;3605.7656252343513;3633.3459977204357;3671.192337685705;6662.700178491979;6676.399124078856;6686.465082793365;6697.866042679119;6704.3295670433545;7175;7181.245969173266;7182.569045857265;7190.712371505186;7210.1708303545765;6604.5707029043915;6632.933670663425;6656.534042617067;6698.765543205965;6735.898961515679;6797.354251346114;6846.657667116525;6858.588484690935;6873.113292417297;6895.931040689729;6728.158980127484;6774.153230846145;6786.355296246848;6811.557248778813;6875.418653709575;6597.208334999831;6621.602703837785;6627.117204016268;6682.365175308338;6695.363940425652;5083.313752643346;5096.872578185575;5098.46466121052;5110.1568241239775;5127.17965125593;6910.818954532436;6916.896246556406;6941.965290173517;6983.266756990442;7020.929790702232;6536.869262614626;6587.505937054836;6614.966925165343;6615;6625.238097618835;6527.249366322933;6566.277709451861;6567.605943643397;6580.769673061612;6592.208934927839;6236.376362363727;6315.621062736251;6414.262359828679;6454.709538070892;6538.117354157318;6601.273859875314;6607.9669601651685;6624.304448032887;6626.6686665667485;6665.966670166618;6323.905141422791;6334.081558174131;6399.232092148785;6437.67811609427;6516.446102081376 11:44:50 INFO - PID 15808 | |5;yui.html;917.2616044084509;920.2499962530537;926.05079793212;936.0265324062975;941.6751220828816;16305.429309974154;16966.915165424154;16990.49028529146;17015.31938722451;22886.54226915465;21895.343139705794;22063.227787027456;22334.441638959033;22421.55156896865;22465.663015054786;969.4716379573132;984.2175470500933;985.960561577536;987.3335498538494;987.4618333008492;979.9608015679399;1008.5915204342253;1013.3970287678856;1017.9338343007681;1025.2566889005486;1068.4550879051662;1079.266099052644;1079.5951518180682;1079.9676009719722;1080.1358912869712;1059.4332032362688;1070.1118072000222;1070.3310430980637;1070.8072546941548;1071.935683858967;775.1086250811555;777.3509119884903;778.0119248554304;782.4092809928525;782.6556315221285;19862.801371986385;19899.80100198994;20177.8991105045;20201.393958181132;20433;21428.357149285548;21772.12911483539;22089;22236;22239.44401389978;17594.29622815086;17661.911690441466;17727;17799.73300400495;17826.91086544572;3773.2076263984595;3798.4302354647025;3798.90502737431;3800.7339486235974;3800.9809950950344;130942.34528827391;131065;132100;133502.3324883379;133600.33199834035;16646.16769161537;16653.41713040038;16666.166691665367;17129.14354282281;17170.484885453207;30646.846765766473;31471.21321966969;31574.526382104286;31584.52623210654;31647.683523164935;7536.5101268417375;7929.960350198212;8518.063013068557;8779.648814047367;8839.51382673959;4366.214081465303;4464.2187617166865;4475.910481790346;4477.619402350771;4482.439695038121;5262.55268302191;5321.840344789663;5337.706426146599;5379.838604841861;5389.892202155935;1096.6874440784338;1133.3143448213712;1146.358039497884;1163.1160318158093;1164.0803765025705;684.0867441965032;710.9395701365338;713.1549114299571;717.9174394944544;733.6661818872507;11967.880321196677;12106.394680265952;12224.694382640506;12375.195612285173;12822.1024528284;710.7228181009307;715.8854583266757;718.192033961793;728.3481284250566;733.5671953547433;5601.411851755588;5680.801171958961;5685.60200785941;5695.487406133468;5717.256756621613;114059;114128.85871141183;114296.42851785854;114373;116898;104885.47557262165;105997.47001264944;107195;107503.46248268709;111649;88620;89664;90241.54879225693;91560;91957;10490.895091049297;10625.149988000787;10664.89335106639;10742.19433542503;10944.452777361259;40698.38952415657;40744.59255407408;42027;42379;42897.785511072245;67007;67721.66139169273;69389.65305173442;69465;71650.64174679093;16119.516414507583;16159.515214543582;17839.375621853174;18215.45353639393;18327.72508412348;18599.256029758657;18627.348042818438;18638.16128274258;20933.16267349289;21575.784242157377;18167.091645417942;18602.81397186011;19398.32105876344;19458.708119378505;19672.508187295432;17455.38906138279;18386.988715620235;18501.35245266409;18899.716504252174;19740.802591973898;17968.640627187644;18059.909700451415;18078.367257145936;18602.34891778781;18731.812681873005;13137.146085504412;13197.868021319664;13204.141730787467;13705.314734263446;13753.931230343784;13390.93304533471;13446.394912229169;13696.315184240948;14361.856381436051;14644.267786610413 11:44:50 INFO - PID 15808 | __end_tp_report 11:44:50 INFO - PID 15808 | __start_cc_report 11:44:50 INFO - PID 15808 | _x_x_mozilla_cycle_collect,378 11:44:50 INFO - PID 15808 | __end_cc_report 11:44:50 INFO - PID 15808 | __startTimestamp1504637090627__endTimestamp 11:44:50 INFO - PID 15808 | 11:44:50 INFO - PID 15808 | ------- Summary: start ------- 11:44:50 INFO - PID 15808 | Number of tests: 6 11:44:50 INFO - PID 15808 | 11:44:50 INFO - PID 15808 | [#0] dojo.html Cycles:165 Average:6401.00 Median:6680.70 stddev:750.91 (11.2%) stddev-sans-first:713.84 11:44:50 INFO - PID 15808 | Values: 3341.9 3368.6 3386.6 3412.4 3423.7 6432.2 6484.7 6491.1 6553.7 6554.5 6301.6 6354.1 6421.2 6430.3 6440.9 5795.0 5962.6 5993.1 6030.9 6039.9 5940.6 6019.0 6045.9 6053.6 6057.0 5797.4 5819.4 5855.3 5915.4 5958.1 5882.1 5887.7 5978.6 5990.0 5990.1 5747.0 5830.1 5830.4 5911.3 5986.4 6391.8 6432.0 6463.9 6488.8 6525.5 6945.9 6946.9 7044.1 7045.0 7053.1 7040.6 7059.5 7107.2 7134.8 7159.6 6387.9 6488.2 6497.2 6580.0 6594.2 7243.2 7250.3 7314.1 7324.3 7334.7 6889.8 6896.9 6946.4 6956.2 6981.2 6836.2 6934.7 7030.3 7047.4 7152.2 6853.6 6868.2 6869.3 6879.1 6882.9 6765.6 6867.9 6869.9 6886.0 6889.0 5406.6 5428.9 5501.9 5504.9 5519.3 4826.6 4848.9 4906.7 4919.9 4922.5 6028.1 6035.1 6102.2 6103.6 6111.4 6816.0 6857.3 6909.1 6940.2 7049.3 6028.8 6038.0 6047.1 6081.0 6097.9 5887.6 5966.8 5973.0 5978.9 5987.2 6646.4 6665.2 6723.9 6734.3 6743.4 6766.9 6907.6 6966.6 6985.7 7048.7 6736.9 6772.0 6779.2 6795.8 6802.5 6775.1 6796.5 6816.1 6836.9 6867.7 6868.9 6900.8 6905.0 6971.7 6976.6 6628.6 6628.7 6663.3 6721.8 6729.6 6680.7 6680.9 6698.1 6705.8 6716.8 6759.5 6775.9 6785.5 6814.8 6844.0 6829.2 6838.2 6902.3 6970.8 6975.0 6573.2 6620.6 6704.1 6716.4 6716.8 11:44:50 INFO - PID 15808 | 11:44:50 INFO - PID 15808 | [#1] ext.html Cycles:180 Average:37854.77 Median:3605.03 stddev:54069.20 (1499.8%) stddev-sans-first:54149.45 11:44:50 INFO - PID 15808 | Values: 840.9 863.2 887.6 890.6 1138.9 30897.7 31371.8 31481.4 41669.0 41982.6 42060.8 42464.6 42513.4 43129.6 43163.1 7324.0 7930.4 7978.2 8036.4 8040.8 7917.1 7979.6 8005.9 8009.6 8015.6 7971.7 8026.4 8030.1 8034.0 8041.0 7964.9 7997.5 7998.5 8003.8 8005.1 7219.3 7255.3 7271.2 7275.7 7281.1 38097.6 38313.4 38337.4 38355.8 38376.2 3583.7 3592.2 3617.8 3619.5 3623.2 31856.4 31981.5 32039.0 32048.8 32057.5 4978.4 5054.5 5156.8 5194.2 5209.7 187732.0 189284.0 189499.0 189824.0 189953.0 47842.0 47890.3 47900.5 47947.8 48018.8 50787.2 50812.5 50867.0 50927.0 51063.0 14432.8 15272.2 15505.7 15522.5 15535.3 12008.9 12328.4 12674.7 12690.7 12773.4 14118.7 14177.0 14185.9 14188.9 14303.0 5642.9 5685.5 5762.5 5768.1 5860.5 997.2 1006.2 1017.5 1020.1 1021.4 22628.4 28663.0 28814.4 28876.6 28908.3 1073.6 1081.6 1091.3 1099.8 1103.8 12012.5 12160.3 12245.5 12280.8 12445.9 230850.0 232851.0 233162.0 233273.0 233323.0 46352.1 46482.3 46545.5 46607.0 46621.0 1407.8 1431.8 1445.7 1449.8 1454.8 21890.2 22249.8 22420.4 22472.3 22861.3 37424.4 37511.8 37521.0 37734.6 37805.0 200902.0 202186.0 202959.0 203160.0 203292.0 33317.7 36382.8 38050.0 38361.8 38433.2 45134.0 45309.0 45383.3 45686.8 46188.5 33876.5 33883.2 34038.1 34198.0 34499.5 32621.0 33111.0 33147.8 33295.8 33797.5 37927.8 38134.2 38212.8 38220.6 38229.4 32517.5 33167.3 33363.0 33410.3 33440.7 23226.2 23585.9 23729.2 23857.5 24078.2 11:44:50 INFO - PID 15808 | 11:44:50 INFO - PID 15808 | [#2] jquery.html Cycles:180 Average:35955.72 Median:13205.13 stddev:85600.19 (648.2%) stddev-sans-first:85799.08 11:44:50 INFO - PID 15808 | Values: 565.2 570.2 570.5 577.2 585.4 22426.6 22608.3 23489.2 23527.6 23557.9 25513.9 26104.6 26107.1 26233.6 26292.0 6475.9 6613.7 6621.1 6632.3 6641.2 6391.6 6540.9 6583.9 6625.4 6687.7 6630.4 6633.4 6636.0 6638.2 6668.8 6653.1 6653.5 6654.3 6655.6 6656.0 6131.2 6159.5 6173.6 6179.0 6181.1 28890.3 29266.7 29758.3 30285.5 30594.0 2052.5 2090.6 2091.1 2094.8 2095.6 19090.9 19676.9 19701.0 19714.0 19729.6 2393.6 2429.5 2467.9 2474.1 2485.7 140031.3 141666.3 142132.0 142524.0 143682.0 14449.3 14588.9 14722.9 15003.5 15182.0 23091.9 23288.4 23293.3 23309.2 23323.1 9094.2 9120.5 9224.0 9411.2 9474.1 8328.2 8351.8 8435.4 8461.7 8494.8 7867.3 9111.5 9269.3 9328.3 9399.8 2593.3 2648.5 2652.0 2671.6 2748.3 973.6 981.2 981.7 985.2 987.2 19065.7 19107.0 19228.3 19882.0 19937.1 1032.2 1038.0 1046.6 1048.6 1059.8 10406.7 10902.2 12908.5 14054.8 14206.9 498192.0 505629.0 507910.0 508005.0 508497.0 126780.0 130541.3 131430.0 131834.3 133133.3 1235.1 1258.9 1284.8 1287.2 1288.6 20439.3 20619.7 20816.8 20837.4 20903.7 54150.5 59871.7 60128.7 60636.1 62949.0 73063.6 73445.6 73612.6 74065.6 74326.6 14251.6 14374.8 14912.2 14914.9 15071.8 24016.6 24231.3 24262.2 24403.9 24469.9 18775.4 19125.1 19325.9 19372.4 19451.5 16507.4 17035.7 17403.9 17447.0 17849.2 16068.8 16213.4 16407.0 16410.6 16413.6 14651.9 14661.3 14734.0 14805.3 14829.1 16272.4 16395.2 16435.7 16439.7 17879.3 11:44:50 INFO - PID 15808 | 11:44:50 INFO - PID 15808 | [#3] mootools.html Cycles:180 Average:9450.51 Median:2693.04 stddev:6796.43 (252.4%) stddev-sans-first:6788.40 11:44:50 INFO - PID 15808 | Values: 1373.2 1398.9 1426.2 1434.2 1449.3 12798.0 13386.3 13388.7 15625.5 16001.8 15332.5 15748.0 15753.2 15761.3 15771.2 2744.6 2801.5 2861.2 2862.4 2864.2 2757.6 2798.4 2805.0 2823.5 2823.5 2739.7 2753.5 2774.6 2774.8 2774.8 2663.9 2683.9 2695.2 2699.4 2705.9 2643.3 2692.2 2693.9 2694.2 2695.5 15174.8 15444.8 15528.7 15566.6 15573.0 8087.8 8402.7 8407.9 8408.2 8414.3 5065.2 5640.0 5670.1 5785.7 5788.9 1866.5 1947.9 1950.3 1987.1 1987.9 26110.2 26777.0 27478.0 27524.9 27549.9 6681.9 6721.8 6785.7 6831.6 6964.3 16983.8 17299.8 17582.8 17591.6 17606.8 7912.8 8110.1 8132.1 8167.2 8172.6 7148.1 7234.7 7427.9 7517.0 7585.2 5288.8 5369.6 5393.1 5401.5 5428.1 1520.6 1535.2 1540.8 1551.9 1553.5 860.1 878.9 888.2 898.4 904.2 7819.0 7924.4 8020.1 8131.8 8136.6 706.7 710.8 719.4 720.9 722.7 4830.2 4946.4 5657.9 5669.8 5887.2 20901.4 21842.9 22052.3 22509.9 22964.7 20946.6 21201.2 22293.4 22342.8 22359.3 11041.4 11412.5 11584.7 11711.4 11712.6 8468.1 8512.7 8689.0 8746.2 8747.9 17707.4 17852.0 18078.1 19128.9 20131.8 19281.5 19765.3 19832.3 19860.5 20016.0 11846.0 11913.4 11960.6 12054.7 12093.1 14193.2 14328.5 14334.9 14352.0 14369.5 11065.4 11075.9 11229.2 11263.7 11293.8 10965.6 10996.3 11096.3 11160.8 11307.3 10170.5 10256.6 10263.4 10268.0 10273.0 7127.0 7154.9 7222.6 7229.0 7280.0 6651.4 6661.5 6723.8 6756.9 6769.6 11:44:50 INFO - PID 15808 | 11:44:50 INFO - PID 15808 | [#4] prototype.html Cycles:180 Average:5596.08 Median:6288.39 stddev:1565.31 (24.9%) stddev-sans-first:1522.22 11:44:50 INFO - PID 15808 | Values: 498.8 501.9 525.2 529.8 533.9 6305.4 6338.9 6345.8 6409.7 6418.8 6130.3 6248.6 6290.8 6314.9 6351.7 5029.6 5067.1 5119.3 5131.2 5165.7 4861.1 5041.3 5087.3 5102.1 5117.3 4910.1 4943.1 5033.2 5049.2 5065.6 4924.0 4967.1 4982.5 5006.0 5051.4 4489.1 4508.5 4526.3 4526.6 4574.3 6226.0 6263.0 6285.9 6298.7 6360.4 5692.3 5734.5 5767.9 5788.9 5820.0 6548.5 6562.8 6563.1 6581.4 6623.2 4879.4 4903.1 4913.7 4930.5 4964.2 6905.6 6933.8 6963.2 7059.3 7066.9 4980.6 5039.7 5046.6 5053.4 5054.4 5109.7 5111.2 5145.4 5151.0 5187.2 5736.2 5779.4 5808.9 5822.2 5849.3 6552.0 6610.3 6625.4 6633.2 6707.2 1668.4 1703.7 1711.1 1714.6 1733.5 1423.5 1425.8 1430.4 1460.5 1464.3 5769.7 5782.6 5817.1 5817.3 5860.8 6566.4 6578.4 6637.9 6675.6 6712.8 5803.8 5803.9 5880.4 5888.1 5906.5 3539.9 3577.6 3605.8 3633.3 3671.2 6662.7 6676.4 6686.5 6697.9 6704.3 7175.0 7181.2 7182.6 7190.7 7210.2 6604.6 6632.9 6656.5 6698.8 6735.9 6797.4 6846.7 6858.6 6873.1 6895.9 6728.2 6774.2 6786.4 6811.6 6875.4 6597.2 6621.6 6627.1 6682.4 6695.4 5083.3 5096.9 5098.5 5110.2 5127.2 6910.8 6916.9 6942.0 6983.3 7020.9 6536.9 6587.5 6615.0 6615.0 6625.2 6527.2 6566.3 6567.6 6580.8 6592.2 6236.4 6315.6 6414.3 6454.7 6538.1 6601.3 6608.0 6624.3 6626.7 6666.0 6323.9 6334.1 6399.2 6437.7 6516.4 11:44:50 INFO - PID 15808 | 11:44:50 INFO - PID 15808 | [#5] yui.html Cycles:180 Average:24533.21 Median:19801.80 stddev:33871.08 (171.1%) stddev-sans-first:33919.68 11:44:50 INFO - PID 15808 | Values: 917.3 920.2 926.1 936.0 941.7 16305.4 16966.9 16990.5 17015.3 22886.5 21895.3 22063.2 22334.4 22421.6 22465.7 969.5 984.2 986.0 987.3 987.5 980.0 1008.6 1013.4 1017.9 1025.3 1068.5 1079.3 1079.6 1080.0 1080.1 1059.4 1070.1 1070.3 1070.8 1071.9 775.1 777.4 778.0 782.4 782.7 19862.8 19899.8 20177.9 20201.4 20433.0 21428.4 21772.1 22089.0 22236.0 22239.4 17594.3 17661.9 17727.0 17799.7 17826.9 3773.2 3798.4 3798.9 3800.7 3801.0 130942.3 131065.0 132100.0 133502.3 133600.3 16646.2 16653.4 16666.2 17129.1 17170.5 30646.8 31471.2 31574.5 31584.5 31647.7 7536.5 7930.0 8518.1 8779.6 8839.5 4366.2 4464.2 4475.9 4477.6 4482.4 5262.6 5321.8 5337.7 5379.8 5389.9 1096.7 1133.3 1146.4 1163.1 1164.1 684.1 710.9 713.2 717.9 733.7 11967.9 12106.4 12224.7 12375.2 12822.1 710.7 715.9 718.2 728.3 733.6 5601.4 5680.8 5685.6 5695.5 5717.3 114059.0 114128.9 114296.4 114373.0 116898.0 104885.5 105997.5 107195.0 107503.5 111649.0 88620.0 89664.0 90241.5 91560.0 91957.0 10490.9 10625.1 10664.9 10742.2 10944.5 40698.4 40744.6 42027.0 42379.0 42897.8 67007.0 67721.7 69389.7 69465.0 71650.6 16119.5 16159.5 17839.4 18215.5 18327.7 18599.3 18627.3 18638.2 20933.2 21575.8 18167.1 18602.8 19398.3 19458.7 19672.5 17455.4 18387.0 18501.4 18899.7 19740.8 17968.6 18059.9 18078.4 18602.3 18731.8 13137.1 13197.9 13204.1 13705.3 13753.9 13390.9 13446.4 13696.3 14361.9 14644.3 11:44:50 INFO - PID 15808 | -------- Summary: end -------- 11:44:50 INFO - PID 15808 | 11:44:51 INFO - TEST-INFO | 15808: exit 0 11:44:51 INFO - TEST-OK | dromaeo_css | took 1111399ms 11:44:51 INFO - TEST-START | kraken 11:44:51 INFO - Initialising browser for kraken test... 11:44:51 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55715/getInfo.html -profile /tmp/tmp0GEeDJ/profile 11:44:51 INFO - TEST-INFO | started process 16182 (/builds/slave/test/build/application/firefox/firefox http://localhost:55715/getInfo.html) 11:44:56 INFO - TEST-INFO | 16182: exit 0 11:44:56 INFO - Browser initialized. 11:44:56 INFO - Running cycle 1/1 for kraken test... 11:44:56 INFO - Using env: {'DISPLAY': ':0', 11:44:56 INFO - 'HOME': '/home/cltbld', 11:44:56 INFO - 'JSGC_DISABLE_POISONING': '1', 11:44:56 INFO - 'LANG': 'en_US.UTF-8', 11:44:56 INFO - 'LANGUAGE': 'en_US:en', 11:44:56 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:44:56 INFO - 'LOGNAME': 'cltbld', 11:44:56 INFO - 'MAIL': '/var/mail/cltbld', 11:44:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:44:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:44:56 INFO - 'MOZ_CRASHREPORTER': '1', 11:44:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:56 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:44:56 INFO - 'MOZ_NO_REMOTE': '1', 11:44:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:44:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:56 INFO - 'NO_EM_RESTART': '1', 11:44:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:56 INFO - 'PWD': '/builds/slave/test', 11:44:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:44:56 INFO - 'RUST_BACKTRACE': 'full', 11:44:56 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:44:56 INFO - 'SHELL': '/bin/bash', 11:44:56 INFO - 'SHLVL': '1', 11:44:56 INFO - 'STYLO_FORCE_ENABLED': '1', 11:44:56 INFO - 'TERM': 'linux', 11:44:56 INFO - 'TMOUT': '86400', 11:44:56 INFO - 'USER': 'cltbld', 11:44:56 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1504628098.915627-640288888', 11:44:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:56 INFO - '_': '/tools/buildbot/bin/python'} 11:44:56 INFO - TEST-INFO | started process 16378 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0GEeDJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:44:57 INFO - PID 16378 | 11:44:57 INFO - PID 16378 | (/builds/slave/test/build/application/firefox/firefox:16431): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:44:57 INFO - PID 16378 | 11:45:07 INFO - PID 16378 | RSS: Main: 172683264 11:45:07 INFO - PID 16378 | 11:45:10 INFO - PID 16378 | Cycle 1(1): loaded http://localhost:55715/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55715/tests/kraken/driver.html?testName=audio-beat-detection) 11:45:11 INFO - PID 16378 | RSS: Main: 178417664 11:45:11 INFO - PID 16378 | 11:45:14 INFO - PID 16378 | Cycle 1(1): loaded http://localhost:55715/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55715/tests/kraken/driver.html?testName=audio-dft) 11:45:14 INFO - PID 16378 | RSS: Main: 179146752 11:45:14 INFO - PID 16378 | 11:45:17 INFO - PID 16378 | Cycle 1(1): loaded http://localhost:55715/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55715/tests/kraken/driver.html?testName=audio-fft) 11:45:18 INFO - PID 16378 | RSS: Main: 173445120 11:45:18 INFO - PID 16378 | 11:45:20 INFO - PID 16378 | Cycle 1(1): loaded http://localhost:55715/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55715/tests/kraken/driver.html?testName=audio-oscillator) 11:45:21 INFO - PID 16378 | RSS: Main: 173940736 11:45:21 INFO - PID 16378 | 11:45:23 INFO - PID 16378 | Cycle 1(1): loaded http://localhost:55715/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55715/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:45:23 INFO - PID 16378 | RSS: Main: 174174208 11:45:23 INFO - PID 16378 | 11:45:26 INFO - PID 16378 | Cycle 1(1): loaded http://localhost:55715/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55715/tests/kraken/driver.html?testName=imaging-darkroom) 11:45:27 INFO - PID 16378 | RSS: Main: 176750592 11:45:27 INFO - PID 16378 | 11:45:31 INFO - PID 16378 | Cycle 1(1): loaded http://localhost:55715/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55715/tests/kraken/driver.html?testName=imaging-desaturate) 11:45:31 INFO - PID 16378 | RSS: Main: 176705536 11:45:31 INFO - PID 16378 | 11:45:34 INFO - PID 16378 | Cycle 1(1): loaded http://localhost:55715/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55715/tests/kraken/driver.html?testName=json-parse-financial) 11:45:35 INFO - PID 16378 | RSS: Main: 177102848 11:45:35 INFO - PID 16378 | 11:45:36 INFO - PID 16378 | Cycle 1(1): loaded http://localhost:55715/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55715/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:45:37 INFO - PID 16378 | RSS: Main: 176988160 11:45:37 INFO - PID 16378 | 11:45:39 INFO - PID 16378 | Cycle 1(1): loaded http://localhost:55715/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55715/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:45:39 INFO - PID 16378 | RSS: Main: 177426432 11:45:39 INFO - PID 16378 | 11:45:41 INFO - PID 16378 | Cycle 1(1): loaded http://localhost:55715/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55715/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:45:42 INFO - PID 16378 | RSS: Main: 174055424 11:45:42 INFO - PID 16378 | 11:45:45 INFO - PID 16378 | Cycle 1(1): loaded http://localhost:55715/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55715/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:45:45 INFO - PID 16378 | RSS: Main: 174354432 11:45:45 INFO - PID 16378 | 11:45:48 INFO - PID 16378 | Cycle 1(1): loaded http://localhost:55715/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55715/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:45:49 INFO - PID 16378 | RSS: Main: 174010368 11:45:49 INFO - PID 16378 | 11:45:51 INFO - PID 16378 | Cycle 1(1): loaded http://localhost:55715/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55715/tests/kraken/driver.html?testName=ai-astar) 11:45:51 INFO - PID 16378 | RSS: Main: 175693824 11:45:51 INFO - PID 16378 | 11:45:51 INFO - PID 16378 | __start_tp_report 11:45:51 INFO - PID 16378 | _x_x_mozilla_page_load 11:45:51 INFO - PID 16378 | _x_x_mozilla_page_load_details 11:45:51 INFO - PID 16378 | |i|pagename|runs| 11:45:51 INFO - PID 16378 | |0;ai-astar;98;107;101;107;106;107;111;99;107;111 11:45:51 INFO - PID 16378 | |1;audio-beat-detection;149;116;142;172;118;146;151;121;167;116 11:45:51 INFO - PID 16378 | |2;audio-dft;162;163;162;162;162;160;161;168;173;162 11:45:51 INFO - PID 16378 | |3;audio-fft;73;74;80;170;78;77;74;75;146;74 11:45:51 INFO - PID 16378 | |4;audio-oscillator;82;82;124;78;78;79;134;79;82;128 11:45:51 INFO - PID 16378 | |5;imaging-gaussian-blur;121;117;118;117;115;114;113;113;114;115 11:45:51 INFO - PID 16378 | |6;imaging-darkroom;148;147;148;147;147;148;149;148;150;148 11:45:51 INFO - PID 16378 | |7;imaging-desaturate;94;95;94;94;94;94;96;94;94;94 11:45:51 INFO - PID 16378 | |8;json-parse-financial;53;55;55;53;53;53;53;54;53;54 11:45:51 INFO - PID 16378 | |9;json-stringify-tinderbox;38;38;38;38;38;38;38;38;39;38 11:45:51 INFO - PID 16378 | |10;stanford-crypto-aes;83;75;74;75;75;74;75;76;74;77 11:45:51 INFO - PID 16378 | |11;stanford-crypto-ccm;121;133;124;125;117;124;125;119;122;155 11:45:51 INFO - PID 16378 | |12;stanford-crypto-pbkdf2;170;168;169;177;169;172;184;171;172;175 11:45:51 INFO - PID 16378 | |13;stanford-crypto-sha256-iterative;66;65;64;67;63;67;63;64;67;63 11:45:51 INFO - PID 16378 | __end_tp_report 11:45:51 INFO - PID 16378 | __start_cc_report 11:45:51 INFO - PID 16378 | _x_x_mozilla_cycle_collect,960 11:45:51 INFO - PID 16378 | __end_cc_report 11:45:51 INFO - PID 16378 | __startTimestamp1504637151545__endTimestamp 11:45:51 INFO - PID 16378 | 11:45:51 INFO - PID 16378 | ------- Summary: start ------- 11:45:51 INFO - PID 16378 | Number of tests: 14 11:45:51 INFO - PID 16378 | 11:45:51 INFO - PID 16378 | [#0] ai-astar Cycles:10 Average:105.40 Median:109.00 stddev:4.58 (4.2%) stddev-sans-first:3.99 11:45:51 INFO - PID 16378 | Values: 98.0 107.0 101.0 107.0 106.0 107.0 111.0 99.0 107.0 111.0 11:45:51 INFO - PID 16378 | 11:45:51 INFO - PID 16378 | [#1] audio-beat-detection Cycles:10 Average:139.80 Median:147.50 stddev:21.06 (14.3%) stddev-sans-first:22.07 11:45:51 INFO - PID 16378 | Values: 149.0 116.0 142.0 172.0 118.0 146.0 151.0 121.0 167.0 116.0 11:45:51 INFO - PID 16378 | 11:45:51 INFO - PID 16378 | [#2] audio-dft Cycles:10 Average:163.50 Median:162.00 stddev:3.95 (2.4%) stddev-sans-first:4.15 11:45:51 INFO - PID 16378 | Values: 162.0 163.0 162.0 162.0 162.0 160.0 161.0 168.0 173.0 162.0 11:45:51 INFO - PID 16378 | 11:45:51 INFO - PID 16378 | [#3] audio-fft Cycles:10 Average:92.10 Median:74.50 stddev:35.26 (47.3%) stddev-sans-first:36.71 11:45:51 INFO - PID 16378 | Values: 73.0 74.0 80.0 170.0 78.0 77.0 74.0 75.0 146.0 74.0 11:45:51 INFO - PID 16378 | 11:45:51 INFO - PID 16378 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:79.00 stddev:23.68 (30.0%) stddev-sans-first:24.67 11:45:51 INFO - PID 16378 | Values: 82.0 82.0 124.0 78.0 78.0 79.0 134.0 79.0 82.0 128.0 11:45:51 INFO - PID 16378 | 11:45:51 INFO - PID 16378 | [#5] imaging-gaussian-blur Cycles:10 Average:115.70 Median:116.00 stddev:2.54 (2.2%) stddev-sans-first:1.83 11:45:51 INFO - PID 16378 | Values: 121.0 117.0 118.0 117.0 115.0 114.0 113.0 113.0 114.0 115.0 11:45:51 INFO - PID 16378 | 11:45:51 INFO - PID 16378 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.94 (0.6%) stddev-sans-first:1.00 11:45:51 INFO - PID 16378 | Values: 148.0 147.0 148.0 147.0 147.0 148.0 149.0 148.0 150.0 148.0 11:45:51 INFO - PID 16378 | 11:45:51 INFO - PID 16378 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 11:45:51 INFO - PID 16378 | Values: 94.0 95.0 94.0 94.0 94.0 94.0 96.0 94.0 94.0 94.0 11:45:51 INFO - PID 16378 | 11:45:51 INFO - PID 16378 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:53.50 stddev:0.84 (1.6%) stddev-sans-first:0.87 11:45:51 INFO - PID 16378 | Values: 53.0 55.0 55.0 53.0 53.0 53.0 53.0 54.0 53.0 54.0 11:45:51 INFO - PID 16378 | 11:45:51 INFO - PID 16378 | [#9] json-stringify-tinderbox Cycles:10 Average:38.10 Median:38.00 stddev:0.32 (0.8%) stddev-sans-first:0.33 11:45:51 INFO - PID 16378 | Values: 38.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 39.0 38.0 11:45:51 INFO - PID 16378 | 11:45:51 INFO - PID 16378 | [#10] stanford-crypto-aes Cycles:10 Average:75.80 Median:75.00 stddev:2.70 (3.6%) stddev-sans-first:1.00 11:45:51 INFO - PID 16378 | Values: 83.0 75.0 74.0 75.0 75.0 74.0 75.0 76.0 74.0 77.0 11:45:51 INFO - PID 16378 | 11:45:51 INFO - PID 16378 | [#11] stanford-crypto-ccm Cycles:10 Average:126.50 Median:124.50 stddev:10.90 (8.8%) stddev-sans-first:11.37 11:45:51 INFO - PID 16378 | Values: 121.0 133.0 124.0 125.0 117.0 124.0 125.0 119.0 122.0 155.0 11:45:51 INFO - PID 16378 | 11:45:51 INFO - PID 16378 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.70 Median:172.00 stddev:4.85 (2.8%) stddev-sans-first:5.05 11:45:51 INFO - PID 16378 | Values: 170.0 168.0 169.0 177.0 169.0 172.0 184.0 171.0 172.0 175.0 11:45:51 INFO - PID 16378 | 11:45:51 INFO - PID 16378 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.50 stddev:1.73 (2.6%) stddev-sans-first:1.79 11:45:51 INFO - PID 16378 | Values: 66.0 65.0 64.0 67.0 63.0 67.0 63.0 64.0 67.0 63.0 11:45:51 INFO - PID 16378 | -------- Summary: end -------- 11:45:51 INFO - PID 16378 | 11:45:51 INFO - PID 16378 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:45:52 INFO - TEST-INFO | 16378: exit 0 11:45:52 INFO - TEST-OK | kraken | took 60932ms 11:45:52 INFO - SUITE-END | took 1172s 11:45:52 INFO - Completed test suite (00:19:32) 11:45:52 INFO - javascript benchmark 11:45:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8680.651302005033, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3341.9331613367735, 3368.5789276340456, 3386.627470978193, 3412.351653185893, 3423.6576342365765, 6432.195975503062, 6484.675766211694, 6491.058796474508, 6553.705083271247, 6554.508411869111, 6301.621902685842, 6354.110424540557, 6421.197350331208, 6430.324815894334, 6440.903386449207, 5794.971025144869, 5962.642241465504, 5993.130996005577, 6030.939690603103, 6039.909401358983, 5940.584159108864, 6019.0, 6045.879082418349, 6053.606515576495, 6057.0, 5797.449242321973, 5819.447152520504, 5855.326637436707, 5915.438033386865, 5958.076498142795, 5882.0588705807295, 5887.735051922631, 5978.551608629326, 5990.041593345044, 5990.101484777275, 5746.9712651436475, 5830.125481177814, 5830.3586605473365, 5911.290645122613, 5986.3714309997695, 6391.776287829904, 6432.0, 6463.93536064638, 6488.837779055514, 6525.543211975164, 6945.89581156283, 6946.895796563055, 7044.119485064367, 7045.048918396003, 7053.0830991971225, 7040.577565346096, 7059.470539709542, 7107.2182059973875, 7134.821629459305, 7159.642017899137, 6387.93612063878, 6488.221413430371, 6497.220333559956, 6580.012998050331, 6594.175728033996, 7243.239459856744, 7250.274972502708, 7314.08573928259, 7324.304191101837, 7334.706611735577, 6889.758858439931, 6896.862062758817, 6946.444284457332, 6956.2000369958105, 6981.197162326296, 6836.179658440919, 6934.722611095601, 7030.3321184487395, 7047.40097091753, 7152.249013853574, 6853.554518956252, 6868.244493105754, 6869.313068693091, 6879.071325371011, 6882.931170688329, 6765.560238584476, 6867.896981545281, 6869.896951545731, 6886.0, 6889.0355350251, 5406.567474602022, 5428.891422171534, 5501.9174712379345, 5504.91742623861, 5519.337679478408, 4826.617609241797, 4848.878778030577, 4906.705597664151, 4919.852404427873, 4922.458529561745, 6028.125921741411, 6035.094735789579, 6102.237220347457, 6103.572749907553, 6111.449969502677, 6816.0, 6857.314268573203, 6909.067275917687, 6940.167179938338, 7049.29507049291, 6028.849278767978, 6038.0, 6047.0627052806885, 6080.996635555084, 6097.908531372033, 5887.558433117533, 5966.820995370146, 5973.0, 5978.880422391528, 5987.191729116601, 6646.368594983469, 6665.166854143232, 6723.865522689519, 6734.326567343226, 6743.393094621508, 6766.8646627068165, 6907.620080895599, 6966.582005079711, 6985.650717464208, 7048.682809273698, 6736.93263067363, 6771.966140169267, 6779.220389655253, 6795.762148324785, 6802.489813263926, 6775.085363476065, 6796.490263230178, 6816.113905192492, 6836.931630683828, 6867.656617169221, 6868.896966545406, 6900.7929762107215, 6904.964255361736, 6971.65141742921, 6976.5814051157095, 6628.602283862983, 6628.7017084230365, 6663.267040625624, 6721.831954200989, 6729.629870356982, 6680.699368528525, 6680.866382672417, 6698.095757072733, 6705.765298214539, 6716.832079197864, 6759.526833121831, 6775.864482710417, 6785.457163427012, 6814.761483348258, 6844.007618895332, 6829.214640316229, 6838.179418469816, 6902.309769023058, 6970.756023539152, 6975.0, 6573.1783527059115, 6620.63586502747, 6704.06143139951, 6716.3955244028275, 6716.798496045127], "value": 6346.227255115589, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [840.9075001749807, 863.2058506174319, 887.6360692116237, 890.5858775669315, 1138.9487473063712, 30897.691023089763, 31371.84314078432, 31481.370372592533, 41669.0, 41982.58017419825, 42060.78969605155, 42464.57535424645, 42513.36229956545, 43129.568704313024, 43163.13673726524, 7324.0, 7930.405219608538, 7978.2420670036545, 8036.437449378546, 8040.798980025517, 7917.089534703525, 7979.640916158758, 8005.919940800605, 8009.639566219505, 8015.559144247064, 7971.681132754683, 8026.398020148483, 8030.076541197778, 8034.0, 8040.959795201015, 7964.8805267921025, 7997.520148791091, 7998.480098793589, 8003.839923201504, 8005.119436861912, 7219.278072192791, 7255.347018768336, 7271.163816161156, 7275.67259473325, 7281.053463049822, 38097.61902380968, 38313.42529862055, 38337.42493862594, 38355.808220958716, 38376.23247535062, 3583.6953858922025, 3592.2456284180353, 3617.819109044537, 3619.5294611700574, 3623.1847834237087, 31856.362872742648, 31981.52027719563, 32039.0, 32048.839755801073, 32057.51913721296, 4978.377702787152, 5054.494550544953, 5156.819511317123, 5194.194899790538, 5209.661372010807, 187732.0, 189284.0, 189499.0, 189823.99999999863, 189953.0, 47842.0, 47890.28164577534, 47900.520994790306, 47947.76026119847, 48018.75990620095, 50787.23819142716, 50812.49187508078, 50867.0, 50927.0, 51063.0, 14432.783508247385, 15272.236388180547, 15505.689886202214, 15522.5343239703, 15535.300911459011, 12008.879911200776, 12328.445219965122, 12674.746505069847, 12690.682732931751, 12773.361331933365, 14118.71762564743, 14177.0, 14185.929070354583, 14188.85811141896, 14303.0, 5642.887142257132, 5685.545156387562, 5762.481376676035, 5768.077107662753, 5860.472557469848, 997.1574019953129, 1006.2453160129902, 1017.5217647705566, 1020.1074060197327, 1021.3514418344405, 22628.434289142904, 28663.0, 28814.42371152565, 28876.566851497246, 28908.27729306784, 1073.63496411219, 1081.5835903177333, 1091.252492042953, 1099.796537640539, 1103.773726386089, 12012.519499219934, 12160.331181785086, 12245.510179592717, 12280.754384912252, 12445.875541244472, 230850.0, 232851.0, 233162.0, 233273.0, 233323.0, 46352.07295854064, 46482.302765458546, 46545.534544654794, 46607.0, 46621.0, 1407.838098618672, 1431.7637589797566, 1445.6891768269873, 1449.8332691740375, 1454.763451066585, 21890.23384181546, 22249.777502225417, 22420.439489012904, 22472.32583022512, 22861.31416057521, 37424.438633421065, 37511.81244093762, 37521.0, 37734.62265377421, 37805.0, 200902.0, 202186.0, 202959.0, 203160.0, 203292.0, 33317.666823331456, 36382.8180859094, 38050.0, 38361.808190958865, 38433.2313353737, 45134.0, 45309.0, 45383.319250211935, 45686.77156614196, 46188.53811461842, 33876.49185262174, 33883.15292117717, 34038.14904627404, 34198.0, 34499.48250776291, 32621.0, 33111.0, 33147.83426082854, 33295.83352083224, 33797.49303760396, 37927.81036094802, 38134.2373152541, 38212.808935955145, 38220.61779382282, 38229.4265586022, 32517.512237315987, 33167.33665326728, 33363.0, 33410.33179336448, 33440.66559334376, 23226.187083451998, 23585.882070589538, 23729.16947906815, 23857.52284954326, 24078.157264495658], "value": 17305.052747359787, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.2143520506494, 570.2273419516553, 570.4751628501778, 577.1746402644219, 585.3619554685392, 22426.55146897061, 22608.321750347495, 23489.177878774248, 23527.64708529369, 23557.882210588967, 25513.872430637868, 26104.60843087355, 26107.086251981185, 26233.606495902575, 26292.0, 6475.90286145707, 6613.6693165341785, 6621.139251897247, 6632.336766323353, 6641.169853768279, 6391.616503009835, 6540.93459065408, 6583.934160658404, 6625.370589793962, 6687.665616719169, 6630.4032637062655, 6633.369829866155, 6636.0, 6638.236602790668, 6668.76659316924, 6653.068570400148, 6653.534252602296, 6654.334566543355, 6655.600663960129, 6655.966720166392, 6131.233595800525, 6159.5072394208355, 6173.567850250484, 6179.0, 6181.07283907413, 28890.27774305659, 29266.70733292661, 29758.256043598867, 30285.545716814264, 30594.0, 2052.4560991337157, 2090.602785470756, 2091.1217288738767, 2094.7695753467106, 2095.612311722321, 19090.904545477322, 19676.901615491974, 19701.0, 19714.0, 19729.605407891762, 2393.628987506939, 2429.5019520998153, 2467.9012839486577, 2474.072222916406, 2485.7141428735745, 140031.29984350014, 141666.29166854202, 142132.0, 142524.0, 143682.0, 14449.277536123152, 14588.854111458963, 14722.852771472148, 15003.474878379204, 15182.013169143971, 23091.88454057719, 23288.4177895554, 23293.301200963997, 23309.18417855401, 23323.06707731672, 9094.181523662903, 9120.543972801333, 9224.0, 9411.200047995997, 9474.052594740471, 8328.208820162075, 8351.8329633407, 8435.367347448842, 8461.746147615582, 8494.787630309293, 7867.291943725092, 9111.544422778834, 9269.258459323239, 9328.34701570897, 9399.812003759887, 2593.286846117295, 2648.549746543092, 2652.0, 2671.6126161706834, 2748.2717079973822, 973.6251543155794, 981.2052237687496, 981.6809536900536, 985.1626117799813, 987.2250283527396, 19065.714014289795, 19107.016441825584, 19228.327008554912, 19882.0, 19937.102830372667, 1032.1587905856702, 1037.9896201038043, 1046.6336782126195, 1048.6434612231878, 1059.7850492470773, 10406.739831504121, 10902.236843420884, 12908.483660653657, 14054.789178162337, 14206.85793142076, 498192.0, 505629.0, 507910.0, 508005.0, 508497.0, 126780.0, 130541.34729326292, 131430.0, 131834.34082829524, 133133.3373332528, 1235.092207227687, 1258.9118761686593, 1284.7944328907518, 1287.1955028107434, 1288.6391810293132, 20439.284625038053, 20619.659722118013, 20816.791832081486, 20837.37487875366, 20903.686444703646, 54150.45849541454, 59871.700641496514, 60128.69935650294, 60636.09045864228, 62949.0, 73063.63468182625, 73445.6327718358, 73612.63193683997, 74065.62967185346, 74326.62836685783, 14251.57245282643, 14374.784378234544, 14912.179830109448, 14914.85085149178, 15071.773923391378, 24016.63975040411, 24231.273061808173, 24262.15082472105, 24403.877980609985, 24469.877650612347, 18775.436736897915, 19125.139368728163, 19325.903370483058, 19372.4188274352, 19451.51371215731, 16507.422240221535, 17035.659286814443, 17403.912980435016, 17447.0, 17849.196786144916, 16068.758968615246, 16213.432529861399, 16407.0, 16410.589735256715, 16413.58966025859, 14651.853481465048, 14661.340239689027, 14734.0, 14805.333759981042, 14829.110253384832, 16272.430464934145, 16395.180240988142, 16435.67128657444, 16439.67120657604, 17879.28482860671], "value": 12116.968271944754, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1373.2241283674723, 1398.8810951069158, 1426.2227086238001, 1434.1610158057536, 1449.311577000924, 12798.0, 13386.263755493455, 13388.7322253555, 15625.453109141183, 16001.83998160021, 15332.540023799276, 15748.0, 15753.212339383013, 15761.290741916613, 15771.21143942801, 2744.5745909384077, 2801.523740964036, 2861.1702606244266, 2862.4275144970984, 2864.183707643322, 2757.5725762506845, 2798.4263226038615, 2804.957925631117, 2823.4635419270376, 2823.477656633519, 2739.7260273972543, 2753.490604238222, 2774.611554382388, 2774.8473833939124, 2774.8473833939124, 2663.8934442622367, 2683.932901677464, 2695.164499005295, 2699.419624780662, 2705.864706764664, 2643.312738687955, 2692.192342297303, 2693.892244310225, 2694.191742477249, 2695.501332253539, 15174.772378414333, 15444.768328475082, 15528.689426211526, 15566.610834729108, 15573.0, 8087.838243235103, 8402.663893444254, 8407.915920840836, 8408.2432581068, 8414.326853851677, 5065.214891691757, 5639.971800141014, 5670.149477578396, 5785.739641716133, 5788.913166302509, 1866.4680566038749, 1947.8799690178205, 1950.2589016173763, 1987.1058023889307, 1987.8608497405187, 26110.216693499224, 26777.0, 27478.0, 27524.862375688193, 27549.86225068882, 6681.9331806682285, 6721.764738234138, 6785.660716964132, 6831.6242606657115, 6964.268751781091, 16983.83016169847, 17299.82700172982, 17582.824171758373, 17591.648167036587, 17606.823931760773, 7912.762617121495, 8110.0673422557165, 8132.146124656944, 8167.224113709188, 8172.6322315495945, 7148.106486689164, 7234.746783862644, 7427.888581671279, 7516.962415187999, 7585.241475852371, 5288.8413347599635, 5369.570434365241, 5393.110136827458, 5401.513863752281, 5428.050091234098, 1520.6198450387403, 1535.1710076558757, 1540.822805377396, 1551.945681901128, 1553.5086317135451, 860.1398601398602, 878.9296856251484, 888.2139306713605, 898.4429653614801, 904.2268860124499, 7818.960905195438, 7924.366050715929, 8020.11778704342, 8131.79670508242, 8136.633851476698, 706.7349743846057, 710.8187412209853, 719.4352433339908, 720.9423246140296, 722.7325889420948, 4830.203016502238, 4946.35697359341, 5657.886842263131, 5669.801556945487, 5887.20522729426, 20901.37295881126, 21842.89078554597, 22052.338429847132, 22509.88745056264, 22964.65553016706, 20946.581068378546, 21201.15195392167, 22293.442663933532, 22342.776572234394, 22359.32922012342, 11041.44792760375, 11412.543498260142, 11584.710382240342, 11711.355875426763, 11712.648620541397, 8468.068512463748, 8512.74461766148, 8688.956555217184, 8746.169113934166, 8747.91252087471, 17707.38024169148, 17852.0, 18078.09609519545, 19128.904355478135, 20131.798682013577, 19281.5179620505, 19765.308214212433, 19832.305869294505, 19860.50348741293, 20016.0, 11846.0, 11913.404329783649, 11960.58137965167, 12054.698632534257, 12093.09301802386, 14193.219372934587, 14328.498502552779, 14334.856651433769, 14352.0, 14369.497067602584, 11065.446727663746, 11075.889241107487, 11229.21395502307, 11263.66209013731, 11293.830592540955, 10965.61620343284, 10996.28524145928, 11096.278741881752, 11160.776784464102, 11307.321560706056, 10170.542325595217, 10256.641017564349, 10263.384196948207, 10268.0, 10273.02406271403, 7126.964365178141, 7154.856902861809, 7222.6388680566815, 7228.96385518069, 7279.963600181965, 6651.401373876374, 6661.46708263328, 6723.7646682365885, 6756.898646520404, 6769.627670478171], "value": 6706.212356873587, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.7630875334219, 501.90584525733897, 525.1885836382788, 529.7774934527498, 533.8932213557287, 6305.432511074003, 6338.936610633892, 6345.842413579382, 6409.711562979665, 6418.775342863, 6130.264368275802, 6248.625082495054, 6290.842728931779, 6314.873702525947, 6351.745930162788, 5029.647924645276, 5067.113255180348, 5119.308893299412, 5131.153359695646, 5165.690058596496, 4861.1492988727005, 5041.344625198737, 5087.313212716292, 5102.107131252016, 5117.283580298743, 4910.140725373046, 4943.0702591439895, 5033.194688849785, 5049.166887463564, 5065.6200784941275, 4923.950760492385, 4967.0810899983435, 4982.501749824988, 5005.974970125162, 5051.368578927634, 4489.147062058199, 4508.526604706524, 4526.3210518422175, 4526.615237704799, 4574.336721175444, 6226.003839385677, 6262.96868515659, 6285.937140628581, 6298.716557754912, 6360.363963603649, 5692.316921969349, 5734.512566431817, 5767.942320576783, 5788.913166302509, 5819.970900145472, 6548.476121910236, 6562.770303039419, 6563.146790917151, 6581.374769396947, 6623.238327592292, 4879.39007624047, 4903.141950158708, 4913.656044076916, 4930.534732633683, 4964.205727083686, 6905.620190889549, 6933.757318493828, 6963.224377783633, 7059.258777828357, 7066.858662826715, 4980.626453016038, 5039.672421292605, 5046.571041461517, 5053.393592768891, 5054.368203974504, 5109.667871588409, 5111.211076123402, 5145.434002259748, 5150.97424512875, 5187.247849061865, 5736.1682556029145, 5779.3642699303045, 5808.94191058084, 5822.184894114827, 5849.268841394825, 6551.9844424114335, 6610.272869984298, 6625.4037136657935, 6633.2040155181685, 6707.1616047994, 1668.357682292302, 1703.744438334235, 1711.1016716224083, 1714.6227829877407, 1733.5232810977081, 1423.4519709911551, 1425.7647488164544, 1430.370636919752, 1460.4596299369302, 1464.2605484230396, 5769.68266745333, 5782.595218334676, 5817.127430885316, 5817.272840894888, 5860.824175274749, 6566.376194261537, 6578.440832529192, 6637.86724265512, 6675.59678515734, 6712.765053223114, 5803.82588522345, 5803.912941305884, 5880.441358070976, 5888.057910734262, 5906.49794767441, 3539.911502212465, 3577.624349443323, 3605.7656252343513, 3633.3459977204357, 3671.192337685705, 6662.700178491979, 6676.399124078856, 6686.465082793365, 6697.866042679119, 6704.3295670433545, 7175.0, 7181.245969173266, 7182.569045857265, 7190.712371505186, 7210.1708303545765, 6604.5707029043915, 6632.933670663425, 6656.534042617067, 6698.765543205965, 6735.898961515679, 6797.354251346114, 6846.657667116525, 6858.588484690935, 6873.113292417297, 6895.931040689729, 6728.158980127484, 6774.153230846145, 6786.355296246848, 6811.557248778813, 6875.418653709575, 6597.208334999831, 6621.602703837785, 6627.117204016268, 6682.365175308338, 6695.363940425652, 5083.313752643346, 5096.872578185575, 5098.46466121052, 5110.1568241239775, 5127.17965125593, 6910.818954532436, 6916.896246556406, 6941.965290173517, 6983.266756990442, 7020.929790702232, 6536.869262614626, 6587.505937054836, 6614.966925165343, 6615.0, 6625.238097618835, 6527.249366322933, 6566.277709451861, 6567.605943643397, 6580.769673061612, 6592.208934927839, 6236.376362363727, 6315.621062736251, 6414.262359828679, 6454.709538070892, 6538.117354157318, 6601.273859875314, 6607.9669601651685, 6624.304448032887, 6626.6686665667485, 6665.966670166618, 6323.905141422791, 6334.081558174131, 6399.232092148785, 6437.67811609427, 6516.446102081376], "value": 5143.876107247406, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [917.2616044084509, 920.2499962530537, 926.05079793212, 936.0265324062975, 941.6751220828816, 16305.429309974154, 16966.915165424154, 16990.49028529146, 17015.31938722451, 22886.54226915465, 21895.343139705794, 22063.227787027456, 22334.441638959033, 22421.55156896865, 22465.663015054786, 969.4716379573132, 984.2175470500933, 985.960561577536, 987.3335498538494, 987.4618333008492, 979.9608015679399, 1008.5915204342253, 1013.3970287678856, 1017.9338343007681, 1025.2566889005486, 1068.4550879051662, 1079.266099052644, 1079.5951518180682, 1079.9676009719722, 1080.1358912869712, 1059.4332032362688, 1070.1118072000222, 1070.3310430980637, 1070.8072546941548, 1071.935683858967, 775.1086250811555, 777.3509119884903, 778.0119248554304, 782.4092809928525, 782.6556315221285, 19862.801371986385, 19899.80100198994, 20177.8991105045, 20201.393958181132, 20433.0, 21428.357149285548, 21772.12911483539, 22089.0, 22236.0, 22239.44401389978, 17594.29622815086, 17661.911690441466, 17727.0, 17799.73300400495, 17826.91086544572, 3773.2076263984595, 3798.4302354647025, 3798.90502737431, 3800.7339486235974, 3800.9809950950344, 130942.34528827391, 131065.0, 132100.0, 133502.3324883379, 133600.33199834035, 16646.16769161537, 16653.41713040038, 16666.166691665367, 17129.14354282281, 17170.484885453207, 30646.846765766473, 31471.21321966969, 31574.526382104286, 31584.52623210654, 31647.683523164935, 7536.5101268417375, 7929.960350198212, 8518.063013068557, 8779.648814047367, 8839.51382673959, 4366.214081465303, 4464.2187617166865, 4475.910481790346, 4477.619402350771, 4482.439695038121, 5262.55268302191, 5321.840344789663, 5337.706426146599, 5379.838604841861, 5389.892202155935, 1096.6874440784338, 1133.3143448213712, 1146.358039497884, 1163.1160318158093, 1164.0803765025705, 684.0867441965032, 710.9395701365338, 713.1549114299571, 717.9174394944544, 733.6661818872507, 11967.880321196677, 12106.394680265952, 12224.694382640506, 12375.195612285173, 12822.1024528284, 710.7228181009307, 715.8854583266757, 718.192033961793, 728.3481284250566, 733.5671953547433, 5601.411851755588, 5680.801171958961, 5685.60200785941, 5695.487406133468, 5717.256756621613, 114059.0, 114128.85871141183, 114296.42851785854, 114373.0, 116898.0, 104885.47557262165, 105997.47001264944, 107195.0, 107503.46248268709, 111649.0, 88620.0, 89664.0, 90241.54879225693, 91560.0, 91957.0, 10490.895091049297, 10625.149988000787, 10664.89335106639, 10742.19433542503, 10944.452777361259, 40698.38952415657, 40744.59255407408, 42027.0, 42379.0, 42897.785511072245, 67007.0, 67721.66139169273, 69389.65305173442, 69465.0, 71650.64174679093, 16119.516414507583, 16159.515214543582, 17839.375621853174, 18215.45353639393, 18327.72508412348, 18599.256029758657, 18627.348042818438, 18638.16128274258, 20933.16267349289, 21575.784242157377, 18167.091645417942, 18602.81397186011, 19398.32105876344, 19458.708119378505, 19672.508187295432, 17455.38906138279, 18386.988715620235, 18501.35245266409, 18899.716504252174, 19740.802591973898, 17968.640627187644, 18059.909700451415, 18078.367257145936, 18602.34891778781, 18731.812681873005, 13137.146085504412, 13197.868021319664, 13204.141730787467, 13705.314734263446, 13753.931230343784, 13390.93304533471, 13446.394912229169, 13696.315184240948, 14361.856381436051, 14644.267786610413], "value": 9320.486409091294, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1485.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 107.0, 101.0, 107.0, 106.0, 107.0, 111.0, 99.0, 107.0, 111.0], "value": 105.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 116.0, 142.0, 172.0, 118.0, 146.0, 151.0, 121.0, 167.0, 116.0], "value": 139.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 162.0, 162.0, 160.0, 161.0, 168.0, 173.0, 162.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 80.0, 170.0, 78.0, 77.0, 74.0, 75.0, 146.0, 74.0], "value": 92.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 124.0, 78.0, 78.0, 79.0, 134.0, 79.0, 82.0, 128.0], "value": 94.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 117.0, 118.0, 117.0, 115.0, 114.0, 113.0, 113.0, 114.0, 115.0], "value": 115.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 147.0, 147.0, 148.0, 149.0, 148.0, 150.0, 148.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 96.0, 94.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 55.0, 53.0, 53.0, 53.0, 53.0, 54.0, 53.0, 54.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 39.0, 38.0], "value": 38.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 75.0, 74.0, 75.0, 75.0, 74.0, 75.0, 76.0, 74.0, 77.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 133.0, 124.0, 125.0, 117.0, 124.0, 125.0, 119.0, 122.0, 155.0], "value": 126.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 168.0, 169.0, 177.0, 169.0, 172.0, 184.0, 171.0, 172.0, 175.0], "value": 172.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 64.0, 67.0, 63.0, 67.0, 63.0, 64.0, 67.0, 63.0], "value": 64.9, "unit": "score"}]}]} 11:45:52 INFO - Return code: 0 11:45:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:45:52 INFO - # TBPL SUCCESS # 11:45:52 INFO - Running post-action listener: _package_coverage_data 11:45:52 INFO - Running post-action listener: _resource_record_post_action 11:45:52 INFO - [mozharness: 2017-09-05 18:45:52.835942Z] Finished run-tests step (success) 11:45:52 INFO - Running post-run listener: _resource_record_post_run 11:45:52 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 147456; Write bytes: 391880704; Read time: 40; Write time: 221792 11:45:52 INFO - TinderboxPrint: CPU usage
13.1% 11:45:52 INFO - TinderboxPrint: I/O read bytes / time
147,456 / 40 11:45:52 INFO - TinderboxPrint: I/O write bytes / time
391,880,704 / 221,792 11:45:52 INFO - TinderboxPrint: CPU idle
8,244.5 (86.9%) 11:45:52 INFO - TinderboxPrint: CPU user
1,194.0 (12.6%) 11:45:52 INFO - TinderboxPrint: Swap in / out
0 / 0 11:45:52 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 106311680; Read time: 0; Write time: 71460 11:45:52 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:45:52 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 147456; Write bytes: 285155328; Read time: 40; Write time: 150300 11:45:53 INFO - Running post-run listener: _upload_blobber_files 11:45:53 INFO - Blob upload gear active. 11:45:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:45:53 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 11:45:53 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'] 11:45:53 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 11:45:53 INFO - (blobuploader) - INFO - Open directory for files ... 11:45:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:45:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:54 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:45:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:54 INFO - (blobuploader) - INFO - Done attempting. 11:45:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:45:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:45:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:56 INFO - (blobuploader) - INFO - Done attempting. 11:45:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:45:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:45:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:56 INFO - (blobuploader) - INFO - Done attempting. 11:45:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:45:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:46:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:46:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:46:04 INFO - (blobuploader) - INFO - Done attempting. 11:46:04 INFO - (blobuploader) - INFO - Iteration through files over. 11:46:04 INFO - Return code: 0 11:46:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:46:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:46:04 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/59efb6d52e6daa8d7e5ef127210247be0d572a25dfe3eb0b9c69cb8e3f9c8c3ab972943196ac8a6a6e8764d6872762b9d7a36141adad2cf35078fe8c49d50d2c", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c66144aec7b2f4cea0ff32b0551d5459dee0c67542d793a6bdf1ab0b6a0a41297634ee7c5fbef2f5eaf2f5416a8b14a0014731866caa452b3359d2f67b712414", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c664b468ae02d2494d71e0d76dd4b2c5fff5c10bf7dc9b3f9108bbc51696293f8a48f44c05e47e4fdbe9bb6d11446272bb75a941583c7756e4a34ca94ddb8f1c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58b0944272a3a56d05fa32165cce0f7b2cddeaa84c7649e3fc27c6712acbbff636ba77393fabda549b7d37ba096677f93c61b02eda8e9b22457d1b12bd6bee10"} 11:46:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:46:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:46:04 INFO - Contents: 11:46:04 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/59efb6d52e6daa8d7e5ef127210247be0d572a25dfe3eb0b9c69cb8e3f9c8c3ab972943196ac8a6a6e8764d6872762b9d7a36141adad2cf35078fe8c49d50d2c", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c66144aec7b2f4cea0ff32b0551d5459dee0c67542d793a6bdf1ab0b6a0a41297634ee7c5fbef2f5eaf2f5416a8b14a0014731866caa452b3359d2f67b712414", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c664b468ae02d2494d71e0d76dd4b2c5fff5c10bf7dc9b3f9108bbc51696293f8a48f44c05e47e4fdbe9bb6d11446272bb75a941583c7756e4a34ca94ddb8f1c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58b0944272a3a56d05fa32165cce0f7b2cddeaa84c7649e3fc27c6712acbbff636ba77393fabda549b7d37ba096677f93c61b02eda8e9b22457d1b12bd6bee10"} 11:46:04 INFO - Running post-run listener: copy_logs_to_upload_dir 11:46:04 INFO - Copying logs to upload dir... 11:46:04 INFO - mkdir: /builds/slave/test/build/upload/logs 11:46:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.219955 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-09-05 11:46:04.568683) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-05 11:46:04.575833) ========= 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=00204705a9daa57ed339a427000001b9-1504628098.915627-640288888 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/59efb6d52e6daa8d7e5ef127210247be0d572a25dfe3eb0b9c69cb8e3f9c8c3ab972943196ac8a6a6e8764d6872762b9d7a36141adad2cf35078fe8c49d50d2c", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c66144aec7b2f4cea0ff32b0551d5459dee0c67542d793a6bdf1ab0b6a0a41297634ee7c5fbef2f5eaf2f5416a8b14a0014731866caa452b3359d2f67b712414", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c664b468ae02d2494d71e0d76dd4b2c5fff5c10bf7dc9b3f9108bbc51696293f8a48f44c05e47e4fdbe9bb6d11446272bb75a941583c7756e4a34ca94ddb8f1c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58b0944272a3a56d05fa32165cce0f7b2cddeaa84c7649e3fc27c6712acbbff636ba77393fabda549b7d37ba096677f93c61b02eda8e9b22457d1b12bd6bee10"} build_url:https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011279 build_url: 'https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/59efb6d52e6daa8d7e5ef127210247be0d572a25dfe3eb0b9c69cb8e3f9c8c3ab972943196ac8a6a6e8764d6872762b9d7a36141adad2cf35078fe8c49d50d2c", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c66144aec7b2f4cea0ff32b0551d5459dee0c67542d793a6bdf1ab0b6a0a41297634ee7c5fbef2f5eaf2f5416a8b14a0014731866caa452b3359d2f67b712414", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c664b468ae02d2494d71e0d76dd4b2c5fff5c10bf7dc9b3f9108bbc51696293f8a48f44c05e47e4fdbe9bb6d11446272bb75a941583c7756e4a34ca94ddb8f1c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58b0944272a3a56d05fa32165cce0f7b2cddeaa84c7649e3fc27c6712acbbff636ba77393fabda549b7d37ba096677f93c61b02eda8e9b22457d1b12bd6bee10"}' ========= master_lag: 0.08 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-05 11:46:04.663882) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-05 11:46:04.664216) ========= 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=00204705a9daa57ed339a427000001b9-1504628098.915627-640288888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004796 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-05 11:46:04.718338) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-05 11:46:04.718684) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-05 11:46:04.718997) ========= ========= Total master_lag: 0.30 =========