builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-023 starttime: 1504140930.21 results: success (0) revision: d9b405d82cffb07343a5f2fd941e029298c7f6c4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-30 17:55:30.210384) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-30 17:55:30.210840) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-30 17:55:30.211132) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-30 17:55:30.225638) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 17:55:30.225978) ========= 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=6d15e502d8e29d5d2676d664000001c3-1504140929.173484-2013152947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-30 17:55:30-- 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% 39.5M=0s 2017-08-30 17:55:30 (39.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.193777 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 17:55:30.438250) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 17:55:30.438631) ========= 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=6d15e502d8e29d5d2676d664000001c3-1504140929.173484-2013152947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014196 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 17:55:30.491243) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 17:55:30.491678) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d9b405d82cffb07343a5f2fd941e029298c7f6c4 --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 d9b405d82cffb07343a5f2fd941e029298c7f6c4 --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=6d15e502d8e29d5d2676d664000001c3-1504140929.173484-2013152947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-30 17:55:30,493 truncating revision to first 12 chars 2017-08-30 17:55:30,493 Setting DEBUG logging. 2017-08-30 17:55:30,493 attempt 1/10 2017-08-30 17:55:30,493 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d9b405d82cff?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-30 17:55:30,968 unpacking tar archive at: mozilla-central-d9b405d82cff/testing/mozharness/ program finished with exit code 0 elapsedTime=0.817479 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 17:55:31.327176) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-30 17:55:31.327494) ========= script_repo_revision: d9b405d82cffb07343a5f2fd941e029298c7f6c4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-30 17:55:31.327864) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-30 17:55:31.328140) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-30 17:55:31.340279) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-08-30 17:55:31.340667) ========= /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=6d15e502d8e29d5d2676d664000001c3-1504140929.173484-2013152947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:55:31 INFO - MultiFileLogger online at 20170830 17:55:31 in /builds/slave/test 17:55:31 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 17:55:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:55:31 INFO - {'append_to_log': False, 17:55:31 INFO - 'base_work_dir': '/builds/slave/test', 17:55:31 INFO - 'blob_upload_branch': 'Firefox', 17:55:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:55:31 INFO - 'branch': 'Firefox', 17:55:31 INFO - 'buildbot_json_path': 'buildprops.json', 17:55:31 INFO - 'code_coverage': False, 17:55:31 INFO - 'config_files': ('talos/linux_config.py',), 17:55:31 INFO - 'default_actions': ('clobber', 17:55:31 INFO - 'read-buildbot-config', 17:55:31 INFO - 'download-and-extract', 17:55:31 INFO - 'populate-webroot', 17:55:31 INFO - 'create-virtualenv', 17:55:31 INFO - 'install', 17:55:31 INFO - 'setup-mitmproxy', 17:55:31 INFO - 'run-tests'), 17:55:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:55:31 INFO - 'disable_ccov_upload': False, 17:55:31 INFO - 'disable_stylo': False, 17:55:31 INFO - 'download_minidump_stackwalk': True, 17:55:31 INFO - 'download_symbols': 'ondemand', 17:55:31 INFO - 'enable_stylo': False, 17:55:31 INFO - 'enable_webrender': False, 17:55:31 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 17:55:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:55:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:55:31 INFO - 'gecko_profile': False, 17:55:31 INFO - 'gecko_profile_interval': 0, 17:55:31 INFO - 'installer_path': 'installer.exe', 17:55:31 INFO - 'log_level': 'info', 17:55:31 INFO - 'log_name': 'talos', 17:55:31 INFO - 'log_to_console': True, 17:55:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:55:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:55:31 INFO - 'opt_config_files': (), 17:55:31 INFO - 'pip_index': False, 17:55:31 INFO - 'suite': 'dromaeojs-e10s', 17:55:31 INFO - 'system_bits': '32', 17:55:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:55:31 INFO - 'title': 'talos-linux64-ix-023', 17:55:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:55:31 INFO - 'use_talos_json': True, 17:55:31 INFO - 'verify': 'False', 17:55:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:55:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:55:31 INFO - 'work_dir': 'build'} 17:55:31 INFO - [mozharness: 2017-08-31 00:55:31.482306Z] Running clobber step. 17:55:31 INFO - Running pre-action listener: _resource_record_pre_action 17:55:31 INFO - Running main action method: clobber 17:55:31 INFO - rmtree: /builds/slave/test/build 17:55:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:55:32 INFO - Running post-action listener: _resource_record_post_action 17:55:32 INFO - [mozharness: 2017-08-31 00:55:32.505083Z] Finished clobber step (success) 17:55:32 INFO - [mozharness: 2017-08-31 00:55:32.505180Z] Running read-buildbot-config step. 17:55:32 INFO - Running pre-action listener: _resource_record_pre_action 17:55:32 INFO - Running main action method: read_buildbot_config 17:55:32 INFO - Using buildbot properties: 17:55:32 INFO - { 17:55:32 INFO - "project": "", 17:55:32 INFO - "product": "firefox", 17:55:32 INFO - "who": "kwierso@gmail.com", 17:55:32 INFO - "installer_path": "public/build/target.tar.bz2", 17:55:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 17:55:32 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:55:32 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 17:55:32 INFO - "stage_platform": "linux64-qr", 17:55:32 INFO - "basedir": "/builds/slave/test", 17:55:32 INFO - "buildnumber": 24, 17:55:32 INFO - "platform": "ubuntu64_hw_qr", 17:55:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:55:32 INFO - "slavebuilddir": "test", 17:55:32 INFO - "taskId": "M2-tgm9CSG-LsFLNyL3yrw", 17:55:32 INFO - "branch": "mozilla-central", 17:55:32 INFO - "script_repo_revision": "production", 17:55:32 INFO - "revision": "d9b405d82cffb07343a5f2fd941e029298c7f6c4", 17:55:32 INFO - "slavename": "talos-linux64-ix-023", 17:55:32 INFO - "repo_path": "mozilla-central" 17:55:32 INFO - } 17:55:32 INFO - Finding installer, test and symbols from parent task. 17:55:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M2-tgm9CSG-LsFLNyL3yrw'}, attempt #1 17:55:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M2-tgm9CSG-LsFLNyL3yrw'}, attempt #1 17:55:33 INFO - Task dependencies: JjWT5fwtQZy7VNboNo6e0g 17:55:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g'}, attempt #1 17:55:33 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.tar.bz2 17:55:33 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.test_packages.json 17:55:33 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.crashreporter-symbols.zip 17:55:33 INFO - Running post-action listener: _resource_record_post_action 17:55:33 INFO - [mozharness: 2017-08-31 00:55:33.836523Z] Finished read-buildbot-config step (success) 17:55:33 INFO - [mozharness: 2017-08-31 00:55:33.836739Z] Running download-and-extract step. 17:55:33 INFO - Running pre-action listener: _resource_record_pre_action 17:55:33 INFO - Running main action method: download_and_extract 17:55:33 INFO - mkdir: /builds/slave/test/build/tests 17:55:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:55:33 INFO - trying https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.test_packages.json 17:55:33 INFO - Downloading https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:55:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:55:34 INFO - Downloaded 989 bytes. 17:55:34 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:55:34 INFO - Using the following test package requirements: 17:55:34 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:55:34 INFO - u'common': [u'target.common.tests.zip'], 17:55:34 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:55:34 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:55:34 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:55:34 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:55:34 INFO - u'mozbase': [u'target.common.tests.zip'], 17:55:34 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:55:34 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:55:34 INFO - u'web-platform': [u'target.common.tests.zip', 17:55:34 INFO - u'target.web-platform.tests.tar.gz'], 17:55:34 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:55:34 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:55:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.common.tests.zip 17:55:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:55:34 INFO - Fetch https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.common.tests.zip into memory 17:55:35 INFO - Content-Length response header: 54962746 17:55:35 INFO - Bytes received: 54962746 17:55:46 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:55:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.common.tests.zip 17:55:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:55:46 INFO - Fetch https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.common.tests.zip into memory 17:55:47 INFO - Content-Length response header: 54962746 17:55:47 INFO - Bytes received: 54962746 17:55:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.talos.tests.zip 17:55:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:55:59 INFO - Fetch https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.talos.tests.zip into memory 17:56:00 INFO - Content-Length response header: 14496650 17:56:00 INFO - Bytes received: 14496650 17:56:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:00 INFO - trying https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.tar.bz2 17:56:00 INFO - Downloading https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:56:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:56:01 INFO - Downloaded 62519587 bytes. 17:56:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.tar.bz2 17:56:01 INFO - mkdir: /builds/slave/test/properties 17:56:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:56:01 INFO - Writing to file /builds/slave/test/properties/build_url 17:56:01 INFO - Contents: 17:56:01 INFO - build_url:https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.tar.bz2 17:56:01 INFO - Running post-action listener: _resource_record_post_action 17:56:01 INFO - Running post-action listener: find_tests_for_verification 17:56:01 INFO - Running post-action listener: set_extra_try_arguments 17:56:01 INFO - [mozharness: 2017-08-31 00:56:01.851126Z] Finished download-and-extract step (success) 17:56:01 INFO - [mozharness: 2017-08-31 00:56:01.851222Z] Running populate-webroot step. 17:56:01 INFO - Running pre-action listener: _resource_record_pre_action 17:56:01 INFO - Running main action method: populate_webroot 17:56:01 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:56:01 INFO - 'chromez-stylo-e10s': {'talos_options': ['--enable-stylo'], 17:56:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:56:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:56:01 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--enable-stylo'], 17:56:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:56:01 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:56:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:56:01 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:56:01 INFO - 'talos_options': ['--enable-stylo'], 17:56:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:56:01 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:56:01 INFO - 'tests': ['damp', 'tps']}, 17:56:01 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:56:01 INFO - 'talos_options': ['--enable-stylo'], 17:56:01 INFO - 'tests': ['damp', 'tps']}, 17:56:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:56:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:56:01 INFO - 'g4-stylo-e10s': {'talos_options': ['--enable-stylo'], 17:56:01 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:56:01 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:56:01 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:56:01 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:56:01 INFO - 'talos_options': ['--enable-stylo'], 17:56:01 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:56:01 INFO - 'other-e10s': {'tests': ['a11yr', 17:56:01 INFO - 'ts_paint', 17:56:01 INFO - 'tpaint', 17:56:01 INFO - 'sessionrestore', 17:56:01 INFO - 'sessionrestore_many_windows', 17:56:01 INFO - 'sessionrestore_no_auto_restore', 17:56:01 INFO - 'tabpaint']}, 17:56:01 INFO - 'other-stylo-e10s': {'talos_options': ['--enable-stylo'], 17:56:01 INFO - 'tests': ['a11yr', 17:56:01 INFO - 'ts_paint', 17:56:01 INFO - 'tpaint', 17:56:01 INFO - 'sessionrestore', 17:56:01 INFO - 'sessionrestore_many_windows', 17:56:01 INFO - 'sessionrestore_no_auto_restore', 17:56:01 INFO - 'tabpaint']}, 17:56:01 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 17:56:01 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 17:56:01 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--enable-stylo'], 17:56:01 INFO - 'tests': ['bloom_basic_singleton']}, 17:56:01 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--enable-stylo'], 17:56:01 INFO - 'tests': ['bloom_basic']}, 17:56:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:56:01 INFO - 'tsvgr_opacity', 17:56:01 INFO - 'tart', 17:56:01 INFO - 'tscrollx', 17:56:01 INFO - 'tsvg_static']}, 17:56:01 INFO - 'svgr-stylo-e10s': {'talos_options': ['--enable-stylo'], 17:56:01 INFO - 'tests': ['tsvgx', 17:56:01 INFO - 'tsvgr_opacity', 17:56:01 INFO - 'tart', 17:56:01 INFO - 'tscrollx', 17:56:01 INFO - 'tsvg_static']}, 17:56:01 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:56:01 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:56:01 INFO - 'talos_options': ['--enable-stylo'], 17:56:01 INFO - 'tests': ['tp5o']}, 17:56:01 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:56:01 INFO - 'talos_options': ['--mitmproxy', 17:56:01 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:56:01 INFO - '--firstNonBlankPaint'], 17:56:01 INFO - 'tests': ['tp6_google', 17:56:01 INFO - 'tp6_youtube', 17:56:01 INFO - 'tp6_amazon', 17:56:01 INFO - 'tp6_facebook']}, 17:56:01 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:56:01 INFO - 'talos_options': ['--enable-stylo', 17:56:01 INFO - '--mitmproxy', 17:56:01 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:56:01 INFO - '--firstNonBlankPaint'], 17:56:01 INFO - 'tests': ['tp6_google', 17:56:01 INFO - 'tp6_youtube', 17:56:01 INFO - 'tp6_amazon', 17:56:01 INFO - 'tp6_facebook']}, 17:56:01 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:56:01 INFO - 'talos_options': ['--enable-stylo', 17:56:01 INFO - '--stylo-threads=1', 17:56:01 INFO - '--mitmproxy', 17:56:01 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:56:01 INFO - '--firstNonBlankPaint'], 17:56:01 INFO - 'tests': ['tp6_google', 17:56:01 INFO - 'tp6_youtube', 17:56:01 INFO - 'tp6_amazon', 17:56:01 INFO - 'tp6_facebook']}, 17:56:01 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:56:01 INFO - 'talos_options': ['--xperf_path', 17:56:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:56:01 INFO - 'tests': ['tp5n']}, 17:56:01 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:56:01 INFO - 'talos_options': ['--enable-stylo', 17:56:01 INFO - '--xperf_path', 17:56:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:56:01 INFO - 'tests': ['tp5n']}}} 17:56:01 INFO - Running post-action listener: _resource_record_post_action 17:56:01 INFO - [mozharness: 2017-08-31 00:56:01.865409Z] Finished populate-webroot step (success) 17:56:01 INFO - [mozharness: 2017-08-31 00:56:01.865498Z] Running create-virtualenv step. 17:56:01 INFO - Running pre-action listener: _resource_record_pre_action 17:56:01 INFO - Running main action method: create_virtualenv 17:56:01 INFO - Creating virtualenv /builds/slave/test/build/venv 17:56:01 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:56:01 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 17:56:01 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:56:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:56:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:56:02 INFO - Installing distribute.............................................................................................................................................................................................done. 17:56:02 INFO - Installing pip...............done. 17:56:02 INFO - Return code: 0 17:56:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:56:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:56:02 INFO - Reading from file tmpfile_stdout 17:56:02 INFO - Output received: 17:56:02 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 17:56:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:56: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')]} 17:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56: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')]} 17:56:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b1580>, '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 0x19b2480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b2910>, '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': '6d15e502d8e29d5d2676d664000001c3-1504140929.173484-2013152947', '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 17:56: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', 'pip>=1.5'] in /builds/slave/test/build 17:56: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 pip>=1.5 17:56:02 INFO - Using env: {'DISPLAY': ':0', 17:56:02 INFO - 'HOME': '/home/cltbld', 17:56:02 INFO - 'LANG': 'en_US.UTF-8', 17:56:02 INFO - 'LANGUAGE': 'en_US:en', 17:56:02 INFO - 'LOGNAME': 'cltbld', 17:56:02 INFO - 'MAIL': '/var/mail/cltbld', 17:56:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:02 INFO - 'MOZ_NO_REMOTE': '1', 17:56:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:02 INFO - 'NO_EM_RESTART': '1', 17:56:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:02 INFO - 'PWD': '/builds/slave/test', 17:56:02 INFO - 'SHELL': '/bin/bash', 17:56:02 INFO - 'SHLVL': '1', 17:56:02 INFO - 'TERM': 'linux', 17:56:02 INFO - 'TMOUT': '86400', 17:56:02 INFO - 'USER': 'cltbld', 17:56:02 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1504140929.173484-2013152947', 17:56:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:02 INFO - '_': '/tools/buildbot/bin/python'} 17:56:04 INFO - Ignoring indexes: http://pypi.python.org/simple/ 17:56:04 INFO - Downloading/unpacking pip>=1.5 17:56:04 INFO - Running setup.py egg_info for package pip 17:56:04 INFO - warning: no files found matching 'pip/cacert.pem' 17:56:04 INFO - warning: no files found matching '*.html' under directory 'docs' 17:56:04 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:56:04 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:56:04 INFO - Installing collected packages: pip 17:56:04 INFO - Found existing installation: pip 1.1 17:56:04 INFO - Uninstalling pip: 17:56:04 INFO - Successfully uninstalled pip 17:56:04 INFO - Running setup.py install for pip 17:56:04 INFO - warning: no files found matching 'pip/cacert.pem' 17:56:04 INFO - warning: no files found matching '*.html' under directory 'docs' 17:56:04 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:56:04 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:56:04 INFO - Installing pip script to /builds/slave/test/build/venv/bin 17:56:04 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 17:56:04 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 17:56:04 INFO - Successfully installed pip 17:56:04 INFO - Cleaning up... 17:56:04 INFO - Return code: 0 17:56:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:04 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 0x16451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b1580>, '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 0x19b2480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b2910>, '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': '6d15e502d8e29d5d2676d664000001c3-1504140929.173484-2013152947', '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 17:56:04 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 17:56:04 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 17:56:04 INFO - Using env: {'DISPLAY': ':0', 17:56:04 INFO - 'HOME': '/home/cltbld', 17:56:04 INFO - 'LANG': 'en_US.UTF-8', 17:56:04 INFO - 'LANGUAGE': 'en_US:en', 17:56:04 INFO - 'LOGNAME': 'cltbld', 17:56:04 INFO - 'MAIL': '/var/mail/cltbld', 17:56:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:04 INFO - 'MOZ_NO_REMOTE': '1', 17:56:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:04 INFO - 'NO_EM_RESTART': '1', 17:56:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:04 INFO - 'PWD': '/builds/slave/test', 17:56:04 INFO - 'SHELL': '/bin/bash', 17:56:04 INFO - 'SHLVL': '1', 17:56:04 INFO - 'TERM': 'linux', 17:56:04 INFO - 'TMOUT': '86400', 17:56:04 INFO - 'USER': 'cltbld', 17:56:04 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1504140929.173484-2013152947', 17:56:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:04 INFO - '_': '/tools/buildbot/bin/python'} 17:56:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:04 INFO - Downloading/unpacking psutil>=3.1.1 17:56:04 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 17:56:04 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 17:56:04 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 17:56:04 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 17:56:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:56:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:56:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:56:06 INFO - Installing collected packages: psutil 17:56:06 INFO - Running setup.py install for psutil 17:56:06 INFO - building 'psutil._psutil_linux' extension 17:56:06 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 17:56:06 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 17:56:06 INFO - building 'psutil._psutil_posix' extension 17:56:06 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 17:56:06 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 17:56:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:56:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:56:06 INFO - Successfully installed psutil 17:56:06 INFO - Cleaning up... 17:56:06 INFO - Return code: 0 17:56:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:56:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:06 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 0x16451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b1580>, '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 0x19b2480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b2910>, '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': '6d15e502d8e29d5d2676d664000001c3-1504140929.173484-2013152947', '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 17:56:06 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 17:56:06 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 17:56:06 INFO - Using env: {'DISPLAY': ':0', 17:56:06 INFO - 'HOME': '/home/cltbld', 17:56:06 INFO - 'LANG': 'en_US.UTF-8', 17:56:06 INFO - 'LANGUAGE': 'en_US:en', 17:56:06 INFO - 'LOGNAME': 'cltbld', 17:56:06 INFO - 'MAIL': '/var/mail/cltbld', 17:56:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:06 INFO - 'MOZ_NO_REMOTE': '1', 17:56:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:06 INFO - 'NO_EM_RESTART': '1', 17:56:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:06 INFO - 'PWD': '/builds/slave/test', 17:56:06 INFO - 'SHELL': '/bin/bash', 17:56:06 INFO - 'SHLVL': '1', 17:56:06 INFO - 'TERM': 'linux', 17:56:06 INFO - 'TMOUT': '86400', 17:56:06 INFO - 'USER': 'cltbld', 17:56:06 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1504140929.173484-2013152947', 17:56:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:06 INFO - '_': '/tools/buildbot/bin/python'} 17:56:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:56:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:56:08 INFO - Installing collected packages: mozsystemmonitor 17:56:08 INFO - Running setup.py install for mozsystemmonitor 17:56:08 INFO - Successfully installed mozsystemmonitor 17:56:08 INFO - Cleaning up... 17:56:08 INFO - Return code: 0 17:56:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:56:08 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')]} 17:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:08 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')]} 17:56:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:08 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 0x16451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b1580>, '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 0x19b2480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b2910>, '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': '6d15e502d8e29d5d2676d664000001c3-1504140929.173484-2013152947', '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 17:56:08 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 17:56:08 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 17:56:08 INFO - Using env: {'DISPLAY': ':0', 17:56:08 INFO - 'HOME': '/home/cltbld', 17:56:08 INFO - 'LANG': 'en_US.UTF-8', 17:56:08 INFO - 'LANGUAGE': 'en_US:en', 17:56:08 INFO - 'LOGNAME': 'cltbld', 17:56:08 INFO - 'MAIL': '/var/mail/cltbld', 17:56:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:08 INFO - 'MOZ_NO_REMOTE': '1', 17:56:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:08 INFO - 'NO_EM_RESTART': '1', 17:56:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:08 INFO - 'PWD': '/builds/slave/test', 17:56:08 INFO - 'SHELL': '/bin/bash', 17:56:08 INFO - 'SHLVL': '1', 17:56:08 INFO - 'TERM': 'linux', 17:56:08 INFO - 'TMOUT': '86400', 17:56:08 INFO - 'USER': 'cltbld', 17:56:08 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1504140929.173484-2013152947', 17:56:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:08 INFO - '_': '/tools/buildbot/bin/python'} 17:56:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:08 INFO - Downloading/unpacking jsonschema==2.5.1 17:56:08 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 17:56:08 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 17:56:08 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 17:56:08 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 17:56:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:56:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:10 INFO - Downloading functools32-3.2.3-2.tar.gz 17:56:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:56:10 INFO - warning: no files found matching '*.txt' 17:56:10 INFO - no previously-included directories found matching 'build' 17:56:10 INFO - no previously-included directories found matching 'dist' 17:56:10 INFO - no previously-included directories found matching '.git*' 17:56:10 INFO - Installing collected packages: jsonschema, functools32 17:56:10 INFO - Running setup.py install for functools32 17:56:10 INFO - warning: no files found matching '*.txt' 17:56:10 INFO - no previously-included directories found matching 'build' 17:56:10 INFO - no previously-included directories found matching 'dist' 17:56:10 INFO - no previously-included directories found matching '.git*' 17:56:10 INFO - Successfully installed jsonschema functools32 17:56:10 INFO - Cleaning up... 17:56:10 INFO - Return code: 0 17:56:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:56:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x16451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b1580>, '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 0x19b2480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b2910>, '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': '6d15e502d8e29d5d2676d664000001c3-1504140929.173484-2013152947', '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 17:56:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:56:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:56:10 INFO - Using env: {'DISPLAY': ':0', 17:56:10 INFO - 'HOME': '/home/cltbld', 17:56:10 INFO - 'LANG': 'en_US.UTF-8', 17:56:10 INFO - 'LANGUAGE': 'en_US:en', 17:56:10 INFO - 'LOGNAME': 'cltbld', 17:56:10 INFO - 'MAIL': '/var/mail/cltbld', 17:56:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:10 INFO - 'MOZ_NO_REMOTE': '1', 17:56:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:10 INFO - 'NO_EM_RESTART': '1', 17:56:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:10 INFO - 'PWD': '/builds/slave/test', 17:56:10 INFO - 'SHELL': '/bin/bash', 17:56:10 INFO - 'SHLVL': '1', 17:56:10 INFO - 'TERM': 'linux', 17:56:10 INFO - 'TMOUT': '86400', 17:56:10 INFO - 'USER': 'cltbld', 17:56:10 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1504140929.173484-2013152947', 17:56:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:10 INFO - '_': '/tools/buildbot/bin/python'} 17:56:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:56:10 INFO - Cleaning up... 17:56:10 INFO - Return code: 0 17:56:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:56:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x16451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b1580>, '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 0x19b2480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b2910>, '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': '6d15e502d8e29d5d2676d664000001c3-1504140929.173484-2013152947', '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 17:56:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:56:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:56:10 INFO - Using env: {'DISPLAY': ':0', 17:56:10 INFO - 'HOME': '/home/cltbld', 17:56:10 INFO - 'LANG': 'en_US.UTF-8', 17:56:10 INFO - 'LANGUAGE': 'en_US:en', 17:56:10 INFO - 'LOGNAME': 'cltbld', 17:56:10 INFO - 'MAIL': '/var/mail/cltbld', 17:56:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:10 INFO - 'MOZ_NO_REMOTE': '1', 17:56:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:10 INFO - 'NO_EM_RESTART': '1', 17:56:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:10 INFO - 'PWD': '/builds/slave/test', 17:56:10 INFO - 'SHELL': '/bin/bash', 17:56:10 INFO - 'SHLVL': '1', 17:56:10 INFO - 'TERM': 'linux', 17:56:10 INFO - 'TMOUT': '86400', 17:56:10 INFO - 'USER': 'cltbld', 17:56:10 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1504140929.173484-2013152947', 17:56:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:10 INFO - '_': '/tools/buildbot/bin/python'} 17:56:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:10 INFO - Downloading/unpacking blobuploader==1.2.4 17:56:10 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 17:56:10 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 17:56:10 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 17:56:10 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 17:56:11 INFO - Downloading blobuploader-1.2.4.tar.gz 17:56:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:56:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:56:11 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 17:56:11 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 17:56:11 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 17:56:11 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 17:56:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:56:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:56:12 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 17:56:12 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 17:56:12 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 17:56:12 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 17:56:12 INFO - Downloading docopt-0.6.1.tar.gz 17:56:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:56:12 INFO - Installing collected packages: blobuploader, requests, docopt 17:56:12 INFO - Running setup.py install for blobuploader 17:56:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:56:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:56:12 INFO - Running setup.py install for requests 17:56:12 INFO - Running setup.py install for docopt 17:56:12 INFO - Successfully installed blobuploader requests docopt 17:56:12 INFO - Cleaning up... 17:56:13 INFO - Return code: 0 17:56:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:56:13 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')]} 17:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:13 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')]} 17:56:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:13 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 0x16451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b1580>, '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 0x19b2480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b2910>, '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': '6d15e502d8e29d5d2676d664000001c3-1504140929.173484-2013152947', '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 17:56:13 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 17:56:13 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 17:56:13 INFO - Using env: {'DISPLAY': ':0', 17:56:13 INFO - 'HOME': '/home/cltbld', 17:56:13 INFO - 'LANG': 'en_US.UTF-8', 17:56:13 INFO - 'LANGUAGE': 'en_US:en', 17:56:13 INFO - 'LOGNAME': 'cltbld', 17:56:13 INFO - 'MAIL': '/var/mail/cltbld', 17:56:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:13 INFO - 'MOZ_NO_REMOTE': '1', 17:56:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:13 INFO - 'NO_EM_RESTART': '1', 17:56:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:13 INFO - 'PWD': '/builds/slave/test', 17:56:13 INFO - 'SHELL': '/bin/bash', 17:56:13 INFO - 'SHLVL': '1', 17:56:13 INFO - 'TERM': 'linux', 17:56:13 INFO - 'TMOUT': '86400', 17:56:13 INFO - 'USER': 'cltbld', 17:56:13 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1504140929.173484-2013152947', 17:56:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:13 INFO - '_': '/tools/buildbot/bin/python'} 17:56:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:56:13 INFO - Running setup.py (path:/tmp/pip-w7m3fL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:56:13 INFO - Running setup.py (path:/tmp/pip-Zq00El-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:56:13 INFO - Running setup.py (path:/tmp/pip-dyHKwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:56:13 INFO - Running setup.py (path:/tmp/pip-kOX03C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:56:13 INFO - Running setup.py (path:/tmp/pip-he6i0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:56:13 INFO - Running setup.py (path:/tmp/pip-X_tCFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:56:13 INFO - Running setup.py (path:/tmp/pip-pq5gTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:56:13 INFO - Running setup.py (path:/tmp/pip-VwEJm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:56:13 INFO - Running setup.py (path:/tmp/pip-zlkuop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:56:13 INFO - Running setup.py (path:/tmp/pip-UzI__1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:56:13 INFO - Running setup.py (path:/tmp/pip-ttmkSU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:56:13 INFO - Running setup.py (path:/tmp/pip-JTPtiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:56:14 INFO - Running setup.py (path:/tmp/pip-JOHsly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:56:14 INFO - Running setup.py (path:/tmp/pip-vfjpyR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:56:14 INFO - Running setup.py (path:/tmp/pip-pCuikt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:56:14 INFO - Running setup.py (path:/tmp/pip-0Fd5n5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:56:14 INFO - Running setup.py (path:/tmp/pip-I5OMCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:56:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:56:14 INFO - Running setup.py install for manifestparser 17:56:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:56:14 INFO - Running setup.py install for mozcrash 17:56:14 INFO - Running setup.py install for mozdebug 17:56:14 INFO - Running setup.py install for mozdevice 17:56:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:56:14 INFO - Running setup.py install for mozfile 17:56:14 INFO - Running setup.py install for mozhttpd 17:56:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:56:15 INFO - Running setup.py install for mozinfo 17:56:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:56:15 INFO - Running setup.py install for mozInstall 17:56:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:56:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:56:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:56:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:56:15 INFO - Running setup.py install for mozleak 17:56:15 INFO - Running setup.py install for mozlog 17:56:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:56:15 INFO - Running setup.py install for moznetwork 17:56:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:56:15 INFO - Running setup.py install for mozprocess 17:56:15 INFO - Running setup.py install for mozprofile 17:56:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:56:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:56:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:56:15 INFO - Running setup.py install for mozrunner 17:56:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:56:15 INFO - Running setup.py install for mozscreenshot 17:56:15 INFO - Running setup.py install for moztest 17:56:16 INFO - Running setup.py install for mozversion 17:56:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:56:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:56:16 INFO - Cleaning up... 17:56:16 INFO - Return code: 0 17:56:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:56:16 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')]} 17:56:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:16 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')]} 17:56:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:16 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 0x16451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b1580>, '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 0x19b2480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b2910>, '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': '6d15e502d8e29d5d2676d664000001c3-1504140929.173484-2013152947', '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 17:56:16 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 17:56:16 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 17:56:16 INFO - Using env: {'DISPLAY': ':0', 17:56:16 INFO - 'HOME': '/home/cltbld', 17:56:16 INFO - 'LANG': 'en_US.UTF-8', 17:56:16 INFO - 'LANGUAGE': 'en_US:en', 17:56:16 INFO - 'LOGNAME': 'cltbld', 17:56:16 INFO - 'MAIL': '/var/mail/cltbld', 17:56:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:16 INFO - 'MOZ_NO_REMOTE': '1', 17:56:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:16 INFO - 'NO_EM_RESTART': '1', 17:56:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:16 INFO - 'PWD': '/builds/slave/test', 17:56:16 INFO - 'SHELL': '/bin/bash', 17:56:16 INFO - 'SHLVL': '1', 17:56:16 INFO - 'TERM': 'linux', 17:56:16 INFO - 'TMOUT': '86400', 17:56:16 INFO - 'USER': 'cltbld', 17:56:16 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1504140929.173484-2013152947', 17:56:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:16 INFO - '_': '/tools/buildbot/bin/python'} 17:56:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:56:16 INFO - Running setup.py (path:/tmp/pip-G6ciuu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:56:16 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)) 17:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:56:16 INFO - Running setup.py (path:/tmp/pip-xuQWHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:56:16 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)) 17:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:56:16 INFO - Running setup.py (path:/tmp/pip-O5rE9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:56:16 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)) 17:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:56:16 INFO - Running setup.py (path:/tmp/pip-37MpOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:56:16 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)) 17:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:56:16 INFO - Running setup.py (path:/tmp/pip-Wzyvkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:56:16 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)) 17:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:56:16 INFO - Running setup.py (path:/tmp/pip-hYBGNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:56:16 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)) 17:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:56:16 INFO - Running setup.py (path:/tmp/pip-ncHk22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:56:16 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)) 17:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:56:16 INFO - Running setup.py (path:/tmp/pip-hu8_GP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:56:16 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)) 17:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:56:16 INFO - Running setup.py (path:/tmp/pip-DUFyZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:56:17 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)) 17:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:56:17 INFO - Running setup.py (path:/tmp/pip-HRXRz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:56:17 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)) 17:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:56:17 INFO - Running setup.py (path:/tmp/pip-wBkJeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:56:17 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)) 17:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:56:17 INFO - Running setup.py (path:/tmp/pip-v38y1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:56:17 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)) 17:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:56:17 INFO - Running setup.py (path:/tmp/pip-l0sFGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:56:17 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)) 17:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:56:17 INFO - Running setup.py (path:/tmp/pip-OhWH7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:56:17 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)) 17:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:56:17 INFO - Running setup.py (path:/tmp/pip-U2FLF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:56:17 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)) 17:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:56:17 INFO - Running setup.py (path:/tmp/pip-ugHp8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:56:17 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)) 17:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:56:17 INFO - Running setup.py (path:/tmp/pip-d848EP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:56:17 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)) 17:56:17 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)) 17:56:17 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)) 17:56:17 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)) 17:56:17 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)) 17:56:17 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)) 17:56:17 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)) 17:56:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:56:17 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 17:56:17 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 17:56:17 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 17:56:17 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 17:56:18 INFO - Downloading blessings-1.6.tar.gz 17:56:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:56:18 INFO - Installing collected packages: blessings 17:56:18 INFO - Running setup.py install for blessings 17:56:18 INFO - Successfully installed blessings 17:56:18 INFO - Cleaning up... 17:56:18 INFO - Return code: 0 17:56:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:56:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:56:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:56:19 INFO - Reading from file tmpfile_stdout 17:56:19 INFO - Current package versions: 17:56:19 INFO - argparse == 1.2.1 17:56:19 INFO - blessings == 1.6 17:56:19 INFO - blobuploader == 1.2.4 17:56:19 INFO - docopt == 0.6.1 17:56:19 INFO - functools32 == 3.2.3-2 17:56:19 INFO - jsonschema == 2.5.1 17:56:19 INFO - manifestparser == 1.1 17:56:19 INFO - mozInstall == 1.13 17:56:19 INFO - mozcrash == 1.0 17:56:19 INFO - mozdebug == 0.1 17:56:19 INFO - mozdevice == 0.51 17:56:19 INFO - mozfile == 1.2 17:56:19 INFO - mozhttpd == 0.7 17:56:19 INFO - mozinfo == 0.10 17:56:19 INFO - mozleak == 0.1 17:56:19 INFO - mozlog == 3.5 17:56:19 INFO - moznetwork == 0.27 17:56:19 INFO - mozprocess == 0.25 17:56:19 INFO - mozprofile == 0.28 17:56:19 INFO - mozrunner == 6.13 17:56:19 INFO - mozscreenshot == 0.1 17:56:19 INFO - mozsystemmonitor == 0.3 17:56:19 INFO - moztest == 0.8 17:56:19 INFO - mozversion == 1.4 17:56:19 INFO - psutil == 3.1.1 17:56:19 INFO - requests == 1.2.3 17:56:19 INFO - wsgiref == 0.1.2 17:56:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:56: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')]} 17:56:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56: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')]} 17:56:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:19 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 0x16451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b1580>, '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 0x19b2480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b2910>, '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': '6d15e502d8e29d5d2676d664000001c3-1504140929.173484-2013152947', '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 17:56:19 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 17:56:19 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 17:56:19 INFO - Using env: {'DISPLAY': ':0', 17:56:19 INFO - 'HOME': '/home/cltbld', 17:56:19 INFO - 'LANG': 'en_US.UTF-8', 17:56:19 INFO - 'LANGUAGE': 'en_US:en', 17:56:19 INFO - 'LOGNAME': 'cltbld', 17:56:19 INFO - 'MAIL': '/var/mail/cltbld', 17:56:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:19 INFO - 'MOZ_NO_REMOTE': '1', 17:56:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:19 INFO - 'NO_EM_RESTART': '1', 17:56:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:19 INFO - 'PWD': '/builds/slave/test', 17:56:19 INFO - 'SHELL': '/bin/bash', 17:56:19 INFO - 'SHLVL': '1', 17:56:19 INFO - 'TERM': 'linux', 17:56:19 INFO - 'TMOUT': '86400', 17:56:19 INFO - 'USER': 'cltbld', 17:56:19 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1504140929.173484-2013152947', 17:56:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:19 INFO - '_': '/tools/buildbot/bin/python'} 17:56:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:19 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)) 17:56:19 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)) 17:56:19 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)) 17:56:19 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)) 17:56:19 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)) 17:56:19 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)) 17:56:19 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)) 17:56:19 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)) 17:56:19 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)) 17:56:19 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:56:19 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 17:56:19 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 17:56:19 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 17:56:19 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 17:56:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:56:20 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)) 17:56:20 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)) 17:56:20 INFO - Installing collected packages: simplejson 17:56:20 INFO - Running setup.py install for simplejson 17:56:20 INFO - building 'simplejson._speedups' extension 17:56:20 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 17:56:21 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 17:56:21 INFO - Successfully installed simplejson 17:56:21 INFO - Cleaning up... 17:56:21 INFO - Return code: 0 17:56:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:56:21 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')]} 17:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:21 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')]} 17:56:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:21 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 0x16451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b1580>, '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 0x19b2480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b2910>, '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': '6d15e502d8e29d5d2676d664000001c3-1504140929.173484-2013152947', '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 17:56:21 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 17:56:21 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 17:56:21 INFO - Using env: {'DISPLAY': ':0', 17:56:21 INFO - 'HOME': '/home/cltbld', 17:56:21 INFO - 'LANG': 'en_US.UTF-8', 17:56:21 INFO - 'LANGUAGE': 'en_US:en', 17:56:21 INFO - 'LOGNAME': 'cltbld', 17:56:21 INFO - 'MAIL': '/var/mail/cltbld', 17:56:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:21 INFO - 'MOZ_NO_REMOTE': '1', 17:56:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:21 INFO - 'NO_EM_RESTART': '1', 17:56:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:21 INFO - 'PWD': '/builds/slave/test', 17:56:21 INFO - 'SHELL': '/bin/bash', 17:56:21 INFO - 'SHLVL': '1', 17:56:21 INFO - 'TERM': 'linux', 17:56:21 INFO - 'TMOUT': '86400', 17:56:21 INFO - 'USER': 'cltbld', 17:56:21 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1504140929.173484-2013152947', 17:56:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:21 INFO - '_': '/tools/buildbot/bin/python'} 17:56:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:56:21 INFO - Cleaning up... 17:56:21 INFO - Return code: 0 17:56:21 INFO - Running post-action listener: _resource_record_post_action 17:56:21 INFO - Running post-action listener: _start_resource_monitoring 17:56:21 INFO - Starting resource monitoring. 17:56:21 INFO - [mozharness: 2017-08-31 00:56:21.862577Z] Finished create-virtualenv step (success) 17:56:21 INFO - [mozharness: 2017-08-31 00:56:21.863091Z] Running install step. 17:56:21 INFO - Running pre-action listener: _resource_record_pre_action 17:56:21 INFO - Running main action method: install 17:56:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:56:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:56:22 INFO - Reading from file tmpfile_stdout 17:56:22 INFO - Detecting whether we're running mozinstall >=1.0... 17:56:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:56:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:56:22 INFO - Reading from file tmpfile_stdout 17:56:22 INFO - Output received: 17:56:22 INFO - Usage: mozinstall [options] installer 17:56:22 INFO - Options: 17:56:22 INFO - -h, --help show this help message and exit 17:56:22 INFO - -d DEST, --destination=DEST 17:56:22 INFO - Directory to install application into. [default: 17:56:22 INFO - "/builds/slave/test"] 17:56:22 INFO - --app=APP Application being installed. [default: firefox] 17:56:22 INFO - mkdir: /builds/slave/test/build/application 17:56:22 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'] 17:56:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:56:38 INFO - Reading from file tmpfile_stdout 17:56:38 INFO - Output received: 17:56:38 INFO - /builds/slave/test/build/application/firefox/firefox 17:56:38 INFO - Running post-action listener: _resource_record_post_action 17:56:38 INFO - [mozharness: 2017-08-31 00:56:38.674642Z] Finished install step (success) 17:56:38 INFO - [mozharness: 2017-08-31 00:56:38.674918Z] Running setup-mitmproxy step. 17:56:38 INFO - Running pre-action listener: _resource_record_pre_action 17:56:38 INFO - Running main action method: setup_mitmproxy 17:56:38 INFO - Skipping: mitmproxy is not required 17:56:38 INFO - Running post-action listener: _resource_record_post_action 17:56:38 INFO - [mozharness: 2017-08-31 00:56:38.676045Z] Finished setup-mitmproxy step (success) 17:56:38 INFO - [mozharness: 2017-08-31 00:56:38.676262Z] Running run-tests step. 17:56:38 INFO - Running pre-action listener: _resource_record_pre_action 17:56:38 INFO - Running pre-action listener: _set_gcov_prefix 17:56:38 INFO - Running main action method: run_tests 17:56:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:56:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:56:38 INFO - Python 2.7.3 17:56:38 INFO - Return code: 0 17:56:38 INFO - grabbing minidump binary from tooltool 17:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:38 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 0x19b1580>, '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 0x19b2480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b2910>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:56:38 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 17:56:38 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 17:56:38 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 17:56:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:56:38 INFO - Return code: 0 17:56:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:56:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:56:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:56:38 INFO - ENV: RUST_BACKTRACE is now full 17:56:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:56:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:56:38 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/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 17:56:38 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/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 17:56:38 INFO - Using env: {'DISPLAY': ':0', 17:56:38 INFO - 'HOME': '/home/cltbld', 17:56:38 INFO - 'LANG': 'en_US.UTF-8', 17:56:38 INFO - 'LANGUAGE': 'en_US:en', 17:56:38 INFO - 'LOGNAME': 'cltbld', 17:56:38 INFO - 'MAIL': '/var/mail/cltbld', 17:56:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:56:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:56:38 INFO - 'MOZ_ACCELERATED': '1', 17:56:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:38 INFO - 'MOZ_NO_REMOTE': '1', 17:56:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:56:38 INFO - 'MOZ_WEBRENDER': '1', 17:56:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:38 INFO - 'NO_EM_RESTART': '1', 17:56:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:38 INFO - 'PWD': '/builds/slave/test', 17:56:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:56:38 INFO - 'RUST_BACKTRACE': 'full', 17:56:38 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:56:38 INFO - 'SHELL': '/bin/bash', 17:56:38 INFO - 'SHLVL': '1', 17:56:38 INFO - 'TERM': 'linux', 17:56:38 INFO - 'TMOUT': '86400', 17:56:38 INFO - 'USER': 'cltbld', 17:56:38 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1504140929.173484-2013152947', 17:56:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:38 INFO - '_': '/tools/buildbot/bin/python'} 17:56:38 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/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 17:56:39 INFO - mozversion application_buildid: 20170831001019 17:56:39 INFO - mozversion application_changeset: d9b405d82cffb07343a5f2fd941e029298c7f6c4 17:56:39 INFO - mozversion application_display_name: Nightly 17:56:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:56:39 INFO - mozversion application_name: Firefox 17:56:39 INFO - mozversion application_remotingname: firefox 17:56:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:56:39 INFO - mozversion application_vendor: Mozilla 17:56:39 INFO - mozversion application_version: 57.0a1 17:56:39 INFO - mozversion platform_buildid: 20170831001019 17:56:39 INFO - mozversion platform_changeset: d9b405d82cffb07343a5f2fd941e029298c7f6c4 17:56:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:56:39 INFO - mozversion platform_version: 57.0a1 17:56:39 INFO - using testdate: 1504140999 17:56:39 INFO - actual date: 1504140999 17:56:39 INFO - starting webserver on 'localhost:38224' 17:56:39 INFO - SUITE-START | Running 2 tests 17:56:39 INFO - TEST-START | dromaeo_css 17:56:39 INFO - Initialising browser for dromaeo_css test... 17:56:39 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38224/getInfo.html -profile /tmp/tmpC03fyb/profile 17:56:39 INFO - TEST-INFO | started process 7568 (/builds/slave/test/build/application/firefox/firefox http://localhost:38224/getInfo.html) 17:56:44 INFO - TEST-INFO | 7568: exit 0 17:56:44 INFO - Browser initialized. 17:56:44 INFO - Running cycle 1/1 for dromaeo_css test... 17:56:44 INFO - Using env: {'DISPLAY': ':0', 17:56:44 INFO - 'HOME': '/home/cltbld', 17:56:44 INFO - 'JSGC_DISABLE_POISONING': '1', 17:56:44 INFO - 'LANG': 'en_US.UTF-8', 17:56:44 INFO - 'LANGUAGE': 'en_US:en', 17:56:44 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:56:44 INFO - 'LOGNAME': 'cltbld', 17:56:44 INFO - 'MAIL': '/var/mail/cltbld', 17:56:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:56:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:56:44 INFO - 'MOZ_ACCELERATED': '1', 17:56:44 INFO - 'MOZ_CRASHREPORTER': '1', 17:56:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:44 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:56:44 INFO - 'MOZ_NO_REMOTE': '1', 17:56:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:56:44 INFO - 'MOZ_WEBRENDER': '1', 17:56:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:44 INFO - 'NO_EM_RESTART': '1', 17:56:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:44 INFO - 'PWD': '/builds/slave/test', 17:56:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:56:44 INFO - 'RUST_BACKTRACE': 'full', 17:56:44 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:56:44 INFO - 'SHELL': '/bin/bash', 17:56:44 INFO - 'SHLVL': '1', 17:56:44 INFO - 'TERM': 'linux', 17:56:44 INFO - 'TMOUT': '86400', 17:56:44 INFO - 'USER': 'cltbld', 17:56:44 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1504140929.173484-2013152947', 17:56:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:44 INFO - '_': '/tools/buildbot/bin/python'} 17:56:44 INFO - TEST-INFO | started process 7758 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC03fyb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:56:45 INFO - PID 7758 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 17:56:45 INFO - PID 7758 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 17:56:46 INFO - PID 7758 | 17:56:46 INFO - PID 7758 | (/builds/slave/test/build/application/firefox/firefox:7819): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:56:46 INFO - PID 7758 | 17:56:56 INFO - PID 7758 | RSS: Main: 207810560 17:56:56 INFO - PID 7758 | 17:56:59 INFO - PID 7758 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 17:59:55 INFO - PID 7758 | Cycle 1(1): loaded http://localhost:38224/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38224/tests/dromaeo/cssquery-ext.html) 17:59:56 INFO - PID 7758 | RSS: Main: 216702976 17:59:56 INFO - PID 7758 | 18:02:59 INFO - PID 7758 | Cycle 1(1): loaded http://localhost:38224/tests/dromaeo/cssquery-ext.html (next: http://localhost:38224/tests/dromaeo/cssquery-jquery.html) 18:02:59 INFO - PID 7758 | RSS: Main: 216301568 18:02:59 INFO - PID 7758 | 18:06:01 INFO - PID 7758 | Cycle 1(1): loaded http://localhost:38224/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38224/tests/dromaeo/cssquery-mootools.html) 18:06:02 INFO - PID 7758 | RSS: Main: 215920640 18:06:02 INFO - PID 7758 | 18:09:04 INFO - PID 7758 | Cycle 1(1): loaded http://localhost:38224/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38224/tests/dromaeo/cssquery-prototype.html) 18:09:05 INFO - PID 7758 | RSS: Main: 214306816 18:09:05 INFO - PID 7758 | 18:12:08 INFO - PID 7758 | Cycle 1(1): loaded http://localhost:38224/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38224/tests/dromaeo/cssquery-yui.html) 18:12:09 INFO - PID 7758 | RSS: Main: 216403968 18:12:09 INFO - PID 7758 | 18:15:11 INFO - PID 7758 | Cycle 1(1): loaded http://localhost:38224/tests/dromaeo/cssquery-yui.html (next: http://localhost:38224/tests/dromaeo/cssquery-dojo.html) 18:15:11 INFO - PID 7758 | RSS: Main: 216387584 18:15:11 INFO - PID 7758 | 18:15:11 INFO - PID 7758 | __start_tp_report 18:15:11 INFO - PID 7758 | _x_x_mozilla_page_load 18:15:11 INFO - PID 7758 | _x_x_mozilla_page_load_details 18:15:11 INFO - PID 7758 | |i|pagename|runs| 18:15:11 INFO - PID 7758 | |0;dojo.html;3308.057203696947;3329.6004479462467;3344.2809795893886;3349.4138525757994;3394.083597428693;6219.782307619234;6319.241690997075;6330.525210609199;6355.173827402443;6387.712552935118;6013.368596297391;6186.628802271855;6200.844978875519;6211.192544969159;6222.906656400158;5774.191613174159;5788.971055144719;5794.884102317951;5802.274715660543;5813.505852002585;5777.884442311172;5788.218590490272;5801.7389217485315;5809.941900580982;5827.096799996008;5764.048931926227;5766.798162064329;5793.217915581385;5803.564732645047;5812.912806307909;5763.769449222026;5791.942080579182;5794.246747922764;5815.796447124372;5827.329857066449;5653.830385088454;5685.147227915804;5755.740991655385;5757.395473475267;5811.738471768781;6167.568270221086;6227.439530442237;6293.527985401068;6311.274203466614;6328.303886572473;6551.508636852255;6648.900266496006;6661.533692641517;6699.3300669933105;6701.195856497252;6643.335666433318;6671.93328066718;6690.029945657852;6704.329567043305;6800.217974932896;6263.091851681526;6283.842903927439;6348.269948955883;6391.296957334689;6394.9360506394805;6765.154355705537;6913.1358580177475;6969.9303006969285;7082.752103676346;7093.077899872984;6558.737650493927;6562.081308616797;6568;6568.704408301543;6582.341765823475;6690.765823196165;6698.866022679519;6720.495962802809;6747.865042699119;6813.0121132435515;6345.87835722481;6758.628275444799;6759.087523184406;6796.150481189851;6803;6689.665516724144;6700.96649516759;6739.797806065826;6796.72813087471;6803.829904252334;5049.2173713074535;5190.532852043259;5203.19350500673;5327.840164795062;5346.492083252085;4615.976920115378;4618.584327410482;4644.651651126179;4646.3727396801;4647.535246475325;5707.800226992118;5716.485516303553;5721.456461636221;5746.2529871116485;5871.794487192928;6757.729690812411;6835.931640683629;6843;6843.897341539781;6878.243393226741;5848.064309710426;5854.970725146347;5855.414458554195;5889.823305300848;5897.3807750185615;5727.684977326204;5815.389384114692;5824.88350232993;5833.941660583425;5924.526037916957;6436.034594810816;6481.611103333815;6529.706163222666;6547.377999090174;6599.8020059398295;6796.660166991532;6837.794866154023;6908.585484870924;6909.516333856582;6917.377436030782;6470.48236141117;6560.868782624416;6570.8028759137305;6587.242467116343;6655.101561289164;6676.165479315086;6694.732210711517;6715.026321183499;6730.0914376560495;6731.730730770911;6820.556663816836;6854.143232095988;6857.2114206866845;6859.039734437282;6937.06349642812;6521.902171467337;6525.771597994048;6565.573237739532;6611.768588099393;6675.432588229861;6297.905531416941;6456.967715161394;6527;6623.735050597922;6624.436922861611;6425.5502114851515;6469.4824414045825;6472.15861937945;6479.319671434431;6481.254655714653;6457.741690332334;6511.283758786624;6565.770198043046;6574.8356291091195;6605.504587156079;6315.715792789428;6364.109024736633;6365.427111559982;6385.584936979081;6387.680615969276 18:15:11 INFO - PID 7758 | |1;ext.html;800.7597720683797;834.3908946469081;861.6294993152944;887.2901678657076;888.9955550222248;41114.79442602787;42019.57980420199;42137.15725685484;42147.57852421475;42203.78898105513;38022;38305;38386;38422;38480.80759596198;6976.546524475905;7085.751998680022;7089.89365159523;7090.50366474347;7103.502754807139;6987.231404545496;6996.265392133829;6998.895016574756;7000.579965202079;7042.4718146138985;6988.475864310197;7157.749478768244;7459.813504662373;7805.687772489094;7873.5275883447175;7751.961240193791;7855.764327070168;7858.646360913773;7865.17415671352;7870.134285228621;7534.133574638877;7661.540307581563;7673.2326767323375;7682.308592226726;7685;38064.42903356452;38345;38755;38900.416493752615;39243.8037809812;3495.5980062292906;3530.735194860396;3532.8056956867363;3538.8230588470474;3544.4151714967;31223;31286.843565782252;31308.217294567592;31335.37329253425;31408.21479463009;5204.34945631796;5242.370915490127;5244.632875698702;5267.736613169326;5281.735913204325;180274;181620;181699;182094;182098;47098.5290147101;47215.291770623466;47473.28790068152;47488.28767568489;47608;49559.75220123876;49661.75169124131;49666;49667.50332496701;49706;14425.78361324581;14629.268536573129;14771.63070923214;14772.778408323884;14817.851821481647;11779.234349767408;11843.407829608484;11959.880401196051;11971.700707482383;11972.10209234311;13977.60223977594;13989;14045.85954140466;14160.85839141616;14208.64478388028;5654.293213348332;5773.220615216892;5793;5814.215080964101;5826.854328641818;999.9500024998721;1001.6844693921391;1009.9192064634811;1011.6054738651932;1031.2111234905303;23280.65079023816;29770.85114574413;29782.10653680393;29887.551686724717;29949.550756738667;1011.858339832424;1012.9696109116738;1013.133770626104;1016.3546148195801;1016.6441745389054;11500.94249528747;11566.595169169206;11799.997000254903;11828.763424731456;11862.644120676394;226680;230380;230616;230856;231611;43230.56769432266;46029;46121;46159.07681846344;46188.7690561545;1289.1169548859061;1470.3750905864965;1497.3336865094927;1502.774583812437;1505.2925125191362;27542.862285688443;28077.57883631706;28394.574081389208;28768.568471472525;28829.85585072145;45532.77233613943;45896.31155532603;45930.54069459263;45972;46027.53972460233;206504;207732;208137;208527;208960;34125.82937085299;35043;35326.64673353233;35547;35618.46572301469;43322.78338608413;43401.782991084845;43682.12635747331;43906.780466097465;44518.3322250173;32716.83641581777;33452.330953381286;33501.66498335083;33757.3248535023;33805.15487112842;32361.35277294488;32756.344873101927;32920.88563528203;32983;33018.504722429665;37415;37516.43725344176;37586.81206593949;37596.812015939744;37653;31821.522677160323;31842.20394490156;31962.68037319597;32131.196720082185;32278.35443291168;23363.76636233616;23414.946327414968;23453.179138730062;23888.163914262917;24027.43821651587 18:15:11 INFO - PID 7758 | |2;jquery.html;568.2442351672273;579.226732312363;582.9679367634778;583.7431530126745;587.9382664820195;22200.77799222007;22912.88543557284;23022.309330720105;23062.423439414;23113.306600802003;18431.72352414715;19204.423867283967;22023.77976220237;24554.508909821838;24768.628470572956;6603.537752357337;6815.38661520463;6823.283555226704;6836.418904393107;6841;6668.433183179435;6768.7630932917355;6770.458363330922;6772.2211945626395;6777.593344399352;3831;4367.585079417466;6739.292374300701;6749.628770417625;6792.150981127359;6773.796786096425;6805.421539169151;6817.318268173168;6847;6850.794476165723;6260.280067792171;6269.0909818076125;6274.090256912722;6284.151639528651;6297.0554416837385;25258.873705631355;27404.314892127855;27713.58429623557;27729.168124956283;27784.86107569449;1809.9547511312192;2004.5189154602936;2028.0468179955396;2034.1558253324852;2036.8879711615855;18970.43088707327;19413.22347106114;19477.12352944107;19488.70766938483;19510.609787804307;2404.6873906392057;2419.676313481635;2463.556559819232;2468.123816045296;2471.653968444419;140359.29820350936;147991.26004370017;148126;148281.25859370743;148327;13896.444142234399;14015.458299587037;14118.941079418879;14152;14651.267436628339;22227;22342.3297301078;22474;22514.324570262917;22554.436139096655;9544.95227523858;9896.20830333586;9923.404595724136;9937.950310248547;10064.69805905824;9033.864492032493;9097.81804363909;9199.816003679889;9226.26189904806;9284.95357523208;8721.433106848035;8801.955990220007;8868.911310886937;8925.196732293995;8953.376358254887;2369.822263330257;2673.799465040091;2741.4791189673897;2744.3825139343885;2766.6265054217424;994.955227014786;1007.0835539659022;1015.9542820573092;1021.4177918586334;1025.1235193909101;18565.535861603566;19268.903655481634;19403.320883769;19544.609107818047;19588.608227835648;1062.4422178356424;1078.7734575739182;1080.7406222506543;1085.3270971997254;1094.5020015892749;10451.16390688743;10573.524191411405;10838.783224335626;10995.450227488753;10998.945005275082;451217;453544;458856;463081;475011;102649;107925.38111928328;110809;113164;125931.3703431477;1205.9276443413423;1235.8516977962702;1239.2130996817086;1241.3296819717252;1257.8930291761446;20267.69598455995;20548.486287842923;20700.275490357766;21028.47428814292;21502.78497215008;58354.7082264586;60113;60317.09524357226;61490;61703;65620.67189664021;66258.66870665616;66536.66731666504;66785.33214667792;67539;14269.643258918195;14379.496717614833;14437.566872993826;14475.27623618836;14883.925580372028;22796.202132925268;23180.768192318537;23199.3040208794;23279.41801454977;23533.529329412973;18369.908150459163;18593;18603.348882789036;18639.627207455505;18932.810671893654;15452.84547154559;16191.352345906032;16587.502374928772;16588.58528536748;17062.829371706124;17682.734758978368;18388;18388.632227355647;18418.81581184171;18513.81486185121;13600.795988059988;14236.501722439665;14285.500007499688;14391.208483533088;14446.133232006114;18117;18181.636367272844;18201.726974095134;18478.168482418594;18521.35175268859 18:15:11 INFO - PID 7758 | |3;mootools.html;1315.6381994951387;1359.2524111738542;1382.4953891829484;1388.049186307379;1393.0805668258952;14938.178400187986;15215.46745863895;15493.84506154938;15740.763888541682;15818.525444236677;15579.221038948035;15805.84194158058;15824.287907044181;15831;15836.129012904286;2766.695663477021;2856.2573730829927;2857.771378289742;2860.356419805548;2862.9427411451757;2628.47430513897;2681.8793154308005;2745.533259345906;2747.0659975608287;2849.743523082922;2818.8590570471497;2858.3140046388926;2861.02725073475;2861.957070643942;2862.341661417875;2703.4728227995547;2717.55160398534;2747.835129892213;2754.628125203112;2758.820676656021;2666.5066962611977;2666.546687063204;2669.5328317544354;2677.8794954227105;2679.812413131062;14756.409743610242;15030.17334046627;15089.5473135805;15103.39586416542;15123.470678526308;7938.285554300083;8202.712905048294;8235.341172706168;8249.876251856227;8256.091829898707;5520.227168196416;5535.557155427556;5574.86062848432;5591.30108736408;5782.335031471351;1801.0994502748626;1871.0177156992552;2391.653210284499;2402.6035704108976;2410.1564452441507;27478.725212747817;27497.17508474749;27640.447191056068;27693.030743924068;27706;6594.86810263792;6805.829854253584;6960.199577048603;6997.825054373579;7042.295770422917;16946.23741931616;17179.398721044705;17257.05086220245;17257.309707611807;17270.913645431945;7904.920950790533;7961.840763184704;8095.392845536609;8103.83792324162;8106.946097007351;7361.595112268877;7397.371223446067;7419.146798118178;7482.102147742197;7495.737649182252;4784.497627749106;4947.529984651453;4963.751812409365;4967.602591792648;5003.4746351633285;1511.6749898771816;1561.2584022589178;1572.4103461202048;1595.8085029796498;1604.606871316535;847.6482259862088;890.973270801877;893.678275820704;901.3915606965403;904.4663648447316;7539.509931854412;7546.886796698054;7615.276548727862;7662.731804386931;7710.460267781202;718.4647437658978;734.6179986407145;735.8234023834349;746.660269577341;747.8055705516605;4242.342436922282;4334.804933777988;4338.284183109815;4358.542353052947;5439.156930675752;20978;21073.367798966057;21281.78718212798;21844.563108737737;21872.906354682204;20747.273845415337;21133.577328453346;21609.56780864374;21650.891745541172;21902.780972190074;10979.451027448597;10982.286151400293;11069.833952490559;11087.667369978752;11136.665900023012;7957.7612671619945;8266.669333226604;8273.710420135267;8363.790905227417;8420.242178203991;17913.820861791737;18073.728894066862;18359.990200539098;18594.2562297512;18876.150573223964;18944.147513362208;19048;19695.80304196997;19985.400437986882;20073.096710647766;10862.619808306672;11065.5020524075;11077.723056923642;11093;11110.888891110986;13673.179609223478;13865.72268554603;13930.72138557203;13971.441142354191;14001.159930404208;10788.298760580537;10801.567937282734;11056.170787190831;11121.555137794398;11368.204225704121;10804.567817287221;10896.291741036806;10958.232923695265;11157.832632510681;11340.94329528347;9983.400995940267;10017;10043.096121349114;10043.799124017332;10053.547590358598;6881.518293719391;6931.757388491378;7023.473239506955;7026.402755765817;7091;6997.860042799014;7081.539699919489;7177;7192.4246060314;7211.71153153868 18:15:11 INFO - PID 7758 | |4;prototype.html;508.5169089365104;515.435598020168;517.5057819782108;530.4324372920973;531.5163201486648;6199.349068347826;6259.968700156499;6260.9999999999945;6313.106068179545;6418.486521078315;6160.322364539908;6200.379962003797;6204.875902481947;6209.130721698954;6247.875042499159;5129.281900533928;5143.639945203847;5193.870153246161;5197.674592978785;5205.479452054783;5186.092433824085;5186.559142472895;5187.210412407713;5227.5295223429885;5232.319798426218;4759.428868535781;4900.137947579915;4969.155243608595;4992.575631071363;5075.893504195755;4918.926216106761;4975.253711943201;4991.600671946236;4993.350864387643;5016.523430274118;4334.934975975363;4359.367891655724;4452.265376212921;4467.1735728889935;4505.504394516601;6069.786042791416;6077.453029227391;6083.30042045166;6115.847103822395;6157.876842463171;5653.462921022538;5698.373178950312;5710;5723.54211663066;5745.683987380692;6439.291677915426;6572.572782769104;6630.436412904909;6632.767853125118;6633.237177724575;4829.323894654716;4854.708717476963;4909.165441874889;4926.11329960607;4927.6550641455115;6684.866302673968;6795.18457785059;6875.07186529817;6929.341712537301;6938.653067346612;4981.178105612534;4988.301637770715;4990.451050384455;5014.047331007097;5043.974780126149;4961;5014.348134742533;5014.6991180529285;5047.747612619354;5108.386993560722;5629.408912064175;5635.9421216723895;5692.943070569241;5701.828945131652;5776.133579963039;6551.574147680385;6600.471962243009;6614;6657.300983396771;6679.632620205838;1755.3505203074944;1779.4839496545856;1781.118346418531;1784.5003399048287;1787.5799187191;1152.809786385237;1204.50615247748;1204.9819252711216;1220.3464305865602;1253.4422182129047;5734.311882574118;5737.426257374313;5737.684427356536;5751.734618383949;5817.825465236049;6773.8645227095185;6781.559198652072;6823.590584564942;6851.417629501549;6869.587824730532;5796.88406231873;5833.82498525045;5851.590388672752;5852.912206316909;5861.824145275648;3472.305538892181;3553.911152221215;3571;3611.422172452395;3639.1629925117372;6507.674616269168;6550.2794692583775;6598.822388611842;6637.668116594151;6692.464602831762;6814.522983391214;6844.349786770249;6863.897041544381;6891.138607674041;6893.414059804973;6476.579022363531;6503.187101612299;6521.445677117498;6554.9999999999045;6576.106513134206;6730.101645813081;6770.255271919987;6788.25329213796;6797.150356205474;6878.449724021966;6701.481722095744;6715.4291885190305;6730.192376914802;6766.391024807791;6772.898406523807;6542;6565.803025909039;6614.8346291343105;6678.899816502659;6683.7660681875905;4976.975115124401;4986.276989836526;4989.25161225819;4995.875103122451;5024.0956627807345;6470.935290647033;6731.899021514583;6767.966160169168;6814.23003897264;6844.247132815287;6255.374462553708;6520.576162549419;6522;6569.178852643419;6615.966920165561;6479.514036447191;6540.215174179129;6600.141981542369;6607.53747237708;6611.636360000246;6486.189226346707;6495.902561461677;6518;6529.151210342625;6567.343265673395;6531.183602049744;6619.470442364503;6649.2685804562425;6687.6321802301345;6700.430463410665;6412.487001039999;6450.774222902363;6470.638217050837;6482.124913136855;6517.869642607026 18:15:11 INFO - PID 7758 | |5;yui.html;890.8752774611554;911.5123408976199;914.7713071732067;927.452802846321;930.8929473110594;17997;18693.065346732677;18762.99999999998;18809.153588088535;18820.529486762836;14153.15081095135;14733.116013039198;15505.457308994188;15671;20545.794542054577;980.1472718734675;985.9112679858812;987.6444479987199;993.2401712689762;997.9222439765073;988.3871999360407;990.2869933647762;992.4888682328607;993.0516356879199;993.5628323537657;716.090564982472;731.5464412064528;970.3207754571793;1032.406366339354;1045.94770261487;1003.8243307421172;1014.8579198912158;1015.0052948110819;1016.8118898003819;1017.6133069433605;741.2365263778318;742.6917829100917;744.04761904762;744.7728442824937;747.137056699513;18542.721859172125;18958.14688339028;19176.520586985436;19220.80779192204;20378.898105509525;21090.26184083565;21216.469588260417;21512.677309840365;21718.674219886714;22020.559588808133;15728;15861.206939653086;16016;16054.678906421806;19277.807221927742;6005.189299444606;6033.185519954794;6063.666498342589;6098.08528720691;6101.389861013908;130680;133165.3341733295;134206.32896835552;135013;135332;15612.29744661493;16028.27872745706;16093.517194484184;16222.756658650129;16333.836661633231;23302.65046024311;23930.40173995629;25274.368140796258;29817.25456863596;29871.103866884027;8506.31949444043;8532.573371331533;8589.52757598338;8597.011343695554;8628.266597339296;4119.526254480713;4120.484939382577;4126.855560055444;4333.393324934512;4352.086061927031;5327.174287985368;5477.068898287301;5480.808171713971;5483.396826349099;5484.341878974548;1060.7772367802693;1086.0497065068066;1107.0534692837507;1107.191750022472;1107.7618312062946;678.1556961582861;694.2016680817;694.7985084325591;708.4332533972802;709.5990765217635;11646.825297620542;12007.819882701766;12127.332996685267;12246.671394468493;12295.692607684701;639.1020616034479;653.3923451190343;666.9633170175687;676.235853485568;704.1796307301936;5193.610479213999;5380.704061276668;5498.45015498447;5601.411851755588;6175.536834737412;102657;103638.48180759048;107154;108606;109442.45278773556;73300;93655;96088.51955740177;98648;103868.48065759774;88908;91559;92673;93498.53250733839;94531.52734236285;11470.770584588094;11928.463219154984;11987.520499180284;12214.6946326339;12566.623001309976;39040.41439378468;41764.373534397615;41812;42817.571824282604;43414;70329.64835175792;71043;71422;72490.27509725046;74106;18790.06049697537;18862.811371886106;18924.243030279184;18929.33747318837;19365.12856921414;19805;20122.39632811018;20467.385978420672;20609.89695051515;20756.481087972923;12445.128840981044;12585.496580137058;12634.810477842655;12657.810132848199;17781.911090444464;18831.6233675323;18872.905635471736;19041.619167616846;19132.23471061142;19250.8074919249;16847.15764211809;17434;17667.55831104233;17750.201240944447;17770.111494424968;11590.478428470571;11966.46150923193;11983.041356691618;11993.280403175837;12013.579524716593;12823.487060517475;13036.41336139857;13409.664758380728;13501.662458438617;13519.864801351861 18:15:11 INFO - PID 7758 | __end_tp_report 18:15:11 INFO - PID 7758 | __start_cc_report 18:15:11 INFO - PID 7758 | _x_x_mozilla_cycle_collect,348 18:15:11 INFO - PID 7758 | __end_cc_report 18:15:11 INFO - PID 7758 | __startTimestamp1504142111775__endTimestamp 18:15:11 INFO - PID 7758 | 18:15:11 INFO - PID 7758 | ------- Summary: start ------- 18:15:11 INFO - PID 7758 | Number of tests: 6 18:15:11 INFO - PID 7758 | 18:15:11 INFO - PID 7758 | [#0] dojo.html Cycles:165 Average:6198.31 Median:6425.55 stddev:726.18 (11.3%) stddev-sans-first:692.10 18:15:11 INFO - PID 7758 | Values: 3308.1 3329.6 3344.3 3349.4 3394.1 6219.8 6319.2 6330.5 6355.2 6387.7 6013.4 6186.6 6200.8 6211.2 6222.9 5774.2 5789.0 5794.9 5802.3 5813.5 5777.9 5788.2 5801.7 5809.9 5827.1 5764.0 5766.8 5793.2 5803.6 5812.9 5763.8 5791.9 5794.2 5815.8 5827.3 5653.8 5685.1 5755.7 5757.4 5811.7 6167.6 6227.4 6293.5 6311.3 6328.3 6551.5 6648.9 6661.5 6699.3 6701.2 6643.3 6671.9 6690.0 6704.3 6800.2 6263.1 6283.8 6348.3 6391.3 6394.9 6765.2 6913.1 6969.9 7082.8 7093.1 6558.7 6562.1 6568.0 6568.7 6582.3 6690.8 6698.9 6720.5 6747.9 6813.0 6345.9 6758.6 6759.1 6796.2 6803.0 6689.7 6701.0 6739.8 6796.7 6803.8 5049.2 5190.5 5203.2 5327.8 5346.5 4616.0 4618.6 4644.7 4646.4 4647.5 5707.8 5716.5 5721.5 5746.3 5871.8 6757.7 6835.9 6843.0 6843.9 6878.2 5848.1 5855.0 5855.4 5889.8 5897.4 5727.7 5815.4 5824.9 5833.9 5924.5 6436.0 6481.6 6529.7 6547.4 6599.8 6796.7 6837.8 6908.6 6909.5 6917.4 6470.5 6560.9 6570.8 6587.2 6655.1 6676.2 6694.7 6715.0 6730.1 6731.7 6820.6 6854.1 6857.2 6859.0 6937.1 6521.9 6525.8 6565.6 6611.8 6675.4 6297.9 6457.0 6527.0 6623.7 6624.4 6425.6 6469.5 6472.2 6479.3 6481.3 6457.7 6511.3 6565.8 6574.8 6605.5 6315.7 6364.1 6365.4 6385.6 6387.7 18:15:11 INFO - PID 7758 | 18:15:11 INFO - PID 7758 | [#1] ext.html Cycles:180 Average:37825.10 Median:3541.62 stddev:53697.29 (1516.2%) stddev-sans-first:53775.96 18:15:11 INFO - PID 7758 | Values: 800.8 834.4 861.6 887.3 889.0 41114.8 42019.6 42137.2 42147.6 42203.8 38022.0 38305.0 38386.0 38422.0 38480.8 6976.5 7085.8 7089.9 7090.5 7103.5 6987.2 6996.3 6998.9 7000.6 7042.5 6988.5 7157.7 7459.8 7805.7 7873.5 7752.0 7855.8 7858.6 7865.2 7870.1 7534.1 7661.5 7673.2 7682.3 7685.0 38064.4 38345.0 38755.0 38900.4 39243.8 3495.6 3530.7 3532.8 3538.8 3544.4 31223.0 31286.8 31308.2 31335.4 31408.2 5204.3 5242.4 5244.6 5267.7 5281.7 180274.0 181620.0 181699.0 182094.0 182098.0 47098.5 47215.3 47473.3 47488.3 47608.0 49559.8 49661.8 49666.0 49667.5 49706.0 14425.8 14629.3 14771.6 14772.8 14817.9 11779.2 11843.4 11959.9 11971.7 11972.1 13977.6 13989.0 14045.9 14160.9 14208.6 5654.3 5773.2 5793.0 5814.2 5826.9 1000.0 1001.7 1009.9 1011.6 1031.2 23280.7 29770.9 29782.1 29887.6 29949.6 1011.9 1013.0 1013.1 1016.4 1016.6 11500.9 11566.6 11800.0 11828.8 11862.6 226680.0 230380.0 230616.0 230856.0 231611.0 43230.6 46029.0 46121.0 46159.1 46188.8 1289.1 1470.4 1497.3 1502.8 1505.3 27542.9 28077.6 28394.6 28768.6 28829.9 45532.8 45896.3 45930.5 45972.0 46027.5 206504.0 207732.0 208137.0 208527.0 208960.0 34125.8 35043.0 35326.6 35547.0 35618.5 43322.8 43401.8 43682.1 43906.8 44518.3 32716.8 33452.3 33501.7 33757.3 33805.2 32361.4 32756.3 32920.9 32983.0 33018.5 37415.0 37516.4 37586.8 37596.8 37653.0 31821.5 31842.2 31962.7 32131.2 32278.4 23363.8 23414.9 23453.2 23888.2 24027.4 18:15:11 INFO - PID 7758 | 18:15:11 INFO - PID 7758 | [#2] jquery.html Cycles:180 Average:33870.39 Median:22408.16 stddev:78278.87 (349.3%) stddev-sans-first:78458.53 18:15:11 INFO - PID 7758 | Values: 568.2 579.2 583.0 583.7 587.9 22200.8 22912.9 23022.3 23062.4 23113.3 18431.7 19204.4 22023.8 24554.5 24768.6 6603.5 6815.4 6823.3 6836.4 6841.0 6668.4 6768.8 6770.5 6772.2 6777.6 3831.0 4367.6 6739.3 6749.6 6792.2 6773.8 6805.4 6817.3 6847.0 6850.8 6260.3 6269.1 6274.1 6284.2 6297.1 25258.9 27404.3 27713.6 27729.2 27784.9 1810.0 2004.5 2028.0 2034.2 2036.9 18970.4 19413.2 19477.1 19488.7 19510.6 2404.7 2419.7 2463.6 2468.1 2471.7 140359.3 147991.3 148126.0 148281.3 148327.0 13896.4 14015.5 14118.9 14152.0 14651.3 22227.0 22342.3 22474.0 22514.3 22554.4 9545.0 9896.2 9923.4 9938.0 10064.7 9033.9 9097.8 9199.8 9226.3 9285.0 8721.4 8802.0 8868.9 8925.2 8953.4 2369.8 2673.8 2741.5 2744.4 2766.6 995.0 1007.1 1016.0 1021.4 1025.1 18565.5 19268.9 19403.3 19544.6 19588.6 1062.4 1078.8 1080.7 1085.3 1094.5 10451.2 10573.5 10838.8 10995.5 10998.9 451217.0 453544.0 458856.0 463081.0 475011.0 102649.0 107925.4 110809.0 113164.0 125931.4 1205.9 1235.9 1239.2 1241.3 1257.9 20267.7 20548.5 20700.3 21028.5 21502.8 58354.7 60113.0 60317.1 61490.0 61703.0 65620.7 66258.7 66536.7 66785.3 67539.0 14269.6 14379.5 14437.6 14475.3 14883.9 22796.2 23180.8 23199.3 23279.4 23533.5 18369.9 18593.0 18603.3 18639.6 18932.8 15452.8 16191.4 16587.5 16588.6 17062.8 17682.7 18388.0 18388.6 18418.8 18513.8 13600.8 14236.5 14285.5 14391.2 14446.1 18117.0 18181.6 18201.7 18478.2 18521.4 18:15:11 INFO - PID 7758 | 18:15:11 INFO - PID 7758 | [#3] mootools.html Cycles:180 Average:9332.92 Median:2692.68 stddev:6763.13 (251.2%) stddev-sans-first:6755.28 18:15:11 INFO - PID 7758 | Values: 1315.6 1359.3 1382.5 1388.0 1393.1 14938.2 15215.5 15493.8 15740.8 15818.5 15579.2 15805.8 15824.3 15831.0 15836.1 2766.7 2856.3 2857.8 2860.4 2862.9 2628.5 2681.9 2745.5 2747.1 2849.7 2818.9 2858.3 2861.0 2862.0 2862.3 2703.5 2717.6 2747.8 2754.6 2758.8 2666.5 2666.5 2669.5 2677.9 2679.8 14756.4 15030.2 15089.5 15103.4 15123.5 7938.3 8202.7 8235.3 8249.9 8256.1 5520.2 5535.6 5574.9 5591.3 5782.3 1801.1 1871.0 2391.7 2402.6 2410.2 27478.7 27497.2 27640.4 27693.0 27706.0 6594.9 6805.8 6960.2 6997.8 7042.3 16946.2 17179.4 17257.1 17257.3 17270.9 7904.9 7961.8 8095.4 8103.8 8106.9 7361.6 7397.4 7419.1 7482.1 7495.7 4784.5 4947.5 4963.8 4967.6 5003.5 1511.7 1561.3 1572.4 1595.8 1604.6 847.6 891.0 893.7 901.4 904.5 7539.5 7546.9 7615.3 7662.7 7710.5 718.5 734.6 735.8 746.7 747.8 4242.3 4334.8 4338.3 4358.5 5439.2 20978.0 21073.4 21281.8 21844.6 21872.9 20747.3 21133.6 21609.6 21650.9 21902.8 10979.5 10982.3 11069.8 11087.7 11136.7 7957.8 8266.7 8273.7 8363.8 8420.2 17913.8 18073.7 18360.0 18594.3 18876.2 18944.1 19048.0 19695.8 19985.4 20073.1 10862.6 11065.5 11077.7 11093.0 11110.9 13673.2 13865.7 13930.7 13971.4 14001.2 10788.3 10801.6 11056.2 11121.6 11368.2 10804.6 10896.3 10958.2 11157.8 11340.9 9983.4 10017.0 10043.1 10043.8 10053.5 6881.5 6931.8 7023.5 7026.4 7091.0 6997.9 7081.5 7177.0 7192.4 7211.7 18:15:11 INFO - PID 7758 | 18:15:11 INFO - PID 7758 | [#4] prototype.html Cycles:180 Average:5547.50 Median:6179.84 stddev:1559.36 (25.2%) stddev-sans-first:1517.18 18:15:11 INFO - PID 7758 | Values: 508.5 515.4 517.5 530.4 531.5 6199.3 6260.0 6261.0 6313.1 6418.5 6160.3 6200.4 6204.9 6209.1 6247.9 5129.3 5143.6 5193.9 5197.7 5205.5 5186.1 5186.6 5187.2 5227.5 5232.3 4759.4 4900.1 4969.2 4992.6 5075.9 4918.9 4975.3 4991.6 4993.4 5016.5 4334.9 4359.4 4452.3 4467.2 4505.5 6069.8 6077.5 6083.3 6115.8 6157.9 5653.5 5698.4 5710.0 5723.5 5745.7 6439.3 6572.6 6630.4 6632.8 6633.2 4829.3 4854.7 4909.2 4926.1 4927.7 6684.9 6795.2 6875.1 6929.3 6938.7 4981.2 4988.3 4990.5 5014.0 5044.0 4961.0 5014.3 5014.7 5047.7 5108.4 5629.4 5635.9 5692.9 5701.8 5776.1 6551.6 6600.5 6614.0 6657.3 6679.6 1755.4 1779.5 1781.1 1784.5 1787.6 1152.8 1204.5 1205.0 1220.3 1253.4 5734.3 5737.4 5737.7 5751.7 5817.8 6773.9 6781.6 6823.6 6851.4 6869.6 5796.9 5833.8 5851.6 5852.9 5861.8 3472.3 3553.9 3571.0 3611.4 3639.2 6507.7 6550.3 6598.8 6637.7 6692.5 6814.5 6844.3 6863.9 6891.1 6893.4 6476.6 6503.2 6521.4 6555.0 6576.1 6730.1 6770.3 6788.3 6797.2 6878.4 6701.5 6715.4 6730.2 6766.4 6772.9 6542.0 6565.8 6614.8 6678.9 6683.8 4977.0 4986.3 4989.3 4995.9 5024.1 6470.9 6731.9 6768.0 6814.2 6844.2 6255.4 6520.6 6522.0 6569.2 6616.0 6479.5 6540.2 6600.1 6607.5 6611.6 6486.2 6495.9 6518.0 6529.2 6567.3 6531.2 6619.5 6649.3 6687.6 6700.4 6412.5 6450.8 6470.6 6482.1 6517.9 18:15:11 INFO - PID 7758 | 18:15:11 INFO - PID 7758 | [#5] yui.html Cycles:180 Average:23615.82 Median:20577.85 stddev:32764.81 (159.2%) stddev-sans-first:32812.29 18:15:11 INFO - PID 7758 | Values: 890.9 911.5 914.8 927.5 930.9 17997.0 18693.1 18763.0 18809.2 18820.5 14153.2 14733.1 15505.5 15671.0 20545.8 980.1 985.9 987.6 993.2 997.9 988.4 990.3 992.5 993.1 993.6 716.1 731.5 970.3 1032.4 1045.9 1003.8 1014.9 1015.0 1016.8 1017.6 741.2 742.7 744.0 744.8 747.1 18542.7 18958.1 19176.5 19220.8 20378.9 21090.3 21216.5 21512.7 21718.7 22020.6 15728.0 15861.2 16016.0 16054.7 19277.8 6005.2 6033.2 6063.7 6098.1 6101.4 130680.0 133165.3 134206.3 135013.0 135332.0 15612.3 16028.3 16093.5 16222.8 16333.8 23302.7 23930.4 25274.4 29817.3 29871.1 8506.3 8532.6 8589.5 8597.0 8628.3 4119.5 4120.5 4126.9 4333.4 4352.1 5327.2 5477.1 5480.8 5483.4 5484.3 1060.8 1086.0 1107.1 1107.2 1107.8 678.2 694.2 694.8 708.4 709.6 11646.8 12007.8 12127.3 12246.7 12295.7 639.1 653.4 667.0 676.2 704.2 5193.6 5380.7 5498.5 5601.4 6175.5 102657.0 103638.5 107154.0 108606.0 109442.5 73300.0 93655.0 96088.5 98648.0 103868.5 88908.0 91559.0 92673.0 93498.5 94531.5 11470.8 11928.5 11987.5 12214.7 12566.6 39040.4 41764.4 41812.0 42817.6 43414.0 70329.6 71043.0 71422.0 72490.3 74106.0 18790.1 18862.8 18924.2 18929.3 19365.1 19805.0 20122.4 20467.4 20609.9 20756.5 12445.1 12585.5 12634.8 12657.8 17781.9 18831.6 18872.9 19041.6 19132.2 19250.8 16847.2 17434.0 17667.6 17750.2 17770.1 11590.5 11966.5 11983.0 11993.3 12013.6 12823.5 13036.4 13409.7 13501.7 13519.9 18:15:11 INFO - PID 7758 | -------- Summary: end -------- 18:15:11 INFO - PID 7758 | 18:15:12 INFO - TEST-INFO | 7758: exit 0 18:15:12 INFO - TEST-OK | dromaeo_css | took 1113754ms 18:15:12 INFO - TEST-START | kraken 18:15:12 INFO - Initialising browser for kraken test... 18:15:12 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38224/getInfo.html -profile /tmp/tmpU7tkO2/profile 18:15:12 INFO - TEST-INFO | started process 8135 (/builds/slave/test/build/application/firefox/firefox http://localhost:38224/getInfo.html) 18:15:18 INFO - TEST-INFO | 8135: exit 0 18:15:19 INFO - Browser initialized. 18:15:19 INFO - Running cycle 1/1 for kraken test... 18:15:19 INFO - Using env: {'DISPLAY': ':0', 18:15:19 INFO - 'HOME': '/home/cltbld', 18:15:19 INFO - 'JSGC_DISABLE_POISONING': '1', 18:15:19 INFO - 'LANG': 'en_US.UTF-8', 18:15:19 INFO - 'LANGUAGE': 'en_US:en', 18:15:19 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 18:15:19 INFO - 'LOGNAME': 'cltbld', 18:15:19 INFO - 'MAIL': '/var/mail/cltbld', 18:15:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:15:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:15:19 INFO - 'MOZ_ACCELERATED': '1', 18:15:19 INFO - 'MOZ_CRASHREPORTER': '1', 18:15:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:15:19 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 18:15:19 INFO - 'MOZ_NO_REMOTE': '1', 18:15:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:15:19 INFO - 'MOZ_WEBRENDER': '1', 18:15:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:15:19 INFO - 'NO_EM_RESTART': '1', 18:15:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:15:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:15:19 INFO - 'PWD': '/builds/slave/test', 18:15:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:15:19 INFO - 'RUST_BACKTRACE': 'full', 18:15:19 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:15:19 INFO - 'SHELL': '/bin/bash', 18:15:19 INFO - 'SHLVL': '1', 18:15:19 INFO - 'TERM': 'linux', 18:15:19 INFO - 'TMOUT': '86400', 18:15:19 INFO - 'USER': 'cltbld', 18:15:19 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1504140929.173484-2013152947', 18:15:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:15:19 INFO - '_': '/tools/buildbot/bin/python'} 18:15:19 INFO - TEST-INFO | started process 8330 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU7tkO2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:15:19 INFO - PID 8330 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 18:15:20 INFO - PID 8330 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 18:15:20 INFO - PID 8330 | 18:15:20 INFO - PID 8330 | (/builds/slave/test/build/application/firefox/firefox:8391): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:15:20 INFO - PID 8330 | 18:15:30 INFO - PID 8330 | RSS: Main: 201850880 18:15:30 INFO - PID 8330 | 18:15:33 INFO - PID 8330 | Cycle 1(1): loaded http://localhost:38224/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38224/tests/kraken/driver.html?testName=audio-beat-detection) 18:15:34 INFO - PID 8330 | RSS: Main: 207917056 18:15:34 INFO - PID 8330 | 18:15:37 INFO - PID 8330 | Cycle 1(1): loaded http://localhost:38224/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38224/tests/kraken/driver.html?testName=audio-dft) 18:15:37 INFO - PID 8330 | RSS: Main: 208764928 18:15:37 INFO - PID 8330 | 18:15:40 INFO - PID 8330 | Cycle 1(1): loaded http://localhost:38224/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38224/tests/kraken/driver.html?testName=audio-fft) 18:15:41 INFO - PID 8330 | RSS: Main: 202727424 18:15:41 INFO - PID 8330 | 18:15:43 INFO - PID 8330 | Cycle 1(1): loaded http://localhost:38224/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38224/tests/kraken/driver.html?testName=audio-oscillator) 18:15:44 INFO - PID 8330 | RSS: Main: 203386880 18:15:44 INFO - PID 8330 | 18:15:46 INFO - PID 8330 | Cycle 1(1): loaded http://localhost:38224/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38224/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:15:46 INFO - PID 8330 | RSS: Main: 204115968 18:15:46 INFO - PID 8330 | 18:15:50 INFO - PID 8330 | Cycle 1(1): loaded http://localhost:38224/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38224/tests/kraken/driver.html?testName=imaging-darkroom) 18:15:50 INFO - PID 8330 | RSS: Main: 207142912 18:15:50 INFO - PID 8330 | 18:15:54 INFO - PID 8330 | Cycle 1(1): loaded http://localhost:38224/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38224/tests/kraken/driver.html?testName=imaging-desaturate) 18:15:54 INFO - PID 8330 | RSS: Main: 206336000 18:15:54 INFO - PID 8330 | 18:15:57 INFO - PID 8330 | Cycle 1(1): loaded http://localhost:38224/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38224/tests/kraken/driver.html?testName=json-parse-financial) 18:15:58 INFO - PID 8330 | RSS: Main: 207282176 18:15:58 INFO - PID 8330 | 18:16:00 INFO - PID 8330 | Cycle 1(1): loaded http://localhost:38224/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38224/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:16:00 INFO - PID 8330 | RSS: Main: 206299136 18:16:00 INFO - PID 8330 | 18:16:02 INFO - PID 8330 | Cycle 1(1): loaded http://localhost:38224/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38224/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:16:03 INFO - PID 8330 | RSS: Main: 207249408 18:16:03 INFO - PID 8330 | 18:16:05 INFO - PID 8330 | Cycle 1(1): loaded http://localhost:38224/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38224/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:16:05 INFO - PID 8330 | RSS: Main: 205545472 18:16:05 INFO - PID 8330 | 18:16:08 INFO - PID 8330 | Cycle 1(1): loaded http://localhost:38224/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38224/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:16:09 INFO - PID 8330 | RSS: Main: 207355904 18:16:09 INFO - PID 8330 | 18:16:12 INFO - PID 8330 | Cycle 1(1): loaded http://localhost:38224/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38224/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:16:13 INFO - PID 8330 | RSS: Main: 207187968 18:16:13 INFO - PID 8330 | 18:16:14 INFO - PID 8330 | Cycle 1(1): loaded http://localhost:38224/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38224/tests/kraken/driver.html?testName=ai-astar) 18:16:15 INFO - PID 8330 | RSS: Main: 209453056 18:16:15 INFO - PID 8330 | 18:16:15 INFO - PID 8330 | __start_tp_report 18:16:15 INFO - PID 8330 | _x_x_mozilla_page_load 18:16:15 INFO - PID 8330 | _x_x_mozilla_page_load_details 18:16:15 INFO - PID 8330 | |i|pagename|runs| 18:16:15 INFO - PID 8330 | |0;ai-astar;98;116;101;108;117;113;116;100;115;115 18:16:15 INFO - PID 8330 | |1;audio-beat-detection;151;122;157;177;118;153;163;130;181;127 18:16:15 INFO - PID 8330 | |2;audio-dft;165;165;163;169;164;163;167;171;164;170 18:16:15 INFO - PID 8330 | |3;audio-fft;73;76;75;183;77;74;73;74;168;74 18:16:15 INFO - PID 8330 | |4;audio-oscillator;87;80;133;84;80;79;143;81;79;129 18:16:15 INFO - PID 8330 | |5;imaging-gaussian-blur;118;118;122;116;115;121;114;117;117;118 18:16:15 INFO - PID 8330 | |6;imaging-darkroom;149;154;150;151;154;147;148;158;149;149 18:16:15 INFO - PID 8330 | |7;imaging-desaturate;96;95;95;95;94;95;98;97;97;95 18:16:15 INFO - PID 8330 | |8;json-parse-financial;55;54;55;61;53;54;55;52;52;54 18:16:15 INFO - PID 8330 | |9;json-stringify-tinderbox;43;47;49;43;40;39;44;48;40;49 18:16:15 INFO - PID 8330 | |10;stanford-crypto-aes;87;85;94;74;75;81;80;76;74;80 18:16:15 INFO - PID 8330 | |11;stanford-crypto-ccm;125;129;125;126;119;127;135;126;132;161 18:16:15 INFO - PID 8330 | |12;stanford-crypto-pbkdf2;171;184;184;175;170;175;184;162;171;171 18:16:15 INFO - PID 8330 | |13;stanford-crypto-sha256-iterative;64;66;65;65;64;66;66;65;67;73 18:16:15 INFO - PID 8330 | __end_tp_report 18:16:15 INFO - PID 8330 | __start_cc_report 18:16:15 INFO - PID 8330 | _x_x_mozilla_cycle_collect,919 18:16:15 INFO - PID 8330 | __end_cc_report 18:16:15 INFO - PID 8330 | __startTimestamp1504142175092__endTimestamp 18:16:15 INFO - PID 8330 | 18:16:15 INFO - PID 8330 | ------- Summary: start ------- 18:16:15 INFO - PID 8330 | Number of tests: 14 18:16:15 INFO - PID 8330 | 18:16:15 INFO - PID 8330 | [#0] ai-astar Cycles:10 Average:109.90 Median:115.50 stddev:7.52 (6.5%) stddev-sans-first:6.63 18:16:15 INFO - PID 8330 | Values: 98.0 116.0 101.0 108.0 117.0 113.0 116.0 100.0 115.0 115.0 18:16:15 INFO - PID 8330 | 18:16:15 INFO - PID 8330 | [#1] audio-beat-detection Cycles:10 Average:147.90 Median:155.00 stddev:22.63 (14.6%) stddev-sans-first:23.98 18:16:15 INFO - PID 8330 | Values: 151.0 122.0 157.0 177.0 118.0 153.0 163.0 130.0 181.0 127.0 18:16:15 INFO - PID 8330 | 18:16:15 INFO - PID 8330 | [#2] audio-dft Cycles:10 Average:166.10 Median:166.00 stddev:2.96 (1.8%) stddev-sans-first:3.11 18:16:15 INFO - PID 8330 | Values: 165.0 165.0 163.0 169.0 164.0 163.0 167.0 171.0 164.0 170.0 18:16:15 INFO - PID 8330 | 18:16:15 INFO - PID 8330 | [#3] audio-fft Cycles:10 Average:94.70 Median:74.00 stddev:42.75 (57.8%) stddev-sans-first:44.62 18:16:15 INFO - PID 8330 | Values: 73.0 76.0 75.0 183.0 77.0 74.0 73.0 74.0 168.0 74.0 18:16:15 INFO - PID 8330 | 18:16:15 INFO - PID 8330 | [#4] audio-oscillator Cycles:10 Average:97.50 Median:80.00 stddev:26.21 (32.8%) stddev-sans-first:27.53 18:16:15 INFO - PID 8330 | Values: 87.0 80.0 133.0 84.0 80.0 79.0 143.0 81.0 79.0 129.0 18:16:15 INFO - PID 8330 | 18:16:15 INFO - PID 8330 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:2.46 (2.1%) stddev-sans-first:2.60 18:16:15 INFO - PID 8330 | Values: 118.0 118.0 122.0 116.0 115.0 121.0 114.0 117.0 117.0 118.0 18:16:15 INFO - PID 8330 | 18:16:15 INFO - PID 8330 | [#6] imaging-darkroom Cycles:10 Average:150.90 Median:150.50 stddev:3.41 (2.3%) stddev-sans-first:3.55 18:16:15 INFO - PID 8330 | Values: 149.0 154.0 150.0 151.0 154.0 147.0 148.0 158.0 149.0 149.0 18:16:15 INFO - PID 8330 | 18:16:15 INFO - PID 8330 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:95.50 stddev:1.25 (1.3%) stddev-sans-first:1.32 18:16:15 INFO - PID 8330 | Values: 96.0 95.0 95.0 95.0 94.0 95.0 98.0 97.0 97.0 95.0 18:16:15 INFO - PID 8330 | 18:16:15 INFO - PID 8330 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:54.50 stddev:2.55 (4.7%) stddev-sans-first:2.70 18:16:15 INFO - PID 8330 | Values: 55.0 54.0 55.0 61.0 53.0 54.0 55.0 52.0 52.0 54.0 18:16:15 INFO - PID 8330 | 18:16:15 INFO - PID 8330 | [#9] json-stringify-tinderbox Cycles:10 Average:44.20 Median:45.50 stddev:3.85 (8.5%) stddev-sans-first:4.06 18:16:15 INFO - PID 8330 | Values: 43.0 47.0 49.0 43.0 40.0 39.0 44.0 48.0 40.0 49.0 18:16:15 INFO - PID 8330 | 18:16:15 INFO - PID 8330 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:80.50 stddev:6.50 (8.1%) stddev-sans-first:6.47 18:16:15 INFO - PID 8330 | Values: 87.0 85.0 94.0 74.0 75.0 81.0 80.0 76.0 74.0 80.0 18:16:15 INFO - PID 8330 | 18:16:15 INFO - PID 8330 | [#11] stanford-crypto-ccm Cycles:10 Average:130.50 Median:128.00 stddev:11.55 (9.0%) stddev-sans-first:12.08 18:16:15 INFO - PID 8330 | Values: 125.0 129.0 125.0 126.0 119.0 127.0 135.0 126.0 132.0 161.0 18:16:15 INFO - PID 8330 | 18:16:15 INFO - PID 8330 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.70 Median:175.00 stddev:7.33 (4.2%) stddev-sans-first:7.66 18:16:15 INFO - PID 8330 | Values: 171.0 184.0 184.0 175.0 170.0 175.0 184.0 162.0 171.0 171.0 18:16:15 INFO - PID 8330 | 18:16:15 INFO - PID 8330 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:2.60 (3.9%) stddev-sans-first:2.65 18:16:15 INFO - PID 8330 | Values: 64.0 66.0 65.0 65.0 64.0 66.0 66.0 65.0 67.0 73.0 18:16:15 INFO - PID 8330 | -------- Summary: end -------- 18:16:15 INFO - PID 8330 | 18:16:15 INFO - PID 8330 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:16:16 INFO - TEST-INFO | 8330: exit 0 18:16:16 INFO - TEST-OK | kraken | took 63288ms 18:16:16 INFO - SUITE-END | took 1177s 18:16:16 INFO - Completed test suite (00:19:37) 18:16:16 INFO - javascript benchmark 18:16:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8519.916895702368, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3308.057203696947, 3329.6004479462467, 3344.2809795893886, 3349.4138525757994, 3394.083597428693, 6219.782307619234, 6319.241690997075, 6330.525210609199, 6355.173827402443, 6387.712552935118, 6013.368596297391, 6186.628802271855, 6200.844978875519, 6211.192544969159, 6222.906656400158, 5774.191613174159, 5788.971055144719, 5794.884102317951, 5802.274715660543, 5813.505852002585, 5777.884442311172, 5788.218590490272, 5801.7389217485315, 5809.941900580982, 5827.096799996008, 5764.048931926227, 5766.798162064329, 5793.217915581385, 5803.564732645047, 5812.912806307909, 5763.769449222026, 5791.942080579182, 5794.246747922764, 5815.796447124372, 5827.329857066449, 5653.830385088454, 5685.147227915804, 5755.740991655385, 5757.395473475267, 5811.738471768781, 6167.568270221086, 6227.439530442237, 6293.527985401068, 6311.274203466614, 6328.303886572473, 6551.508636852255, 6648.900266496006, 6661.533692641517, 6699.3300669933105, 6701.195856497252, 6643.335666433318, 6671.93328066718, 6690.029945657852, 6704.329567043305, 6800.217974932896, 6263.091851681526, 6283.842903927439, 6348.269948955883, 6391.296957334689, 6394.9360506394805, 6765.154355705537, 6913.1358580177475, 6969.9303006969285, 7082.752103676346, 7093.077899872984, 6558.737650493927, 6562.081308616797, 6568.0, 6568.704408301543, 6582.341765823475, 6690.765823196165, 6698.866022679519, 6720.495962802809, 6747.865042699119, 6813.0121132435515, 6345.87835722481, 6758.628275444799, 6759.087523184406, 6796.150481189851, 6803.0, 6689.665516724144, 6700.96649516759, 6739.797806065826, 6796.72813087471, 6803.829904252334, 5049.2173713074535, 5190.532852043259, 5203.19350500673, 5327.840164795062, 5346.492083252085, 4615.976920115378, 4618.584327410482, 4644.651651126179, 4646.3727396801, 4647.535246475325, 5707.800226992118, 5716.485516303553, 5721.456461636221, 5746.2529871116485, 5871.794487192928, 6757.729690812411, 6835.931640683629, 6843.0, 6843.897341539781, 6878.243393226741, 5848.064309710426, 5854.970725146347, 5855.414458554195, 5889.823305300848, 5897.3807750185615, 5727.684977326204, 5815.389384114692, 5824.88350232993, 5833.941660583425, 5924.526037916957, 6436.034594810816, 6481.611103333815, 6529.706163222666, 6547.377999090174, 6599.8020059398295, 6796.660166991532, 6837.794866154023, 6908.585484870924, 6909.516333856582, 6917.377436030782, 6470.48236141117, 6560.868782624416, 6570.8028759137305, 6587.242467116343, 6655.101561289164, 6676.165479315086, 6694.732210711517, 6715.026321183499, 6730.0914376560495, 6731.730730770911, 6820.556663816836, 6854.143232095988, 6857.2114206866845, 6859.039734437282, 6937.06349642812, 6521.902171467337, 6525.771597994048, 6565.573237739532, 6611.768588099393, 6675.432588229861, 6297.905531416941, 6456.967715161394, 6527.0, 6623.735050597922, 6624.436922861611, 6425.5502114851515, 6469.4824414045825, 6472.15861937945, 6479.319671434431, 6481.254655714653, 6457.741690332334, 6511.283758786624, 6565.770198043046, 6574.8356291091195, 6605.504587156079, 6315.715792789428, 6364.109024736633, 6365.427111559982, 6385.584936979081, 6387.680615969276], "value": 6146.011473110898, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [800.7597720683797, 834.3908946469081, 861.6294993152944, 887.2901678657076, 888.9955550222248, 41114.79442602787, 42019.57980420199, 42137.15725685484, 42147.57852421475, 42203.78898105513, 38022.0, 38305.0, 38386.0, 38422.0, 38480.80759596198, 6976.546524475905, 7085.751998680022, 7089.89365159523, 7090.50366474347, 7103.502754807139, 6987.231404545496, 6996.265392133829, 6998.895016574756, 7000.579965202079, 7042.4718146138985, 6988.475864310197, 7157.749478768244, 7459.813504662373, 7805.687772489094, 7873.5275883447175, 7751.961240193791, 7855.764327070168, 7858.646360913773, 7865.17415671352, 7870.134285228621, 7534.133574638877, 7661.540307581563, 7673.2326767323375, 7682.308592226726, 7685.0, 38064.42903356452, 38345.0, 38755.0, 38900.416493752615, 39243.8037809812, 3495.5980062292906, 3530.735194860396, 3532.8056956867363, 3538.8230588470474, 3544.4151714967, 31223.0, 31286.843565782252, 31308.217294567592, 31335.37329253425, 31408.21479463009, 5204.34945631796, 5242.370915490127, 5244.632875698702, 5267.736613169326, 5281.735913204325, 180274.0, 181620.0, 181699.0, 182094.0, 182098.0, 47098.5290147101, 47215.291770623466, 47473.28790068152, 47488.28767568489, 47608.0, 49559.75220123876, 49661.75169124131, 49666.0, 49667.50332496701, 49706.0, 14425.78361324581, 14629.268536573129, 14771.63070923214, 14772.778408323884, 14817.851821481647, 11779.234349767408, 11843.407829608484, 11959.880401196051, 11971.700707482383, 11972.10209234311, 13977.60223977594, 13989.0, 14045.85954140466, 14160.85839141616, 14208.64478388028, 5654.293213348332, 5773.220615216892, 5793.0, 5814.215080964101, 5826.854328641818, 999.9500024998721, 1001.6844693921391, 1009.9192064634811, 1011.6054738651932, 1031.2111234905303, 23280.65079023816, 29770.85114574413, 29782.10653680393, 29887.551686724717, 29949.550756738667, 1011.858339832424, 1012.9696109116738, 1013.133770626104, 1016.3546148195801, 1016.6441745389054, 11500.94249528747, 11566.595169169206, 11799.997000254903, 11828.763424731456, 11862.644120676394, 226680.0, 230380.0, 230616.0, 230856.0, 231611.0, 43230.56769432266, 46029.0, 46121.0, 46159.07681846344, 46188.7690561545, 1289.1169548859061, 1470.3750905864965, 1497.3336865094927, 1502.774583812437, 1505.2925125191362, 27542.862285688443, 28077.57883631706, 28394.574081389208, 28768.568471472525, 28829.85585072145, 45532.77233613943, 45896.31155532603, 45930.54069459263, 45972.0, 46027.53972460233, 206504.0, 207732.0, 208137.0, 208527.0, 208960.0, 34125.82937085299, 35043.0, 35326.64673353233, 35547.0, 35618.46572301469, 43322.78338608413, 43401.782991084845, 43682.12635747331, 43906.780466097465, 44518.3322250173, 32716.83641581777, 33452.330953381286, 33501.66498335083, 33757.3248535023, 33805.15487112842, 32361.35277294488, 32756.344873101927, 32920.88563528203, 32983.0, 33018.504722429665, 37415.0, 37516.43725344176, 37586.81206593949, 37596.812015939744, 37653.0, 31821.522677160323, 31842.20394490156, 31962.68037319597, 32131.196720082185, 32278.35443291168, 23363.76636233616, 23414.946327414968, 23453.179138730062, 23888.163914262917, 24027.43821651587], "value": 17165.458996473542, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.2442351672273, 579.226732312363, 582.9679367634778, 583.7431530126745, 587.9382664820195, 22200.77799222007, 22912.88543557284, 23022.309330720105, 23062.423439414, 23113.306600802003, 18431.72352414715, 19204.423867283967, 22023.77976220237, 24554.508909821838, 24768.628470572956, 6603.537752357337, 6815.38661520463, 6823.283555226704, 6836.418904393107, 6841.0, 6668.433183179435, 6768.7630932917355, 6770.458363330922, 6772.2211945626395, 6777.593344399352, 3831.0, 4367.585079417466, 6739.292374300701, 6749.628770417625, 6792.150981127359, 6773.796786096425, 6805.421539169151, 6817.318268173168, 6847.0, 6850.794476165723, 6260.280067792171, 6269.0909818076125, 6274.090256912722, 6284.151639528651, 6297.0554416837385, 25258.873705631355, 27404.314892127855, 27713.58429623557, 27729.168124956283, 27784.86107569449, 1809.9547511312192, 2004.5189154602936, 2028.0468179955396, 2034.1558253324852, 2036.8879711615855, 18970.43088707327, 19413.22347106114, 19477.12352944107, 19488.70766938483, 19510.609787804307, 2404.6873906392057, 2419.676313481635, 2463.556559819232, 2468.123816045296, 2471.653968444419, 140359.29820350936, 147991.26004370017, 148126.0, 148281.25859370743, 148327.0, 13896.444142234399, 14015.458299587037, 14118.941079418879, 14152.0, 14651.267436628339, 22227.0, 22342.3297301078, 22474.0, 22514.324570262917, 22554.436139096655, 9544.95227523858, 9896.20830333586, 9923.404595724136, 9937.950310248547, 10064.69805905824, 9033.864492032493, 9097.81804363909, 9199.816003679889, 9226.26189904806, 9284.95357523208, 8721.433106848035, 8801.955990220007, 8868.911310886937, 8925.196732293995, 8953.376358254887, 2369.822263330257, 2673.799465040091, 2741.4791189673897, 2744.3825139343885, 2766.6265054217424, 994.955227014786, 1007.0835539659022, 1015.9542820573092, 1021.4177918586334, 1025.1235193909101, 18565.535861603566, 19268.903655481634, 19403.320883769, 19544.609107818047, 19588.608227835648, 1062.4422178356424, 1078.7734575739182, 1080.7406222506543, 1085.3270971997254, 1094.5020015892749, 10451.16390688743, 10573.524191411405, 10838.783224335626, 10995.450227488753, 10998.945005275082, 451217.0, 453544.0, 458856.0, 463081.0, 475011.0, 102649.0, 107925.38111928328, 110809.0, 113164.0, 125931.3703431477, 1205.9276443413423, 1235.8516977962702, 1239.2130996817086, 1241.3296819717252, 1257.8930291761446, 20267.69598455995, 20548.486287842923, 20700.275490357766, 21028.47428814292, 21502.78497215008, 58354.7082264586, 60113.0, 60317.09524357226, 61490.0, 61703.0, 65620.67189664021, 66258.66870665616, 66536.66731666504, 66785.33214667792, 67539.0, 14269.643258918195, 14379.496717614833, 14437.566872993826, 14475.27623618836, 14883.925580372028, 22796.202132925268, 23180.768192318537, 23199.3040208794, 23279.41801454977, 23533.529329412973, 18369.908150459163, 18593.0, 18603.348882789036, 18639.627207455505, 18932.810671893654, 15452.84547154559, 16191.352345906032, 16587.502374928772, 16588.58528536748, 17062.829371706124, 17682.734758978368, 18388.0, 18388.632227355647, 18418.81581184171, 18513.81486185121, 13600.795988059988, 14236.501722439665, 14285.500007499688, 14391.208483533088, 14446.133232006114, 18117.0, 18181.636367272844, 18201.726974095134, 18478.168482418594, 18521.35175268859], "value": 11874.284060433129, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1315.6381994951387, 1359.2524111738542, 1382.4953891829484, 1388.049186307379, 1393.0805668258952, 14938.178400187986, 15215.46745863895, 15493.84506154938, 15740.763888541682, 15818.525444236677, 15579.221038948035, 15805.84194158058, 15824.287907044181, 15831.0, 15836.129012904286, 2766.695663477021, 2856.2573730829927, 2857.771378289742, 2860.356419805548, 2862.9427411451757, 2628.47430513897, 2681.8793154308005, 2745.533259345906, 2747.0659975608287, 2849.743523082922, 2818.8590570471497, 2858.3140046388926, 2861.02725073475, 2861.957070643942, 2862.341661417875, 2703.4728227995547, 2717.55160398534, 2747.835129892213, 2754.628125203112, 2758.820676656021, 2666.5066962611977, 2666.546687063204, 2669.5328317544354, 2677.8794954227105, 2679.812413131062, 14756.409743610242, 15030.17334046627, 15089.5473135805, 15103.39586416542, 15123.470678526308, 7938.285554300083, 8202.712905048294, 8235.341172706168, 8249.876251856227, 8256.091829898707, 5520.227168196416, 5535.557155427556, 5574.86062848432, 5591.30108736408, 5782.335031471351, 1801.0994502748626, 1871.0177156992552, 2391.653210284499, 2402.6035704108976, 2410.1564452441507, 27478.725212747817, 27497.17508474749, 27640.447191056068, 27693.030743924068, 27706.0, 6594.86810263792, 6805.829854253584, 6960.199577048603, 6997.825054373579, 7042.295770422917, 16946.23741931616, 17179.398721044705, 17257.05086220245, 17257.309707611807, 17270.913645431945, 7904.920950790533, 7961.840763184704, 8095.392845536609, 8103.83792324162, 8106.946097007351, 7361.595112268877, 7397.371223446067, 7419.146798118178, 7482.102147742197, 7495.737649182252, 4784.497627749106, 4947.529984651453, 4963.751812409365, 4967.602591792648, 5003.4746351633285, 1511.6749898771816, 1561.2584022589178, 1572.4103461202048, 1595.8085029796498, 1604.606871316535, 847.6482259862088, 890.973270801877, 893.678275820704, 901.3915606965403, 904.4663648447316, 7539.509931854412, 7546.886796698054, 7615.276548727862, 7662.731804386931, 7710.460267781202, 718.4647437658978, 734.6179986407145, 735.8234023834349, 746.660269577341, 747.8055705516605, 4242.342436922282, 4334.804933777988, 4338.284183109815, 4358.542353052947, 5439.156930675752, 20978.0, 21073.367798966057, 21281.78718212798, 21844.563108737737, 21872.906354682204, 20747.273845415337, 21133.577328453346, 21609.56780864374, 21650.891745541172, 21902.780972190074, 10979.451027448597, 10982.286151400293, 11069.833952490559, 11087.667369978752, 11136.665900023012, 7957.7612671619945, 8266.669333226604, 8273.710420135267, 8363.790905227417, 8420.242178203991, 17913.820861791737, 18073.728894066862, 18359.990200539098, 18594.2562297512, 18876.150573223964, 18944.147513362208, 19048.0, 19695.80304196997, 19985.400437986882, 20073.096710647766, 10862.619808306672, 11065.5020524075, 11077.723056923642, 11093.0, 11110.888891110986, 13673.179609223478, 13865.72268554603, 13930.72138557203, 13971.441142354191, 14001.159930404208, 10788.298760580537, 10801.567937282734, 11056.170787190831, 11121.555137794398, 11368.204225704121, 10804.567817287221, 10896.291741036806, 10958.232923695265, 11157.832632510681, 11340.94329528347, 9983.400995940267, 10017.0, 10043.096121349114, 10043.799124017332, 10053.547590358598, 6881.518293719391, 6931.757388491378, 7023.473239506955, 7026.402755765817, 7091.0, 6997.860042799014, 7081.539699919489, 7177.0, 7192.4246060314, 7211.71153153868], "value": 6635.445004837128, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [508.5169089365104, 515.435598020168, 517.5057819782108, 530.4324372920973, 531.5163201486648, 6199.349068347826, 6259.968700156499, 6260.9999999999945, 6313.106068179545, 6418.486521078315, 6160.322364539908, 6200.379962003797, 6204.875902481947, 6209.130721698954, 6247.875042499159, 5129.281900533928, 5143.639945203847, 5193.870153246161, 5197.674592978785, 5205.479452054783, 5186.092433824085, 5186.559142472895, 5187.210412407713, 5227.5295223429885, 5232.319798426218, 4759.428868535781, 4900.137947579915, 4969.155243608595, 4992.575631071363, 5075.893504195755, 4918.926216106761, 4975.253711943201, 4991.600671946236, 4993.350864387643, 5016.523430274118, 4334.934975975363, 4359.367891655724, 4452.265376212921, 4467.1735728889935, 4505.504394516601, 6069.786042791416, 6077.453029227391, 6083.30042045166, 6115.847103822395, 6157.876842463171, 5653.462921022538, 5698.373178950312, 5710.0, 5723.54211663066, 5745.683987380692, 6439.291677915426, 6572.572782769104, 6630.436412904909, 6632.767853125118, 6633.237177724575, 4829.323894654716, 4854.708717476963, 4909.165441874889, 4926.11329960607, 4927.6550641455115, 6684.866302673968, 6795.18457785059, 6875.07186529817, 6929.341712537301, 6938.653067346612, 4981.178105612534, 4988.301637770715, 4990.451050384455, 5014.047331007097, 5043.974780126149, 4961.0, 5014.348134742533, 5014.6991180529285, 5047.747612619354, 5108.386993560722, 5629.408912064175, 5635.9421216723895, 5692.943070569241, 5701.828945131652, 5776.133579963039, 6551.574147680385, 6600.471962243009, 6614.0, 6657.300983396771, 6679.632620205838, 1755.3505203074944, 1779.4839496545856, 1781.118346418531, 1784.5003399048287, 1787.5799187191, 1152.809786385237, 1204.50615247748, 1204.9819252711216, 1220.3464305865602, 1253.4422182129047, 5734.311882574118, 5737.426257374313, 5737.684427356536, 5751.734618383949, 5817.825465236049, 6773.8645227095185, 6781.559198652072, 6823.590584564942, 6851.417629501549, 6869.587824730532, 5796.88406231873, 5833.82498525045, 5851.590388672752, 5852.912206316909, 5861.824145275648, 3472.305538892181, 3553.911152221215, 3571.0, 3611.422172452395, 3639.1629925117372, 6507.674616269168, 6550.2794692583775, 6598.822388611842, 6637.668116594151, 6692.464602831762, 6814.522983391214, 6844.349786770249, 6863.897041544381, 6891.138607674041, 6893.414059804973, 6476.579022363531, 6503.187101612299, 6521.445677117498, 6554.9999999999045, 6576.106513134206, 6730.101645813081, 6770.255271919987, 6788.25329213796, 6797.150356205474, 6878.449724021966, 6701.481722095744, 6715.4291885190305, 6730.192376914802, 6766.391024807791, 6772.898406523807, 6542.0, 6565.803025909039, 6614.8346291343105, 6678.899816502659, 6683.7660681875905, 4976.975115124401, 4986.276989836526, 4989.25161225819, 4995.875103122451, 5024.0956627807345, 6470.935290647033, 6731.899021514583, 6767.966160169168, 6814.23003897264, 6844.247132815287, 6255.374462553708, 6520.576162549419, 6522.0, 6569.178852643419, 6615.966920165561, 6479.514036447191, 6540.215174179129, 6600.141981542369, 6607.53747237708, 6611.636360000246, 6486.189226346707, 6495.902561461677, 6518.0, 6529.151210342625, 6567.343265673395, 6531.183602049744, 6619.470442364503, 6649.2685804562425, 6687.6321802301345, 6700.430463410665, 6412.487001039999, 6450.774222902363, 6470.638217050837, 6482.124913136855, 6517.869642607026], "value": 5088.181045326774, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [890.8752774611554, 911.5123408976199, 914.7713071732067, 927.452802846321, 930.8929473110594, 17997.0, 18693.065346732677, 18762.99999999998, 18809.153588088535, 18820.529486762836, 14153.15081095135, 14733.116013039198, 15505.457308994188, 15671.0, 20545.794542054577, 980.1472718734675, 985.9112679858812, 987.6444479987199, 993.2401712689762, 997.9222439765073, 988.3871999360407, 990.2869933647762, 992.4888682328607, 993.0516356879199, 993.5628323537657, 716.090564982472, 731.5464412064528, 970.3207754571793, 1032.406366339354, 1045.94770261487, 1003.8243307421172, 1014.8579198912158, 1015.0052948110819, 1016.8118898003819, 1017.6133069433605, 741.2365263778318, 742.6917829100917, 744.04761904762, 744.7728442824937, 747.137056699513, 18542.721859172125, 18958.14688339028, 19176.520586985436, 19220.80779192204, 20378.898105509525, 21090.26184083565, 21216.469588260417, 21512.677309840365, 21718.674219886714, 22020.559588808133, 15728.0, 15861.206939653086, 16016.0, 16054.678906421806, 19277.807221927742, 6005.189299444606, 6033.185519954794, 6063.666498342589, 6098.08528720691, 6101.389861013908, 130680.0, 133165.3341733295, 134206.32896835552, 135013.0, 135332.0, 15612.29744661493, 16028.27872745706, 16093.517194484184, 16222.756658650129, 16333.836661633231, 23302.65046024311, 23930.40173995629, 25274.368140796258, 29817.25456863596, 29871.103866884027, 8506.31949444043, 8532.573371331533, 8589.52757598338, 8597.011343695554, 8628.266597339296, 4119.526254480713, 4120.484939382577, 4126.855560055444, 4333.393324934512, 4352.086061927031, 5327.174287985368, 5477.068898287301, 5480.808171713971, 5483.396826349099, 5484.341878974548, 1060.7772367802693, 1086.0497065068066, 1107.0534692837507, 1107.191750022472, 1107.7618312062946, 678.1556961582861, 694.2016680817, 694.7985084325591, 708.4332533972802, 709.5990765217635, 11646.825297620542, 12007.819882701766, 12127.332996685267, 12246.671394468493, 12295.692607684701, 639.1020616034479, 653.3923451190343, 666.9633170175687, 676.235853485568, 704.1796307301936, 5193.610479213999, 5380.704061276668, 5498.45015498447, 5601.411851755588, 6175.536834737412, 102657.0, 103638.48180759048, 107154.0, 108606.0, 109442.45278773556, 73300.0, 93655.0, 96088.51955740177, 98648.0, 103868.48065759774, 88908.0, 91559.0, 92673.0, 93498.53250733839, 94531.52734236285, 11470.770584588094, 11928.463219154984, 11987.520499180284, 12214.6946326339, 12566.623001309976, 39040.41439378468, 41764.373534397615, 41812.0, 42817.571824282604, 43414.0, 70329.64835175792, 71043.0, 71422.0, 72490.27509725046, 74106.0, 18790.06049697537, 18862.811371886106, 18924.243030279184, 18929.33747318837, 19365.12856921414, 19805.0, 20122.39632811018, 20467.385978420672, 20609.89695051515, 20756.481087972923, 12445.128840981044, 12585.496580137058, 12634.810477842655, 12657.810132848199, 17781.911090444464, 18831.6233675323, 18872.905635471736, 19041.619167616846, 19132.23471061142, 19250.8074919249, 16847.15764211809, 17434.0, 17667.55831104233, 17750.201240944447, 17770.111494424968, 11590.478428470571, 11966.46150923193, 11983.041356691618, 11993.280403175837, 12013.579524716593, 12823.487060517475, 13036.41336139857, 13409.664758380728, 13501.662458438617, 13519.864801351861], "value": 9042.693309526177, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1530.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 116.0, 101.0, 108.0, 117.0, 113.0, 116.0, 100.0, 115.0, 115.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 122.0, 157.0, 177.0, 118.0, 153.0, 163.0, 130.0, 181.0, 127.0], "value": 147.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 163.0, 169.0, 164.0, 163.0, 167.0, 171.0, 164.0, 170.0], "value": 166.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 75.0, 183.0, 77.0, 74.0, 73.0, 74.0, 168.0, 74.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 80.0, 133.0, 84.0, 80.0, 79.0, 143.0, 81.0, 79.0, 129.0], "value": 97.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 122.0, 116.0, 115.0, 121.0, 114.0, 117.0, 117.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 154.0, 150.0, 151.0, 154.0, 147.0, 148.0, 158.0, 149.0, 149.0], "value": 150.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 94.0, 95.0, 98.0, 97.0, 97.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 61.0, 53.0, 54.0, 55.0, 52.0, 52.0, 54.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [43.0, 47.0, 49.0, 43.0, 40.0, 39.0, 44.0, 48.0, 40.0, 49.0], "value": 44.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 94.0, 74.0, 75.0, 81.0, 80.0, 76.0, 74.0, 80.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 129.0, 125.0, 126.0, 119.0, 127.0, 135.0, 126.0, 132.0, 161.0], "value": 130.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 184.0, 184.0, 175.0, 170.0, 175.0, 184.0, 162.0, 171.0, 171.0], "value": 174.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 65.0, 64.0, 66.0, 66.0, 65.0, 67.0, 73.0], "value": 66.1, "unit": "score"}]}]} 18:16:16 INFO - Return code: 0 18:16:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:16:16 INFO - # TBPL SUCCESS # 18:16:16 INFO - Running post-action listener: _package_coverage_data 18:16:16 INFO - Running post-action listener: _resource_record_post_action 18:16:16 INFO - [mozharness: 2017-08-31 01:16:16.363421Z] Finished run-tests step (success) 18:16:16 INFO - Running post-run listener: _resource_record_post_run 18:16:16 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 20480; Write bytes: 388370432; Read time: 404; Write time: 300520 18:16:16 INFO - TinderboxPrint: CPU usage
13.3% 18:16:16 INFO - TinderboxPrint: I/O read bytes / time
20,480 / 404 18:16:16 INFO - TinderboxPrint: I/O write bytes / time
388,370,432 / 300,520 18:16:16 INFO - TinderboxPrint: CPU idle
8,251.8 (86.7%) 18:16:16 INFO - TinderboxPrint: CPU user
1,200.1 (12.6%) 18:16:16 INFO - TinderboxPrint: Swap in / out
0 / 0 18:16:16 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 106237952; Read time: 148; Write time: 72312 18:16:16 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:16:16 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 16384; Write bytes: 282132480; Read time: 256; Write time: 228180 18:16:17 INFO - Running post-run listener: _upload_blobber_files 18:16:17 INFO - Blob upload gear active. 18:16:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:16:17 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 18:16:17 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'] 18:16:17 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 18:16:17 INFO - (blobuploader) - INFO - Open directory for files ... 18:16:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:16:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:16:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:16:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:16:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:16:18 INFO - (blobuploader) - INFO - Done attempting. 18:16:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:16:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:16:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:16:19 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:16:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:16:19 INFO - (blobuploader) - INFO - Done attempting. 18:16:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:16:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:16:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:16:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:16:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:16:20 INFO - (blobuploader) - INFO - Done attempting. 18:16:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:16:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:16:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:16:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:16:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:16:24 INFO - (blobuploader) - INFO - Done attempting. 18:16:24 INFO - (blobuploader) - INFO - Iteration through files over. 18:16:24 INFO - Return code: 0 18:16:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:16:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:16:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a02ac990bdfbb74523844ee147d6910f390ec8057a30ff66584572aedfb79f0d0dffe1efe02bdb2cf76f686e42d40151ee726eba44a12b09bad42de01442a3c", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/808cd6a0ca1c6bb612e3c70c95f3a08aaa9165d2e38ff62708e422ed7c526565ad97185fc55940a0186ba90b4855978e44c9a29df119ec8186478541f71212f9", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5249e90171b04f14cd776386d6554bcace353e970bd1e55a6aedcc39118b6096766ee919d845d12b8bcffb511ec693d7047f7b4f42c8f141b9234056aa6112ed", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d8b3f0f83cf736e53cbd2157983728ff5804b108e58b7ec04d36a43cd9b663f23d3c59047cebf40fd866a2d8f797b409a47a469cd0e16ca9cf7a113cc26e3f7"} 18:16:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:16:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:16:24 INFO - Contents: 18:16:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a02ac990bdfbb74523844ee147d6910f390ec8057a30ff66584572aedfb79f0d0dffe1efe02bdb2cf76f686e42d40151ee726eba44a12b09bad42de01442a3c", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/808cd6a0ca1c6bb612e3c70c95f3a08aaa9165d2e38ff62708e422ed7c526565ad97185fc55940a0186ba90b4855978e44c9a29df119ec8186478541f71212f9", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5249e90171b04f14cd776386d6554bcace353e970bd1e55a6aedcc39118b6096766ee919d845d12b8bcffb511ec693d7047f7b4f42c8f141b9234056aa6112ed", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d8b3f0f83cf736e53cbd2157983728ff5804b108e58b7ec04d36a43cd9b663f23d3c59047cebf40fd866a2d8f797b409a47a469cd0e16ca9cf7a113cc26e3f7"} 18:16:24 INFO - Running post-run listener: copy_logs_to_upload_dir 18:16:24 INFO - Copying logs to upload dir... 18:16:24 INFO - mkdir: /builds/slave/test/build/upload/logs 18:16:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.259000 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-08-30 18:16:24.637906) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-30 18:16:24.642508) ========= 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=6d15e502d8e29d5d2676d664000001c3-1504140929.173484-2013152947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a02ac990bdfbb74523844ee147d6910f390ec8057a30ff66584572aedfb79f0d0dffe1efe02bdb2cf76f686e42d40151ee726eba44a12b09bad42de01442a3c", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/808cd6a0ca1c6bb612e3c70c95f3a08aaa9165d2e38ff62708e422ed7c526565ad97185fc55940a0186ba90b4855978e44c9a29df119ec8186478541f71212f9", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5249e90171b04f14cd776386d6554bcace353e970bd1e55a6aedcc39118b6096766ee919d845d12b8bcffb511ec693d7047f7b4f42c8f141b9234056aa6112ed", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d8b3f0f83cf736e53cbd2157983728ff5804b108e58b7ec04d36a43cd9b663f23d3c59047cebf40fd866a2d8f797b409a47a469cd0e16ca9cf7a113cc26e3f7"} build_url:https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011276 build_url: 'https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a02ac990bdfbb74523844ee147d6910f390ec8057a30ff66584572aedfb79f0d0dffe1efe02bdb2cf76f686e42d40151ee726eba44a12b09bad42de01442a3c", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/808cd6a0ca1c6bb612e3c70c95f3a08aaa9165d2e38ff62708e422ed7c526565ad97185fc55940a0186ba90b4855978e44c9a29df119ec8186478541f71212f9", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5249e90171b04f14cd776386d6554bcace353e970bd1e55a6aedcc39118b6096766ee919d845d12b8bcffb511ec693d7047f7b4f42c8f141b9234056aa6112ed", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d8b3f0f83cf736e53cbd2157983728ff5804b108e58b7ec04d36a43cd9b663f23d3c59047cebf40fd866a2d8f797b409a47a469cd0e16ca9cf7a113cc26e3f7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-30 18:16:24.672118) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 18:16:24.672482) ========= 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=6d15e502d8e29d5d2676d664000001c3-1504140929.173484-2013152947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004512 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 18:16:24.723065) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-30 18:16:24.723426) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-30 18:16:24.723780) ========= ========= Total master_lag: 0.18 =========