builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-007 starttime: 1503091635.89 results: success (0) revision: 8febdfacc7160c9ba90ba480e8bf5cd174e4fcab ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-18 14:27:15.887719) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-18 14:27:15.888225) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-18 14:27:15.888558) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-18 14:27:15.900571) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 14:27:15.900898) ========= 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=923d835db2ba3686ebe126b700000192-1503091635.205831-160446131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-18 14:27:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.5M=0s 2017-08-18 14:27:16 (37.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123836 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 14:27:16.040173) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 14:27:16.040761) ========= 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=923d835db2ba3686ebe126b700000192-1503091635.205831-160446131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014466 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 14:27:16.093266) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-18 14:27:16.093878) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8febdfacc7160c9ba90ba480e8bf5cd174e4fcab --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 8febdfacc7160c9ba90ba480e8bf5cd174e4fcab --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=923d835db2ba3686ebe126b700000192-1503091635.205831-160446131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-18 14:27:16,164 truncating revision to first 12 chars 2017-08-18 14:27:16,164 Setting DEBUG logging. 2017-08-18 14:27:16,165 attempt 1/10 2017-08-18 14:27:16,165 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8febdfacc716?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-18 14:27:17,360 unpacking tar archive at: mozilla-central-8febdfacc716/testing/mozharness/ program finished with exit code 0 elapsedTime=1.543840 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-18 14:27:17.656249) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-18 14:27:17.656849) ========= script_repo_revision: 8febdfacc7160c9ba90ba480e8bf5cd174e4fcab ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-18 14:27:17.657518) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-18 14:27:17.658048) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-18 14:27:17.670456) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-08-18 14:27:17.670818) ========= /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=923d835db2ba3686ebe126b700000192-1503091635.205831-160446131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:27:17 INFO - MultiFileLogger online at 20170818 14:27:17 in /builds/slave/test 14:27:17 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 14:27:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:27:17 INFO - {'append_to_log': False, 14:27:17 INFO - 'base_work_dir': '/builds/slave/test', 14:27:17 INFO - 'blob_upload_branch': 'Firefox', 14:27:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:27:17 INFO - 'branch': 'Firefox', 14:27:17 INFO - 'buildbot_json_path': 'buildprops.json', 14:27:17 INFO - 'code_coverage': False, 14:27:17 INFO - 'config_files': ('talos/linux_config.py',), 14:27:17 INFO - 'default_actions': ('clobber', 14:27:17 INFO - 'read-buildbot-config', 14:27:17 INFO - 'download-and-extract', 14:27:17 INFO - 'populate-webroot', 14:27:17 INFO - 'create-virtualenv', 14:27:17 INFO - 'install', 14:27:17 INFO - 'setup-mitmproxy', 14:27:17 INFO - 'run-tests'), 14:27:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:27:17 INFO - 'disable_ccov_upload': False, 14:27:17 INFO - 'download_minidump_stackwalk': True, 14:27:17 INFO - 'download_symbols': 'ondemand', 14:27:17 INFO - 'enable_stylo': False, 14:27:17 INFO - 'enable_webrender': False, 14:27:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:27:17 INFO - 'tooltool.py': '/tools/tooltool.py', 14:27:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:27:17 INFO - '/tools/misc-python/virtualenv.py')}, 14:27:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:27:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:27:17 INFO - 'gecko_profile': False, 14:27:17 INFO - 'gecko_profile_interval': 0, 14:27:17 INFO - 'installer_path': 'installer.exe', 14:27:17 INFO - 'log_level': 'info', 14:27:17 INFO - 'log_name': 'talos', 14:27:17 INFO - 'log_to_console': True, 14:27:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:27:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:27:17 INFO - 'opt_config_files': (), 14:27:17 INFO - 'pip_index': False, 14:27:17 INFO - 'suite': 'dromaeojs-e10s', 14:27:17 INFO - 'system_bits': '32', 14:27:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:27:17 INFO - 'title': 'talos-linux64-ix-007', 14:27:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:27:17 INFO - 'use_talos_json': True, 14:27:17 INFO - 'verify': 'False', 14:27:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:27:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:27:17 INFO - 'work_dir': 'build'} 14:27:17 INFO - [mozharness: 2017-08-18 21:27:17.885154Z] Running clobber step. 14:27:17 INFO - Running pre-action listener: _resource_record_pre_action 14:27:17 INFO - Running main action method: clobber 14:27:17 INFO - rmtree: /builds/slave/test/build 14:27:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:27:19 INFO - Running post-action listener: _resource_record_post_action 14:27:19 INFO - [mozharness: 2017-08-18 21:27:19.472228Z] Finished clobber step (success) 14:27:19 INFO - [mozharness: 2017-08-18 21:27:19.472325Z] Running read-buildbot-config step. 14:27:19 INFO - Running pre-action listener: _resource_record_pre_action 14:27:19 INFO - Running main action method: read_buildbot_config 14:27:19 INFO - Using buildbot properties: 14:27:19 INFO - { 14:27:19 INFO - "project": "", 14:27:19 INFO - "product": "firefox", 14:27:19 INFO - "who": "kwierso@gmail.com", 14:27:19 INFO - "installer_path": "public/build/target.tar.bz2", 14:27:19 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 14:27:19 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 14:27:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 14:27:19 INFO - "stage_platform": "linux64-pgo", 14:27:19 INFO - "basedir": "/builds/slave/test", 14:27:19 INFO - "buildnumber": 128, 14:27:19 INFO - "platform": "ubuntu64_hw", 14:27:19 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:27:19 INFO - "slavebuilddir": "test", 14:27:19 INFO - "taskId": "MKWfeAaMRJWUuI4ukw-yWA", 14:27:19 INFO - "branch": "mozilla-central", 14:27:19 INFO - "script_repo_revision": "production", 14:27:19 INFO - "revision": "8febdfacc7160c9ba90ba480e8bf5cd174e4fcab", 14:27:19 INFO - "slavename": "talos-linux64-ix-007", 14:27:19 INFO - "repo_path": "mozilla-central" 14:27:19 INFO - } 14:27:19 INFO - Finding installer, test and symbols from parent task. 14:27:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MKWfeAaMRJWUuI4ukw-yWA'}, attempt #1 14:27:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MKWfeAaMRJWUuI4ukw-yWA'}, attempt #1 14:27:20 INFO - Task dependencies: armNvNolSCK4aKko4g5vMw 14:27:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/armNvNolSCK4aKko4g5vMw'}, attempt #1 14:27:20 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/armNvNolSCK4aKko4g5vMw/artifacts/public/build/target.tar.bz2 14:27:20 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/armNvNolSCK4aKko4g5vMw/artifacts/public/build/target.test_packages.json 14:27:20 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/armNvNolSCK4aKko4g5vMw/artifacts/public/build/target.crashreporter-symbols.zip 14:27:20 INFO - Running post-action listener: _resource_record_post_action 14:27:20 INFO - [mozharness: 2017-08-18 21:27:20.829051Z] Finished read-buildbot-config step (success) 14:27:20 INFO - [mozharness: 2017-08-18 21:27:20.829302Z] Running download-and-extract step. 14:27:20 INFO - Running pre-action listener: _resource_record_pre_action 14:27:20 INFO - Running main action method: download_and_extract 14:27:20 INFO - mkdir: /builds/slave/test/build/tests 14:27:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:20 INFO - trying https://queue.taskcluster.net/v1/task/armNvNolSCK4aKko4g5vMw/artifacts/public/build/target.test_packages.json 14:27:20 INFO - Downloading https://queue.taskcluster.net/v1/task/armNvNolSCK4aKko4g5vMw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 14:27:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/armNvNolSCK4aKko4g5vMw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 14:27:21 INFO - Downloaded 989 bytes. 14:27:21 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 14:27:21 INFO - Using the following test package requirements: 14:27:21 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 14:27:21 INFO - u'common': [u'target.common.tests.zip'], 14:27:21 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 14:27:21 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 14:27:21 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 14:27:21 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 14:27:21 INFO - u'mozbase': [u'target.common.tests.zip'], 14:27:21 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 14:27:21 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 14:27:21 INFO - u'web-platform': [u'target.common.tests.zip', 14:27:21 INFO - u'target.web-platform.tests.tar.gz'], 14:27:21 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 14:27:21 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 14:27:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/armNvNolSCK4aKko4g5vMw/artifacts/public/build/target.common.tests.zip 14:27:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/armNvNolSCK4aKko4g5vMw/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:27:21 INFO - Fetch https://queue.taskcluster.net/v1/task/armNvNolSCK4aKko4g5vMw/artifacts/public/build/target.common.tests.zip into memory 14:27:22 INFO - Content-Length response header: 54622790 14:27:22 INFO - Bytes received: 54622790 14:27:33 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 14:27:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/armNvNolSCK4aKko4g5vMw/artifacts/public/build/target.common.tests.zip 14:27:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/armNvNolSCK4aKko4g5vMw/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:27:33 INFO - Fetch https://queue.taskcluster.net/v1/task/armNvNolSCK4aKko4g5vMw/artifacts/public/build/target.common.tests.zip into memory 14:27:34 INFO - Content-Length response header: 54622790 14:27:34 INFO - Bytes received: 54622790 14:27:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/armNvNolSCK4aKko4g5vMw/artifacts/public/build/target.talos.tests.zip 14:27:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/armNvNolSCK4aKko4g5vMw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 14:27:46 INFO - Fetch https://queue.taskcluster.net/v1/task/armNvNolSCK4aKko4g5vMw/artifacts/public/build/target.talos.tests.zip into memory 14:27:47 INFO - Content-Length response header: 14496256 14:27:47 INFO - Bytes received: 14496256 14:27:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:47 INFO - trying https://queue.taskcluster.net/v1/task/armNvNolSCK4aKko4g5vMw/artifacts/public/build/target.tar.bz2 14:27:47 INFO - Downloading https://queue.taskcluster.net/v1/task/armNvNolSCK4aKko4g5vMw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 14:27:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/armNvNolSCK4aKko4g5vMw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 14:27:48 INFO - Downloaded 63276104 bytes. 14:27:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/armNvNolSCK4aKko4g5vMw/artifacts/public/build/target.tar.bz2 14:27:48 INFO - mkdir: /builds/slave/test/properties 14:27:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:27:48 INFO - Writing to file /builds/slave/test/properties/build_url 14:27:48 INFO - Contents: 14:27:48 INFO - build_url:https://queue.taskcluster.net/v1/task/armNvNolSCK4aKko4g5vMw/artifacts/public/build/target.tar.bz2 14:27:48 INFO - Running post-action listener: _resource_record_post_action 14:27:48 INFO - Running post-action listener: find_tests_for_verification 14:27:48 INFO - Running post-action listener: set_extra_try_arguments 14:27:48 INFO - [mozharness: 2017-08-18 21:27:48.657874Z] Finished download-and-extract step (success) 14:27:48 INFO - [mozharness: 2017-08-18 21:27:48.657972Z] Running populate-webroot step. 14:27:48 INFO - Running pre-action listener: _resource_record_pre_action 14:27:48 INFO - Running main action method: populate_webroot 14:27:48 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:27:48 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 14:27:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:27:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:27:48 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 14:27:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:27:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:27:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:27:48 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 14:27:48 INFO - 'talos_options': ['--stylo'], 14:27:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:27:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:27:48 INFO - 'tests': ['damp', 'tps']}, 14:27:48 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 14:27:48 INFO - 'talos_options': ['--stylo'], 14:27:48 INFO - 'tests': ['damp', 'tps']}, 14:27:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:27:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 14:27:48 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 14:27:48 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 14:27:48 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 14:27:48 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 14:27:48 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 14:27:48 INFO - 'talos_options': ['--stylo'], 14:27:48 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 14:27:48 INFO - 'other-e10s': {'tests': ['a11yr', 14:27:48 INFO - 'ts_paint', 14:27:48 INFO - 'tpaint', 14:27:48 INFO - 'sessionrestore', 14:27:48 INFO - 'sessionrestore_many_windows', 14:27:48 INFO - 'sessionrestore_no_auto_restore', 14:27:48 INFO - 'tabpaint']}, 14:27:48 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 14:27:48 INFO - 'tests': ['a11yr', 14:27:48 INFO - 'ts_paint', 14:27:48 INFO - 'tpaint', 14:27:48 INFO - 'sessionrestore', 14:27:48 INFO - 'sessionrestore_many_windows', 14:27:48 INFO - 'sessionrestore_no_auto_restore', 14:27:48 INFO - 'tabpaint']}, 14:27:48 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 14:27:48 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 14:27:48 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 14:27:48 INFO - 'tests': ['bloom_basic_singleton']}, 14:27:48 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 14:27:48 INFO - 'tests': ['bloom_basic']}, 14:27:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:27:48 INFO - 'tsvgr_opacity', 14:27:48 INFO - 'tart', 14:27:48 INFO - 'tscrollx', 14:27:48 INFO - 'tsvg_static']}, 14:27:48 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 14:27:48 INFO - 'tests': ['tsvgx', 14:27:48 INFO - 'tsvgr_opacity', 14:27:48 INFO - 'tart', 14:27:48 INFO - 'tscrollx', 14:27:48 INFO - 'tsvg_static']}, 14:27:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:27:48 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 14:27:48 INFO - 'talos_options': ['--stylo'], 14:27:48 INFO - 'tests': ['tp5o']}, 14:27:48 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:27:48 INFO - 'talos_options': ['--mitmproxy', 14:27:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:27:48 INFO - '--firstNonBlankPaint'], 14:27:48 INFO - 'tests': ['tp6_google', 14:27:48 INFO - 'tp6_youtube', 14:27:48 INFO - 'tp6_amazon', 14:27:48 INFO - 'tp6_facebook']}, 14:27:48 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:27:48 INFO - 'talos_options': ['--stylo', 14:27:48 INFO - '--mitmproxy', 14:27:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:27:48 INFO - '--firstNonBlankPaint'], 14:27:48 INFO - 'tests': ['tp6_google', 14:27:48 INFO - 'tp6_youtube', 14:27:48 INFO - 'tp6_amazon', 14:27:48 INFO - 'tp6_facebook']}, 14:27:48 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:27:48 INFO - 'talos_options': ['--stylo', 14:27:48 INFO - '--stylo-threads=1', 14:27:48 INFO - '--mitmproxy', 14:27:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:27:48 INFO - '--firstNonBlankPaint'], 14:27:48 INFO - 'tests': ['tp6_google', 14:27:48 INFO - 'tp6_youtube', 14:27:48 INFO - 'tp6_amazon', 14:27:48 INFO - 'tp6_facebook']}, 14:27:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:27:48 INFO - 'talos_options': ['--xperf_path', 14:27:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:27:48 INFO - 'tests': ['tp5n']}, 14:27:48 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 14:27:48 INFO - 'talos_options': ['--stylo', 14:27:48 INFO - '--xperf_path', 14:27:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:27:48 INFO - 'tests': ['tp5n']}}} 14:27:48 INFO - Running post-action listener: _resource_record_post_action 14:27:48 INFO - [mozharness: 2017-08-18 21:27:48.672215Z] Finished populate-webroot step (success) 14:27:48 INFO - [mozharness: 2017-08-18 21:27:48.672302Z] Running create-virtualenv step. 14:27:48 INFO - Running pre-action listener: _resource_record_pre_action 14:27:48 INFO - Running main action method: create_virtualenv 14:27:48 INFO - Creating virtualenv /builds/slave/test/build/venv 14:27:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:27:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:27:48 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 14:27:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:27:48 INFO - Using real prefix '/usr' 14:27:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:27:49 INFO - Installing distribute.............................................................................................................................................................................................done. 14:27:51 INFO - Installing pip.................done. 14:27:51 INFO - Return code: 0 14:27:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:27:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:27:51 INFO - Reading from file tmpfile_stdout 14:27:51 INFO - Output received: 14:27:51 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 14:27:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:27:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xad31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe41f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3f130>, '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 0xe40030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe404c0>, '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': '923d835db2ba3686ebe126b700000192-1503091635.205831-160446131', '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 14:27:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:27:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:27:51 INFO - Using env: {'DISPLAY': ':0', 14:27:51 INFO - 'HOME': '/home/cltbld', 14:27:51 INFO - 'LANG': 'en_US.UTF-8', 14:27:51 INFO - 'LANGUAGE': 'en_US:en', 14:27:51 INFO - 'LOGNAME': 'cltbld', 14:27:51 INFO - 'MAIL': '/var/mail/cltbld', 14:27:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:51 INFO - 'MOZ_NO_REMOTE': '1', 14:27:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:27:51 INFO - 'NO_EM_RESTART': '1', 14:27:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:27:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:51 INFO - 'PWD': '/builds/slave/test', 14:27:51 INFO - 'SHELL': '/bin/bash', 14:27:51 INFO - 'SHLVL': '1', 14:27:51 INFO - 'TERM': 'linux', 14:27:51 INFO - 'TMOUT': '86400', 14:27:51 INFO - 'USER': 'cltbld', 14:27:51 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1503091635.205831-160446131', 14:27:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:51 INFO - '_': '/tools/buildbot/bin/python'} 14:27:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:27:51 INFO - Cleaning up... 14:27:51 INFO - Return code: 0 14:27:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:27:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xad31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe41f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3f130>, '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 0xe40030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe404c0>, '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': '923d835db2ba3686ebe126b700000192-1503091635.205831-160446131', '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 14:27:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:27:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:27:51 INFO - Using env: {'DISPLAY': ':0', 14:27:51 INFO - 'HOME': '/home/cltbld', 14:27:51 INFO - 'LANG': 'en_US.UTF-8', 14:27:51 INFO - 'LANGUAGE': 'en_US:en', 14:27:51 INFO - 'LOGNAME': 'cltbld', 14:27:51 INFO - 'MAIL': '/var/mail/cltbld', 14:27:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:51 INFO - 'MOZ_NO_REMOTE': '1', 14:27:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:27:51 INFO - 'NO_EM_RESTART': '1', 14:27:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:27:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:51 INFO - 'PWD': '/builds/slave/test', 14:27:51 INFO - 'SHELL': '/bin/bash', 14:27:51 INFO - 'SHLVL': '1', 14:27:51 INFO - 'TERM': 'linux', 14:27:51 INFO - 'TMOUT': '86400', 14:27:51 INFO - 'USER': 'cltbld', 14:27:51 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1503091635.205831-160446131', 14:27:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:51 INFO - '_': '/tools/buildbot/bin/python'} 14:27:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:51 INFO - Downloading/unpacking psutil>=3.1.1 14:27:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:27:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:27:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:27:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:27:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:27:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:27:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:27:53 INFO - Installing collected packages: psutil 14:27:53 INFO - Running setup.py install for psutil 14:27:53 INFO - building 'psutil._psutil_linux' extension 14:27:53 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 14:27:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:27:53 INFO - building 'psutil._psutil_posix' extension 14:27:53 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 14:27:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:27:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:27:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:27:53 INFO - Successfully installed psutil 14:27:53 INFO - Cleaning up... 14:27:53 INFO - Return code: 0 14:27:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:27:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xad31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe41f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3f130>, '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 0xe40030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe404c0>, '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': '923d835db2ba3686ebe126b700000192-1503091635.205831-160446131', '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 14:27:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:27:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:27:53 INFO - Using env: {'DISPLAY': ':0', 14:27:53 INFO - 'HOME': '/home/cltbld', 14:27:53 INFO - 'LANG': 'en_US.UTF-8', 14:27:53 INFO - 'LANGUAGE': 'en_US:en', 14:27:53 INFO - 'LOGNAME': 'cltbld', 14:27:53 INFO - 'MAIL': '/var/mail/cltbld', 14:27:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:53 INFO - 'MOZ_NO_REMOTE': '1', 14:27:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:27:53 INFO - 'NO_EM_RESTART': '1', 14:27:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:27:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:53 INFO - 'PWD': '/builds/slave/test', 14:27:53 INFO - 'SHELL': '/bin/bash', 14:27:53 INFO - 'SHLVL': '1', 14:27:53 INFO - 'TERM': 'linux', 14:27:53 INFO - 'TMOUT': '86400', 14:27:53 INFO - 'USER': 'cltbld', 14:27:53 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1503091635.205831-160446131', 14:27:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:53 INFO - '_': '/tools/buildbot/bin/python'} 14:27:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:27:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:27:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:27:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:27:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:27:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:27:55 INFO - Installing collected packages: mozsystemmonitor 14:27:55 INFO - Running setup.py install for mozsystemmonitor 14:27:55 INFO - Successfully installed mozsystemmonitor 14:27:55 INFO - Cleaning up... 14:27:55 INFO - Return code: 0 14:27:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:27:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xad31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe41f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3f130>, '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 0xe40030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe404c0>, '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': '923d835db2ba3686ebe126b700000192-1503091635.205831-160446131', '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 14:27:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:27:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:27:55 INFO - Using env: {'DISPLAY': ':0', 14:27:55 INFO - 'HOME': '/home/cltbld', 14:27:55 INFO - 'LANG': 'en_US.UTF-8', 14:27:55 INFO - 'LANGUAGE': 'en_US:en', 14:27:55 INFO - 'LOGNAME': 'cltbld', 14:27:55 INFO - 'MAIL': '/var/mail/cltbld', 14:27:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:55 INFO - 'MOZ_NO_REMOTE': '1', 14:27:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:27:55 INFO - 'NO_EM_RESTART': '1', 14:27:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:27:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:55 INFO - 'PWD': '/builds/slave/test', 14:27:55 INFO - 'SHELL': '/bin/bash', 14:27:55 INFO - 'SHLVL': '1', 14:27:55 INFO - 'TERM': 'linux', 14:27:55 INFO - 'TMOUT': '86400', 14:27:55 INFO - 'USER': 'cltbld', 14:27:55 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1503091635.205831-160446131', 14:27:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:55 INFO - '_': '/tools/buildbot/bin/python'} 14:27:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:55 INFO - Downloading/unpacking jsonschema==2.5.1 14:27:55 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 14:27:55 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 14:27:55 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 14:27:55 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 14:27:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:27:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:27:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:27:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:27:56 INFO - Downloading functools32-3.2.3-2.tar.gz 14:27:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:27:56 INFO - warning: no files found matching '*.txt' 14:27:56 INFO - no previously-included directories found matching 'build' 14:27:56 INFO - no previously-included directories found matching 'dist' 14:27:56 INFO - no previously-included directories found matching '.git*' 14:27:56 INFO - Installing collected packages: jsonschema, functools32 14:27:56 INFO - Running setup.py install for functools32 14:27:56 INFO - warning: no files found matching '*.txt' 14:27:56 INFO - no previously-included directories found matching 'build' 14:27:56 INFO - no previously-included directories found matching 'dist' 14:27:56 INFO - no previously-included directories found matching '.git*' 14:27:56 INFO - Successfully installed jsonschema functools32 14:27:56 INFO - Cleaning up... 14:27:56 INFO - Return code: 0 14:27:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xad31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe41f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3f130>, '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 0xe40030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe404c0>, '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': '923d835db2ba3686ebe126b700000192-1503091635.205831-160446131', '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 14:27:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:27:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:27:56 INFO - Using env: {'DISPLAY': ':0', 14:27:56 INFO - 'HOME': '/home/cltbld', 14:27:56 INFO - 'LANG': 'en_US.UTF-8', 14:27:56 INFO - 'LANGUAGE': 'en_US:en', 14:27:56 INFO - 'LOGNAME': 'cltbld', 14:27:56 INFO - 'MAIL': '/var/mail/cltbld', 14:27:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:56 INFO - 'MOZ_NO_REMOTE': '1', 14:27:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:27:56 INFO - 'NO_EM_RESTART': '1', 14:27:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:27:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:56 INFO - 'PWD': '/builds/slave/test', 14:27:56 INFO - 'SHELL': '/bin/bash', 14:27:56 INFO - 'SHLVL': '1', 14:27:56 INFO - 'TERM': 'linux', 14:27:56 INFO - 'TMOUT': '86400', 14:27:56 INFO - 'USER': 'cltbld', 14:27:56 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1503091635.205831-160446131', 14:27:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:56 INFO - '_': '/tools/buildbot/bin/python'} 14:27:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:27:57 INFO - Cleaning up... 14:27:57 INFO - Return code: 0 14:27:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:27:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xad31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe41f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3f130>, '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 0xe40030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe404c0>, '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': '923d835db2ba3686ebe126b700000192-1503091635.205831-160446131', '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 14:27:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:27:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:27:57 INFO - Using env: {'DISPLAY': ':0', 14:27:57 INFO - 'HOME': '/home/cltbld', 14:27:57 INFO - 'LANG': 'en_US.UTF-8', 14:27:57 INFO - 'LANGUAGE': 'en_US:en', 14:27:57 INFO - 'LOGNAME': 'cltbld', 14:27:57 INFO - 'MAIL': '/var/mail/cltbld', 14:27:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:57 INFO - 'MOZ_NO_REMOTE': '1', 14:27:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:27:57 INFO - 'NO_EM_RESTART': '1', 14:27:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:27:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:57 INFO - 'PWD': '/builds/slave/test', 14:27:57 INFO - 'SHELL': '/bin/bash', 14:27:57 INFO - 'SHLVL': '1', 14:27:57 INFO - 'TERM': 'linux', 14:27:57 INFO - 'TMOUT': '86400', 14:27:57 INFO - 'USER': 'cltbld', 14:27:57 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1503091635.205831-160446131', 14:27:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:57 INFO - '_': '/tools/buildbot/bin/python'} 14:27:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:57 INFO - Downloading/unpacking blobuploader==1.2.4 14:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:27:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:27:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:27:58 INFO - Downloading blobuploader-1.2.4.tar.gz 14:27:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:27:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:27:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:27:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:27:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:27:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:27:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:27:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:27:58 INFO - Downloading docopt-0.6.1.tar.gz 14:27:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:27:58 INFO - Installing collected packages: blobuploader, requests, docopt 14:27:58 INFO - Running setup.py install for blobuploader 14:27:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:27:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:27:59 INFO - Running setup.py install for requests 14:27:59 INFO - Running setup.py install for docopt 14:27:59 INFO - Successfully installed blobuploader requests docopt 14:27:59 INFO - Cleaning up... 14:27:59 INFO - Return code: 0 14:27:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:27:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:59 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 0xad31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe41f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3f130>, '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 0xe40030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe404c0>, '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': '923d835db2ba3686ebe126b700000192-1503091635.205831-160446131', '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 14:27:59 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 14:27:59 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 14:27:59 INFO - Using env: {'DISPLAY': ':0', 14:27:59 INFO - 'HOME': '/home/cltbld', 14:27:59 INFO - 'LANG': 'en_US.UTF-8', 14:27:59 INFO - 'LANGUAGE': 'en_US:en', 14:27:59 INFO - 'LOGNAME': 'cltbld', 14:27:59 INFO - 'MAIL': '/var/mail/cltbld', 14:27:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:59 INFO - 'MOZ_NO_REMOTE': '1', 14:27:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:27:59 INFO - 'NO_EM_RESTART': '1', 14:27:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:27:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:59 INFO - 'PWD': '/builds/slave/test', 14:27:59 INFO - 'SHELL': '/bin/bash', 14:27:59 INFO - 'SHLVL': '1', 14:27:59 INFO - 'TERM': 'linux', 14:27:59 INFO - 'TMOUT': '86400', 14:27:59 INFO - 'USER': 'cltbld', 14:27:59 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1503091635.205831-160446131', 14:27:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:59 INFO - '_': '/tools/buildbot/bin/python'} 14:27:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:27:59 INFO - Running setup.py (path:/tmp/pip-hSXPZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:27:59 INFO - Running setup.py (path:/tmp/pip-UQGwAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:27:59 INFO - Running setup.py (path:/tmp/pip-PSkzS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:28:00 INFO - Running setup.py (path:/tmp/pip-pCY4CB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:28:00 INFO - Running setup.py (path:/tmp/pip-XwDEo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:28:00 INFO - Running setup.py (path:/tmp/pip-rrGZqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:28:00 INFO - Running setup.py (path:/tmp/pip-qOaxs4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:28:00 INFO - Running setup.py (path:/tmp/pip-SPFRLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:28:00 INFO - Running setup.py (path:/tmp/pip-EyZnhP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:28:00 INFO - Running setup.py (path:/tmp/pip-PoBlz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:28:00 INFO - Running setup.py (path:/tmp/pip-awB340-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:28:00 INFO - Running setup.py (path:/tmp/pip-dGoj3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:28:00 INFO - Running setup.py (path:/tmp/pip-cOqQST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:28:00 INFO - Running setup.py (path:/tmp/pip-bJOjMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:28:00 INFO - Running setup.py (path:/tmp/pip-WvOPv6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:28:00 INFO - Running setup.py (path:/tmp/pip-LQ5bgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:28:00 INFO - Running setup.py (path:/tmp/pip-1EQumH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:28:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:28:01 INFO - Running setup.py install for manifestparser 14:28:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:28:01 INFO - Running setup.py install for mozcrash 14:28:01 INFO - Running setup.py install for mozdebug 14:28:01 INFO - Running setup.py install for mozdevice 14:28:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:28:01 INFO - Running setup.py install for mozfile 14:28:01 INFO - Running setup.py install for mozhttpd 14:28:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:28:01 INFO - Running setup.py install for mozinfo 14:28:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:28:01 INFO - Running setup.py install for mozInstall 14:28:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:28:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:28:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:28:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:28:01 INFO - Running setup.py install for mozleak 14:28:01 INFO - Running setup.py install for mozlog 14:28:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:28:02 INFO - Running setup.py install for moznetwork 14:28:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:28:02 INFO - Running setup.py install for mozprocess 14:28:02 INFO - Running setup.py install for mozprofile 14:28:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:28:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:28:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:28:02 INFO - Running setup.py install for mozrunner 14:28:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:28:02 INFO - Running setup.py install for mozscreenshot 14:28:02 INFO - Running setup.py install for moztest 14:28:02 INFO - Running setup.py install for mozversion 14:28:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:28:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:28:02 INFO - Cleaning up... 14:28:02 INFO - Return code: 0 14:28:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:28: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')]} 14:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28: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')]} 14:28:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:02 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 0xad31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe41f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3f130>, '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 0xe40030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe404c0>, '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': '923d835db2ba3686ebe126b700000192-1503091635.205831-160446131', '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 14:28:02 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 14:28:02 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 14:28:02 INFO - Using env: {'DISPLAY': ':0', 14:28:02 INFO - 'HOME': '/home/cltbld', 14:28:02 INFO - 'LANG': 'en_US.UTF-8', 14:28:02 INFO - 'LANGUAGE': 'en_US:en', 14:28:02 INFO - 'LOGNAME': 'cltbld', 14:28:02 INFO - 'MAIL': '/var/mail/cltbld', 14:28:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:02 INFO - 'MOZ_NO_REMOTE': '1', 14:28:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:02 INFO - 'NO_EM_RESTART': '1', 14:28:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:02 INFO - 'PWD': '/builds/slave/test', 14:28:02 INFO - 'SHELL': '/bin/bash', 14:28:02 INFO - 'SHLVL': '1', 14:28:02 INFO - 'TERM': 'linux', 14:28:02 INFO - 'TMOUT': '86400', 14:28:02 INFO - 'USER': 'cltbld', 14:28:02 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1503091635.205831-160446131', 14:28:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:02 INFO - '_': '/tools/buildbot/bin/python'} 14:28:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:28:03 INFO - Running setup.py (path:/tmp/pip-S3QrAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:28:03 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)) 14:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:28:03 INFO - Running setup.py (path:/tmp/pip-4jBWih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:28:03 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)) 14:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:28:03 INFO - Running setup.py (path:/tmp/pip-jjWlnG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:28:03 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)) 14:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:28:03 INFO - Running setup.py (path:/tmp/pip-2HQrbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:28:03 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)) 14:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:28:03 INFO - Running setup.py (path:/tmp/pip-srVcre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:28:03 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)) 14:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:28:03 INFO - Running setup.py (path:/tmp/pip-bLFOaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:28:03 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)) 14:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:28:03 INFO - Running setup.py (path:/tmp/pip-OmLBHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:28:03 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)) 14:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:28:03 INFO - Running setup.py (path:/tmp/pip-UpekFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:28:03 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)) 14:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:28:03 INFO - Running setup.py (path:/tmp/pip-m6uHKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:28:03 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)) 14:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:28:03 INFO - Running setup.py (path:/tmp/pip-cKelee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:28:03 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)) 14:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:28:03 INFO - Running setup.py (path:/tmp/pip-9iOJ5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:28:03 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)) 14:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:28:03 INFO - Running setup.py (path:/tmp/pip-Dpzw2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:28:03 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)) 14:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:28:03 INFO - Running setup.py (path:/tmp/pip-Mm6VqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:28:03 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)) 14:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:28:04 INFO - Running setup.py (path:/tmp/pip-Zd1IyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:28:04 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)) 14:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:28:04 INFO - Running setup.py (path:/tmp/pip-m5tS0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:28:04 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)) 14:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:28:04 INFO - Running setup.py (path:/tmp/pip-Quydjt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:28:04 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)) 14:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:28:04 INFO - Running setup.py (path:/tmp/pip-BEBn6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:28:04 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)) 14:28:04 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)) 14:28:04 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)) 14:28:04 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)) 14:28:04 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)) 14:28:04 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)) 14:28:04 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)) 14:28:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:28: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 14:28: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 14:28: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 14:28: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 14:28:05 INFO - Downloading blessings-1.6.tar.gz 14:28:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:28:05 INFO - Installing collected packages: blessings 14:28:05 INFO - Running setup.py install for blessings 14:28:05 INFO - Successfully installed blessings 14:28:05 INFO - Cleaning up... 14:28:05 INFO - Return code: 0 14:28:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:28:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:28:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:28:05 INFO - Reading from file tmpfile_stdout 14:28:05 INFO - Current package versions: 14:28:05 INFO - argparse == 1.2.1 14:28:05 INFO - blessings == 1.6 14:28:05 INFO - blobuploader == 1.2.4 14:28:05 INFO - docopt == 0.6.1 14:28:05 INFO - functools32 == 3.2.3-2 14:28:05 INFO - jsonschema == 2.5.1 14:28:05 INFO - manifestparser == 1.1 14:28:05 INFO - mozInstall == 1.13 14:28:05 INFO - mozcrash == 1.0 14:28:05 INFO - mozdebug == 0.1 14:28:05 INFO - mozdevice == 0.51 14:28:05 INFO - mozfile == 1.2 14:28:05 INFO - mozhttpd == 0.7 14:28:05 INFO - mozinfo == 0.10 14:28:05 INFO - mozleak == 0.1 14:28:05 INFO - mozlog == 3.5 14:28:05 INFO - moznetwork == 0.27 14:28:05 INFO - mozprocess == 0.25 14:28:05 INFO - mozprofile == 0.28 14:28:05 INFO - mozrunner == 6.13 14:28:05 INFO - mozscreenshot == 0.1 14:28:05 INFO - mozsystemmonitor == 0.3 14:28:05 INFO - moztest == 0.8 14:28:05 INFO - mozversion == 1.4 14:28:05 INFO - psutil == 3.1.1 14:28:05 INFO - requests == 1.2.3 14:28:05 INFO - wsgiref == 0.1.2 14:28:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:28:05 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')]} 14:28:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:05 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')]} 14:28:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:05 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 0xad31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe41f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3f130>, '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 0xe40030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe404c0>, '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': '923d835db2ba3686ebe126b700000192-1503091635.205831-160446131', '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 14:28:05 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 14:28:05 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 14:28:05 INFO - Using env: {'DISPLAY': ':0', 14:28:05 INFO - 'HOME': '/home/cltbld', 14:28:05 INFO - 'LANG': 'en_US.UTF-8', 14:28:05 INFO - 'LANGUAGE': 'en_US:en', 14:28:05 INFO - 'LOGNAME': 'cltbld', 14:28:05 INFO - 'MAIL': '/var/mail/cltbld', 14:28:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:05 INFO - 'MOZ_NO_REMOTE': '1', 14:28:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:05 INFO - 'NO_EM_RESTART': '1', 14:28:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:05 INFO - 'PWD': '/builds/slave/test', 14:28:05 INFO - 'SHELL': '/bin/bash', 14:28:05 INFO - 'SHLVL': '1', 14:28:05 INFO - 'TERM': 'linux', 14:28:05 INFO - 'TMOUT': '86400', 14:28:05 INFO - 'USER': 'cltbld', 14:28:05 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1503091635.205831-160446131', 14:28:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:05 INFO - '_': '/tools/buildbot/bin/python'} 14:28:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:06 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)) 14:28:06 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)) 14:28:06 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)) 14:28:06 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)) 14:28:06 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)) 14:28:06 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)) 14:28:06 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)) 14:28:06 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)) 14:28:06 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)) 14:28:06 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 14:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 14:28:07 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)) 14:28:07 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)) 14:28:07 INFO - Installing collected packages: simplejson 14:28:07 INFO - Running setup.py install for simplejson 14:28:07 INFO - building 'simplejson._speedups' extension 14:28:07 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 14:28:08 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 14:28:08 INFO - Successfully installed simplejson 14:28:08 INFO - Cleaning up... 14:28:08 INFO - Return code: 0 14:28:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:28: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')]} 14:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28: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')]} 14:28:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xad31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe41f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3f130>, '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 0xe40030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe404c0>, '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': '923d835db2ba3686ebe126b700000192-1503091635.205831-160446131', '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 14:28: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'] in /builds/slave/test/build 14:28: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 14:28:08 INFO - Using env: {'DISPLAY': ':0', 14:28:08 INFO - 'HOME': '/home/cltbld', 14:28:08 INFO - 'LANG': 'en_US.UTF-8', 14:28:08 INFO - 'LANGUAGE': 'en_US:en', 14:28:08 INFO - 'LOGNAME': 'cltbld', 14:28:08 INFO - 'MAIL': '/var/mail/cltbld', 14:28:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:08 INFO - 'MOZ_NO_REMOTE': '1', 14:28:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:08 INFO - 'NO_EM_RESTART': '1', 14:28:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:08 INFO - 'PWD': '/builds/slave/test', 14:28:08 INFO - 'SHELL': '/bin/bash', 14:28:08 INFO - 'SHLVL': '1', 14:28:08 INFO - 'TERM': 'linux', 14:28:08 INFO - 'TMOUT': '86400', 14:28:08 INFO - 'USER': 'cltbld', 14:28:08 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1503091635.205831-160446131', 14:28:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:08 INFO - '_': '/tools/buildbot/bin/python'} 14:28:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:28:08 INFO - Cleaning up... 14:28:08 INFO - Return code: 0 14:28:08 INFO - Running post-action listener: _resource_record_post_action 14:28:08 INFO - Running post-action listener: _start_resource_monitoring 14:28:08 INFO - Starting resource monitoring. 14:28:08 INFO - [mozharness: 2017-08-18 21:28:08.523005Z] Finished create-virtualenv step (success) 14:28:08 INFO - [mozharness: 2017-08-18 21:28:08.523529Z] Running install step. 14:28:08 INFO - Running pre-action listener: _resource_record_pre_action 14:28:08 INFO - Running main action method: install 14:28:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:28:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:28:08 INFO - Reading from file tmpfile_stdout 14:28:08 INFO - Detecting whether we're running mozinstall >=1.0... 14:28:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:28:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:28:08 INFO - Reading from file tmpfile_stdout 14:28:08 INFO - Output received: 14:28:08 INFO - Usage: mozinstall [options] installer 14:28:08 INFO - Options: 14:28:08 INFO - -h, --help show this help message and exit 14:28:08 INFO - -d DEST, --destination=DEST 14:28:08 INFO - Directory to install application into. [default: 14:28:08 INFO - "/builds/slave/test"] 14:28:08 INFO - --app=APP Application being installed. [default: firefox] 14:28:08 INFO - mkdir: /builds/slave/test/build/application 14:28:08 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'] 14:28:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 14:28:26 INFO - Reading from file tmpfile_stdout 14:28:26 INFO - Output received: 14:28:26 INFO - /builds/slave/test/build/application/firefox/firefox 14:28:26 INFO - Running post-action listener: _resource_record_post_action 14:28:26 INFO - [mozharness: 2017-08-18 21:28:26.780137Z] Finished install step (success) 14:28:26 INFO - [mozharness: 2017-08-18 21:28:26.780419Z] Running setup-mitmproxy step. 14:28:26 INFO - Running pre-action listener: _resource_record_pre_action 14:28:26 INFO - Running main action method: setup_mitmproxy 14:28:26 INFO - Skipping: mitmproxy is not required 14:28:26 INFO - Running post-action listener: _resource_record_post_action 14:28:26 INFO - [mozharness: 2017-08-18 21:28:26.781630Z] Finished setup-mitmproxy step (success) 14:28:26 INFO - [mozharness: 2017-08-18 21:28:26.781849Z] Running run-tests step. 14:28:26 INFO - Running pre-action listener: _resource_record_pre_action 14:28:26 INFO - Running pre-action listener: _set_gcov_prefix 14:28:26 INFO - Running main action method: run_tests 14:28:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:28:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:28:26 INFO - Python 2.7.3 14:28:26 INFO - Return code: 0 14:28:26 INFO - grabbing minidump binary from tooltool 14:28:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:26 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 0xe3f130>, '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 0xe40030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe404c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:28:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 14:28:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:28:26 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 14:28:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:28:26 INFO - Return code: 0 14:28:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:28:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:28:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:28:26 INFO - ENV: RUST_BACKTRACE is now full 14:28:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:28:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:28:26 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/armNvNolSCK4aKko4g5vMw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 14:28:26 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/armNvNolSCK4aKko4g5vMw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-007 --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 14:28:26 INFO - Using env: {'DISPLAY': ':0', 14:28:26 INFO - 'HOME': '/home/cltbld', 14:28:26 INFO - 'LANG': 'en_US.UTF-8', 14:28:26 INFO - 'LANGUAGE': 'en_US:en', 14:28:26 INFO - 'LOGNAME': 'cltbld', 14:28:26 INFO - 'MAIL': '/var/mail/cltbld', 14:28:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:28:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:28:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:26 INFO - 'MOZ_NO_REMOTE': '1', 14:28:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:28:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:26 INFO - 'NO_EM_RESTART': '1', 14:28:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:26 INFO - 'PWD': '/builds/slave/test', 14:28:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:28:26 INFO - 'RUST_BACKTRACE': 'full', 14:28:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:28:26 INFO - 'SHELL': '/bin/bash', 14:28:26 INFO - 'SHLVL': '1', 14:28:26 INFO - 'TERM': 'linux', 14:28:26 INFO - 'TMOUT': '86400', 14:28:26 INFO - 'USER': 'cltbld', 14:28:26 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1503091635.205831-160446131', 14:28:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:26 INFO - '_': '/tools/buildbot/bin/python'} 14:28:26 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/armNvNolSCK4aKko4g5vMw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 14:28:27 INFO - mozversion application_buildid: 20170818201121 14:28:27 INFO - mozversion application_changeset: 8febdfacc7160c9ba90ba480e8bf5cd174e4fcab 14:28:27 INFO - mozversion application_display_name: Nightly 14:28:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:28:27 INFO - mozversion application_name: Firefox 14:28:27 INFO - mozversion application_remotingname: firefox 14:28:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:28:27 INFO - mozversion application_vendor: Mozilla 14:28:27 INFO - mozversion application_version: 57.0a1 14:28:27 INFO - mozversion platform_buildid: 20170818201121 14:28:27 INFO - mozversion platform_changeset: 8febdfacc7160c9ba90ba480e8bf5cd174e4fcab 14:28:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:28:27 INFO - mozversion platform_version: 57.0a1 14:28:27 INFO - using testdate: 1503091707 14:28:27 INFO - actual date: 1503091707 14:28:27 INFO - starting webserver on 'localhost:55776' 14:28:27 INFO - SUITE-START | Running 2 tests 14:28:27 INFO - TEST-START | dromaeo_css 14:28:27 INFO - Initialising browser for dromaeo_css test... 14:28:27 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55776/getInfo.html -profile /tmp/tmpULM79D/profile 14:28:27 INFO - TEST-INFO | started process 2006 (/builds/slave/test/build/application/firefox/firefox http://localhost:55776/getInfo.html) 14:28:32 INFO - TEST-INFO | 2006: exit 0 14:28:32 INFO - Browser initialized. 14:28:32 INFO - Running cycle 1/1 for dromaeo_css test... 14:28:32 INFO - TEST-INFO | started process 2183 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpULM79D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:28:33 INFO - PID 2183 | 14:28:33 INFO - PID 2183 | (/builds/slave/test/build/application/firefox/firefox:2234): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:28:33 INFO - PID 2183 | 14:28:33 INFO - PID 2183 | 14:28:33 INFO - PID 2183 | (/builds/slave/test/build/application/firefox/firefox:2291): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:28:33 INFO - PID 2183 | 14:28:33 INFO - PID 2183 | __metrics Screen width/height:1600/1200 14:28:33 INFO - PID 2183 | colorDepth:24 14:28:33 INFO - PID 2183 | Browser inner width/height: 1024/768 14:28:33 INFO - PID 2183 | __metrics 14:28:43 INFO - PID 2183 | RSS: Main: 166268928 14:28:43 INFO - PID 2183 | 14:31:40 INFO - PID 2183 | Cycle 1(1): loaded http://localhost:55776/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55776/tests/dromaeo/cssquery-ext.html) 14:31:41 INFO - PID 2183 | RSS: Main: 170631168 14:31:41 INFO - PID 2183 | 14:34:43 INFO - PID 2183 | Cycle 1(1): loaded http://localhost:55776/tests/dromaeo/cssquery-ext.html (next: http://localhost:55776/tests/dromaeo/cssquery-jquery.html) 14:34:44 INFO - PID 2183 | RSS: Main: 166445056 14:34:44 INFO - PID 2183 | 14:37:45 INFO - PID 2183 | Cycle 1(1): loaded http://localhost:55776/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55776/tests/dromaeo/cssquery-mootools.html) 14:37:46 INFO - PID 2183 | RSS: Main: 169230336 14:37:46 INFO - PID 2183 | 14:40:47 INFO - PID 2183 | Cycle 1(1): loaded http://localhost:55776/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55776/tests/dromaeo/cssquery-prototype.html) 14:40:48 INFO - PID 2183 | RSS: Main: 167723008 14:40:48 INFO - PID 2183 | 14:43:51 INFO - PID 2183 | Cycle 1(1): loaded http://localhost:55776/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55776/tests/dromaeo/cssquery-yui.html) 14:43:52 INFO - PID 2183 | RSS: Main: 171962368 14:43:52 INFO - PID 2183 | 14:46:53 INFO - PID 2183 | Cycle 1(1): loaded http://localhost:55776/tests/dromaeo/cssquery-yui.html (next: http://localhost:55776/tests/dromaeo/cssquery-dojo.html) 14:46:54 INFO - PID 2183 | RSS: Main: 169865216 14:46:54 INFO - PID 2183 | 14:46:54 INFO - PID 2183 | __start_tp_report 14:46:54 INFO - PID 2183 | _x_x_mozilla_page_load 14:46:54 INFO - PID 2183 | _x_x_mozilla_page_load_details 14:46:54 INFO - PID 2183 | |i|pagename|runs| 14:46:54 INFO - PID 2183 | |0;dojo.html;3429.7942123472576;3481.8433170507324;3485.5991560970497;3494.405950988333;3500.8424620892056;6002.399760023995;6072.514198864092;6134.570580059398;6137.508999280058;6165.136880836686;6075.574709770318;6141.907871381922;6164.10620460033;6172.290186628539;6184.196054512919;5359.410464848864;5396.43337449567;5434.592405569579;5438.91841622376;5459.945400545984;5467.9453205468035;5467.972660136694;5477.972610136943;5499.560035197174;5529.087700529408;5382.650127741724;5434.2935418395555;5454;5530.5022547970675;5542.057850165462;5255.106631872591;5295.258663787073;5382.273393091921;5469.179623056533;5481.040817856899;5367.1680889462195;5393.6763794172475;5437.211604317352;5443.618946673734;5465.289512363407;6004.279486461609;6052.757889684452;6053.697315134225;6076.605020673686;6162.8767424651705;6581.901271480931;6592.604443733343;6607;6622.470202383798;6673.8665226695675;6712.362325579063;6741.426978706816;6806.183258009021;6806.319368063204;6812.659367031629;6155.169052177944;6165.106059621375;6222;6247.406496382836;6253.468455181315;6629.237637671633;6745.460363170934;6763.864722705518;6788.185417749902;6836.316368363224;6553.63954982471;6592.670366481657;6607.240167380813;6636.634985075867;6647.235567909655;6674.9666251669405;6697.8995315070315;6753.594784312957;6754.527183097234;6781.287964763629;6524.575902566318;6602.108715323466;6614.0740296358545;6701.564398314094;6708.698108585126;6640.103586015923;6640.402363787282;6700.497462690318;6706.26231114577;6707.362800534039;4864.1001414737675;4864.683795553277;4865.489123641966;4874.829380971649;4880.219164933665;4225.535191128974;4235.8093885775215;4283.593058659422;4293.162833247487;4295.3771703102875;6341.492680585542;6344.968275158594;6376.617402955838;6396.648184349812;6400.583962042452;6698.497612679069;6726.058351830748;6727.058211850345;6811.352921472452;6811.352921472452;6312.179416675895;6336.461400780893;6388.488920886318;6396.0405939109505;6399.104125422445;5444.727763611803;5446.046941785172;5452.863678407992;5456.672599644034;5460.645058071213;6995.475339349569;7075.82310442243;7083.114610673666;7084.220735719066;7091.82270443243;6696.83257918556;6699.698513566901;6703.966480167763;6713.4964877634375;6794.218664853605;6808.353206445379;6935.479839011993;6971.860562788817;7017.4386049116965;7055.576665400093;6615.437687796399;6682.198136223684;6682.665866706742;6700.798976030727;6721.126253587003;6738.225104112894;6742.831429214113;6746;6752.054712340375;6819.727210911508;6518.0941735365195;6526.804195874131;6570.8028759137305;6596.736130554724;6604.14146160996;6529.379708927644;6535.901961470677;6543.345665433419;6572.244191917799;6586.308437613981;6516.446102081376;6522;6530.412262896362;6566.179227596551;6600.372964568358;6514.0880276760345;6520.478361731145;6561.540692151503;6570.408663220333;6655.301193374626;6386.9361306386345;6427.196600424947;6433.195850518685;6448.806535803933;6451.0968464415955 14:46:54 INFO - PID 2183 | |1;ext.html;892.1918409845691;895.9552022398882;924.2005665099688;943.0286804591274;952.2667545989589;38588.80705596475;39638.207235855305;39752.80123599378;39784.60215397845;39809.40285895714;37271.813640931825;37658.246835063284;37846.810765946204;37862;38021.42967855484;6803.217629972567;6889.4832887533385;6912.135983002125;6913.204981427125;6914.274001229874;6636.435902948231;6725.05849181115;6735.663216839139;6742.123523941881;6802.897956530656;6794.966025169867;7475.32722055015;7603.809904752397;7612;7620.3141717245435;7524.360429363511;7577.128630207541;7578.886316705254;7579.81050473737;7579.924200757977;7409.555426674363;7515.173330933593;7564.77305680825;7568.735094271674;7579.734709285149;37583.436248456295;38357;38400.61599383999;38403.231935361415;38407.807960960294;3421.8460169292443;3472.722182225441;3477.2697733475748;3479.460683594047;3480.1473638958364;29948.550771738443;30104;30115;30115.247118822204;30119.548206776915;5038.39539255288;5069.873253168664;5096.541311281965;5097;5107;198140;201249;202600;203693;259219;49835.25247121296;49985.25022124671;49985.50014499881;50448.243276350884;50701;53771.46228537665;54329.45670543323;54342.45657543453;54817.451825481236;54988;16365.181740912907;16438.75341869873;16592;16604.750928736077;16743.665126697397;13612.591622251348;13649.249291289074;13716.3827627755;13791.586252412444;13797.931010345084;14934.954553181173;15076.793856491455;15143.318550665246;15265.465708700141;15327.770083448757;6095.817125486243;6156.538259630545;6198.411150940653;6217.253929528486;6280;1069.588208539718;1084.2464487181333;1100.9394483303336;1103.779244151157;1104.8563686720836;23801.285961421185;24190.202967798068;24224.152154674503;24361.512769744506;30441.543376849364;1166.5392170092766;1200.6818193178815;1201.5013769285824;1208.5709573101599;1213.9271643701406;12699.238045717286;12910.935445322713;12950;13029.413676384396;13123.475060997453;278075;281749;282754;284006;284549;55523.16715249194;55927.72036139793;55956;55964.16053759197;55975.160372594444;1479.8742106920818;1504.5711972087902;1525.3898440623618;1527.7250094982787;1529.395888623965;28259.15222543327;28430;29034.41931161407;29272;29840.10479685613;49497.75251123722;50042.49957500524;50290.74854625703;50345.49654503408;50373.49626503688;239387;242293;242617;243270;243614;33874.83062584671;34536.309273814884;35295.82352088223;36911.63088369082;37386.6261337394;45672.54327456683;45757.084858303315;45957.540424595325;45974.54025459703;46170.53829461662;34491.31017379588;34592.48111278282;34687.47968780521;34699.30601388009;34994.475082873265;33554.496682549296;33697.83151084229;34005.48991765076;34040.82979585086;34131.4880276801;39009.41485877771;39086.804565976985;39261.607383925795;39277.60722392739;39554.60445395509;32886;33094.83452582722;33425.66574334226;33608;33893.83053084719;24530;25556.616650750624;25972.480550389264;26155.7767589757;26271.737282626927 14:46:54 INFO - PID 2183 | |2;jquery.html;572.8567858035491;579.2469789273943;580.0921557762102;586;599.7690889007732;22784.8860755696;22870.771292287092;23335.41661458462;23456.76543234567;23562.646560301568;26373.868130659368;26490.67546622666;26617.467650646977;26897.731022689768;26921;6206.1931948846695;6312.053192021211;6315.210598675166;6315.305316415191;6317.305096439388;5987.700614969256;6217.533684973622;6217.56477046607;6226.408491193352;6246.0630905364105;6139.938600614004;6179;6180.598261113036;6184.72168752405;6192.102145188945;6127.601705889125;6137.846553836145;6166.691665416756;6170.5372097092895;6174.536909731765;5734.111212762028;5757.280339957505;5762.798302059407;5771.365149833515;5778.797742079007;28994.565081523582;29403.705962940312;29461.410771784445;29543.261418464495;29952.550711739343;2195.6267434536167;2224.154821167962;2225.8330625203175;2227.2093406840663;2235.2623634200677;17663.11684415774;17754.467365979042;18648.440546783484;18766.530836729053;18783.436496905113;2017.8991050447419;2019.4345583236718;2042.8774273543636;2049.661805802041;2064.9070791814406;157036;166262.168689157;166484;166545;166733.16633416875;14984;15728.483442649122;15741.685166296838;15790.447334343244;15849.207539623203;24232.151874684303;24302.513949720906;24417.51164976726;24453.87773061123;24471;10270.794584108276;10653.307535010199;10755.247132700635;10787.298825576469;10850.67447976562;9816.950915245521;9856.753581160385;9882.80234395308;9918.752031199278;9964.601415943425;10008.199344052458;10021.446675765268;10070.446125463024;10122;10189.592416303412;2637.512060268856;2670.919872403792;2706.9323266918486;2844.9573256401172;2904.433635441111;1022.6062965758088;1033.7312298802215;1050.4117694091333;1050.7950949564915;1053.2942928238099;20752.48118797012;21271.574568508542;21691.67462488064;21721.13115475363;22256.332310030724;1089.7384627689298;1109.417555783204;1111.3387534417009;1116.1238427834112;1118.9776204475866;11705.707357315965;14138.929305353407;15043.247837608076;15259.558470644644;15267.007644503072;551318;586753;590419;600017;615588;131180.3440982789;139781;141196;142227;142328.28835855753;1172.9824052639217;1254.7176885200756;1276.7446510697898;1320.1946812444594;1334.8064530643003;22962;23183.420414489097;23333.766662333837;23543.529129417657;23553.882230588737;64651;65108;65855.34144658492;65866.67066664636;68457.65771171311;77609.61195194213;78048;78723.60638196772;78757.60621196857;79202;14922.477713279983;15370.154641494824;15427.84572154309;15539;15576.065436073872;23055;23234.767652323262;23519.41201469977;23861.761382385954;23943.401414964766;20346.59306813826;20529.48676283105;20658.276960306917;20675.4831129223;20728.68906966427;17211;17550.21024053946;17720.113994299976;17946.5513362167;18018.549536261697;19483.51291217731;20209.797902020793;21263.255786047415;21654.783452165277;21658.458538536663;15099.773503397239;15210.619734506727;15286.986171623716;15349.6162595936;15377.538673839803;18836.34072807445;18932.52668683239;18958;19461.90269048646;19825.801741982395 14:46:54 INFO - PID 2183 | |3;mootools.html;1464.2093269634397;1497.5881632551054;1502.7595584706442;1512.6294057955802;1512.826025007124;15439.305231264592;15752.84247157528;16067.59831004224;16097.114658693796;16111.194440277983;15566.143862087609;16371.099589522571;16384.426545070924;16396.75404868928;16403.261853216605;2638.8812503437393;2683.5035518429054;2687.422204226091;2689.1529168312018;2693.676758788948;2479.8884050217694;2556.910508132216;2611.5038142752815;2683.2889284339667;2733.9179824605294;2691.9596206056926;2721.102036328007;2721.142840005402;2722.0336780442954;2732.904348347808;2505.1357281737774;2531.999860055277;2534.6198070289606;2535.2901187667576;2536.8097392695436;2427.235420842429;2478.3556275368355;2564.230730780758;2638.0898589986423;2698.811083224175;15438.691226175413;15499;15524.689506209925;15532;15614.375424982987;7874.645640946172;8075;8088;8111.675532978674;8139.75580732579;4867.367242258484;5034.798608055673;5049.267856160873;5122.1804511278015;5147.794088236466;1848.1036697201846;1911.0731295321757;1924.114907142716;1931.4688460673287;1943.416974907522;27836.304092397648;28058.158255252172;28088.719112808816;28241.717582824112;28283.71716282852;6286.591371560834;6341.524385671001;6355.237371515355;6500.902486462707;6520.706568204442;18897.244110235435;18969.715454268196;19004.334848280243;19017.429477115707;19018.80981190198;8010.19898010206;8243.546604936666;8244.752657420288;8263.338932885355;8268.958655206805;7548.207438219018;7548.433867459962;7670.232976702285;7707.653155608011;7708.922910770821;5261.657992230493;5453.291072160594;5469.781208751605;5507.531859791882;5525.806596769094;1287.4914408808656;1311;1416.178616402484;1416.7591509443419;1521.4750910935709;966.4732720667254;973.99026009739;974.7855471796194;979.0747743382577;998.5606333213362;8485.660573577112;8507.61715722794;8512.233898949;8525.275351595184;8589.914100859036;1030.294248439821;1032.4321623107262;1038.055369613648;1038.133158812385;1047.1988928469727;5233.973830130825;5244.9737751310995;5300.01949639318;5313.628046036741;5376.516113549799;22929;22938.197163099212;23648.40878978005;23790.64314035291;23806.285811425685;23374.76625233726;23599.410014749425;23600.881995589913;23652.29043128709;23783.881080594485;11912.404379780975;12571;12592.559260425842;12726.68183295425;12735.745285094432;9469.715908522756;9509.191718703987;9527;9582.472963987047;9598.616055357708;20297.89851050735;20464.48838778983;20817.06323215489;21032.26387076445;21057;20998.895005524875;21056.368308950758;21085;21187.258445954318;21232.36302910915;12074.27554346742;12191.268523888595;12197.207181533173;12304.446299916346;12308.076894233147;14570.927145364205;14793.334299956743;14827.99822024056;14838.480653177086;14854.480093197119;11968.820467692818;12014.33921134346;12022.098342624164;12117.575884843987;12375.566855160027;11692.88307116952;11709.238899471507;11838.171328006956;11895.405229738652;12099.455524501594;9598.66404675833;9742.464164471023;9742.976987416503;10201;10440;7762.611869406394;7770.53376797394;7798;7809.375249980101;7952.6421311042295;7598.240175982358;7705.922940770521;7729.497582657109;7750.496217745828;7763.72826951054 14:46:54 INFO - PID 2183 | |4;prototype.html;522.1254398881877;529.9152135658293;534.7085838218171;542.823582335741;545.5799034743251;6136.417040381168;6164.506839452839;6170.321264660889;6180.443760061594;6231.158793562868;6051.455369016788;6080.513558915287;6094.085887116935;6118.38816118388;6120.14317995481;4867.610591152699;4896.706197628154;4917.21324588066;4920.9911968046645;4938.086454006002;4647.302904564309;4791.856244312677;4839.330431001316;4860.927086093711;4912.48418916014;4711.340412342275;4735.384400028009;4739.573438390544;4757.548032936866;4764.213419967512;4749.501302363236;4769.736019954715;4774.427068751755;4780.9680885623475;4786.7845946932475;4243.236217480852;4326.913461730779;4328.264195086843;4352.238358287319;4353.934690979638;6019.88632103058;6020.759169633209;6023.427774361428;6031.396860313977;6047.274327080779;5745.310562732457;5746.367899531048;5767.163761254595;5774.740136693859;5781.161731548944;6556.377144171296;6582.539222254444;6583.539152259344;6594.53838231324;6594.637294948776;4916.754162291907;4916.803327866881;4928.162212423897;4940.2342636891335;4945.7774400152075;6627.536072474881;6642.368974947372;6747.966260168668;6823.317668233187;6845.794626161223;4997.525235102659;5021.698698078127;5038.924416133761;5047.611906725607;5050.116229659869;5094.821681241138;5108.693478391308;5110.616703747234;5117.84848409105;5119.74401279942;5686.213755259892;5705.857353566194;5710.543156547466;5715.685637289906;5722.7424765885635;6513.46933470634;6527.184101987252;6531.150950376421;6547.247066587308;6567.343265673395;1741.268667159796;1752.0013592252549;1766.6908291049015;1774.6539424812038;1775.6448710258;1179.6637958181877;1231.378154032208;1233.5805826019018;1237.127824883455;1242.3415589737454;6089.117078023662;6114.357992410822;6134.44789968896;6141.324454310023;6161.784337548164;6457.967710161419;6486.643234622141;6541.47668186544;6595.637239951849;6668.399844013965;6077.809150196094;6094.421030002142;6121.326654068138;6201.317855035943;6223.595466294767;3444.293919746446;3472.8610855565494;3475.9652403475643;3495.265994141259;3522.1898963238086;6817.5568588041615;6822.4200942919415;6863.691133898987;6869.175698916162;6952.341930906305;6651.833704157338;6690.431313338323;6696;6710.832229194211;6819.931800682029;6802.761903333459;6828.897566536407;6845.8973115403305;6969.303069693092;7024.297570242935;5895.557833162444;6580.012998050331;6625.006249062486;6627.768028118992;6642.169728783902;6525.804225873231;6553.672316384066;6558.278589355263;6575.2767195607485;6579.605223686594;6860.725570977304;6881.931180688129;6882;6903.482238832208;6961.512694111364;4926.753662316798;5094.936550696973;5111.744412779421;5113.284140220447;5124;6526.477881769352;6578.934210657832;6692.297308782508;6725.663716814041;6809.693563789542;6477.878404907506;6484.740610375721;6527;6545.807154603262;6554.295883070531;6464.547481676237;6473.831266525578;6496.837579060372;6521.347865213441;6528.608283503005;6453.838654033687;6477.125588045742;6495.415412612888;6500.117393758656;6521.64130972801;6513.120728701754;6519.8044058678315;6551.412192184156;6567.408933196035;6593.835154121185;6360.522960777867;6364.459020983269;6366.331535188739;6389.8722025560155;6399.520035997226 14:46:54 INFO - PID 2183 | |5;yui.html;950.5152372290135;956.9234461243101;965.676498373045;969.3941286695815;973.3186769261519;18219.544511387205;19223.711644325347;19230.23079076837;19235.422937311887;20899.26852560161;20827.895860520675;22154.88922555389;22348.664770028423;22406.77593224067;22520.09919603218;1030.1192480429238;1038.9376637401742;1040.0951172479954;1040.885502594714;1042.8748550173989;1026.3687831983352;1062.654637242899;1063.5639387850983;1063.9202059845504;1069.6684027951321;1099.76355083657;1103.8454616353717;1110.0675432636583;1110.1562812262657;1111.4776055254017;1037.289456722144;1082.1883587309517;1083.3066837224183;1085.468120620894;1085.8642669666292;775.2247752247753;803.0443771911407;817.709713051864;821.1829229916212;821.4537332673765;19468.902655486774;19907.303244386523;20061.8996905016;20098.196072157098;20317.390478285673;21235.68146477804;22076.448088797748;22444.88777556118;22860.08559657612;22878.54242915149;14280.857191428056;14448.783268250985;14568.344424500923;14617.19605421712;14718.92640536801;3673.8714145005065;3680.1167719747336;3680.871169509054;3681.0429288384944;3681.5582130144553;135400.999999999;141425;141564;142060.28969855187;142374.28812855974;17589.82410175882;18085.7287140693;18137.18382672783;18182.090895455174;18186.818131818778;31808.36383272368;31983.20041998922;32455.026349209562;32555.34889302201;32562.511562326585;8557.144285571392;8777.429467084747;8940.971788244306;8994.730158095268;9030.774230644287;4336.371226172188;4357.128574285156;4371.890702732457;4403.119376124724;4414.27164517851;5618;5652.208690783294;5718;5730.140478928194;5757.740901659436;1136.5113001409472;1173.4895320535595;1175.6531823112202;1175.8824117588345;1186.6024881664566;704.9964750176216;711.3420086420144;711.8718630646533;727.1746567645761;738.8189893476133;13442.059055865995;13508.932455337661;13781.242031688153;13999;14028;717.4188906985358;720.3480849830911;721.2210812322679;737.1449119022016;739.7817643795094;6071;6119.877602448015;6193.721282542297;6219.875602487925;6223.284322302993;136772;139412.605873942;140222;140406.73562184663;141587;121438;126668.36665816612;129252.35373823071;129282.30859482188;132768;108844;109019.45490272497;109424.4528777367;110199;111167.44416278029;13381.721478237894;13517.459301628218;13626.318684065955;13723.588292351245;13873.79189312141;50484;51184.23223651723;51619.48380516297;51664;52630.73684631552;64257.35742642514;67208.32791672216;68654.65672671604;86532.56733716291;87991.56004219937;20369;20492.897535512227;20672.069756860677;20728.896355518125;20749.273775417787;21993.120275188812;22653.66019509742;22680.65979010349;22856.885715571316;22884.31347059591;18761.249550017845;18786.436406907815;19012.524686882938;19730.50673733168;20437.795622044185;20270.290539831036;20824.687629685264;20996.370108896757;21128.788712113295;21444.678329824754;20788.06453709617;20885.686714698986;21073.6838947419;21296.893515532323;21422.571548569253;13705.588832335046;13902.86097139056;13914.07804361055;13959.581212563638;14310.49913253031;14899.329530171384;15245.771313430529;15664.138472384127;15914.840851591336;16062.518124456285 14:46:54 INFO - PID 2183 | __end_tp_report 14:46:54 INFO - PID 2183 | __start_cc_report 14:46:54 INFO - PID 2183 | _x_x_mozilla_cycle_collect,343 14:46:54 INFO - PID 2183 | __end_cc_report 14:46:54 INFO - PID 2183 | __startTimestamp1503092814155__endTimestamp 14:46:54 INFO - PID 2183 | 14:46:54 INFO - PID 2183 | ------- Summary: start ------- 14:46:54 INFO - PID 2183 | Number of tests: 6 14:46:54 INFO - PID 2183 | 14:46:54 INFO - PID 2183 | [#0] dojo.html Cycles:165 Average:6148.45 Median:6518.09 stddev:803.14 (12.3%) stddev-sans-first:776.77 14:46:54 INFO - PID 2183 | Values: 3429.8 3481.8 3485.6 3494.4 3500.8 6002.4 6072.5 6134.6 6137.5 6165.1 6075.6 6141.9 6164.1 6172.3 6184.2 5359.4 5396.4 5434.6 5438.9 5459.9 5467.9 5468.0 5478.0 5499.6 5529.1 5382.7 5434.3 5454.0 5530.5 5542.1 5255.1 5295.3 5382.3 5469.2 5481.0 5367.2 5393.7 5437.2 5443.6 5465.3 6004.3 6052.8 6053.7 6076.6 6162.9 6581.9 6592.6 6607.0 6622.5 6673.9 6712.4 6741.4 6806.2 6806.3 6812.7 6155.2 6165.1 6222.0 6247.4 6253.5 6629.2 6745.5 6763.9 6788.2 6836.3 6553.6 6592.7 6607.2 6636.6 6647.2 6675.0 6697.9 6753.6 6754.5 6781.3 6524.6 6602.1 6614.1 6701.6 6708.7 6640.1 6640.4 6700.5 6706.3 6707.4 4864.1 4864.7 4865.5 4874.8 4880.2 4225.5 4235.8 4283.6 4293.2 4295.4 6341.5 6345.0 6376.6 6396.6 6400.6 6698.5 6726.1 6727.1 6811.4 6811.4 6312.2 6336.5 6388.5 6396.0 6399.1 5444.7 5446.0 5452.9 5456.7 5460.6 6995.5 7075.8 7083.1 7084.2 7091.8 6696.8 6699.7 6704.0 6713.5 6794.2 6808.4 6935.5 6971.9 7017.4 7055.6 6615.4 6682.2 6682.7 6700.8 6721.1 6738.2 6742.8 6746.0 6752.1 6819.7 6518.1 6526.8 6570.8 6596.7 6604.1 6529.4 6535.9 6543.3 6572.2 6586.3 6516.4 6522.0 6530.4 6566.2 6600.4 6514.1 6520.5 6561.5 6570.4 6655.3 6386.9 6427.2 6433.2 6448.8 6451.1 14:46:54 INFO - PID 2183 | 14:46:54 INFO - PID 2183 | [#1] ext.html Cycles:180 Average:41954.03 Median:19237.31 stddev:64530.38 (335.4%) stddev-sans-first:64637.75 14:46:54 INFO - PID 2183 | Values: 892.2 896.0 924.2 943.0 952.3 38588.8 39638.2 39752.8 39784.6 39809.4 37271.8 37658.2 37846.8 37862.0 38021.4 6803.2 6889.5 6912.1 6913.2 6914.3 6636.4 6725.1 6735.7 6742.1 6802.9 6795.0 7475.3 7603.8 7612.0 7620.3 7524.4 7577.1 7578.9 7579.8 7579.9 7409.6 7515.2 7564.8 7568.7 7579.7 37583.4 38357.0 38400.6 38403.2 38407.8 3421.8 3472.7 3477.3 3479.5 3480.1 29948.6 30104.0 30115.0 30115.2 30119.5 5038.4 5069.9 5096.5 5097.0 5107.0 198140.0 201249.0 202600.0 203693.0 259219.0 49835.3 49985.3 49985.5 50448.2 50701.0 53771.5 54329.5 54342.5 54817.5 54988.0 16365.2 16438.8 16592.0 16604.8 16743.7 13612.6 13649.2 13716.4 13791.6 13797.9 14935.0 15076.8 15143.3 15265.5 15327.8 6095.8 6156.5 6198.4 6217.3 6280.0 1069.6 1084.2 1100.9 1103.8 1104.9 23801.3 24190.2 24224.2 24361.5 30441.5 1166.5 1200.7 1201.5 1208.6 1213.9 12699.2 12910.9 12950.0 13029.4 13123.5 278075.0 281749.0 282754.0 284006.0 284549.0 55523.2 55927.7 55956.0 55964.2 55975.2 1479.9 1504.6 1525.4 1527.7 1529.4 28259.2 28430.0 29034.4 29272.0 29840.1 49497.8 50042.5 50290.7 50345.5 50373.5 239387.0 242293.0 242617.0 243270.0 243614.0 33874.8 34536.3 35295.8 36911.6 37386.6 45672.5 45757.1 45957.5 45974.5 46170.5 34491.3 34592.5 34687.5 34699.3 34994.5 33554.5 33697.8 34005.5 34040.8 34131.5 39009.4 39086.8 39261.6 39277.6 39554.6 32886.0 33094.8 33425.7 33608.0 33893.8 24530.0 25556.6 25972.5 26155.8 26271.7 14:46:54 INFO - PID 2183 | 14:46:54 INFO - PID 2183 | [#2] jquery.html Cycles:180 Average:39964.55 Median:2224.99 stddev:99483.43 (4471.2%) stddev-sans-first:99718.54 14:46:54 INFO - PID 2183 | Values: 572.9 579.2 580.1 586.0 599.8 22784.9 22870.8 23335.4 23456.8 23562.6 26373.9 26490.7 26617.5 26897.7 26921.0 6206.2 6312.1 6315.2 6315.3 6317.3 5987.7 6217.5 6217.6 6226.4 6246.1 6139.9 6179.0 6180.6 6184.7 6192.1 6127.6 6137.8 6166.7 6170.5 6174.5 5734.1 5757.3 5762.8 5771.4 5778.8 28994.6 29403.7 29461.4 29543.3 29952.6 2195.6 2224.2 2225.8 2227.2 2235.3 17663.1 17754.5 18648.4 18766.5 18783.4 2017.9 2019.4 2042.9 2049.7 2064.9 157036.0 166262.2 166484.0 166545.0 166733.2 14984.0 15728.5 15741.7 15790.4 15849.2 24232.2 24302.5 24417.5 24453.9 24471.0 10270.8 10653.3 10755.2 10787.3 10850.7 9817.0 9856.8 9882.8 9918.8 9964.6 10008.2 10021.4 10070.4 10122.0 10189.6 2637.5 2670.9 2706.9 2845.0 2904.4 1022.6 1033.7 1050.4 1050.8 1053.3 20752.5 21271.6 21691.7 21721.1 22256.3 1089.7 1109.4 1111.3 1116.1 1119.0 11705.7 14138.9 15043.2 15259.6 15267.0 551318.0 586753.0 590419.0 600017.0 615588.0 131180.3 139781.0 141196.0 142227.0 142328.3 1173.0 1254.7 1276.7 1320.2 1334.8 22962.0 23183.4 23333.8 23543.5 23553.9 64651.0 65108.0 65855.3 65866.7 68457.7 77609.6 78048.0 78723.6 78757.6 79202.0 14922.5 15370.2 15427.8 15539.0 15576.1 23055.0 23234.8 23519.4 23861.8 23943.4 20346.6 20529.5 20658.3 20675.5 20728.7 17211.0 17550.2 17720.1 17946.6 18018.5 19483.5 20209.8 21263.3 21654.8 21658.5 15099.8 15210.6 15287.0 15349.6 15377.5 18836.3 18932.5 18958.0 19461.9 19825.8 14:46:54 INFO - PID 2183 | 14:46:54 INFO - PID 2183 | [#3] mootools.html Cycles:180 Average:9904.82 Median:2518.57 stddev:7303.90 (290.0%) stddev-sans-first:7296.86 14:46:54 INFO - PID 2183 | Values: 1464.2 1497.6 1502.8 1512.6 1512.8 15439.3 15752.8 16067.6 16097.1 16111.2 15566.1 16371.1 16384.4 16396.8 16403.3 2638.9 2683.5 2687.4 2689.2 2693.7 2479.9 2556.9 2611.5 2683.3 2733.9 2692.0 2721.1 2721.1 2722.0 2732.9 2505.1 2532.0 2534.6 2535.3 2536.8 2427.2 2478.4 2564.2 2638.1 2698.8 15438.7 15499.0 15524.7 15532.0 15614.4 7874.6 8075.0 8088.0 8111.7 8139.8 4867.4 5034.8 5049.3 5122.2 5147.8 1848.1 1911.1 1924.1 1931.5 1943.4 27836.3 28058.2 28088.7 28241.7 28283.7 6286.6 6341.5 6355.2 6500.9 6520.7 18897.2 18969.7 19004.3 19017.4 19018.8 8010.2 8243.5 8244.8 8263.3 8269.0 7548.2 7548.4 7670.2 7707.7 7708.9 5261.7 5453.3 5469.8 5507.5 5525.8 1287.5 1311.0 1416.2 1416.8 1521.5 966.5 974.0 974.8 979.1 998.6 8485.7 8507.6 8512.2 8525.3 8589.9 1030.3 1032.4 1038.1 1038.1 1047.2 5234.0 5245.0 5300.0 5313.6 5376.5 22929.0 22938.2 23648.4 23790.6 23806.3 23374.8 23599.4 23600.9 23652.3 23783.9 11912.4 12571.0 12592.6 12726.7 12735.7 9469.7 9509.2 9527.0 9582.5 9598.6 20297.9 20464.5 20817.1 21032.3 21057.0 20998.9 21056.4 21085.0 21187.3 21232.4 12074.3 12191.3 12197.2 12304.4 12308.1 14570.9 14793.3 14828.0 14838.5 14854.5 11968.8 12014.3 12022.1 12117.6 12375.6 11692.9 11709.2 11838.2 11895.4 12099.5 9598.7 9742.5 9743.0 10201.0 10440.0 7762.6 7770.5 7798.0 7809.4 7952.6 7598.2 7705.9 7729.5 7750.5 7763.7 14:46:54 INFO - PID 2183 | 14:46:54 INFO - PID 2183 | [#4] prototype.html Cycles:180 Average:5518.08 Median:6127.89 stddev:1565.56 (25.5%) stddev-sans-first:1524.38 14:46:54 INFO - PID 2183 | Values: 522.1 529.9 534.7 542.8 545.6 6136.4 6164.5 6170.3 6180.4 6231.2 6051.5 6080.5 6094.1 6118.4 6120.1 4867.6 4896.7 4917.2 4921.0 4938.1 4647.3 4791.9 4839.3 4860.9 4912.5 4711.3 4735.4 4739.6 4757.5 4764.2 4749.5 4769.7 4774.4 4781.0 4786.8 4243.2 4326.9 4328.3 4352.2 4353.9 6019.9 6020.8 6023.4 6031.4 6047.3 5745.3 5746.4 5767.2 5774.7 5781.2 6556.4 6582.5 6583.5 6594.5 6594.6 4916.8 4916.8 4928.2 4940.2 4945.8 6627.5 6642.4 6748.0 6823.3 6845.8 4997.5 5021.7 5038.9 5047.6 5050.1 5094.8 5108.7 5110.6 5117.8 5119.7 5686.2 5705.9 5710.5 5715.7 5722.7 6513.5 6527.2 6531.2 6547.2 6567.3 1741.3 1752.0 1766.7 1774.7 1775.6 1179.7 1231.4 1233.6 1237.1 1242.3 6089.1 6114.4 6134.4 6141.3 6161.8 6458.0 6486.6 6541.5 6595.6 6668.4 6077.8 6094.4 6121.3 6201.3 6223.6 3444.3 3472.9 3476.0 3495.3 3522.2 6817.6 6822.4 6863.7 6869.2 6952.3 6651.8 6690.4 6696.0 6710.8 6819.9 6802.8 6828.9 6845.9 6969.3 7024.3 5895.6 6580.0 6625.0 6627.8 6642.2 6525.8 6553.7 6558.3 6575.3 6579.6 6860.7 6881.9 6882.0 6903.5 6961.5 4926.8 5094.9 5111.7 5113.3 5124.0 6526.5 6578.9 6692.3 6725.7 6809.7 6477.9 6484.7 6527.0 6545.8 6554.3 6464.5 6473.8 6496.8 6521.3 6528.6 6453.8 6477.1 6495.4 6500.1 6521.6 6513.1 6519.8 6551.4 6567.4 6593.8 6360.5 6364.5 6366.3 6389.9 6399.5 14:46:54 INFO - PID 2183 | 14:46:54 INFO - PID 2183 | [#5] yui.html Cycles:180 Average:27548.44 Median:20465.35 stddev:39292.74 (192.0%) stddev-sans-first:39352.21 14:46:54 INFO - PID 2183 | Values: 950.5 956.9 965.7 969.4 973.3 18219.5 19223.7 19230.2 19235.4 20899.3 20827.9 22154.9 22348.7 22406.8 22520.1 1030.1 1038.9 1040.1 1040.9 1042.9 1026.4 1062.7 1063.6 1063.9 1069.7 1099.8 1103.8 1110.1 1110.2 1111.5 1037.3 1082.2 1083.3 1085.5 1085.9 775.2 803.0 817.7 821.2 821.5 19468.9 19907.3 20061.9 20098.2 20317.4 21235.7 22076.4 22444.9 22860.1 22878.5 14280.9 14448.8 14568.3 14617.2 14718.9 3673.9 3680.1 3680.9 3681.0 3681.6 135401.0 141425.0 141564.0 142060.3 142374.3 17589.8 18085.7 18137.2 18182.1 18186.8 31808.4 31983.2 32455.0 32555.3 32562.5 8557.1 8777.4 8941.0 8994.7 9030.8 4336.4 4357.1 4371.9 4403.1 4414.3 5618.0 5652.2 5718.0 5730.1 5757.7 1136.5 1173.5 1175.7 1175.9 1186.6 705.0 711.3 711.9 727.2 738.8 13442.1 13508.9 13781.2 13999.0 14028.0 717.4 720.3 721.2 737.1 739.8 6071.0 6119.9 6193.7 6219.9 6223.3 136772.0 139412.6 140222.0 140406.7 141587.0 121438.0 126668.4 129252.4 129282.3 132768.0 108844.0 109019.5 109424.5 110199.0 111167.4 13381.7 13517.5 13626.3 13723.6 13873.8 50484.0 51184.2 51619.5 51664.0 52630.7 64257.4 67208.3 68654.7 86532.6 87991.6 20369.0 20492.9 20672.1 20728.9 20749.3 21993.1 22653.7 22680.7 22856.9 22884.3 18761.2 18786.4 19012.5 19730.5 20437.8 20270.3 20824.7 20996.4 21128.8 21444.7 20788.1 20885.7 21073.7 21296.9 21422.6 13705.6 13902.9 13914.1 13959.6 14310.5 14899.3 15245.8 15664.1 15914.8 16062.5 14:46:54 INFO - PID 2183 | -------- Summary: end -------- 14:46:54 INFO - PID 2183 | 14:46:54 INFO - TEST-INFO | 2183: exit 0 14:46:54 INFO - TEST-OK | dromaeo_css | took 1107641ms 14:46:54 INFO - TEST-START | kraken 14:46:54 INFO - Initialising browser for kraken test... 14:46:54 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55776/getInfo.html -profile /tmp/tmpcoG32q/profile 14:46:54 INFO - TEST-INFO | started process 2695 (/builds/slave/test/build/application/firefox/firefox http://localhost:55776/getInfo.html) 14:46:59 INFO - TEST-INFO | 2695: exit 0 14:46:59 INFO - Browser initialized. 14:46:59 INFO - Running cycle 1/1 for kraken test... 14:46:59 INFO - TEST-INFO | started process 3020 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcoG32q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:47:00 INFO - PID 3020 | 14:47:00 INFO - PID 3020 | (/builds/slave/test/build/application/firefox/firefox:3071): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:47:00 INFO - PID 3020 | 14:47:01 INFO - PID 3020 | 14:47:01 INFO - PID 3020 | (/builds/slave/test/build/application/firefox/firefox:3127): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:47:01 INFO - PID 3020 | 14:47:01 INFO - PID 3020 | __metrics Screen width/height:1600/1200 14:47:01 INFO - PID 3020 | colorDepth:24 14:47:01 INFO - PID 3020 | Browser inner width/height: 1024/768 14:47:01 INFO - PID 3020 | __metrics 14:47:10 INFO - PID 3020 | RSS: Main: 166031360 14:47:10 INFO - PID 3020 | 14:47:13 INFO - PID 3020 | Cycle 1(1): loaded http://localhost:55776/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55776/tests/kraken/driver.html?testName=audio-beat-detection) 14:47:14 INFO - PID 3020 | RSS: Main: 170078208 14:47:14 INFO - PID 3020 | 14:47:16 INFO - PID 3020 | Cycle 1(1): loaded http://localhost:55776/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55776/tests/kraken/driver.html?testName=audio-dft) 14:47:17 INFO - PID 3020 | RSS: Main: 172658688 14:47:17 INFO - PID 3020 | 14:47:20 INFO - PID 3020 | Cycle 1(1): loaded http://localhost:55776/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55776/tests/kraken/driver.html?testName=audio-fft) 14:47:21 INFO - PID 3020 | RSS: Main: 165810176 14:47:21 INFO - PID 3020 | 14:47:23 INFO - PID 3020 | Cycle 1(1): loaded http://localhost:55776/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55776/tests/kraken/driver.html?testName=audio-oscillator) 14:47:23 INFO - PID 3020 | RSS: Main: 166797312 14:47:23 INFO - PID 3020 | 14:47:25 INFO - PID 3020 | Cycle 1(1): loaded http://localhost:55776/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55776/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:47:26 INFO - PID 3020 | RSS: Main: 167165952 14:47:26 INFO - PID 3020 | 14:47:29 INFO - PID 3020 | Cycle 1(1): loaded http://localhost:55776/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55776/tests/kraken/driver.html?testName=imaging-darkroom) 14:47:30 INFO - PID 3020 | RSS: Main: 168607744 14:47:30 INFO - PID 3020 | 14:47:33 INFO - PID 3020 | Cycle 1(1): loaded http://localhost:55776/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55776/tests/kraken/driver.html?testName=imaging-desaturate) 14:47:34 INFO - PID 3020 | RSS: Main: 170250240 14:47:34 INFO - PID 3020 | 14:47:36 INFO - PID 3020 | Cycle 1(1): loaded http://localhost:55776/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55776/tests/kraken/driver.html?testName=json-parse-financial) 14:47:37 INFO - PID 3020 | RSS: Main: 168935424 14:47:37 INFO - PID 3020 | 14:47:39 INFO - PID 3020 | Cycle 1(1): loaded http://localhost:55776/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55776/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:47:39 INFO - PID 3020 | RSS: Main: 168652800 14:47:39 INFO - PID 3020 | 14:47:41 INFO - PID 3020 | Cycle 1(1): loaded http://localhost:55776/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55776/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:47:42 INFO - PID 3020 | RSS: Main: 168685568 14:47:42 INFO - PID 3020 | 14:47:44 INFO - PID 3020 | Cycle 1(1): loaded http://localhost:55776/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55776/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:47:44 INFO - PID 3020 | RSS: Main: 168783872 14:47:44 INFO - PID 3020 | 14:47:47 INFO - PID 3020 | Cycle 1(1): loaded http://localhost:55776/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55776/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:47:47 INFO - PID 3020 | RSS: Main: 168304640 14:47:47 INFO - PID 3020 | 14:47:50 INFO - PID 3020 | Cycle 1(1): loaded http://localhost:55776/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55776/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:47:51 INFO - PID 3020 | RSS: Main: 168878080 14:47:51 INFO - PID 3020 | 14:47:53 INFO - PID 3020 | Cycle 1(1): loaded http://localhost:55776/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55776/tests/kraken/driver.html?testName=ai-astar) 14:47:53 INFO - PID 3020 | RSS: Main: 170676224 14:47:53 INFO - PID 3020 | 14:47:53 INFO - PID 3020 | __start_tp_report 14:47:53 INFO - PID 3020 | _x_x_mozilla_page_load 14:47:53 INFO - PID 3020 | _x_x_mozilla_page_load_details 14:47:53 INFO - PID 3020 | |i|pagename|runs| 14:47:53 INFO - PID 3020 | |0;ai-astar;98;106;99;107;107;106;107;100;108;108 14:47:53 INFO - PID 3020 | |1;audio-beat-detection;142;121;145;166;116;146;142;113;172;115 14:47:53 INFO - PID 3020 | |2;audio-dft;167;166;163;162;162;165;160;162;164;162 14:47:53 INFO - PID 3020 | |3;audio-fft;73;73;72;171;74;75;73;86;95;73 14:47:53 INFO - PID 3020 | |4;audio-oscillator;79;78;139;79;78;79;133;78;79;126 14:47:53 INFO - PID 3020 | |5;imaging-gaussian-blur;115;114;114;113;114;114;113;113;114;115 14:47:53 INFO - PID 3020 | |6;imaging-darkroom;148;149;150;151;149;148;148;148;147;151 14:47:53 INFO - PID 3020 | |7;imaging-desaturate;94;93;97;94;93;94;93;94;93;94 14:47:53 INFO - PID 3020 | |8;json-parse-financial;47;46;49;47;51;50;48;47;47;47 14:47:53 INFO - PID 3020 | |9;json-stringify-tinderbox;61;54;59;54;54;55;54;55;56;55 14:47:53 INFO - PID 3020 | |10;stanford-crypto-aes;72;73;72;72;73;75;76;71;73;72 14:47:53 INFO - PID 3020 | |11;stanford-crypto-ccm;127;113;117;111;115;117;114;110;109;157 14:47:53 INFO - PID 3020 | |12;stanford-crypto-pbkdf2;170;172;168;162;164;162;160;172;164;159 14:47:53 INFO - PID 3020 | |13;stanford-crypto-sha256-iterative;63;60;66;66;62;61;60;60;61;61 14:47:53 INFO - PID 3020 | __end_tp_report 14:47:53 INFO - PID 3020 | __start_cc_report 14:47:53 INFO - PID 3020 | _x_x_mozilla_cycle_collect,869 14:47:53 INFO - PID 3020 | __end_cc_report 14:47:53 INFO - PID 3020 | __startTimestamp1503092873318__endTimestamp 14:47:53 INFO - PID 3020 | 14:47:53 INFO - PID 3020 | ------- Summary: start ------- 14:47:53 INFO - PID 3020 | Number of tests: 14 14:47:53 INFO - PID 3020 | 14:47:53 INFO - PID 3020 | [#0] ai-astar Cycles:10 Average:104.60 Median:107.50 stddev:3.95 (3.7%) stddev-sans-first:3.39 14:47:53 INFO - PID 3020 | Values: 98.0 106.0 99.0 107.0 107.0 106.0 107.0 100.0 108.0 108.0 14:47:53 INFO - PID 3020 | 14:47:53 INFO - PID 3020 | [#1] audio-beat-detection Cycles:10 Average:137.80 Median:143.50 stddev:21.11 (14.7%) stddev-sans-first:22.34 14:47:53 INFO - PID 3020 | Values: 142.0 121.0 145.0 166.0 116.0 146.0 142.0 113.0 172.0 115.0 14:47:53 INFO - PID 3020 | 14:47:53 INFO - PID 3020 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.50 stddev:2.16 (1.3%) stddev-sans-first:1.83 14:47:53 INFO - PID 3020 | Values: 167.0 166.0 163.0 162.0 162.0 165.0 160.0 162.0 164.0 162.0 14:47:53 INFO - PID 3020 | 14:47:53 INFO - PID 3020 | [#3] audio-fft Cycles:10 Average:86.50 Median:73.50 stddev:30.62 (41.7%) stddev-sans-first:32.09 14:47:53 INFO - PID 3020 | Values: 73.0 73.0 72.0 171.0 74.0 75.0 73.0 86.0 95.0 73.0 14:47:53 INFO - PID 3020 | 14:47:53 INFO - PID 3020 | [#4] audio-oscillator Cycles:10 Average:94.80 Median:78.50 stddev:26.31 (33.5%) stddev-sans-first:27.28 14:47:53 INFO - PID 3020 | Values: 79.0 78.0 139.0 79.0 78.0 79.0 133.0 78.0 79.0 126.0 14:47:53 INFO - PID 3020 | 14:47:53 INFO - PID 3020 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.74 (0.6%) stddev-sans-first:0.67 14:47:53 INFO - PID 3020 | Values: 115.0 114.0 114.0 113.0 114.0 114.0 113.0 113.0 114.0 115.0 14:47:53 INFO - PID 3020 | 14:47:53 INFO - PID 3020 | [#6] imaging-darkroom Cycles:10 Average:148.90 Median:149.00 stddev:1.37 (0.9%) stddev-sans-first:1.41 14:47:53 INFO - PID 3020 | Values: 148.0 149.0 150.0 151.0 149.0 148.0 148.0 148.0 147.0 151.0 14:47:53 INFO - PID 3020 | 14:47:53 INFO - PID 3020 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:1.20 (1.3%) stddev-sans-first:1.27 14:47:53 INFO - PID 3020 | Values: 94.0 93.0 97.0 94.0 93.0 94.0 93.0 94.0 93.0 94.0 14:47:53 INFO - PID 3020 | 14:47:53 INFO - PID 3020 | [#8] json-parse-financial Cycles:10 Average:47.90 Median:47.50 stddev:1.60 (3.4%) stddev-sans-first:1.66 14:47:53 INFO - PID 3020 | Values: 47.0 46.0 49.0 47.0 51.0 50.0 48.0 47.0 47.0 47.0 14:47:53 INFO - PID 3020 | 14:47:53 INFO - PID 3020 | [#9] json-stringify-tinderbox Cycles:10 Average:55.70 Median:55.00 stddev:2.41 (4.4%) stddev-sans-first:1.62 14:47:53 INFO - PID 3020 | Values: 61.0 54.0 59.0 54.0 54.0 55.0 54.0 55.0 56.0 55.0 14:47:53 INFO - PID 3020 | 14:47:53 INFO - PID 3020 | [#10] stanford-crypto-aes Cycles:10 Average:72.90 Median:73.00 stddev:1.52 (2.1%) stddev-sans-first:1.58 14:47:53 INFO - PID 3020 | Values: 72.0 73.0 72.0 72.0 73.0 75.0 76.0 71.0 73.0 72.0 14:47:53 INFO - PID 3020 | 14:47:53 INFO - PID 3020 | [#11] stanford-crypto-ccm Cycles:10 Average:119.00 Median:116.00 stddev:14.29 (12.3%) stddev-sans-first:14.86 14:47:53 INFO - PID 3020 | Values: 127.0 113.0 117.0 111.0 115.0 117.0 114.0 110.0 109.0 157.0 14:47:53 INFO - PID 3020 | 14:47:53 INFO - PID 3020 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.30 Median:166.00 stddev:4.85 (2.9%) stddev-sans-first:4.84 14:47:53 INFO - PID 3020 | Values: 170.0 172.0 168.0 162.0 164.0 162.0 160.0 172.0 164.0 159.0 14:47:53 INFO - PID 3020 | 14:47:53 INFO - PID 3020 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.00 Median:61.50 stddev:2.31 (3.8%) stddev-sans-first:2.42 14:47:53 INFO - PID 3020 | Values: 63.0 60.0 66.0 66.0 62.0 61.0 60.0 60.0 61.0 61.0 14:47:53 INFO - PID 3020 | -------- Summary: end -------- 14:47:53 INFO - PID 3020 | 14:47:53 INFO - PID 3020 | 14:47:53 INFO - PID 3020 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150079,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 14:47:53 INFO - PID 3020 | 14:47:53 INFO - PID 3020 | 14:47:53 INFO - PID 3020 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 14:47:53 INFO - PID 3020 | 14:47:53 INFO - PID 3020 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 14:47:53 INFO - TEST-INFO | 3020: exit 0 14:47:54 INFO - TEST-OK | kraken | took 59235ms 14:47:54 INFO - SUITE-END | took 1166s 14:47:54 INFO - Completed test suite (00:19:27) 14:47:54 INFO - javascript benchmark 14:47:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8866.373161746633, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3429.7942123472576, 3481.8433170507324, 3485.5991560970497, 3494.405950988333, 3500.8424620892056, 6002.399760023995, 6072.514198864092, 6134.570580059398, 6137.508999280058, 6165.136880836686, 6075.574709770318, 6141.907871381922, 6164.10620460033, 6172.290186628539, 6184.196054512919, 5359.410464848864, 5396.43337449567, 5434.592405569579, 5438.91841622376, 5459.945400545984, 5467.9453205468035, 5467.972660136694, 5477.972610136943, 5499.560035197174, 5529.087700529408, 5382.650127741724, 5434.2935418395555, 5454.0, 5530.5022547970675, 5542.057850165462, 5255.106631872591, 5295.258663787073, 5382.273393091921, 5469.179623056533, 5481.040817856899, 5367.1680889462195, 5393.6763794172475, 5437.211604317352, 5443.618946673734, 5465.289512363407, 6004.279486461609, 6052.757889684452, 6053.697315134225, 6076.605020673686, 6162.8767424651705, 6581.901271480931, 6592.604443733343, 6607.0, 6622.470202383798, 6673.8665226695675, 6712.362325579063, 6741.426978706816, 6806.183258009021, 6806.319368063204, 6812.659367031629, 6155.169052177944, 6165.106059621375, 6222.0, 6247.406496382836, 6253.468455181315, 6629.237637671633, 6745.460363170934, 6763.864722705518, 6788.185417749902, 6836.316368363224, 6553.63954982471, 6592.670366481657, 6607.240167380813, 6636.634985075867, 6647.235567909655, 6674.9666251669405, 6697.8995315070315, 6753.594784312957, 6754.527183097234, 6781.287964763629, 6524.575902566318, 6602.108715323466, 6614.0740296358545, 6701.564398314094, 6708.698108585126, 6640.103586015923, 6640.402363787282, 6700.497462690318, 6706.26231114577, 6707.362800534039, 4864.1001414737675, 4864.683795553277, 4865.489123641966, 4874.829380971649, 4880.219164933665, 4225.535191128974, 4235.8093885775215, 4283.593058659422, 4293.162833247487, 4295.3771703102875, 6341.492680585542, 6344.968275158594, 6376.617402955838, 6396.648184349812, 6400.583962042452, 6698.497612679069, 6726.058351830748, 6727.058211850345, 6811.352921472452, 6811.352921472452, 6312.179416675895, 6336.461400780893, 6388.488920886318, 6396.0405939109505, 6399.104125422445, 5444.727763611803, 5446.046941785172, 5452.863678407992, 5456.672599644034, 5460.645058071213, 6995.475339349569, 7075.82310442243, 7083.114610673666, 7084.220735719066, 7091.82270443243, 6696.83257918556, 6699.698513566901, 6703.966480167763, 6713.4964877634375, 6794.218664853605, 6808.353206445379, 6935.479839011993, 6971.860562788817, 7017.4386049116965, 7055.576665400093, 6615.437687796399, 6682.198136223684, 6682.665866706742, 6700.798976030727, 6721.126253587003, 6738.225104112894, 6742.831429214113, 6746.0, 6752.054712340375, 6819.727210911508, 6518.0941735365195, 6526.804195874131, 6570.8028759137305, 6596.736130554724, 6604.14146160996, 6529.379708927644, 6535.901961470677, 6543.345665433419, 6572.244191917799, 6586.308437613981, 6516.446102081376, 6522.0, 6530.412262896362, 6566.179227596551, 6600.372964568358, 6514.0880276760345, 6520.478361731145, 6561.540692151503, 6570.408663220333, 6655.301193374626, 6386.9361306386345, 6427.196600424947, 6433.195850518685, 6448.806535803933, 6451.0968464415955], "value": 6086.394293785906, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [892.1918409845691, 895.9552022398882, 924.2005665099688, 943.0286804591274, 952.2667545989589, 38588.80705596475, 39638.207235855305, 39752.80123599378, 39784.60215397845, 39809.40285895714, 37271.813640931825, 37658.246835063284, 37846.810765946204, 37862.0, 38021.42967855484, 6803.217629972567, 6889.4832887533385, 6912.135983002125, 6913.204981427125, 6914.274001229874, 6636.435902948231, 6725.05849181115, 6735.663216839139, 6742.123523941881, 6802.897956530656, 6794.966025169867, 7475.32722055015, 7603.809904752397, 7612.0, 7620.3141717245435, 7524.360429363511, 7577.128630207541, 7578.886316705254, 7579.81050473737, 7579.924200757977, 7409.555426674363, 7515.173330933593, 7564.77305680825, 7568.735094271674, 7579.734709285149, 37583.436248456295, 38357.0, 38400.61599383999, 38403.231935361415, 38407.807960960294, 3421.8460169292443, 3472.722182225441, 3477.2697733475748, 3479.460683594047, 3480.1473638958364, 29948.550771738443, 30104.0, 30115.0, 30115.247118822204, 30119.548206776915, 5038.39539255288, 5069.873253168664, 5096.541311281965, 5097.0, 5107.0, 198140.0, 201249.0, 202600.0, 203693.0, 259219.0, 49835.25247121296, 49985.25022124671, 49985.50014499881, 50448.243276350884, 50701.0, 53771.46228537665, 54329.45670543323, 54342.45657543453, 54817.451825481236, 54988.0, 16365.181740912907, 16438.75341869873, 16592.0, 16604.750928736077, 16743.665126697397, 13612.591622251348, 13649.249291289074, 13716.3827627755, 13791.586252412444, 13797.931010345084, 14934.954553181173, 15076.793856491455, 15143.318550665246, 15265.465708700141, 15327.770083448757, 6095.817125486243, 6156.538259630545, 6198.411150940653, 6217.253929528486, 6280.0, 1069.588208539718, 1084.2464487181333, 1100.9394483303336, 1103.779244151157, 1104.8563686720836, 23801.285961421185, 24190.202967798068, 24224.152154674503, 24361.512769744506, 30441.543376849364, 1166.5392170092766, 1200.6818193178815, 1201.5013769285824, 1208.5709573101599, 1213.9271643701406, 12699.238045717286, 12910.935445322713, 12950.0, 13029.413676384396, 13123.475060997453, 278075.0, 281749.0, 282754.0, 284006.0, 284549.0, 55523.16715249194, 55927.72036139793, 55956.0, 55964.16053759197, 55975.160372594444, 1479.8742106920818, 1504.5711972087902, 1525.3898440623618, 1527.7250094982787, 1529.395888623965, 28259.15222543327, 28430.0, 29034.41931161407, 29272.0, 29840.10479685613, 49497.75251123722, 50042.49957500524, 50290.74854625703, 50345.49654503408, 50373.49626503688, 239387.0, 242293.0, 242617.0, 243270.0, 243614.0, 33874.83062584671, 34536.309273814884, 35295.82352088223, 36911.63088369082, 37386.6261337394, 45672.54327456683, 45757.084858303315, 45957.540424595325, 45974.54025459703, 46170.53829461662, 34491.31017379588, 34592.48111278282, 34687.47968780521, 34699.30601388009, 34994.475082873265, 33554.496682549296, 33697.83151084229, 34005.48991765076, 34040.82979585086, 34131.4880276801, 39009.41485877771, 39086.804565976985, 39261.607383925795, 39277.60722392739, 39554.60445395509, 32886.0, 33094.83452582722, 33425.66574334226, 33608.0, 33893.83053084719, 24530.0, 25556.616650750624, 25972.480550389264, 26155.7767589757, 26271.737282626927], "value": 18011.19944308871, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.8567858035491, 579.2469789273943, 580.0921557762102, 586.0, 599.7690889007732, 22784.8860755696, 22870.771292287092, 23335.41661458462, 23456.76543234567, 23562.646560301568, 26373.868130659368, 26490.67546622666, 26617.467650646977, 26897.731022689768, 26921.0, 6206.1931948846695, 6312.053192021211, 6315.210598675166, 6315.305316415191, 6317.305096439388, 5987.700614969256, 6217.533684973622, 6217.56477046607, 6226.408491193352, 6246.0630905364105, 6139.938600614004, 6179.0, 6180.598261113036, 6184.72168752405, 6192.102145188945, 6127.601705889125, 6137.846553836145, 6166.691665416756, 6170.5372097092895, 6174.536909731765, 5734.111212762028, 5757.280339957505, 5762.798302059407, 5771.365149833515, 5778.797742079007, 28994.565081523582, 29403.705962940312, 29461.410771784445, 29543.261418464495, 29952.550711739343, 2195.6267434536167, 2224.154821167962, 2225.8330625203175, 2227.2093406840663, 2235.2623634200677, 17663.11684415774, 17754.467365979042, 18648.440546783484, 18766.530836729053, 18783.436496905113, 2017.8991050447419, 2019.4345583236718, 2042.8774273543636, 2049.661805802041, 2064.9070791814406, 157036.0, 166262.168689157, 166484.0, 166545.0, 166733.16633416875, 14984.0, 15728.483442649122, 15741.685166296838, 15790.447334343244, 15849.207539623203, 24232.151874684303, 24302.513949720906, 24417.51164976726, 24453.87773061123, 24471.0, 10270.794584108276, 10653.307535010199, 10755.247132700635, 10787.298825576469, 10850.67447976562, 9816.950915245521, 9856.753581160385, 9882.80234395308, 9918.752031199278, 9964.601415943425, 10008.199344052458, 10021.446675765268, 10070.446125463024, 10122.0, 10189.592416303412, 2637.512060268856, 2670.919872403792, 2706.9323266918486, 2844.9573256401172, 2904.433635441111, 1022.6062965758088, 1033.7312298802215, 1050.4117694091333, 1050.7950949564915, 1053.2942928238099, 20752.48118797012, 21271.574568508542, 21691.67462488064, 21721.13115475363, 22256.332310030724, 1089.7384627689298, 1109.417555783204, 1111.3387534417009, 1116.1238427834112, 1118.9776204475866, 11705.707357315965, 14138.929305353407, 15043.247837608076, 15259.558470644644, 15267.007644503072, 551318.0, 586753.0, 590419.0, 600017.0, 615588.0, 131180.3440982789, 139781.0, 141196.0, 142227.0, 142328.28835855753, 1172.9824052639217, 1254.7176885200756, 1276.7446510697898, 1320.1946812444594, 1334.8064530643003, 22962.0, 23183.420414489097, 23333.766662333837, 23543.529129417657, 23553.882230588737, 64651.0, 65108.0, 65855.34144658492, 65866.67066664636, 68457.65771171311, 77609.61195194213, 78048.0, 78723.60638196772, 78757.60621196857, 79202.0, 14922.477713279983, 15370.154641494824, 15427.84572154309, 15539.0, 15576.065436073872, 23055.0, 23234.767652323262, 23519.41201469977, 23861.761382385954, 23943.401414964766, 20346.59306813826, 20529.48676283105, 20658.276960306917, 20675.4831129223, 20728.68906966427, 17211.0, 17550.21024053946, 17720.113994299976, 17946.5513362167, 18018.549536261697, 19483.51291217731, 20209.797902020793, 21263.255786047415, 21654.783452165277, 21658.458538536663, 15099.773503397239, 15210.619734506727, 15286.986171623716, 15349.6162595936, 15377.538673839803, 18836.34072807445, 18932.52668683239, 18958.0, 19461.90269048646, 19825.801741982395], "value": 12668.892116929386, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1464.2093269634397, 1497.5881632551054, 1502.7595584706442, 1512.6294057955802, 1512.826025007124, 15439.305231264592, 15752.84247157528, 16067.59831004224, 16097.114658693796, 16111.194440277983, 15566.143862087609, 16371.099589522571, 16384.426545070924, 16396.75404868928, 16403.261853216605, 2638.8812503437393, 2683.5035518429054, 2687.422204226091, 2689.1529168312018, 2693.676758788948, 2479.8884050217694, 2556.910508132216, 2611.5038142752815, 2683.2889284339667, 2733.9179824605294, 2691.9596206056926, 2721.102036328007, 2721.142840005402, 2722.0336780442954, 2732.904348347808, 2505.1357281737774, 2531.999860055277, 2534.6198070289606, 2535.2901187667576, 2536.8097392695436, 2427.235420842429, 2478.3556275368355, 2564.230730780758, 2638.0898589986423, 2698.811083224175, 15438.691226175413, 15499.0, 15524.689506209925, 15532.0, 15614.375424982987, 7874.645640946172, 8075.0, 8088.0, 8111.675532978674, 8139.75580732579, 4867.367242258484, 5034.798608055673, 5049.267856160873, 5122.1804511278015, 5147.794088236466, 1848.1036697201846, 1911.0731295321757, 1924.114907142716, 1931.4688460673287, 1943.416974907522, 27836.304092397648, 28058.158255252172, 28088.719112808816, 28241.717582824112, 28283.71716282852, 6286.591371560834, 6341.524385671001, 6355.237371515355, 6500.902486462707, 6520.706568204442, 18897.244110235435, 18969.715454268196, 19004.334848280243, 19017.429477115707, 19018.80981190198, 8010.19898010206, 8243.546604936666, 8244.752657420288, 8263.338932885355, 8268.958655206805, 7548.207438219018, 7548.433867459962, 7670.232976702285, 7707.653155608011, 7708.922910770821, 5261.657992230493, 5453.291072160594, 5469.781208751605, 5507.531859791882, 5525.806596769094, 1287.4914408808656, 1311.0, 1416.178616402484, 1416.7591509443419, 1521.4750910935709, 966.4732720667254, 973.99026009739, 974.7855471796194, 979.0747743382577, 998.5606333213362, 8485.660573577112, 8507.61715722794, 8512.233898949, 8525.275351595184, 8589.914100859036, 1030.294248439821, 1032.4321623107262, 1038.055369613648, 1038.133158812385, 1047.1988928469727, 5233.973830130825, 5244.9737751310995, 5300.01949639318, 5313.628046036741, 5376.516113549799, 22929.0, 22938.197163099212, 23648.40878978005, 23790.64314035291, 23806.285811425685, 23374.76625233726, 23599.410014749425, 23600.881995589913, 23652.29043128709, 23783.881080594485, 11912.404379780975, 12571.0, 12592.559260425842, 12726.68183295425, 12735.745285094432, 9469.715908522756, 9509.191718703987, 9527.0, 9582.472963987047, 9598.616055357708, 20297.89851050735, 20464.48838778983, 20817.06323215489, 21032.26387076445, 21057.0, 20998.895005524875, 21056.368308950758, 21085.0, 21187.258445954318, 21232.36302910915, 12074.27554346742, 12191.268523888595, 12197.207181533173, 12304.446299916346, 12308.076894233147, 14570.927145364205, 14793.334299956743, 14827.99822024056, 14838.480653177086, 14854.480093197119, 11968.820467692818, 12014.33921134346, 12022.098342624164, 12117.575884843987, 12375.566855160027, 11692.88307116952, 11709.238899471507, 11838.171328006956, 11895.405229738652, 12099.455524501594, 9598.66404675833, 9742.464164471023, 9742.976987416503, 10201.0, 10440.0, 7762.611869406394, 7770.53376797394, 7798.0, 7809.375249980101, 7952.6421311042295, 7598.240175982358, 7705.922940770521, 7729.497582657109, 7750.496217745828, 7763.72826951054], "value": 6936.762538129596, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [522.1254398881877, 529.9152135658293, 534.7085838218171, 542.823582335741, 545.5799034743251, 6136.417040381168, 6164.506839452839, 6170.321264660889, 6180.443760061594, 6231.158793562868, 6051.455369016788, 6080.513558915287, 6094.085887116935, 6118.38816118388, 6120.14317995481, 4867.610591152699, 4896.706197628154, 4917.21324588066, 4920.9911968046645, 4938.086454006002, 4647.302904564309, 4791.856244312677, 4839.330431001316, 4860.927086093711, 4912.48418916014, 4711.340412342275, 4735.384400028009, 4739.573438390544, 4757.548032936866, 4764.213419967512, 4749.501302363236, 4769.736019954715, 4774.427068751755, 4780.9680885623475, 4786.7845946932475, 4243.236217480852, 4326.913461730779, 4328.264195086843, 4352.238358287319, 4353.934690979638, 6019.88632103058, 6020.759169633209, 6023.427774361428, 6031.396860313977, 6047.274327080779, 5745.310562732457, 5746.367899531048, 5767.163761254595, 5774.740136693859, 5781.161731548944, 6556.377144171296, 6582.539222254444, 6583.539152259344, 6594.53838231324, 6594.637294948776, 4916.754162291907, 4916.803327866881, 4928.162212423897, 4940.2342636891335, 4945.7774400152075, 6627.536072474881, 6642.368974947372, 6747.966260168668, 6823.317668233187, 6845.794626161223, 4997.525235102659, 5021.698698078127, 5038.924416133761, 5047.611906725607, 5050.116229659869, 5094.821681241138, 5108.693478391308, 5110.616703747234, 5117.84848409105, 5119.74401279942, 5686.213755259892, 5705.857353566194, 5710.543156547466, 5715.685637289906, 5722.7424765885635, 6513.46933470634, 6527.184101987252, 6531.150950376421, 6547.247066587308, 6567.343265673395, 1741.268667159796, 1752.0013592252549, 1766.6908291049015, 1774.6539424812038, 1775.6448710258, 1179.6637958181877, 1231.378154032208, 1233.5805826019018, 1237.127824883455, 1242.3415589737454, 6089.117078023662, 6114.357992410822, 6134.44789968896, 6141.324454310023, 6161.784337548164, 6457.967710161419, 6486.643234622141, 6541.47668186544, 6595.637239951849, 6668.399844013965, 6077.809150196094, 6094.421030002142, 6121.326654068138, 6201.317855035943, 6223.595466294767, 3444.293919746446, 3472.8610855565494, 3475.9652403475643, 3495.265994141259, 3522.1898963238086, 6817.5568588041615, 6822.4200942919415, 6863.691133898987, 6869.175698916162, 6952.341930906305, 6651.833704157338, 6690.431313338323, 6696.0, 6710.832229194211, 6819.931800682029, 6802.761903333459, 6828.897566536407, 6845.8973115403305, 6969.303069693092, 7024.297570242935, 5895.557833162444, 6580.012998050331, 6625.006249062486, 6627.768028118992, 6642.169728783902, 6525.804225873231, 6553.672316384066, 6558.278589355263, 6575.2767195607485, 6579.605223686594, 6860.725570977304, 6881.931180688129, 6882.0, 6903.482238832208, 6961.512694111364, 4926.753662316798, 5094.936550696973, 5111.744412779421, 5113.284140220447, 5124.0, 6526.477881769352, 6578.934210657832, 6692.297308782508, 6725.663716814041, 6809.693563789542, 6477.878404907506, 6484.740610375721, 6527.0, 6545.807154603262, 6554.295883070531, 6464.547481676237, 6473.831266525578, 6496.837579060372, 6521.347865213441, 6528.608283503005, 6453.838654033687, 6477.125588045742, 6495.415412612888, 6500.117393758656, 6521.64130972801, 6513.120728701754, 6519.8044058678315, 6551.412192184156, 6567.408933196035, 6593.835154121185, 6360.522960777867, 6364.459020983269, 6366.331535188739, 6389.8722025560155, 6399.520035997226], "value": 5062.271173454645, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [950.5152372290135, 956.9234461243101, 965.676498373045, 969.3941286695815, 973.3186769261519, 18219.544511387205, 19223.711644325347, 19230.23079076837, 19235.422937311887, 20899.26852560161, 20827.895860520675, 22154.88922555389, 22348.664770028423, 22406.77593224067, 22520.09919603218, 1030.1192480429238, 1038.9376637401742, 1040.0951172479954, 1040.885502594714, 1042.8748550173989, 1026.3687831983352, 1062.654637242899, 1063.5639387850983, 1063.9202059845504, 1069.6684027951321, 1099.76355083657, 1103.8454616353717, 1110.0675432636583, 1110.1562812262657, 1111.4776055254017, 1037.289456722144, 1082.1883587309517, 1083.3066837224183, 1085.468120620894, 1085.8642669666292, 775.2247752247753, 803.0443771911407, 817.709713051864, 821.1829229916212, 821.4537332673765, 19468.902655486774, 19907.303244386523, 20061.8996905016, 20098.196072157098, 20317.390478285673, 21235.68146477804, 22076.448088797748, 22444.88777556118, 22860.08559657612, 22878.54242915149, 14280.857191428056, 14448.783268250985, 14568.344424500923, 14617.19605421712, 14718.92640536801, 3673.8714145005065, 3680.1167719747336, 3680.871169509054, 3681.0429288384944, 3681.5582130144553, 135400.999999999, 141425.0, 141564.0, 142060.28969855187, 142374.28812855974, 17589.82410175882, 18085.7287140693, 18137.18382672783, 18182.090895455174, 18186.818131818778, 31808.36383272368, 31983.20041998922, 32455.026349209562, 32555.34889302201, 32562.511562326585, 8557.144285571392, 8777.429467084747, 8940.971788244306, 8994.730158095268, 9030.774230644287, 4336.371226172188, 4357.128574285156, 4371.890702732457, 4403.119376124724, 4414.27164517851, 5618.0, 5652.208690783294, 5718.0, 5730.140478928194, 5757.740901659436, 1136.5113001409472, 1173.4895320535595, 1175.6531823112202, 1175.8824117588345, 1186.6024881664566, 704.9964750176216, 711.3420086420144, 711.8718630646533, 727.1746567645761, 738.8189893476133, 13442.059055865995, 13508.932455337661, 13781.242031688153, 13999.0, 14028.0, 717.4188906985358, 720.3480849830911, 721.2210812322679, 737.1449119022016, 739.7817643795094, 6071.0, 6119.877602448015, 6193.721282542297, 6219.875602487925, 6223.284322302993, 136772.0, 139412.605873942, 140222.0, 140406.73562184663, 141587.0, 121438.0, 126668.36665816612, 129252.35373823071, 129282.30859482188, 132768.0, 108844.0, 109019.45490272497, 109424.4528777367, 110199.0, 111167.44416278029, 13381.721478237894, 13517.459301628218, 13626.318684065955, 13723.588292351245, 13873.79189312141, 50484.0, 51184.23223651723, 51619.48380516297, 51664.0, 52630.73684631552, 64257.35742642514, 67208.32791672216, 68654.65672671604, 86532.56733716291, 87991.56004219937, 20369.0, 20492.897535512227, 20672.069756860677, 20728.896355518125, 20749.273775417787, 21993.120275188812, 22653.66019509742, 22680.65979010349, 22856.885715571316, 22884.31347059591, 18761.249550017845, 18786.436406907815, 19012.524686882938, 19730.50673733168, 20437.795622044185, 20270.290539831036, 20824.687629685264, 20996.370108896757, 21128.788712113295, 21444.678329824754, 20788.06453709617, 20885.686714698986, 21073.6838947419, 21296.893515532323, 21422.571548569253, 13705.588832335046, 13902.86097139056, 13914.07804361055, 13959.581212563638, 14310.49913253031, 14899.329530171384, 15245.771313430529, 15664.138472384127, 15914.840851591336, 16062.518124456285], "value": 9961.038024117257, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1466.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 106.0, 99.0, 107.0, 107.0, 106.0, 107.0, 100.0, 108.0, 108.0], "value": 104.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 121.0, 145.0, 166.0, 116.0, 146.0, 142.0, 113.0, 172.0, 115.0], "value": 137.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 166.0, 163.0, 162.0, 162.0, 165.0, 160.0, 162.0, 164.0, 162.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 72.0, 171.0, 74.0, 75.0, 73.0, 86.0, 95.0, 73.0], "value": 86.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 139.0, 79.0, 78.0, 79.0, 133.0, 78.0, 79.0, 126.0], "value": 94.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 113.0, 114.0, 114.0, 113.0, 113.0, 114.0, 115.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 150.0, 151.0, 149.0, 148.0, 148.0, 148.0, 147.0, 151.0], "value": 148.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 97.0, 94.0, 93.0, 94.0, 93.0, 94.0, 93.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 46.0, 49.0, 47.0, 51.0, 50.0, 48.0, 47.0, 47.0, 47.0], "value": 47.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 54.0, 59.0, 54.0, 54.0, 55.0, 54.0, 55.0, 56.0, 55.0], "value": 55.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 72.0, 72.0, 73.0, 75.0, 76.0, 71.0, 73.0, 72.0], "value": 72.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 113.0, 117.0, 111.0, 115.0, 117.0, 114.0, 110.0, 109.0, 157.0], "value": 119.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 172.0, 168.0, 162.0, 164.0, 162.0, 160.0, 172.0, 164.0, 159.0], "value": 165.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 60.0, 66.0, 66.0, 62.0, 61.0, 60.0, 60.0, 61.0, 61.0], "value": 62.0, "unit": "score"}]}]} 14:47:54 INFO - Return code: 0 14:47:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:47:54 INFO - # TBPL SUCCESS # 14:47:54 INFO - Running post-action listener: _package_coverage_data 14:47:54 INFO - Running post-action listener: _resource_record_post_action 14:47:54 INFO - [mozharness: 2017-08-18 21:47:54.619048Z] Finished run-tests step (success) 14:47:54 INFO - Running post-run listener: _resource_record_post_run 14:47:54 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 12288; Write bytes: 446234624; Read time: 32; Write time: 305284 14:47:54 INFO - TinderboxPrint: CPU usage
13.1% 14:47:54 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 32 14:47:54 INFO - TinderboxPrint: I/O write bytes / time
446,234,624 / 305,284 14:47:54 INFO - TinderboxPrint: CPU idle
8,220.6 (86.9%) 14:47:54 INFO - TinderboxPrint: CPU user
1,188.7 (12.6%) 14:47:54 INFO - TinderboxPrint: Swap in / out
0 / 0 14:47:54 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 108355584; Read time: 0; Write time: 77544 14:47:54 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 14:47:54 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 8192; Write bytes: 323833856; Read time: 24; Write time: 221012 14:47:55 INFO - Running post-run listener: _upload_blobber_files 14:47:55 INFO - Blob upload gear active. 14:47:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:47:55 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 14:47:55 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'] 14:47:55 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 14:47:55 INFO - (blobuploader) - INFO - Open directory for files ... 14:47:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:47:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:47:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:47:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:47:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:47:56 INFO - (blobuploader) - INFO - Done attempting. 14:47:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:47:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:47:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:48:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:48:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:48:03 INFO - (blobuploader) - INFO - Done attempting. 14:48:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:48:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:48:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:48:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:48:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:48:04 INFO - (blobuploader) - INFO - Done attempting. 14:48:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:48:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:48:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:48:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:48:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:48:05 INFO - (blobuploader) - INFO - Done attempting. 14:48:05 INFO - (blobuploader) - INFO - Iteration through files over. 14:48:05 INFO - Return code: 0 14:48:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:48:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:48:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/470e688b48c8fc092df0770a96d7f7a60bd6237fe27358fa9ef3e87317ab2bbbbf82b6bd6951136f2704b234011d38007e6f796ea9f5c64048224c9deafc60c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d3d91670bc2c2ae1571a1de55e022155c12616939dfe38f2fbca60502c26edaa1796bf4db9e16d39ff14239670d8844bac3218660f7181e1d94e8c540a05ec20", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/480c7d9f03cf56c402e2ec2bed9925464a5c327aa0a36329c6dafc52cae28f261fdf0a4c50e865bbbfbb8d321c5b65cf43ae86d81bd151bea7114238da4fbc74", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a65ae9e9c483fe7a86e134334ea59ba6566fcb1d2db11b2184a447ed4e530a1891ef10bd2aca06502ed34a1f06ca131ab3c60606778555fb275c5ac51c83ab8"} 14:48:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:48:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:48:05 INFO - Contents: 14:48:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/470e688b48c8fc092df0770a96d7f7a60bd6237fe27358fa9ef3e87317ab2bbbbf82b6bd6951136f2704b234011d38007e6f796ea9f5c64048224c9deafc60c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d3d91670bc2c2ae1571a1de55e022155c12616939dfe38f2fbca60502c26edaa1796bf4db9e16d39ff14239670d8844bac3218660f7181e1d94e8c540a05ec20", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/480c7d9f03cf56c402e2ec2bed9925464a5c327aa0a36329c6dafc52cae28f261fdf0a4c50e865bbbfbb8d321c5b65cf43ae86d81bd151bea7114238da4fbc74", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a65ae9e9c483fe7a86e134334ea59ba6566fcb1d2db11b2184a447ed4e530a1891ef10bd2aca06502ed34a1f06ca131ab3c60606778555fb275c5ac51c83ab8"} 14:48:05 INFO - Running post-run listener: copy_logs_to_upload_dir 14:48:05 INFO - Copying logs to upload dir... 14:48:05 INFO - mkdir: /builds/slave/test/build/upload/logs 14:48:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.960797 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-08-18 14:48:05.643722) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-18 14:48:05.647733) ========= 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=923d835db2ba3686ebe126b700000192-1503091635.205831-160446131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/470e688b48c8fc092df0770a96d7f7a60bd6237fe27358fa9ef3e87317ab2bbbbf82b6bd6951136f2704b234011d38007e6f796ea9f5c64048224c9deafc60c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d3d91670bc2c2ae1571a1de55e022155c12616939dfe38f2fbca60502c26edaa1796bf4db9e16d39ff14239670d8844bac3218660f7181e1d94e8c540a05ec20", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/480c7d9f03cf56c402e2ec2bed9925464a5c327aa0a36329c6dafc52cae28f261fdf0a4c50e865bbbfbb8d321c5b65cf43ae86d81bd151bea7114238da4fbc74", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a65ae9e9c483fe7a86e134334ea59ba6566fcb1d2db11b2184a447ed4e530a1891ef10bd2aca06502ed34a1f06ca131ab3c60606778555fb275c5ac51c83ab8"} build_url:https://queue.taskcluster.net/v1/task/armNvNolSCK4aKko4g5vMw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011222 build_url: 'https://queue.taskcluster.net/v1/task/armNvNolSCK4aKko4g5vMw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/470e688b48c8fc092df0770a96d7f7a60bd6237fe27358fa9ef3e87317ab2bbbbf82b6bd6951136f2704b234011d38007e6f796ea9f5c64048224c9deafc60c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d3d91670bc2c2ae1571a1de55e022155c12616939dfe38f2fbca60502c26edaa1796bf4db9e16d39ff14239670d8844bac3218660f7181e1d94e8c540a05ec20", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/480c7d9f03cf56c402e2ec2bed9925464a5c327aa0a36329c6dafc52cae28f261fdf0a4c50e865bbbfbb8d321c5b65cf43ae86d81bd151bea7114238da4fbc74", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a65ae9e9c483fe7a86e134334ea59ba6566fcb1d2db11b2184a447ed4e530a1891ef10bd2aca06502ed34a1f06ca131ab3c60606778555fb275c5ac51c83ab8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-18 14:48:05.675674) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 14:48:05.676020) ========= 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=923d835db2ba3686ebe126b700000192-1503091635.205831-160446131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 14:48:05.762058) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-18 14:48:05.762562) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-18 14:48:05.763067) ========= ========= Total master_lag: 0.18 =========