builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-010 starttime: 1504607364.43 results: success (0) revision: 35bd47b6e5aca6e89ad17b48cc2f41e56db0ee81 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-05 03:29:24.425875) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-05 03:29:24.426337) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-05 03:29:24.426626) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-05 03:29:24.444123) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-05 03:29:24.444451) ========= 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=eca2ab57546de7b41f256b19000001ef-1504600297.951283-1085524231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-05 03:29:24-- 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% 41.7M=0s 2017-09-05 03:29:24 (41.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125645 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-05 03:29:24.606046) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-05 03:29:24.606377) ========= 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=eca2ab57546de7b41f256b19000001ef-1504600297.951283-1085524231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015054 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-05 03:29:24.659029) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-09-05 03:29:24.662382) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 35bd47b6e5aca6e89ad17b48cc2f41e56db0ee81 --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 35bd47b6e5aca6e89ad17b48cc2f41e56db0ee81 --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=eca2ab57546de7b41f256b19000001ef-1504600297.951283-1085524231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-05 03:29:24,980 truncating revision to first 12 chars 2017-09-05 03:29:24,980 Setting DEBUG logging. 2017-09-05 03:29:24,980 attempt 1/10 2017-09-05 03:29:24,980 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/35bd47b6e5ac?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-05 03:29:26,990 unpacking tar archive at: mozilla-central-35bd47b6e5ac/testing/mozharness/ program finished with exit code 0 elapsedTime=2.346450 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-09-05 03:29:27.028321) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-05 03:29:27.028660) ========= script_repo_revision: 35bd47b6e5aca6e89ad17b48cc2f41e56db0ee81 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-05 03:29:27.029030) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-05 03:29:27.029324) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-05 03:29:27.053949) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-09-05 03:29:27.054293) ========= /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=eca2ab57546de7b41f256b19000001ef-1504600297.951283-1085524231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:29:27 INFO - MultiFileLogger online at 20170905 03:29:27 in /builds/slave/test 03:29:27 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 03:29:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:29:27 INFO - {'append_to_log': False, 03:29:27 INFO - 'base_work_dir': '/builds/slave/test', 03:29:27 INFO - 'blob_upload_branch': 'Firefox', 03:29:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:29:27 INFO - 'branch': 'Firefox', 03:29:27 INFO - 'buildbot_json_path': 'buildprops.json', 03:29:27 INFO - 'code_coverage': False, 03:29:27 INFO - 'config_files': ('talos/linux_config.py',), 03:29:27 INFO - 'default_actions': ('clobber', 03:29:27 INFO - 'read-buildbot-config', 03:29:27 INFO - 'download-and-extract', 03:29:27 INFO - 'populate-webroot', 03:29:27 INFO - 'create-virtualenv', 03:29:27 INFO - 'install', 03:29:27 INFO - 'setup-mitmproxy', 03:29:27 INFO - 'run-tests'), 03:29:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:29:27 INFO - 'disable_ccov_upload': False, 03:29:27 INFO - 'disable_stylo': False, 03:29:27 INFO - 'download_minidump_stackwalk': True, 03:29:27 INFO - 'download_symbols': 'ondemand', 03:29:27 INFO - 'enable_stylo': False, 03:29:27 INFO - 'enable_webrender': False, 03:29:27 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:29:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:29:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:29:27 INFO - 'gecko_profile': False, 03:29:27 INFO - 'gecko_profile_interval': 0, 03:29:27 INFO - 'installer_path': 'installer.exe', 03:29:27 INFO - 'log_level': 'info', 03:29:27 INFO - 'log_name': 'talos', 03:29:27 INFO - 'log_to_console': True, 03:29:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:29:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:29:27 INFO - 'opt_config_files': (), 03:29:27 INFO - 'pip_index': False, 03:29:27 INFO - 'suite': 'dromaeojs-e10s', 03:29:27 INFO - 'system_bits': '32', 03:29:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:29:27 INFO - 'title': 'talos-linux64-ix-010', 03:29:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:29:27 INFO - 'use_talos_json': True, 03:29:27 INFO - 'verify': 'False', 03:29:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:29:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:29:27 INFO - 'work_dir': 'build'} 03:29:27 INFO - [mozharness: 2017-09-05 10:29:27.518295Z] Running clobber step. 03:29:27 INFO - Running pre-action listener: _resource_record_pre_action 03:29:27 INFO - Running main action method: clobber 03:29:27 INFO - rmtree: /builds/slave/test/build 03:29:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:29:28 INFO - Running post-action listener: _resource_record_post_action 03:29:28 INFO - [mozharness: 2017-09-05 10:29:28.532341Z] Finished clobber step (success) 03:29:28 INFO - [mozharness: 2017-09-05 10:29:28.532438Z] Running read-buildbot-config step. 03:29:28 INFO - Running pre-action listener: _resource_record_pre_action 03:29:28 INFO - Running main action method: read_buildbot_config 03:29:28 INFO - Using buildbot properties: 03:29:28 INFO - { 03:29:28 INFO - "project": "", 03:29:28 INFO - "product": "firefox", 03:29:28 INFO - "who": "archaeopteryx@coole-files.de", 03:29:28 INFO - "installer_path": "public/build/target.tar.bz2", 03:29:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 03:29:28 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:29:28 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 03:29:28 INFO - "stage_platform": "linux64-stylosequential", 03:29:28 INFO - "basedir": "/builds/slave/test", 03:29:28 INFO - "buildnumber": 187, 03:29:28 INFO - "platform": "ubuntu64_hw_styloseq", 03:29:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:29:28 INFO - "slavebuilddir": "test", 03:29:28 INFO - "taskId": "MgYUoeC3Q_mu__O9RGbeuQ", 03:29:28 INFO - "branch": "mozilla-central", 03:29:28 INFO - "script_repo_revision": "production", 03:29:28 INFO - "revision": "35bd47b6e5aca6e89ad17b48cc2f41e56db0ee81", 03:29:28 INFO - "slavename": "talos-linux64-ix-010", 03:29:28 INFO - "repo_path": "mozilla-central" 03:29:28 INFO - } 03:29:28 INFO - Finding installer, test and symbols from parent task. 03:29:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MgYUoeC3Q_mu__O9RGbeuQ'}, attempt #1 03:29:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MgYUoeC3Q_mu__O9RGbeuQ'}, attempt #1 03:29:29 INFO - Task dependencies: ERERdZfKQmW_skdNq1NZbA 03:29:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ERERdZfKQmW_skdNq1NZbA'}, attempt #1 03:29:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ERERdZfKQmW_skdNq1NZbA/artifacts/public/build/target.tar.bz2 03:29:30 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/ERERdZfKQmW_skdNq1NZbA/artifacts/public/build/target.test_packages.json 03:29:30 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ERERdZfKQmW_skdNq1NZbA/artifacts/public/build/target.crashreporter-symbols.zip 03:29:30 INFO - Running post-action listener: _resource_record_post_action 03:29:30 INFO - [mozharness: 2017-09-05 10:29:30.086341Z] Finished read-buildbot-config step (success) 03:29:30 INFO - [mozharness: 2017-09-05 10:29:30.086539Z] Running download-and-extract step. 03:29:30 INFO - Running pre-action listener: _resource_record_pre_action 03:29:30 INFO - Running main action method: download_and_extract 03:29:30 INFO - mkdir: /builds/slave/test/build/tests 03:29:30 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')]} 03:29:30 INFO - trying https://queue.taskcluster.net/v1/task/ERERdZfKQmW_skdNq1NZbA/artifacts/public/build/target.test_packages.json 03:29:30 INFO - Downloading https://queue.taskcluster.net/v1/task/ERERdZfKQmW_skdNq1NZbA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:29:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ERERdZfKQmW_skdNq1NZbA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:29:30 INFO - Downloaded 989 bytes. 03:29:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:29:30 INFO - Using the following test package requirements: 03:29:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:29:30 INFO - u'common': [u'target.common.tests.zip'], 03:29:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:29:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:29:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:29:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:29:30 INFO - u'mozbase': [u'target.common.tests.zip'], 03:29:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:29:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:29:30 INFO - u'web-platform': [u'target.common.tests.zip', 03:29:30 INFO - u'target.web-platform.tests.tar.gz'], 03:29:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:29:30 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:29:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ERERdZfKQmW_skdNq1NZbA/artifacts/public/build/target.common.tests.zip 03:29:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ERERdZfKQmW_skdNq1NZbA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:29:30 INFO - Fetch https://queue.taskcluster.net/v1/task/ERERdZfKQmW_skdNq1NZbA/artifacts/public/build/target.common.tests.zip into memory 03:29:31 INFO - Content-Length response header: 55021571 03:29:31 INFO - Bytes received: 55021571 03:29:42 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:29:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ERERdZfKQmW_skdNq1NZbA/artifacts/public/build/target.common.tests.zip 03:29:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ERERdZfKQmW_skdNq1NZbA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:29:42 INFO - Fetch https://queue.taskcluster.net/v1/task/ERERdZfKQmW_skdNq1NZbA/artifacts/public/build/target.common.tests.zip into memory 03:29:43 INFO - Content-Length response header: 55021571 03:29:43 INFO - Bytes received: 55021571 03:29:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ERERdZfKQmW_skdNq1NZbA/artifacts/public/build/target.talos.tests.zip 03:29:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ERERdZfKQmW_skdNq1NZbA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:29:55 INFO - Fetch https://queue.taskcluster.net/v1/task/ERERdZfKQmW_skdNq1NZbA/artifacts/public/build/target.talos.tests.zip into memory 03:29:56 INFO - Content-Length response header: 14496650 03:29:56 INFO - Bytes received: 14496650 03:29: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')]} 03:29:56 INFO - trying https://queue.taskcluster.net/v1/task/ERERdZfKQmW_skdNq1NZbA/artifacts/public/build/target.tar.bz2 03:29:56 INFO - Downloading https://queue.taskcluster.net/v1/task/ERERdZfKQmW_skdNq1NZbA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:29:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ERERdZfKQmW_skdNq1NZbA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:29:58 INFO - Downloaded 62733094 bytes. 03:29:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ERERdZfKQmW_skdNq1NZbA/artifacts/public/build/target.tar.bz2 03:29:58 INFO - mkdir: /builds/slave/test/properties 03:29:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:29:58 INFO - Writing to file /builds/slave/test/properties/build_url 03:29:58 INFO - Contents: 03:29:58 INFO - build_url:https://queue.taskcluster.net/v1/task/ERERdZfKQmW_skdNq1NZbA/artifacts/public/build/target.tar.bz2 03:29:58 INFO - Running post-action listener: _resource_record_post_action 03:29:58 INFO - Running post-action listener: find_tests_for_verification 03:29:58 INFO - Running post-action listener: set_extra_try_arguments 03:29:58 INFO - [mozharness: 2017-09-05 10:29:58.056100Z] Finished download-and-extract step (success) 03:29:58 INFO - [mozharness: 2017-09-05 10:29:58.056195Z] Running populate-webroot step. 03:29:58 INFO - Running pre-action listener: _resource_record_pre_action 03:29:58 INFO - Running main action method: populate_webroot 03:29:58 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:29:58 INFO - 'chromez-stylo-e10s': {'talos_options': ['--enable-stylo'], 03:29:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:29:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:29:58 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--enable-stylo'], 03:29:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:29:58 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:29:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:29:58 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 03:29:58 INFO - 'talos_options': ['--enable-stylo'], 03:29:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:29:58 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:29:58 INFO - 'tests': ['damp', 'tps']}, 03:29:58 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 03:29:58 INFO - 'talos_options': ['--enable-stylo'], 03:29:58 INFO - 'tests': ['damp', 'tps']}, 03:29:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:29:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:29:58 INFO - 'g4-stylo-e10s': {'talos_options': ['--enable-stylo'], 03:29:58 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 03:29:58 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:29:58 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:29:58 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 03:29:58 INFO - 'talos_options': ['--enable-stylo'], 03:29:58 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:29:58 INFO - 'other-e10s': {'tests': ['a11yr', 03:29:58 INFO - 'ts_paint', 03:29:58 INFO - 'tpaint', 03:29:58 INFO - 'sessionrestore', 03:29:58 INFO - 'sessionrestore_many_windows', 03:29:58 INFO - 'sessionrestore_no_auto_restore', 03:29:58 INFO - 'tabpaint']}, 03:29:58 INFO - 'other-stylo-e10s': {'talos_options': ['--enable-stylo'], 03:29:58 INFO - 'tests': ['a11yr', 03:29:58 INFO - 'ts_paint', 03:29:58 INFO - 'tpaint', 03:29:58 INFO - 'sessionrestore', 03:29:58 INFO - 'sessionrestore_many_windows', 03:29:58 INFO - 'sessionrestore_no_auto_restore', 03:29:58 INFO - 'tabpaint']}, 03:29:58 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:29:58 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:29:58 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--enable-stylo'], 03:29:58 INFO - 'tests': ['bloom_basic_singleton']}, 03:29:58 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--enable-stylo'], 03:29:58 INFO - 'tests': ['bloom_basic']}, 03:29:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:29:58 INFO - 'tsvgr_opacity', 03:29:58 INFO - 'tart', 03:29:58 INFO - 'tscrollx', 03:29:58 INFO - 'tsvg_static']}, 03:29:58 INFO - 'svgr-stylo-e10s': {'talos_options': ['--enable-stylo'], 03:29:58 INFO - 'tests': ['tsvgx', 03:29:58 INFO - 'tsvgr_opacity', 03:29:58 INFO - 'tart', 03:29:58 INFO - 'tscrollx', 03:29:58 INFO - 'tsvg_static']}, 03:29:58 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:29:58 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 03:29:58 INFO - 'talos_options': ['--enable-stylo'], 03:29:58 INFO - 'tests': ['tp5o']}, 03:29:58 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:29:58 INFO - 'talos_options': ['--mitmproxy', 03:29:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:29:58 INFO - '--firstNonBlankPaint'], 03:29:58 INFO - 'tests': ['tp6_google', 03:29:58 INFO - 'tp6_youtube', 03:29:58 INFO - 'tp6_amazon', 03:29:58 INFO - 'tp6_facebook']}, 03:29:58 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:29:58 INFO - 'talos_options': ['--enable-stylo', 03:29:58 INFO - '--mitmproxy', 03:29:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:29:58 INFO - '--firstNonBlankPaint'], 03:29:58 INFO - 'tests': ['tp6_google', 03:29:58 INFO - 'tp6_youtube', 03:29:58 INFO - 'tp6_amazon', 03:29:58 INFO - 'tp6_facebook']}, 03:29:58 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:29:58 INFO - 'talos_options': ['--enable-stylo', 03:29:58 INFO - '--stylo-threads=1', 03:29:58 INFO - '--mitmproxy', 03:29:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:29:58 INFO - '--firstNonBlankPaint'], 03:29:58 INFO - 'tests': ['tp6_google', 03:29:58 INFO - 'tp6_youtube', 03:29:58 INFO - 'tp6_amazon', 03:29:58 INFO - 'tp6_facebook']}, 03:29:58 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:29:58 INFO - 'talos_options': ['--xperf_path', 03:29:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:29:58 INFO - 'tests': ['tp5n']}, 03:29:58 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 03:29:58 INFO - 'talos_options': ['--enable-stylo', 03:29:58 INFO - '--xperf_path', 03:29:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:29:58 INFO - 'tests': ['tp5n']}}} 03:29:58 INFO - Running post-action listener: _resource_record_post_action 03:29:58 INFO - [mozharness: 2017-09-05 10:29:58.070466Z] Finished populate-webroot step (success) 03:29:58 INFO - [mozharness: 2017-09-05 10:29:58.070555Z] Running create-virtualenv step. 03:29:58 INFO - Running pre-action listener: _resource_record_pre_action 03:29:58 INFO - Running main action method: create_virtualenv 03:29:58 INFO - Creating virtualenv /builds/slave/test/build/venv 03:29:58 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:29:58 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:29:58 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:29:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:29:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:29:58 INFO - Installing distribute.............................................................................................................................................................................................done. 03:29:58 INFO - Installing pip...............done. 03:29:58 INFO - Return code: 0 03:29:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:29:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:29:59 INFO - Reading from file tmpfile_stdout 03:29:59 INFO - Output received: 03:29:59 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:29:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:29: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')]} 03:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29: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')]} 03:29:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:59 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 0x28551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5090>, '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 0x2bc5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bbff90>, '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': 'eca2ab57546de7b41f256b19000001ef-1504600297.951283-1085524231', '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 03:29:59 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 03:29:59 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 03:29:59 INFO - Using env: {'DISPLAY': ':0', 03:29:59 INFO - 'HOME': '/home/cltbld', 03:29:59 INFO - 'LANG': 'en_US.UTF-8', 03:29:59 INFO - 'LANGUAGE': 'en_US:en', 03:29:59 INFO - 'LOGNAME': 'cltbld', 03:29:59 INFO - 'MAIL': '/var/mail/cltbld', 03:29:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:59 INFO - 'MOZ_NO_REMOTE': '1', 03:29:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:59 INFO - 'NO_EM_RESTART': '1', 03:29:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:59 INFO - 'PWD': '/builds/slave/test', 03:29:59 INFO - 'SHELL': '/bin/bash', 03:29:59 INFO - 'SHLVL': '1', 03:29:59 INFO - 'TERM': 'linux', 03:29:59 INFO - 'TMOUT': '86400', 03:29:59 INFO - 'USER': 'cltbld', 03:29:59 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1504600297.951283-1085524231', 03:29:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:59 INFO - '_': '/tools/buildbot/bin/python'} 03:30:00 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:30:00 INFO - Downloading/unpacking pip>=1.5 03:30:00 INFO - Running setup.py egg_info for package pip 03:30:00 INFO - warning: no files found matching 'pip/cacert.pem' 03:30:00 INFO - warning: no files found matching '*.html' under directory 'docs' 03:30:00 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:30:00 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:30:00 INFO - Installing collected packages: pip 03:30:00 INFO - Found existing installation: pip 1.1 03:30:00 INFO - Uninstalling pip: 03:30:00 INFO - Successfully uninstalled pip 03:30:00 INFO - Running setup.py install for pip 03:30:00 INFO - warning: no files found matching 'pip/cacert.pem' 03:30:00 INFO - warning: no files found matching '*.html' under directory 'docs' 03:30:00 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:30:00 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:30:00 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:30:00 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:30:00 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:30:00 INFO - Successfully installed pip 03:30:00 INFO - Cleaning up... 03:30:00 INFO - Return code: 0 03:30:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:30:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:00 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 0x28551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5090>, '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 0x2bc5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bbff90>, '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': 'eca2ab57546de7b41f256b19000001ef-1504600297.951283-1085524231', '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 03:30:00 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 03:30:00 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 03:30:00 INFO - Using env: {'DISPLAY': ':0', 03:30:00 INFO - 'HOME': '/home/cltbld', 03:30:00 INFO - 'LANG': 'en_US.UTF-8', 03:30:00 INFO - 'LANGUAGE': 'en_US:en', 03:30:00 INFO - 'LOGNAME': 'cltbld', 03:30:00 INFO - 'MAIL': '/var/mail/cltbld', 03:30:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:00 INFO - 'MOZ_NO_REMOTE': '1', 03:30:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:00 INFO - 'NO_EM_RESTART': '1', 03:30:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:00 INFO - 'PWD': '/builds/slave/test', 03:30:00 INFO - 'SHELL': '/bin/bash', 03:30:00 INFO - 'SHLVL': '1', 03:30:00 INFO - 'TERM': 'linux', 03:30:00 INFO - 'TMOUT': '86400', 03:30:00 INFO - 'USER': 'cltbld', 03:30:00 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1504600297.951283-1085524231', 03:30:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:00 INFO - '_': '/tools/buildbot/bin/python'} 03:30:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:00 INFO - Downloading/unpacking psutil>=3.1.1 03:30:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:30:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:30:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:30:01 INFO - Installing collected packages: psutil 03:30:01 INFO - Running setup.py install for psutil 03:30:01 INFO - building 'psutil._psutil_linux' extension 03:30:01 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 03:30:01 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 03:30:01 INFO - building 'psutil._psutil_posix' extension 03:30:01 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 03:30:02 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 03:30:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:30:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:30:02 INFO - Successfully installed psutil 03:30:02 INFO - Cleaning up... 03:30:02 INFO - Return code: 0 03:30:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30: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')]} 03:30:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5090>, '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 0x2bc5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bbff90>, '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': 'eca2ab57546de7b41f256b19000001ef-1504600297.951283-1085524231', '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 03:30:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:30:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:30:02 INFO - Using env: {'DISPLAY': ':0', 03:30:02 INFO - 'HOME': '/home/cltbld', 03:30:02 INFO - 'LANG': 'en_US.UTF-8', 03:30:02 INFO - 'LANGUAGE': 'en_US:en', 03:30:02 INFO - 'LOGNAME': 'cltbld', 03:30:02 INFO - 'MAIL': '/var/mail/cltbld', 03:30:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:02 INFO - 'MOZ_NO_REMOTE': '1', 03:30:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:02 INFO - 'NO_EM_RESTART': '1', 03:30:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:02 INFO - 'PWD': '/builds/slave/test', 03:30:02 INFO - 'SHELL': '/bin/bash', 03:30:02 INFO - 'SHLVL': '1', 03:30:02 INFO - 'TERM': 'linux', 03:30:02 INFO - 'TMOUT': '86400', 03:30:02 INFO - 'USER': 'cltbld', 03:30:02 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1504600297.951283-1085524231', 03:30:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:02 INFO - '_': '/tools/buildbot/bin/python'} 03:30:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:30:02 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 03:30:02 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 03:30:02 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 03:30:02 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 03:30:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:30:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:30:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:30:03 INFO - Installing collected packages: mozsystemmonitor 03:30:03 INFO - Running setup.py install for mozsystemmonitor 03:30:03 INFO - Successfully installed mozsystemmonitor 03:30:03 INFO - Cleaning up... 03:30:03 INFO - Return code: 0 03:30:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:30:03 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')]} 03:30:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:03 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')]} 03:30:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:03 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 0x28551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5090>, '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 0x2bc5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bbff90>, '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': 'eca2ab57546de7b41f256b19000001ef-1504600297.951283-1085524231', '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 03:30:03 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 03:30:03 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 03:30:03 INFO - Using env: {'DISPLAY': ':0', 03:30:03 INFO - 'HOME': '/home/cltbld', 03:30:03 INFO - 'LANG': 'en_US.UTF-8', 03:30:03 INFO - 'LANGUAGE': 'en_US:en', 03:30:03 INFO - 'LOGNAME': 'cltbld', 03:30:03 INFO - 'MAIL': '/var/mail/cltbld', 03:30:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:03 INFO - 'MOZ_NO_REMOTE': '1', 03:30:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:03 INFO - 'NO_EM_RESTART': '1', 03:30:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:03 INFO - 'PWD': '/builds/slave/test', 03:30:03 INFO - 'SHELL': '/bin/bash', 03:30:03 INFO - 'SHLVL': '1', 03:30:03 INFO - 'TERM': 'linux', 03:30:03 INFO - 'TMOUT': '86400', 03:30:03 INFO - 'USER': 'cltbld', 03:30:03 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1504600297.951283-1085524231', 03:30:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:03 INFO - '_': '/tools/buildbot/bin/python'} 03:30:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:03 INFO - Downloading/unpacking jsonschema==2.5.1 03:30:03 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 03:30:03 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 03:30:03 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 03:30:03 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 03:30:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:30:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:30:05 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 03:30:05 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 03:30:05 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 03:30:05 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 03:30:05 INFO - Downloading functools32-3.2.3-2.tar.gz 03:30:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:30:05 INFO - warning: no files found matching '*.txt' 03:30:05 INFO - no previously-included directories found matching 'build' 03:30:05 INFO - no previously-included directories found matching 'dist' 03:30:05 INFO - no previously-included directories found matching '.git*' 03:30:05 INFO - Installing collected packages: jsonschema, functools32 03:30:05 INFO - Running setup.py install for functools32 03:30:05 INFO - warning: no files found matching '*.txt' 03:30:05 INFO - no previously-included directories found matching 'build' 03:30:05 INFO - no previously-included directories found matching 'dist' 03:30:05 INFO - no previously-included directories found matching '.git*' 03:30:05 INFO - Successfully installed jsonschema functools32 03:30:05 INFO - Cleaning up... 03:30:05 INFO - Return code: 0 03:30:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30: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')]} 03:30:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:05 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 0x28551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5090>, '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 0x2bc5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bbff90>, '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': 'eca2ab57546de7b41f256b19000001ef-1504600297.951283-1085524231', '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 03:30:05 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 03:30:05 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 03:30:05 INFO - Using env: {'DISPLAY': ':0', 03:30:05 INFO - 'HOME': '/home/cltbld', 03:30:05 INFO - 'LANG': 'en_US.UTF-8', 03:30:05 INFO - 'LANGUAGE': 'en_US:en', 03:30:05 INFO - 'LOGNAME': 'cltbld', 03:30:05 INFO - 'MAIL': '/var/mail/cltbld', 03:30:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:05 INFO - 'MOZ_NO_REMOTE': '1', 03:30:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:05 INFO - 'NO_EM_RESTART': '1', 03:30:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:05 INFO - 'PWD': '/builds/slave/test', 03:30:05 INFO - 'SHELL': '/bin/bash', 03:30:05 INFO - 'SHLVL': '1', 03:30:05 INFO - 'TERM': 'linux', 03:30:05 INFO - 'TMOUT': '86400', 03:30:05 INFO - 'USER': 'cltbld', 03:30:05 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1504600297.951283-1085524231', 03:30:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:05 INFO - '_': '/tools/buildbot/bin/python'} 03:30:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:30:05 INFO - Cleaning up... 03:30:05 INFO - Return code: 0 03:30:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30: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')]} 03:30:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:05 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 0x28551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5090>, '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 0x2bc5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bbff90>, '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': 'eca2ab57546de7b41f256b19000001ef-1504600297.951283-1085524231', '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 03:30:05 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 03:30:05 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 03:30:05 INFO - Using env: {'DISPLAY': ':0', 03:30:05 INFO - 'HOME': '/home/cltbld', 03:30:05 INFO - 'LANG': 'en_US.UTF-8', 03:30:05 INFO - 'LANGUAGE': 'en_US:en', 03:30:05 INFO - 'LOGNAME': 'cltbld', 03:30:05 INFO - 'MAIL': '/var/mail/cltbld', 03:30:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:05 INFO - 'MOZ_NO_REMOTE': '1', 03:30:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:05 INFO - 'NO_EM_RESTART': '1', 03:30:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:05 INFO - 'PWD': '/builds/slave/test', 03:30:05 INFO - 'SHELL': '/bin/bash', 03:30:05 INFO - 'SHLVL': '1', 03:30:05 INFO - 'TERM': 'linux', 03:30:05 INFO - 'TMOUT': '86400', 03:30:05 INFO - 'USER': 'cltbld', 03:30:05 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1504600297.951283-1085524231', 03:30:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:05 INFO - '_': '/tools/buildbot/bin/python'} 03:30:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:05 INFO - Downloading/unpacking blobuploader==1.2.4 03:30:05 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 03:30:05 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 03:30:05 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 03:30:05 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 03:30:06 INFO - Downloading blobuploader-1.2.4.tar.gz 03:30:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:30:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:30:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:07 INFO - Downloading docopt-0.6.1.tar.gz 03:30:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:30:07 INFO - Installing collected packages: blobuploader, requests, docopt 03:30:07 INFO - Running setup.py install for blobuploader 03:30:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:30:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:30:07 INFO - Running setup.py install for requests 03:30:08 INFO - Running setup.py install for docopt 03:30:08 INFO - Successfully installed blobuploader requests docopt 03:30:08 INFO - Cleaning up... 03:30:08 INFO - Return code: 0 03:30:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30: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')]} 03:30:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:08 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 0x28551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5090>, '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 0x2bc5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bbff90>, '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': 'eca2ab57546de7b41f256b19000001ef-1504600297.951283-1085524231', '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 03:30:08 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 03:30:08 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 03:30:08 INFO - Using env: {'DISPLAY': ':0', 03:30:08 INFO - 'HOME': '/home/cltbld', 03:30:08 INFO - 'LANG': 'en_US.UTF-8', 03:30:08 INFO - 'LANGUAGE': 'en_US:en', 03:30:08 INFO - 'LOGNAME': 'cltbld', 03:30:08 INFO - 'MAIL': '/var/mail/cltbld', 03:30:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:08 INFO - 'MOZ_NO_REMOTE': '1', 03:30:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:08 INFO - 'NO_EM_RESTART': '1', 03:30:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:08 INFO - 'PWD': '/builds/slave/test', 03:30:08 INFO - 'SHELL': '/bin/bash', 03:30:08 INFO - 'SHLVL': '1', 03:30:08 INFO - 'TERM': 'linux', 03:30:08 INFO - 'TMOUT': '86400', 03:30:08 INFO - 'USER': 'cltbld', 03:30:08 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1504600297.951283-1085524231', 03:30:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:08 INFO - '_': '/tools/buildbot/bin/python'} 03:30:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:30:08 INFO - Running setup.py (path:/tmp/pip-xJ7qey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:30:08 INFO - Running setup.py (path:/tmp/pip-1QRn06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:30:08 INFO - Running setup.py (path:/tmp/pip-3J6ntd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:30:08 INFO - Running setup.py (path:/tmp/pip-8rKxCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:30:08 INFO - Running setup.py (path:/tmp/pip-yyIrj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:30:08 INFO - Running setup.py (path:/tmp/pip-tub8YU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:30:08 INFO - Running setup.py (path:/tmp/pip-kouAbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:30:08 INFO - Running setup.py (path:/tmp/pip-MLI1SZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:30:08 INFO - Running setup.py (path:/tmp/pip-JVjpCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:30:08 INFO - Running setup.py (path:/tmp/pip-P5vnow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:30:09 INFO - Running setup.py (path:/tmp/pip-ujOwAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:30:09 INFO - Running setup.py (path:/tmp/pip-ppsZkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:30:09 INFO - Running setup.py (path:/tmp/pip-bmt_X9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:30:09 INFO - Running setup.py (path:/tmp/pip-LjkC4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:09 INFO - Running setup.py (path:/tmp/pip-kvoFxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:30:09 INFO - Running setup.py (path:/tmp/pip-3olUJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:30:09 INFO - Running setup.py (path:/tmp/pip-QB9KhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:30:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:30:09 INFO - Running setup.py install for manifestparser 03:30:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:30:09 INFO - Running setup.py install for mozcrash 03:30:09 INFO - Running setup.py install for mozdebug 03:30:09 INFO - Running setup.py install for mozdevice 03:30:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:30:09 INFO - Running setup.py install for mozfile 03:30:10 INFO - Running setup.py install for mozhttpd 03:30:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:30:10 INFO - Running setup.py install for mozinfo 03:30:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:30:10 INFO - Running setup.py install for mozInstall 03:30:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:30:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:30:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:30:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:30:10 INFO - Running setup.py install for mozleak 03:30:10 INFO - Running setup.py install for mozlog 03:30:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:30:10 INFO - Running setup.py install for moznetwork 03:30:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:30:10 INFO - Running setup.py install for mozprocess 03:30:10 INFO - Running setup.py install for mozprofile 03:30:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:30:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:30:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:30:10 INFO - Running setup.py install for mozrunner 03:30:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:30:11 INFO - Running setup.py install for mozscreenshot 03:30:11 INFO - Running setup.py install for moztest 03:30:11 INFO - Running setup.py install for mozversion 03:30:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:30:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:30:11 INFO - Cleaning up... 03:30:11 INFO - Return code: 0 03:30:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:30:11 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')]} 03:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:11 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')]} 03:30:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:11 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 0x28551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5090>, '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 0x2bc5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bbff90>, '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': 'eca2ab57546de7b41f256b19000001ef-1504600297.951283-1085524231', '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 03:30:11 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 03:30:11 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 03:30:11 INFO - Using env: {'DISPLAY': ':0', 03:30:11 INFO - 'HOME': '/home/cltbld', 03:30:11 INFO - 'LANG': 'en_US.UTF-8', 03:30:11 INFO - 'LANGUAGE': 'en_US:en', 03:30:11 INFO - 'LOGNAME': 'cltbld', 03:30:11 INFO - 'MAIL': '/var/mail/cltbld', 03:30:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:11 INFO - 'MOZ_NO_REMOTE': '1', 03:30:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:11 INFO - 'NO_EM_RESTART': '1', 03:30:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:11 INFO - 'PWD': '/builds/slave/test', 03:30:11 INFO - 'SHELL': '/bin/bash', 03:30:11 INFO - 'SHLVL': '1', 03:30:11 INFO - 'TERM': 'linux', 03:30:11 INFO - 'TMOUT': '86400', 03:30:11 INFO - 'USER': 'cltbld', 03:30:11 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1504600297.951283-1085524231', 03:30:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:11 INFO - '_': '/tools/buildbot/bin/python'} 03:30:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:30:11 INFO - Running setup.py (path:/tmp/pip-Do3wN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:30:11 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)) 03:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:30:11 INFO - Running setup.py (path:/tmp/pip-2VKfwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:30:11 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)) 03:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:30:11 INFO - Running setup.py (path:/tmp/pip-6nHqgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:30:11 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)) 03:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:30:11 INFO - Running setup.py (path:/tmp/pip-RjfuTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:30:11 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)) 03:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:30:11 INFO - Running setup.py (path:/tmp/pip-kb3Nse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:30:11 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)) 03:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:30:11 INFO - Running setup.py (path:/tmp/pip-nlxR5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:30:11 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)) 03:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:30:11 INFO - Running setup.py (path:/tmp/pip-yCxwKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:30:12 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)) 03:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:30:12 INFO - Running setup.py (path:/tmp/pip-nWmjPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:30:12 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)) 03:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:30:12 INFO - Running setup.py (path:/tmp/pip-YA6y1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:30:12 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)) 03:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:30:12 INFO - Running setup.py (path:/tmp/pip-TDSmWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:30:12 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)) 03:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:30:12 INFO - Running setup.py (path:/tmp/pip-mgTkS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:30:12 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)) 03:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:30:12 INFO - Running setup.py (path:/tmp/pip-AYBLp5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:30:12 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)) 03:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:30:12 INFO - Running setup.py (path:/tmp/pip-JvyOWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:30:12 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)) 03:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:30:12 INFO - Running setup.py (path:/tmp/pip-ykYOSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:30:12 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)) 03:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:12 INFO - Running setup.py (path:/tmp/pip-x_UKW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:12 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)) 03:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:30:12 INFO - Running setup.py (path:/tmp/pip-6mFBLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:30:12 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)) 03:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:30:12 INFO - Running setup.py (path:/tmp/pip-AXlW8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:30:12 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)) 03:30:12 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)) 03:30:12 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)) 03:30:12 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)) 03:30:12 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)) 03:30:12 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)) 03:30:12 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)) 03:30:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:13 INFO - Downloading blessings-1.6.tar.gz 03:30:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:30:13 INFO - Installing collected packages: blessings 03:30:13 INFO - Running setup.py install for blessings 03:30:14 INFO - Successfully installed blessings 03:30:14 INFO - Cleaning up... 03:30:14 INFO - Return code: 0 03:30:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:30:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:30:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:30:14 INFO - Reading from file tmpfile_stdout 03:30:14 INFO - Current package versions: 03:30:14 INFO - argparse == 1.2.1 03:30:14 INFO - blessings == 1.6 03:30:14 INFO - blobuploader == 1.2.4 03:30:14 INFO - docopt == 0.6.1 03:30:14 INFO - functools32 == 3.2.3-2 03:30:14 INFO - jsonschema == 2.5.1 03:30:14 INFO - manifestparser == 1.1 03:30:14 INFO - mozInstall == 1.13 03:30:14 INFO - mozcrash == 1.0 03:30:14 INFO - mozdebug == 0.1 03:30:14 INFO - mozdevice == 0.51 03:30:14 INFO - mozfile == 1.2 03:30:14 INFO - mozhttpd == 0.7 03:30:14 INFO - mozinfo == 0.10 03:30:14 INFO - mozleak == 0.1 03:30:14 INFO - mozlog == 3.5 03:30:14 INFO - moznetwork == 0.27 03:30:14 INFO - mozprocess == 0.25 03:30:14 INFO - mozprofile == 0.28 03:30:14 INFO - mozrunner == 6.13 03:30:14 INFO - mozscreenshot == 0.1 03:30:14 INFO - mozsystemmonitor == 0.3 03:30:14 INFO - moztest == 0.8 03:30:14 INFO - mozversion == 1.4 03:30:14 INFO - psutil == 3.1.1 03:30:14 INFO - requests == 1.2.3 03:30:14 INFO - wsgiref == 0.1.2 03:30:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:30:14 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')]} 03:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:14 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')]} 03:30:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:14 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 0x28551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5090>, '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 0x2bc5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bbff90>, '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': 'eca2ab57546de7b41f256b19000001ef-1504600297.951283-1085524231', '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 03:30:14 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 03:30:14 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 03:30:14 INFO - Using env: {'DISPLAY': ':0', 03:30:14 INFO - 'HOME': '/home/cltbld', 03:30:14 INFO - 'LANG': 'en_US.UTF-8', 03:30:14 INFO - 'LANGUAGE': 'en_US:en', 03:30:14 INFO - 'LOGNAME': 'cltbld', 03:30:14 INFO - 'MAIL': '/var/mail/cltbld', 03:30:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:14 INFO - 'MOZ_NO_REMOTE': '1', 03:30:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:14 INFO - 'NO_EM_RESTART': '1', 03:30:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:14 INFO - 'PWD': '/builds/slave/test', 03:30:14 INFO - 'SHELL': '/bin/bash', 03:30:14 INFO - 'SHLVL': '1', 03:30:14 INFO - 'TERM': 'linux', 03:30:14 INFO - 'TMOUT': '86400', 03:30:14 INFO - 'USER': 'cltbld', 03:30:14 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1504600297.951283-1085524231', 03:30:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:14 INFO - '_': '/tools/buildbot/bin/python'} 03:30:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:14 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)) 03:30:14 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)) 03:30:14 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)) 03:30:14 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)) 03:30:14 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)) 03:30:14 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)) 03:30:14 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)) 03:30:14 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)) 03:30:14 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)) 03:30:14 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:30:14 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 03:30:14 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 03:30:14 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 03:30:14 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 03:30:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:30:15 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)) 03:30:15 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)) 03:30:15 INFO - Installing collected packages: simplejson 03:30:15 INFO - Running setup.py install for simplejson 03:30:15 INFO - building 'simplejson._speedups' extension 03:30:15 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 03:30:16 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 03:30:16 INFO - Successfully installed simplejson 03:30:16 INFO - Cleaning up... 03:30:16 INFO - Return code: 0 03:30:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:30:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:16 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 0x28551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5090>, '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 0x2bc5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bbff90>, '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': 'eca2ab57546de7b41f256b19000001ef-1504600297.951283-1085524231', '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 03:30:16 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 03:30:16 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 03:30:16 INFO - Using env: {'DISPLAY': ':0', 03:30:16 INFO - 'HOME': '/home/cltbld', 03:30:16 INFO - 'LANG': 'en_US.UTF-8', 03:30:16 INFO - 'LANGUAGE': 'en_US:en', 03:30:16 INFO - 'LOGNAME': 'cltbld', 03:30:16 INFO - 'MAIL': '/var/mail/cltbld', 03:30:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:16 INFO - 'MOZ_NO_REMOTE': '1', 03:30:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:16 INFO - 'NO_EM_RESTART': '1', 03:30:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:16 INFO - 'PWD': '/builds/slave/test', 03:30:16 INFO - 'SHELL': '/bin/bash', 03:30:16 INFO - 'SHLVL': '1', 03:30:16 INFO - 'TERM': 'linux', 03:30:16 INFO - 'TMOUT': '86400', 03:30:16 INFO - 'USER': 'cltbld', 03:30:16 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1504600297.951283-1085524231', 03:30:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:16 INFO - '_': '/tools/buildbot/bin/python'} 03:30:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:30:16 INFO - Cleaning up... 03:30:16 INFO - Return code: 0 03:30:16 INFO - Running post-action listener: _resource_record_post_action 03:30:16 INFO - Running post-action listener: _start_resource_monitoring 03:30:17 INFO - Starting resource monitoring. 03:30:17 INFO - [mozharness: 2017-09-05 10:30:17.014663Z] Finished create-virtualenv step (success) 03:30:17 INFO - [mozharness: 2017-09-05 10:30:17.015176Z] Running install step. 03:30:17 INFO - Running pre-action listener: _resource_record_pre_action 03:30:17 INFO - Running main action method: install 03:30:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:30:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:30:17 INFO - Reading from file tmpfile_stdout 03:30:17 INFO - Detecting whether we're running mozinstall >=1.0... 03:30:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:30:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:30:17 INFO - Reading from file tmpfile_stdout 03:30:17 INFO - Output received: 03:30:17 INFO - Usage: mozinstall [options] installer 03:30:17 INFO - Options: 03:30:17 INFO - -h, --help show this help message and exit 03:30:17 INFO - -d DEST, --destination=DEST 03:30:17 INFO - Directory to install application into. [default: 03:30:17 INFO - "/builds/slave/test"] 03:30:17 INFO - --app=APP Application being installed. [default: firefox] 03:30:17 INFO - mkdir: /builds/slave/test/build/application 03:30:17 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'] 03:30:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:30:33 INFO - Reading from file tmpfile_stdout 03:30:33 INFO - Output received: 03:30:33 INFO - /builds/slave/test/build/application/firefox/firefox 03:30:33 INFO - Running post-action listener: _resource_record_post_action 03:30:33 INFO - [mozharness: 2017-09-05 10:30:33.855795Z] Finished install step (success) 03:30:33 INFO - [mozharness: 2017-09-05 10:30:33.855940Z] Running setup-mitmproxy step. 03:30:33 INFO - Running pre-action listener: _resource_record_pre_action 03:30:33 INFO - Running main action method: setup_mitmproxy 03:30:33 INFO - Skipping: mitmproxy is not required 03:30:33 INFO - Running post-action listener: _resource_record_post_action 03:30:33 INFO - [mozharness: 2017-09-05 10:30:33.856456Z] Finished setup-mitmproxy step (success) 03:30:33 INFO - [mozharness: 2017-09-05 10:30:33.856556Z] Running run-tests step. 03:30:33 INFO - Running pre-action listener: _resource_record_pre_action 03:30:33 INFO - Running pre-action listener: _set_gcov_prefix 03:30:33 INFO - Running main action method: run_tests 03:30:33 WARNING - Try message not found. 03:30:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:30:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:30:33 INFO - Python 2.7.3 03:30:33 INFO - Return code: 0 03:30:33 INFO - grabbing minidump binary from tooltool 03:30:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:33 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5090>, '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 0x2bc5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bbff90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:30:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:30:33 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:30:33 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:30:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:30:33 INFO - Return code: 0 03:30:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:30:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:30:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:30:33 INFO - ENV: RUST_BACKTRACE is now full 03:30:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:30:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:30:33 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/ERERdZfKQmW_skdNq1NZbA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 03:30:33 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/ERERdZfKQmW_skdNq1NZbA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 03:30:33 INFO - Using env: {'DISPLAY': ':0', 03:30:33 INFO - 'HOME': '/home/cltbld', 03:30:33 INFO - 'LANG': 'en_US.UTF-8', 03:30:33 INFO - 'LANGUAGE': 'en_US:en', 03:30:33 INFO - 'LOGNAME': 'cltbld', 03:30:33 INFO - 'MAIL': '/var/mail/cltbld', 03:30:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:30:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:30:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:33 INFO - 'MOZ_NO_REMOTE': '1', 03:30:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:30:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:33 INFO - 'NO_EM_RESTART': '1', 03:30:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:33 INFO - 'PWD': '/builds/slave/test', 03:30:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:30:33 INFO - 'RUST_BACKTRACE': 'full', 03:30:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:30:33 INFO - 'SHELL': '/bin/bash', 03:30:33 INFO - 'SHLVL': '1', 03:30:33 INFO - 'STYLO_FORCE_ENABLED': '1', 03:30:33 INFO - 'STYLO_THREADS': '1', 03:30:33 INFO - 'TERM': 'linux', 03:30:33 INFO - 'TMOUT': '86400', 03:30:33 INFO - 'USER': 'cltbld', 03:30:33 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1504600297.951283-1085524231', 03:30:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:33 INFO - '_': '/tools/buildbot/bin/python'} 03:30:33 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/ERERdZfKQmW_skdNq1NZbA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 03:30:34 INFO - mozversion application_buildid: 20170905093911 03:30:34 INFO - mozversion application_changeset: 35bd47b6e5aca6e89ad17b48cc2f41e56db0ee81 03:30:34 INFO - mozversion application_display_name: Nightly 03:30:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:30:34 INFO - mozversion application_name: Firefox 03:30:34 INFO - mozversion application_remotingname: firefox 03:30:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:30:34 INFO - mozversion application_vendor: Mozilla 03:30:34 INFO - mozversion application_version: 57.0a1 03:30:34 INFO - mozversion platform_buildid: 20170905093911 03:30:34 INFO - mozversion platform_changeset: 35bd47b6e5aca6e89ad17b48cc2f41e56db0ee81 03:30:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:30:34 INFO - mozversion platform_version: 57.0a1 03:30:34 INFO - using testdate: 1504607434 03:30:34 INFO - actual date: 1504607434 03:30:34 INFO - starting webserver on 'localhost:33914' 03:30:34 INFO - SUITE-START | Running 2 tests 03:30:34 INFO - TEST-START | dromaeo_css 03:30:34 INFO - Initialising browser for dromaeo_css test... 03:30:34 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33914/getInfo.html -profile /tmp/tmppfKmRI/profile 03:30:34 INFO - TEST-INFO | started process 13975 (/builds/slave/test/build/application/firefox/firefox http://localhost:33914/getInfo.html) 03:30:40 INFO - TEST-INFO | 13975: exit 0 03:30:40 INFO - Browser initialized. 03:30:40 INFO - Running cycle 1/1 for dromaeo_css test... 03:30:40 INFO - Using env: {'DISPLAY': ':0', 03:30:40 INFO - 'HOME': '/home/cltbld', 03:30:40 INFO - 'JSGC_DISABLE_POISONING': '1', 03:30:40 INFO - 'LANG': 'en_US.UTF-8', 03:30:40 INFO - 'LANGUAGE': 'en_US:en', 03:30:40 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:30:40 INFO - 'LOGNAME': 'cltbld', 03:30:40 INFO - 'MAIL': '/var/mail/cltbld', 03:30:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:30:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:30:40 INFO - 'MOZ_CRASHREPORTER': '1', 03:30:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:40 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:30:40 INFO - 'MOZ_NO_REMOTE': '1', 03:30:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:30:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:40 INFO - 'NO_EM_RESTART': '1', 03:30:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:40 INFO - 'PWD': '/builds/slave/test', 03:30:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:30:40 INFO - 'RUST_BACKTRACE': 'full', 03:30:40 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:30:40 INFO - 'SHELL': '/bin/bash', 03:30:40 INFO - 'SHLVL': '1', 03:30:40 INFO - 'STYLO_FORCE_ENABLED': '1', 03:30:40 INFO - 'STYLO_THREADS': '1', 03:30:40 INFO - 'TERM': 'linux', 03:30:40 INFO - 'TMOUT': '86400', 03:30:40 INFO - 'USER': 'cltbld', 03:30:40 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1504600297.951283-1085524231', 03:30:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:40 INFO - '_': '/tools/buildbot/bin/python'} 03:30:40 INFO - TEST-INFO | started process 14162 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppfKmRI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:30:41 INFO - PID 14162 | 03:30:41 INFO - PID 14162 | (/builds/slave/test/build/application/firefox/firefox:14214): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:30:41 INFO - PID 14162 | 03:30:52 INFO - PID 14162 | RSS: Main: 171048960 03:30:52 INFO - PID 14162 | 03:33:50 INFO - PID 14162 | Cycle 1(1): loaded http://localhost:33914/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33914/tests/dromaeo/cssquery-ext.html) 03:33:52 INFO - PID 14162 | RSS: Main: 173514752 03:33:52 INFO - PID 14162 | 03:36:54 INFO - PID 14162 | Cycle 1(1): loaded http://localhost:33914/tests/dromaeo/cssquery-ext.html (next: http://localhost:33914/tests/dromaeo/cssquery-jquery.html) 03:36:54 INFO - PID 14162 | RSS: Main: 170053632 03:36:54 INFO - PID 14162 | 03:39:56 INFO - PID 14162 | Cycle 1(1): loaded http://localhost:33914/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33914/tests/dromaeo/cssquery-mootools.html) 03:39:56 INFO - PID 14162 | RSS: Main: 172503040 03:39:56 INFO - PID 14162 | 03:42:58 INFO - PID 14162 | Cycle 1(1): loaded http://localhost:33914/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33914/tests/dromaeo/cssquery-prototype.html) 03:42:59 INFO - PID 14162 | RSS: Main: 171089920 03:42:59 INFO - PID 14162 | 03:46:03 INFO - PID 14162 | Cycle 1(1): loaded http://localhost:33914/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33914/tests/dromaeo/cssquery-yui.html) 03:46:03 INFO - PID 14162 | RSS: Main: 172507136 03:46:03 INFO - PID 14162 | 03:49:05 INFO - PID 14162 | Cycle 1(1): loaded http://localhost:33914/tests/dromaeo/cssquery-yui.html (next: http://localhost:33914/tests/dromaeo/cssquery-dojo.html) 03:49:05 INFO - PID 14162 | RSS: Main: 175071232 03:49:05 INFO - PID 14162 | 03:49:05 INFO - PID 14162 | __start_tp_report 03:49:05 INFO - PID 14162 | _x_x_mozilla_page_load 03:49:05 INFO - PID 14162 | _x_x_mozilla_page_load_details 03:49:05 INFO - PID 14162 | |i|pagename|runs| 03:49:05 INFO - PID 14162 | |0;dojo.html;3365.6466071062537;3375.1730825947648;3386.2211691311;3403.3873902697505;3419.247765491591;6420.133282006939;6503.609783412992;6521.5108866835;6558.475321974242;6585.967070164655;6368;6460.483161347092;6466.191726034246;6475.384838440353;6502.414782669559;5947.375525569807;5949;5965.582409231356;5978.073398623221;5978.671173085479;5975.25309336333;5979.611325263866;5992.9700351498395;6025.066114752199;6044.727987240584;5966.582339236255;6009.609375390607;6024.307204671475;6028.367021462749;6107.022876339786;5745.253117094792;5979.850503737398;5996.640201587918;6000;6053.394660533955;5361.635674831532;5838.386969368197;5862.70686465675;5895.145203945447;5994.67029313392;6447.129637498924;6459.515536334794;6465.806025819186;6572.507061970371;6580.769673061468;6829.009793579953;6864.4165245954155;6939.132608423947;7048.259932707095;7053.400460960825;7035.68339424722;7037.648117594151;7041.2606676298765;7048.612326322051;7053.153621565394;6486.837829054264;6526.379993900572;6562.704678289489;6565.573237739532;6573.3426657333885;7172.7089123958185;7199;7205.567665939955;7216.458765592602;7296.124465064227;6679.131712877392;6754.898676519856;6877.277885821916;6951.65241737911;6956.617386043817;6908.240093589701;6960.129983752031;7012.894806577905;7017.508774385744;7073.257307982691;6923.896141557881;6926.411255043277;7007.859842803217;7029.92970070303;7033.120859892513;6949;6962.199347075049;7058.400035996895;7068.893966590505;7076.610786406797;5073.239014147834;5105.132127538327;5135.306733590992;5135.871603209875;5136.666116702402;4506.098780243964;4549.0447006128425;4556.066006468666;4585.266357382803;4590.563896429834;5917.112433134978;5959.582829201914;5998.3701711320555;6023.186869772525;6023.307319658208;6793.490488213404;6794.320567943166;6801.5238933274195;6803.591784492946;6812.420944219698;5903.144044113579;5905.940940590625;5908.527317814564;5912.852178695567;5958.761649534057;5868.2664666916635;5869.970650146722;5871.853203669943;5907.881842363215;6031.366706495843;6802.65986700663;6810.012548180585;6868.484863635247;6874.106366172466;6888;6878.55289406187;7014.894776578458;7022.789316320519;7095.716171353088;7101.254368291255;6730.293319201413;6731.932680673131;6735.25912149673;6742.190937087581;6747.156605424322;6787.864242715217;6842.657867106525;6889.311068893271;6944.4791640626145;6952.374286314256;7011.26381729911;7022.33287837675;7082.787516374517;7102.3962963148715;7104.715811367694;6624.436922861611;6690.498212633975;6726.327367263235;6759.121314229119;6852.383285504328;6638.701258443478;6642.070110184482;6651.268360480247;6661.3338666132995;6661.633610151488;6531.673416329069;6575.638339891352;6577.572457790228;6596.274409815012;6631.270560238467;6643.833904152435;6727.26000139994;6751.156105486814;6817.454603631797;6872.725090996304;6453.09656648079;6454.19322584677;6540;6540.051692504465;6602.207735071822 03:49:05 INFO - PID 14162 | |1;ext.html;769.2192424688942;813.9389545784068;849.3714651158142;870.8345414371269;876.6668665906957;39882.2023559529;40713.18573628525;40934.795326023406;40970.180596388054;41058.79470602643;36814.8159259204;37078.62921370792;37130.25739485215;37163.62836371636;37169;6922.757703480392;6981.127359080115;7024.157101147869;7028.753993610199;7037.401820845234;6914.861702765942;7000.229974702778;7001.824954376156;7004.054452648904;7005.124359455068;7552.622368881562;7712.922870771276;7718.575478348688;7722.304992550669;7727.072751269828;7614;7670.693172273131;7676.9616151919445;7677.69289228433;7678.040244969379;7402.592857392895;7519.849603007964;7569.583672897988;7577.734779282699;7586.203448637869;37040.444393333855;37334.43998340027;37406.81296593527;37424.62575374239;37486.250274994345;3483.076984599083;3529.4176460883923;3532.5407696999227;3533.805640689761;3534.3284775892757;30971.535426968614;31002.224944376572;31062.37875242505;31076.68923310783;31108.844455777802;5057;5089.567386772129;5090.414602320743;5103.8213662522;5111.4121875984365;225866;227214;228572;229036;229322;47452.762736186785;48162.27756583584;48322.999999999294;48560.7571962145;48850.26724599134;50454.747726261136;50464.49535504671;50469;50507.24239136416;50570.241446378335;15792.21038948048;15842;15880.841191588168;15885.602859928595;15888.44390446352;12831.550895718792;12843.807342889864;12850.164739291917;12860.164089334163;12937.935310323388;14116.364763585663;14125.364358603887;14159.64600884986;14225.288735563181;14242.643933901529;5602.943970560324;5647.350554686263;5668.744906479218;5688.40271771458;5704.372519022904;1012.696191142669;1017.9083882450615;1024.0527512051324;1027.3219675014454;1031.4327120083924;22832.200872969366;23610.29169124929;28997;29149;29417.264568385963;1067.6636859389268;1077.6389909380446;1115.7991561518843;1115.9721006974892;1120.9159313051555;12166.57416990401;12410.255384676948;12434.502619895284;12442.615007268429;12502.3123728194;233298;235989;236308;236322;237448;49964.75017624888;50786.492135078915;55130.72434637801;56296.155557666665;56378.71810641002;1415.2357726827397;1434.2828585707146;1438.388684808931;1446.6600348917996;1458.795768592398;26649.200523984313;26878.865605671846;26911.596326054732;27084.32289192786;27788.58317125204;48934.26598600952;49505.25742113799;49509.75245123752;49538.25692614542;49570.25644615261;206879;209576;209733;209915;210321;32863;34624.82687586546;34631.480527792606;34713.13217169591;34924.65075349214;42401.57598423976;42520.362194566485;42860.571394286904;43036.139277214905;43177.35233971556;31814.363712726077;32054.519182212753;32087.197820054684;32503.349933000736;32833.34333313368;30648;30870.382592348476;31110;31131.37737245197;31323.68676313208;35674.46488302729;35830.46254306239;35839;35849.46225806563;35941.460878087375;30201;30504.694953050184;30523.38953220879;30797.538036929913;30927.84536077305;23364.415889602897;23409.60335276208;23452.296431107094;23627.40931476727;23987.64018539758 03:49:05 INFO - PID 14162 | |2;jquery.html;559.3399788249864;576.6799426318394;578.7598146769091;582.4845012164236;589.1751547833034;21683.67474487884;22313.888430557825;22635.094596216153;22699.432514187134;22757.886210568966;25073.49853002939;25766.227013189633;25794.871025644894;25920.35199120023;25921.740782592216;6516.315786842372;6650.667466626674;6658.434033107192;6662.467002639777;6671.099401580797;6229.781957631484;6474.708638111297;6506.186726659168;6573.802785916406;6575.178102737158;6492.967535162317;6502.869942601145;6505.902411463831;6539.803805885807;6541.116949211867;6526.54314198004;6564.277929427783;6564.376384243489;6572.277049524549;6584.670766461706;6065.938460769392;6104.908426373608;6118;6132.202813634243;6137.508999280047;27831.16506504808;28236.15291541257;28811.71188288111;29251.41497170066;29370.85314573435;2013.5469519358173;2061.7732049474544;2061.7835127311564;2062.061761898333;2065.4113577630305;18805.341813036615;19503.219871205136;19517;19520.219191232332;19534;2384.988075059631;2422.588160012802;2477.4797292568583;2516.421223118693;2543.4913017396593;125802;130560;130827;131474;131579;14060.945429092859;14880.776788348183;14948.32732527039;14984.400623975136;15149;22517.211897583835;23310.65034024491;23429.7657023431;23540.176093836977;23777.286681399586;9367.156955873868;9417.199538039344;9609.9039009609;9614.615415383307;9702.175315098295;8411.242988131098;8473.872891906627;8561.315094792402;8576.871346929802;8578.227959483676;9017.549122543847;9076.31927605419;9150.496722680316;9198.402103863227;9392.389494682824;2513.3339664988794;2527.646129541866;2591.313301974978;2618.6988496323165;2687.5162470755063;962.0908241711655;967.1827305926481;999.5252255178732;1000.4197565412044;1000.949952502372;19501.902490487457;20099.497512562302;20428.591428171352;23891.436928556395;25115.372115697253;1029.5212726082407;1043.6138628707427;1051.5530899367739;1068.983965240522;1069.6951368859839;11182.217244792786;11445.542178312775;11484;11710.414479276173;11769.293842369485;463684;465098;469883;473300;486148;125065;125750.371248145;126779;129686;131088;1207.3057991654834;1229.0474881966368;1243.1173866554848;1246.1152581666936;1247.3015111537568;18444.35444759427;18708.345207917657;18910.432687019413;21483.248086316904;22338.664920025887;41889;50814.491855080974;58167;59950.70024649849;61207;67774;68265.65867170831;69023;69069.3093069083;76330.61834690791;14728.116313021254;14970.850291496945;15047.473338433103;15051.548453546411;15119;23570.646440303753;23574;23579.174728884405;23667.28998130059;23830.16594419187;18696.53258668544;18744;18790.718139228196;18792.530186744894;18805.204672808348;16573.50279491617;17093.658126837643;17319.393821216196;17489.125543723017;17825.73261401054;17710.380136695152;18538.814611853708;20145.194192232146;20254.392368228386;20278.188872445528;14186.29068546548;14747.778783318045;14994.47519336818;15017.02389344689;15024;18616.16227269803;18926.242950282387;18946.147423366256;19050;19127.23491060342 03:49:05 INFO - PID 14162 | |3;mootools.html;1331.960041198764;1370.5956742760884;1372.5196181336532;1382.2881216173673;1394.177435313165;14916.403343866246;15534.145621990787;15641.765373519407;15651.608709782262;15658.373665053412;14875.404983800636;16007.35970561179;16013.11927843968;16021.599460013476;16047.197640118005;2777.7083406242355;2858.1711303721895;2861.1988643179943;2871.109955913663;2872.1383584924542;2740.8081434299606;2822.1251412062225;2823.378856651533;2823.7882158838065;2824.4915915135266;2695.2857492764433;2794;2833.0792492439937;2840.0485837244446;2842.9004984825533;2703.621492990983;2744.4373903349765;2762.2265765585666;2762.6132341472107;2764.3918337965615;2634.776044036259;2667.8932842686268;2675.5852842809395;2679.169457468191;2693.2189664997322;14763.261836908112;14797.630059248604;14828.925855370655;14890.851091489054;14896;7958.522488650699;8192.426530142893;8193.631286592057;8207.917920820775;8223.21879421454;5089.160288552384;5286.629935904488;5432.6740395576;5434.538064264502;5469.617126801126;1900.6863867461852;1928.4696708405302;1932.5941552273898;1996.2514057228539;2018.1725492547985;26111.608325875128;26185.73814261852;26308.73691263082;26311.868440657676;26324.21027369182;6658.9001164982565;6702.497312701566;6703.731850725916;6886.621235831977;7055.188653304833;16880.493585192464;16908;16908.239129239213;17015.404460843813;17050.31798728037;7892.816077588408;8081.555514446644;8083.676652933935;8084.82769998347;8086.353091752646;5926.851828704317;6027.517798576104;6648.933510664928;7379.594122323217;7589.316961473494;4984.800607975641;5146.330976972969;5170.457102004236;5197.766100525486;5250.159974404077;1459.3360021190333;1487.7545205041263;1492.5522343296968;1495.7083368743208;1515.0379509011857;912.6030176873081;935.5415846235296;942.29328003997;944.504135328944;946.6733976778;7695.192004839411;7780.066392032993;7819.6481158348015;7843.607819608997;7988.440809143421;716.6022857314241;719.5251134251369;730.868443680132;738.3834498194068;984.5766320482118;5274.7626356814035;5350.411454739976;5576.860578485489;5606.6636001840025;5849.356570777296;20980.47548811292;21104.261350852645;21912.12351505954;22150.33548993533;22206;21887;21915.890420547796;21978;22358.441038974157;22386.44033899133;10952.34285942846;11198.888011119947;11291.717707057389;11389.544418223179;11415;8259.917400826154;8533.359998000298;8562.400631955703;8686.956565217133;8802.64789408442;18047.36834210849;18567.44297671072;18607.81392186115;18975;19184;19194.616107678048;19222;19436.125374357904;19721.21115155435;19737.309194178135;10921.890781092088;11295.322280663186;11299.887001129884;11310.4910279036;11312.321260724382;13687.520936767165;13880.375383107583;13962.092463989808;14055.929720351332;14096.718065638835;11295.152863535104;11324.094072474347;11479.311241325548;11681.88318116808;11888.643340699793;10454.640896683382;10507.579696812041;10576.101031412109;10618.575256989634;10728.570857165625;10130.696079117639;10144.644937427154;10395.636152734618;10426.947865260625;10444.63443779464;7105.893411598933;7126.679299431435;7129.893051604126;7184.353408193288;7194.604296763729;7182.138143422822;7182.3894968928225;7218.3503484686635;7225.963870180615;7330.560166390033 03:49:05 INFO - PID 14162 | |4;prototype.html;504.51818513319773;506.99239511407313;531.3676724697611;537.4867002013076;543.8966596346694;6397.8080657580285;6420.935790642092;6447.419732224104;6503;6590.736370545178;6319.98680837668;6387.616742995424;6453.161089058416;6468.159139311882;6492.500387350869;5265.18389649603;5319.255304257407;5319.335083114611;5366.785328586871;5388;5160.948390516103;5220.164773636219;5327.760250788724;5384.973075134619;5393.838184854441;5288.92066619001;5308.973455132719;5336.519713225809;5351.57187425007;5396.406395296514;5359.303290572239;5375.516203541661;5392.595555333346;5426.782928682848;5432.619716619838;4944.752762361867;4979.381700947207;5018.071656743514;5019.4227663818765;5039.44566097729;6392.968035159794;6460.3862633049785;6461.224653041618;6489.805305840832;6508.869822603521;6197.721102550351;6250;6250.249970003629;6290.9685451572905;6300;6744.156980377453;6836.794896153074;6857.588544687334;6885.827854303632;6908.965455172692;5418.864528386783;5435.402105768362;5462.426445223274;5462.617616766828;5471.179323101527;7112.928870711278;7156.318265207724;7241.2396698346965;7262.745803896891;7271;5598.300212473441;5628.915566266509;5629.915551266734;5641.661500309994;5664.405237450009;5663.546916246691;5758.193852860602;5764.625299355528;5777.537796976232;5782.479576838105;6167.383261673796;6250.937490625036;6268.623882567061;6291.937080629226;6302.306746257908;6581.572197807127;6715.865682686319;6750.426213771884;6844.315568443216;6946.756863509753;1877.2303355624128;1895.289266525053;1969.2516843599626;2005.2480319880044;2009.8392128629675;1450.708869106496;1457.9489717859824;1459.4599998000808;1476.3946781819402;1488.3079368093888;5813.912791308134;5922.200502932049;5949.464548190684;5971.552133589911;6011;6874.731338658231;6917.342852429011;6924.203716572558;6954.687039083254;7020.648967551602;5962.701864906738;5978.624916269196;5983.940160598426;5994.700264986734;6062.120992456069;3624.5831729350934;3695.4456831474954;3708.8516459341863;3712.5730540988134;3728.422094575345;6657.367550082831;6686.96656516724;6751.122354093936;6779.6271205084195;6779.966100169566;7036;7061.717531298793;7150.9284907151305;7155.141383034069;7231.385332246713;6615.735370585123;6679.699413526403;6708.6310252936555;6750.084950728566;6793.660316984131;6903.89644155328;6977.511574189961;6978.337057979484;6979.30206979298;7008.579485230903;6914.9654251730435;6946.65266736651;6949.791506254821;6956.539126783432;7012.141782427762;6735.5958642479645;6749.763758268437;6762.932370676427;6793.490488213305;6799.456043516606;5148.665336753099;5187.974060129826;5191.897281600957;5219.947800522098;5225.320708307896;6688.799336019927;6832.350926661959;6963;7012.964935175291;7060.576365418091;6578.342165783383;6621.404073633204;6685.431738302299;6737.764178253738;6784;6567.9014814778775;6585.440237579668;6703.530752847254;6723.159605049369;6767.729290828312;6395.296517382991;6539.7384104637185;6577.2436169841085;6578.276389597237;6612.206535215805;6640.535162538769;6685.130932978682;6740.427063699444;6778.356056174655;6812.693428795816;6367.439977205614;6448.967755161382;6452.773613193403;6531.608103513804;6556.409923106943 03:49:05 INFO - PID 14162 | |5;yui.html;881.1540920716112;885.3669626217253;896.2529846021938;906.8277027364799;916.0381599320712;17668.469945901626;18442.17010234541;18493.53766155847;18554.072296385195;21857.234996775114;19446.805531944676;19675.212991480323;19961.900190499062;19976.400707978784;20036.0983755731;750.0324581290129;764.3197554176787;966.0484422843493;985.4924713772413;991.1278075293732;995.2336700740426;998;998.935069220502;1000.1099021870541;1000.5647543318644;1040.251019266131;1046.4401545173334;1048.0567489259652;1048.7745134796016;1051.4427353502656;1037.232447988487;1037.2946396450411;1037.9117774989136;1039.974000649986;1043.1498328861992;764.8279137194143;765.0933643632313;765.2003656179306;765.3188662090744;768.4275214964887;18288.63422731538;19173.904130479397;19286.614267714707;19339.51651208731;19456.805431945784;20830.37508874736;21280.574388512145;21292.148314067417;21298;21907.342779716633;17462.91268543649;17490.912545437317;17497.037662928535;17607.735883961752;17616.91191544047;3833.3483307837732;3856.7107466940092;3860.092878173627;3860.5946375630433;3862.343401621731;123812.38093809474;125793.37103314424;126513;126603;127675.36162319222;16999.150042497826;17084.82915170857;17394.47816565505;17402.738958915626;17506.29974801019;30213.848930755204;31023.224419389695;31071.533926991113;31167.376652467276;31286.374272514422;7842.333401660809;8727.214550690342;8869.600867960957;8880.51157186348;8894.199522043047;3550.1302180965827;3941.329973904386;4118.238125946709;4122.690798190148;4135.110951145458;5224.138017227115;5286.788528458896;5344.866378340573;5347.545458635982;5355.946440535623;1061.7823346214007;1084.2897901874285;1085.5874767588266;1086.364476781076;1088.0479580367178;638.958467699598;650.5023656902473;658.9011648252705;664.6577012838392;669.0666520204288;10960.28758130719;11305.434728263554;11618.244814087057;11778.469968851423;12045.096617753703;659.3604203922188;660.3198705333514;663.4857985061616;670.0617790986462;684.8287928017995;5531.363893152339;5555.972220138954;5656.43435656431;5746.511546518593;5818.865321262398;113734;113965.4301728486;114579;115113.54659360232;115686.42156789162;101865;101989.49005255074;102611;104794.47602761937;107991;90314;90461.54769226111;92837.53581232051;94295;96244.51877740707;10508.264421490423;10551.683449496528;10584.629537966135;10641.414722190353;10827.133829293794;42651.7867410661;42827.357589636806;43938.78030609954;44022.11955760931;44694.3295850556;53880;54131.18803217876;55258.44741552533;55628;57676.13485797632;18116.547086322946;18694.626107477503;18757.155927983;18958.336458223897;18964.336248231244;19546.60906781885;19730.802691972898;19962.60074798525;20229.291974780812;20807;18910.810891890906;19154.7126793101;19277;19372;19428.8057119427;18039.63920721552;18795.6240875179;18907.71638425397;19055.90472047631;19199.52001199981;17362.47912562625;17409.825901741326;17459.47621571355;17636.470905872844;17677.381291655245;12071.75856482883;12133.575324863587;12438;12553.686157846127;12739.681507962376;13087.672808179872;13639;14252.21612811264;14495.20276384809;14573.344199510835 03:49:05 INFO - PID 14162 | __end_tp_report 03:49:05 INFO - PID 14162 | __start_cc_report 03:49:05 INFO - PID 14162 | _x_x_mozilla_cycle_collect,369 03:49:05 INFO - PID 14162 | __end_cc_report 03:49:05 INFO - PID 14162 | __startTimestamp1504608545632__endTimestamp 03:49:05 INFO - PID 14162 | 03:49:05 INFO - PID 14162 | ------- Summary: start ------- 03:49:05 INFO - PID 14162 | Number of tests: 6 03:49:05 INFO - PID 14162 | 03:49:05 INFO - PID 14162 | [#0] dojo.html Cycles:165 Average:6372.52 Median:6596.27 stddev:790.94 (12.0%) stddev-sans-first:757.38 03:49:05 INFO - PID 14162 | Values: 3365.6 3375.2 3386.2 3403.4 3419.2 6420.1 6503.6 6521.5 6558.5 6586.0 6368.0 6460.5 6466.2 6475.4 6502.4 5947.4 5949.0 5965.6 5978.1 5978.7 5975.3 5979.6 5993.0 6025.1 6044.7 5966.6 6009.6 6024.3 6028.4 6107.0 5745.3 5979.9 5996.6 6000.0 6053.4 5361.6 5838.4 5862.7 5895.1 5994.7 6447.1 6459.5 6465.8 6572.5 6580.8 6829.0 6864.4 6939.1 7048.3 7053.4 7035.7 7037.6 7041.3 7048.6 7053.2 6486.8 6526.4 6562.7 6565.6 6573.3 7172.7 7199.0 7205.6 7216.5 7296.1 6679.1 6754.9 6877.3 6951.7 6956.6 6908.2 6960.1 7012.9 7017.5 7073.3 6923.9 6926.4 7007.9 7029.9 7033.1 6949.0 6962.2 7058.4 7068.9 7076.6 5073.2 5105.1 5135.3 5135.9 5136.7 4506.1 4549.0 4556.1 4585.3 4590.6 5917.1 5959.6 5998.4 6023.2 6023.3 6793.5 6794.3 6801.5 6803.6 6812.4 5903.1 5905.9 5908.5 5912.9 5958.8 5868.3 5870.0 5871.9 5907.9 6031.4 6802.7 6810.0 6868.5 6874.1 6888.0 6878.6 7014.9 7022.8 7095.7 7101.3 6730.3 6731.9 6735.3 6742.2 6747.2 6787.9 6842.7 6889.3 6944.5 6952.4 7011.3 7022.3 7082.8 7102.4 7104.7 6624.4 6690.5 6726.3 6759.1 6852.4 6638.7 6642.1 6651.3 6661.3 6661.6 6531.7 6575.6 6577.6 6596.3 6631.3 6643.8 6727.3 6751.2 6817.5 6872.7 6453.1 6454.2 6540.0 6540.1 6602.2 03:49:05 INFO - PID 14162 | 03:49:05 INFO - PID 14162 | [#1] ext.html Cycles:180 Average:39342.02 Median:19227.03 stddev:58299.51 (303.2%) stddev-sans-first:58391.11 03:49:05 INFO - PID 14162 | Values: 769.2 813.9 849.4 870.8 876.7 39882.2 40713.2 40934.8 40970.2 41058.8 36814.8 37078.6 37130.3 37163.6 37169.0 6922.8 6981.1 7024.2 7028.8 7037.4 6914.9 7000.2 7001.8 7004.1 7005.1 7552.6 7712.9 7718.6 7722.3 7727.1 7614.0 7670.7 7677.0 7677.7 7678.0 7402.6 7519.8 7569.6 7577.7 7586.2 37040.4 37334.4 37406.8 37424.6 37486.3 3483.1 3529.4 3532.5 3533.8 3534.3 30971.5 31002.2 31062.4 31076.7 31108.8 5057.0 5089.6 5090.4 5103.8 5111.4 225866.0 227214.0 228572.0 229036.0 229322.0 47452.8 48162.3 48323.0 48560.8 48850.3 50454.7 50464.5 50469.0 50507.2 50570.2 15792.2 15842.0 15880.8 15885.6 15888.4 12831.6 12843.8 12850.2 12860.2 12937.9 14116.4 14125.4 14159.6 14225.3 14242.6 5602.9 5647.4 5668.7 5688.4 5704.4 1012.7 1017.9 1024.1 1027.3 1031.4 22832.2 23610.3 28997.0 29149.0 29417.3 1067.7 1077.6 1115.8 1116.0 1120.9 12166.6 12410.3 12434.5 12442.6 12502.3 233298.0 235989.0 236308.0 236322.0 237448.0 49964.8 50786.5 55130.7 56296.2 56378.7 1415.2 1434.3 1438.4 1446.7 1458.8 26649.2 26878.9 26911.6 27084.3 27788.6 48934.3 49505.3 49509.8 49538.3 49570.3 206879.0 209576.0 209733.0 209915.0 210321.0 32863.0 34624.8 34631.5 34713.1 34924.7 42401.6 42520.4 42860.6 43036.1 43177.4 31814.4 32054.5 32087.2 32503.3 32833.3 30648.0 30870.4 31110.0 31131.4 31323.7 35674.5 35830.5 35839.0 35849.5 35941.5 30201.0 30504.7 30523.4 30797.5 30927.8 23364.4 23409.6 23452.3 23627.4 23987.6 03:49:05 INFO - PID 14162 | 03:49:05 INFO - PID 14162 | [#2] jquery.html Cycles:180 Average:34436.25 Median:23576.59 stddev:79798.32 (338.5%) stddev-sans-first:79981.64 03:49:05 INFO - PID 14162 | Values: 559.3 576.7 578.8 582.5 589.2 21683.7 22313.9 22635.1 22699.4 22757.9 25073.5 25766.2 25794.9 25920.4 25921.7 6516.3 6650.7 6658.4 6662.5 6671.1 6229.8 6474.7 6506.2 6573.8 6575.2 6493.0 6502.9 6505.9 6539.8 6541.1 6526.5 6564.3 6564.4 6572.3 6584.7 6065.9 6104.9 6118.0 6132.2 6137.5 27831.2 28236.2 28811.7 29251.4 29370.9 2013.5 2061.8 2061.8 2062.1 2065.4 18805.3 19503.2 19517.0 19520.2 19534.0 2385.0 2422.6 2477.5 2516.4 2543.5 125802.0 130560.0 130827.0 131474.0 131579.0 14060.9 14880.8 14948.3 14984.4 15149.0 22517.2 23310.7 23429.8 23540.2 23777.3 9367.2 9417.2 9609.9 9614.6 9702.2 8411.2 8473.9 8561.3 8576.9 8578.2 9017.5 9076.3 9150.5 9198.4 9392.4 2513.3 2527.6 2591.3 2618.7 2687.5 962.1 967.2 999.5 1000.4 1000.9 19501.9 20099.5 20428.6 23891.4 25115.4 1029.5 1043.6 1051.6 1069.0 1069.7 11182.2 11445.5 11484.0 11710.4 11769.3 463684.0 465098.0 469883.0 473300.0 486148.0 125065.0 125750.4 126779.0 129686.0 131088.0 1207.3 1229.0 1243.1 1246.1 1247.3 18444.4 18708.3 18910.4 21483.2 22338.7 41889.0 50814.5 58167.0 59950.7 61207.0 67774.0 68265.7 69023.0 69069.3 76330.6 14728.1 14970.9 15047.5 15051.5 15119.0 23570.6 23574.0 23579.2 23667.3 23830.2 18696.5 18744.0 18790.7 18792.5 18805.2 16573.5 17093.7 17319.4 17489.1 17825.7 17710.4 18538.8 20145.2 20254.4 20278.2 14186.3 14747.8 14994.5 15017.0 15024.0 18616.2 18926.2 18946.1 19050.0 19127.2 03:49:05 INFO - PID 14162 | 03:49:05 INFO - PID 14162 | [#3] mootools.html Cycles:180 Average:9360.35 Median:2651.33 stddev:6708.17 (253.0%) stddev-sans-first:6699.87 03:49:05 INFO - PID 14162 | Values: 1332.0 1370.6 1372.5 1382.3 1394.2 14916.4 15534.1 15641.8 15651.6 15658.4 14875.4 16007.4 16013.1 16021.6 16047.2 2777.7 2858.2 2861.2 2871.1 2872.1 2740.8 2822.1 2823.4 2823.8 2824.5 2695.3 2794.0 2833.1 2840.0 2842.9 2703.6 2744.4 2762.2 2762.6 2764.4 2634.8 2667.9 2675.6 2679.2 2693.2 14763.3 14797.6 14828.9 14890.9 14896.0 7958.5 8192.4 8193.6 8207.9 8223.2 5089.2 5286.6 5432.7 5434.5 5469.6 1900.7 1928.5 1932.6 1996.3 2018.2 26111.6 26185.7 26308.7 26311.9 26324.2 6658.9 6702.5 6703.7 6886.6 7055.2 16880.5 16908.0 16908.2 17015.4 17050.3 7892.8 8081.6 8083.7 8084.8 8086.4 5926.9 6027.5 6648.9 7379.6 7589.3 4984.8 5146.3 5170.5 5197.8 5250.2 1459.3 1487.8 1492.6 1495.7 1515.0 912.6 935.5 942.3 944.5 946.7 7695.2 7780.1 7819.6 7843.6 7988.4 716.6 719.5 730.9 738.4 984.6 5274.8 5350.4 5576.9 5606.7 5849.4 20980.5 21104.3 21912.1 22150.3 22206.0 21887.0 21915.9 21978.0 22358.4 22386.4 10952.3 11198.9 11291.7 11389.5 11415.0 8259.9 8533.4 8562.4 8687.0 8802.6 18047.4 18567.4 18607.8 18975.0 19184.0 19194.6 19222.0 19436.1 19721.2 19737.3 10921.9 11295.3 11299.9 11310.5 11312.3 13687.5 13880.4 13962.1 14055.9 14096.7 11295.2 11324.1 11479.3 11681.9 11888.6 10454.6 10507.6 10576.1 10618.6 10728.6 10130.7 10144.6 10395.6 10426.9 10444.6 7105.9 7126.7 7129.9 7184.4 7194.6 7182.1 7182.4 7218.4 7226.0 7330.6 03:49:05 INFO - PID 14162 | 03:49:05 INFO - PID 14162 | [#4] prototype.html Cycles:180 Average:5801.63 Median:6409.37 stddev:1556.97 (24.3%) stddev-sans-first:1509.72 03:49:05 INFO - PID 14162 | Values: 504.5 507.0 531.4 537.5 543.9 6397.8 6420.9 6447.4 6503.0 6590.7 6320.0 6387.6 6453.2 6468.2 6492.5 5265.2 5319.3 5319.3 5366.8 5388.0 5160.9 5220.2 5327.8 5385.0 5393.8 5288.9 5309.0 5336.5 5351.6 5396.4 5359.3 5375.5 5392.6 5426.8 5432.6 4944.8 4979.4 5018.1 5019.4 5039.4 6393.0 6460.4 6461.2 6489.8 6508.9 6197.7 6250.0 6250.2 6291.0 6300.0 6744.2 6836.8 6857.6 6885.8 6909.0 5418.9 5435.4 5462.4 5462.6 5471.2 7112.9 7156.3 7241.2 7262.7 7271.0 5598.3 5628.9 5629.9 5641.7 5664.4 5663.5 5758.2 5764.6 5777.5 5782.5 6167.4 6250.9 6268.6 6291.9 6302.3 6581.6 6715.9 6750.4 6844.3 6946.8 1877.2 1895.3 1969.3 2005.2 2009.8 1450.7 1457.9 1459.5 1476.4 1488.3 5813.9 5922.2 5949.5 5971.6 6011.0 6874.7 6917.3 6924.2 6954.7 7020.6 5962.7 5978.6 5983.9 5994.7 6062.1 3624.6 3695.4 3708.9 3712.6 3728.4 6657.4 6687.0 6751.1 6779.6 6780.0 7036.0 7061.7 7150.9 7155.1 7231.4 6615.7 6679.7 6708.6 6750.1 6793.7 6903.9 6977.5 6978.3 6979.3 7008.6 6915.0 6946.7 6949.8 6956.5 7012.1 6735.6 6749.8 6762.9 6793.5 6799.5 5148.7 5188.0 5191.9 5219.9 5225.3 6688.8 6832.4 6963.0 7013.0 7060.6 6578.3 6621.4 6685.4 6737.8 6784.0 6567.9 6585.4 6703.5 6723.2 6767.7 6395.3 6539.7 6577.2 6578.3 6612.2 6640.5 6685.1 6740.4 6778.4 6812.7 6367.4 6449.0 6452.8 6531.6 6556.4 03:49:05 INFO - PID 14162 | 03:49:05 INFO - PID 14162 | [#5] yui.html Cycles:180 Average:23879.90 Median:19451.81 stddev:32826.09 (168.8%) stddev-sans-first:32872.75 03:49:05 INFO - PID 14162 | Values: 881.2 885.4 896.3 906.8 916.0 17668.5 18442.2 18493.5 18554.1 21857.2 19446.8 19675.2 19961.9 19976.4 20036.1 750.0 764.3 966.0 985.5 991.1 995.2 998.0 998.9 1000.1 1000.6 1040.3 1046.4 1048.1 1048.8 1051.4 1037.2 1037.3 1037.9 1040.0 1043.1 764.8 765.1 765.2 765.3 768.4 18288.6 19173.9 19286.6 19339.5 19456.8 20830.4 21280.6 21292.1 21298.0 21907.3 17462.9 17490.9 17497.0 17607.7 17616.9 3833.3 3856.7 3860.1 3860.6 3862.3 123812.4 125793.4 126513.0 126603.0 127675.4 16999.2 17084.8 17394.5 17402.7 17506.3 30213.8 31023.2 31071.5 31167.4 31286.4 7842.3 8727.2 8869.6 8880.5 8894.2 3550.1 3941.3 4118.2 4122.7 4135.1 5224.1 5286.8 5344.9 5347.5 5355.9 1061.8 1084.3 1085.6 1086.4 1088.0 639.0 650.5 658.9 664.7 669.1 10960.3 11305.4 11618.2 11778.5 12045.1 659.4 660.3 663.5 670.1 684.8 5531.4 5556.0 5656.4 5746.5 5818.9 113734.0 113965.4 114579.0 115113.5 115686.4 101865.0 101989.5 102611.0 104794.5 107991.0 90314.0 90461.5 92837.5 94295.0 96244.5 10508.3 10551.7 10584.6 10641.4 10827.1 42651.8 42827.4 43938.8 44022.1 44694.3 53880.0 54131.2 55258.4 55628.0 57676.1 18116.5 18694.6 18757.2 18958.3 18964.3 19546.6 19730.8 19962.6 20229.3 20807.0 18910.8 19154.7 19277.0 19372.0 19428.8 18039.6 18795.6 18907.7 19055.9 19199.5 17362.5 17409.8 17459.5 17636.5 17677.4 12071.8 12133.6 12438.0 12553.7 12739.7 13087.7 13639.0 14252.2 14495.2 14573.3 03:49:05 INFO - PID 14162 | -------- Summary: end -------- 03:49:05 INFO - PID 14162 | 03:49:06 INFO - TEST-INFO | 14162: exit 0 03:49:06 INFO - TEST-OK | dromaeo_css | took 1112161ms 03:49:06 INFO - TEST-START | kraken 03:49:06 INFO - Initialising browser for kraken test... 03:49:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33914/getInfo.html -profile /tmp/tmpUtXUlY/profile 03:49:06 INFO - TEST-INFO | started process 14532 (/builds/slave/test/build/application/firefox/firefox http://localhost:33914/getInfo.html) 03:49:12 INFO - TEST-INFO | 14532: exit 0 03:49:12 INFO - Browser initialized. 03:49:12 INFO - Running cycle 1/1 for kraken test... 03:49:12 INFO - Using env: {'DISPLAY': ':0', 03:49:12 INFO - 'HOME': '/home/cltbld', 03:49:12 INFO - 'JSGC_DISABLE_POISONING': '1', 03:49:12 INFO - 'LANG': 'en_US.UTF-8', 03:49:12 INFO - 'LANGUAGE': 'en_US:en', 03:49:12 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:49:12 INFO - 'LOGNAME': 'cltbld', 03:49:12 INFO - 'MAIL': '/var/mail/cltbld', 03:49:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:49:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:49:12 INFO - 'MOZ_CRASHREPORTER': '1', 03:49:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:12 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:49:12 INFO - 'MOZ_NO_REMOTE': '1', 03:49:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:49:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:12 INFO - 'NO_EM_RESTART': '1', 03:49:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:12 INFO - 'PWD': '/builds/slave/test', 03:49:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:49:12 INFO - 'RUST_BACKTRACE': 'full', 03:49:12 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:49:12 INFO - 'SHELL': '/bin/bash', 03:49:12 INFO - 'SHLVL': '1', 03:49:12 INFO - 'STYLO_FORCE_ENABLED': '1', 03:49:12 INFO - 'STYLO_THREADS': '1', 03:49:12 INFO - 'TERM': 'linux', 03:49:12 INFO - 'TMOUT': '86400', 03:49:12 INFO - 'USER': 'cltbld', 03:49:12 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1504600297.951283-1085524231', 03:49:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:12 INFO - '_': '/tools/buildbot/bin/python'} 03:49:12 INFO - TEST-INFO | started process 14722 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUtXUlY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:49:13 INFO - PID 14722 | 03:49:13 INFO - PID 14722 | (/builds/slave/test/build/application/firefox/firefox:14774): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:49:13 INFO - PID 14722 | 03:49:23 INFO - PID 14722 | RSS: Main: 171044864 03:49:23 INFO - PID 14722 | 03:49:26 INFO - PID 14722 | Cycle 1(1): loaded http://localhost:33914/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33914/tests/kraken/driver.html?testName=audio-beat-detection) 03:49:27 INFO - PID 14722 | RSS: Main: 176881664 03:49:27 INFO - PID 14722 | 03:49:30 INFO - PID 14722 | Cycle 1(1): loaded http://localhost:33914/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33914/tests/kraken/driver.html?testName=audio-dft) 03:49:30 INFO - PID 14722 | RSS: Main: 177442816 03:49:30 INFO - PID 14722 | 03:49:33 INFO - PID 14722 | Cycle 1(1): loaded http://localhost:33914/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33914/tests/kraken/driver.html?testName=audio-fft) 03:49:34 INFO - PID 14722 | RSS: Main: 170799104 03:49:34 INFO - PID 14722 | 03:49:36 INFO - PID 14722 | Cycle 1(1): loaded http://localhost:33914/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33914/tests/kraken/driver.html?testName=audio-oscillator) 03:49:37 INFO - PID 14722 | RSS: Main: 171810816 03:49:37 INFO - PID 14722 | 03:49:39 INFO - PID 14722 | Cycle 1(1): loaded http://localhost:33914/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33914/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:49:39 INFO - PID 14722 | RSS: Main: 172138496 03:49:39 INFO - PID 14722 | 03:49:43 INFO - PID 14722 | Cycle 1(1): loaded http://localhost:33914/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33914/tests/kraken/driver.html?testName=imaging-darkroom) 03:49:43 INFO - PID 14722 | RSS: Main: 174362624 03:49:43 INFO - PID 14722 | 03:49:47 INFO - PID 14722 | Cycle 1(1): loaded http://localhost:33914/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33914/tests/kraken/driver.html?testName=imaging-desaturate) 03:49:47 INFO - PID 14722 | RSS: Main: 174043136 03:49:47 INFO - PID 14722 | 03:49:50 INFO - PID 14722 | Cycle 1(1): loaded http://localhost:33914/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33914/tests/kraken/driver.html?testName=json-parse-financial) 03:49:51 INFO - PID 14722 | RSS: Main: 175382528 03:49:51 INFO - PID 14722 | 03:49:52 INFO - PID 14722 | Cycle 1(1): loaded http://localhost:33914/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33914/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:49:53 INFO - PID 14722 | RSS: Main: 175013888 03:49:53 INFO - PID 14722 | 03:49:55 INFO - PID 14722 | Cycle 1(1): loaded http://localhost:33914/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33914/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:49:55 INFO - PID 14722 | RSS: Main: 174342144 03:49:55 INFO - PID 14722 | 03:49:57 INFO - PID 14722 | Cycle 1(1): loaded http://localhost:33914/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33914/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:49:58 INFO - PID 14722 | RSS: Main: 171765760 03:49:58 INFO - PID 14722 | 03:50:01 INFO - PID 14722 | Cycle 1(1): loaded http://localhost:33914/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33914/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:50:01 INFO - PID 14722 | RSS: Main: 171864064 03:50:01 INFO - PID 14722 | 03:50:04 INFO - PID 14722 | Cycle 1(1): loaded http://localhost:33914/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33914/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:50:05 INFO - PID 14722 | RSS: Main: 172187648 03:50:05 INFO - PID 14722 | 03:50:07 INFO - PID 14722 | Cycle 1(1): loaded http://localhost:33914/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33914/tests/kraken/driver.html?testName=ai-astar) 03:50:07 INFO - PID 14722 | RSS: Main: 173748224 03:50:07 INFO - PID 14722 | 03:50:07 INFO - PID 14722 | __start_tp_report 03:50:07 INFO - PID 14722 | _x_x_mozilla_page_load 03:50:07 INFO - PID 14722 | _x_x_mozilla_page_load_details 03:50:07 INFO - PID 14722 | |i|pagename|runs| 03:50:07 INFO - PID 14722 | |0;ai-astar;99;106;99;108;107;111;107;97;107;108 03:50:07 INFO - PID 14722 | |1;audio-beat-detection;148;115;145;171;117;144;142;120;170;123 03:50:07 INFO - PID 14722 | |2;audio-dft;163;164;163;162;161;163;162;171;175;163 03:50:07 INFO - PID 14722 | |3;audio-fft;74;77;73;167;74;75;74;88;97;73 03:50:07 INFO - PID 14722 | |4;audio-oscillator;80;79;155;80;79;79;131;79;80;125 03:50:07 INFO - PID 14722 | |5;imaging-gaussian-blur;114;115;115;115;113;114;114;113;119;114 03:50:07 INFO - PID 14722 | |6;imaging-darkroom;149;149;148;148;148;147;147;148;152;149 03:50:07 INFO - PID 14722 | |7;imaging-desaturate;94;94;95;95;93;94;94;94;94;94 03:50:07 INFO - PID 14722 | |8;json-parse-financial;54;53;54;53;53;53;52;52;53;53 03:50:07 INFO - PID 14722 | |9;json-stringify-tinderbox;37;38;38;36;37;37;38;37;37;37 03:50:07 INFO - PID 14722 | |10;stanford-crypto-aes;75;76;74;75;76;75;73;73;74;75 03:50:07 INFO - PID 14722 | |11;stanford-crypto-ccm;122;124;120;127;116;120;116;123;123;155 03:50:07 INFO - PID 14722 | |12;stanford-crypto-pbkdf2;178;177;173;177;170;172;171;177;171;175 03:50:07 INFO - PID 14722 | |13;stanford-crypto-sha256-iterative;65;70;67;63;70;66;64;64;65;62 03:50:07 INFO - PID 14722 | __end_tp_report 03:50:07 INFO - PID 14722 | __start_cc_report 03:50:07 INFO - PID 14722 | _x_x_mozilla_cycle_collect,912 03:50:07 INFO - PID 14722 | __end_cc_report 03:50:07 INFO - PID 14722 | __startTimestamp1504608607460__endTimestamp 03:50:07 INFO - PID 14722 | 03:50:07 INFO - PID 14722 | ------- Summary: start ------- 03:50:07 INFO - PID 14722 | Number of tests: 14 03:50:07 INFO - PID 14722 | 03:50:07 INFO - PID 14722 | [#0] ai-astar Cycles:10 Average:104.90 Median:109.50 stddev:4.75 (4.3%) stddev-sans-first:4.53 03:50:07 INFO - PID 14722 | Values: 99.0 106.0 99.0 108.0 107.0 111.0 107.0 97.0 107.0 108.0 03:50:07 INFO - PID 14722 | 03:50:07 INFO - PID 14722 | [#1] audio-beat-detection Cycles:10 Average:139.50 Median:144.50 stddev:20.58 (14.2%) stddev-sans-first:21.59 03:50:07 INFO - PID 14722 | Values: 148.0 115.0 145.0 171.0 117.0 144.0 142.0 120.0 170.0 123.0 03:50:07 INFO - PID 14722 | 03:50:07 INFO - PID 14722 | [#2] audio-dft Cycles:10 Average:164.70 Median:163.00 stddev:4.55 (2.8%) stddev-sans-first:4.78 03:50:07 INFO - PID 14722 | Values: 163.0 164.0 163.0 162.0 161.0 163.0 162.0 171.0 175.0 163.0 03:50:07 INFO - PID 14722 | 03:50:07 INFO - PID 14722 | [#3] audio-fft Cycles:10 Average:87.20 Median:74.50 stddev:29.14 (39.1%) stddev-sans-first:30.52 03:50:07 INFO - PID 14722 | Values: 74.0 77.0 73.0 167.0 74.0 75.0 74.0 88.0 97.0 73.0 03:50:07 INFO - PID 14722 | 03:50:07 INFO - PID 14722 | [#4] audio-oscillator Cycles:10 Average:96.70 Median:79.00 stddev:28.80 (36.5%) stddev-sans-first:29.91 03:50:07 INFO - PID 14722 | Values: 80.0 79.0 155.0 80.0 79.0 79.0 131.0 79.0 80.0 125.0 03:50:07 INFO - PID 14722 | 03:50:07 INFO - PID 14722 | [#5] imaging-gaussian-blur Cycles:10 Average:114.60 Median:114.50 stddev:1.71 (1.5%) stddev-sans-first:1.80 03:50:07 INFO - PID 14722 | Values: 114.0 115.0 115.0 115.0 113.0 114.0 114.0 113.0 119.0 114.0 03:50:07 INFO - PID 14722 | 03:50:07 INFO - PID 14722 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:148.50 stddev:1.43 (1.0%) stddev-sans-first:1.51 03:50:07 INFO - PID 14722 | Values: 149.0 149.0 148.0 148.0 148.0 147.0 147.0 148.0 152.0 149.0 03:50:07 INFO - PID 14722 | 03:50:07 INFO - PID 14722 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 03:50:07 INFO - PID 14722 | Values: 94.0 94.0 95.0 95.0 93.0 94.0 94.0 94.0 94.0 94.0 03:50:07 INFO - PID 14722 | 03:50:07 INFO - PID 14722 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:53.00 stddev:0.67 (1.3%) stddev-sans-first:0.60 03:50:07 INFO - PID 14722 | Values: 54.0 53.0 54.0 53.0 53.0 53.0 52.0 52.0 53.0 53.0 03:50:07 INFO - PID 14722 | 03:50:07 INFO - PID 14722 | [#9] json-stringify-tinderbox Cycles:10 Average:37.20 Median:37.00 stddev:0.63 (1.7%) stddev-sans-first:0.67 03:50:07 INFO - PID 14722 | Values: 37.0 38.0 38.0 36.0 37.0 37.0 38.0 37.0 37.0 37.0 03:50:07 INFO - PID 14722 | 03:50:07 INFO - PID 14722 | [#10] stanford-crypto-aes Cycles:10 Average:74.60 Median:75.00 stddev:1.07 (1.4%) stddev-sans-first:1.13 03:50:07 INFO - PID 14722 | Values: 75.0 76.0 74.0 75.0 76.0 75.0 73.0 73.0 74.0 75.0 03:50:07 INFO - PID 14722 | 03:50:07 INFO - PID 14722 | [#11] stanford-crypto-ccm Cycles:10 Average:124.60 Median:123.00 stddev:11.22 (9.1%) stddev-sans-first:11.86 03:50:07 INFO - PID 14722 | Values: 122.0 124.0 120.0 127.0 116.0 120.0 116.0 123.0 123.0 155.0 03:50:07 INFO - PID 14722 | 03:50:07 INFO - PID 14722 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.10 Median:176.00 stddev:3.03 (1.7%) stddev-sans-first:2.87 03:50:07 INFO - PID 14722 | Values: 178.0 177.0 173.0 177.0 170.0 172.0 171.0 177.0 171.0 175.0 03:50:07 INFO - PID 14722 | 03:50:07 INFO - PID 14722 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:65.50 stddev:2.72 (4.1%) stddev-sans-first:2.87 03:50:07 INFO - PID 14722 | Values: 65.0 70.0 67.0 63.0 70.0 66.0 64.0 64.0 65.0 62.0 03:50:07 INFO - PID 14722 | -------- Summary: end -------- 03:50:07 INFO - PID 14722 | 03:50:07 INFO - PID 14722 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:50:08 INFO - TEST-INFO | 14722: exit 0 03:50:08 INFO - TEST-OK | kraken | took 61939ms 03:50:08 INFO - SUITE-END | took 1174s 03:50:08 INFO - Completed test suite (00:19:34) 03:50:08 INFO - javascript benchmark 03:50:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8677.435600742898, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3365.6466071062537, 3375.1730825947648, 3386.2211691311, 3403.3873902697505, 3419.247765491591, 6420.133282006939, 6503.609783412992, 6521.5108866835, 6558.475321974242, 6585.967070164655, 6368.0, 6460.483161347092, 6466.191726034246, 6475.384838440353, 6502.414782669559, 5947.375525569807, 5949.0, 5965.582409231356, 5978.073398623221, 5978.671173085479, 5975.25309336333, 5979.611325263866, 5992.9700351498395, 6025.066114752199, 6044.727987240584, 5966.582339236255, 6009.609375390607, 6024.307204671475, 6028.367021462749, 6107.022876339786, 5745.253117094792, 5979.850503737398, 5996.640201587918, 6000.0, 6053.394660533955, 5361.635674831532, 5838.386969368197, 5862.70686465675, 5895.145203945447, 5994.67029313392, 6447.129637498924, 6459.515536334794, 6465.806025819186, 6572.507061970371, 6580.769673061468, 6829.009793579953, 6864.4165245954155, 6939.132608423947, 7048.259932707095, 7053.400460960825, 7035.68339424722, 7037.648117594151, 7041.2606676298765, 7048.612326322051, 7053.153621565394, 6486.837829054264, 6526.379993900572, 6562.704678289489, 6565.573237739532, 6573.3426657333885, 7172.7089123958185, 7199.0, 7205.567665939955, 7216.458765592602, 7296.124465064227, 6679.131712877392, 6754.898676519856, 6877.277885821916, 6951.65241737911, 6956.617386043817, 6908.240093589701, 6960.129983752031, 7012.894806577905, 7017.508774385744, 7073.257307982691, 6923.896141557881, 6926.411255043277, 7007.859842803217, 7029.92970070303, 7033.120859892513, 6949.0, 6962.199347075049, 7058.400035996895, 7068.893966590505, 7076.610786406797, 5073.239014147834, 5105.132127538327, 5135.306733590992, 5135.871603209875, 5136.666116702402, 4506.098780243964, 4549.0447006128425, 4556.066006468666, 4585.266357382803, 4590.563896429834, 5917.112433134978, 5959.582829201914, 5998.3701711320555, 6023.186869772525, 6023.307319658208, 6793.490488213404, 6794.320567943166, 6801.5238933274195, 6803.591784492946, 6812.420944219698, 5903.144044113579, 5905.940940590625, 5908.527317814564, 5912.852178695567, 5958.761649534057, 5868.2664666916635, 5869.970650146722, 5871.853203669943, 5907.881842363215, 6031.366706495843, 6802.65986700663, 6810.012548180585, 6868.484863635247, 6874.106366172466, 6888.0, 6878.55289406187, 7014.894776578458, 7022.789316320519, 7095.716171353088, 7101.254368291255, 6730.293319201413, 6731.932680673131, 6735.25912149673, 6742.190937087581, 6747.156605424322, 6787.864242715217, 6842.657867106525, 6889.311068893271, 6944.4791640626145, 6952.374286314256, 7011.26381729911, 7022.33287837675, 7082.787516374517, 7102.3962963148715, 7104.715811367694, 6624.436922861611, 6690.498212633975, 6726.327367263235, 6759.121314229119, 6852.383285504328, 6638.701258443478, 6642.070110184482, 6651.268360480247, 6661.3338666132995, 6661.633610151488, 6531.673416329069, 6575.638339891352, 6577.572457790228, 6596.274409815012, 6631.270560238467, 6643.833904152435, 6727.26000139994, 6751.156105486814, 6817.454603631797, 6872.725090996304, 6453.09656648079, 6454.19322584677, 6540.0, 6540.051692504465, 6602.207735071822], "value": 6312.064567624958, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [769.2192424688942, 813.9389545784068, 849.3714651158142, 870.8345414371269, 876.6668665906957, 39882.2023559529, 40713.18573628525, 40934.795326023406, 40970.180596388054, 41058.79470602643, 36814.8159259204, 37078.62921370792, 37130.25739485215, 37163.62836371636, 37169.0, 6922.757703480392, 6981.127359080115, 7024.157101147869, 7028.753993610199, 7037.401820845234, 6914.861702765942, 7000.229974702778, 7001.824954376156, 7004.054452648904, 7005.124359455068, 7552.622368881562, 7712.922870771276, 7718.575478348688, 7722.304992550669, 7727.072751269828, 7614.0, 7670.693172273131, 7676.9616151919445, 7677.69289228433, 7678.040244969379, 7402.592857392895, 7519.849603007964, 7569.583672897988, 7577.734779282699, 7586.203448637869, 37040.444393333855, 37334.43998340027, 37406.81296593527, 37424.62575374239, 37486.250274994345, 3483.076984599083, 3529.4176460883923, 3532.5407696999227, 3533.805640689761, 3534.3284775892757, 30971.535426968614, 31002.224944376572, 31062.37875242505, 31076.68923310783, 31108.844455777802, 5057.0, 5089.567386772129, 5090.414602320743, 5103.8213662522, 5111.4121875984365, 225866.0, 227214.0, 228572.0, 229036.0, 229322.0, 47452.762736186785, 48162.27756583584, 48322.999999999294, 48560.7571962145, 48850.26724599134, 50454.747726261136, 50464.49535504671, 50469.0, 50507.24239136416, 50570.241446378335, 15792.21038948048, 15842.0, 15880.841191588168, 15885.602859928595, 15888.44390446352, 12831.550895718792, 12843.807342889864, 12850.164739291917, 12860.164089334163, 12937.935310323388, 14116.364763585663, 14125.364358603887, 14159.64600884986, 14225.288735563181, 14242.643933901529, 5602.943970560324, 5647.350554686263, 5668.744906479218, 5688.40271771458, 5704.372519022904, 1012.696191142669, 1017.9083882450615, 1024.0527512051324, 1027.3219675014454, 1031.4327120083924, 22832.200872969366, 23610.29169124929, 28997.0, 29149.0, 29417.264568385963, 1067.6636859389268, 1077.6389909380446, 1115.7991561518843, 1115.9721006974892, 1120.9159313051555, 12166.57416990401, 12410.255384676948, 12434.502619895284, 12442.615007268429, 12502.3123728194, 233298.0, 235989.0, 236308.0, 236322.0, 237448.0, 49964.75017624888, 50786.492135078915, 55130.72434637801, 56296.155557666665, 56378.71810641002, 1415.2357726827397, 1434.2828585707146, 1438.388684808931, 1446.6600348917996, 1458.795768592398, 26649.200523984313, 26878.865605671846, 26911.596326054732, 27084.32289192786, 27788.58317125204, 48934.26598600952, 49505.25742113799, 49509.75245123752, 49538.25692614542, 49570.25644615261, 206879.0, 209576.0, 209733.0, 209915.0, 210321.0, 32863.0, 34624.82687586546, 34631.480527792606, 34713.13217169591, 34924.65075349214, 42401.57598423976, 42520.362194566485, 42860.571394286904, 43036.139277214905, 43177.35233971556, 31814.363712726077, 32054.519182212753, 32087.197820054684, 32503.349933000736, 32833.34333313368, 30648.0, 30870.382592348476, 31110.0, 31131.37737245197, 31323.68676313208, 35674.46488302729, 35830.46254306239, 35839.0, 35849.46225806563, 35941.460878087375, 30201.0, 30504.694953050184, 30523.38953220879, 30797.538036929913, 30927.84536077305, 23364.415889602897, 23409.60335276208, 23452.296431107094, 23627.40931476727, 23987.64018539758], "value": 17306.171990664512, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.3399788249864, 576.6799426318394, 578.7598146769091, 582.4845012164236, 589.1751547833034, 21683.67474487884, 22313.888430557825, 22635.094596216153, 22699.432514187134, 22757.886210568966, 25073.49853002939, 25766.227013189633, 25794.871025644894, 25920.35199120023, 25921.740782592216, 6516.315786842372, 6650.667466626674, 6658.434033107192, 6662.467002639777, 6671.099401580797, 6229.781957631484, 6474.708638111297, 6506.186726659168, 6573.802785916406, 6575.178102737158, 6492.967535162317, 6502.869942601145, 6505.902411463831, 6539.803805885807, 6541.116949211867, 6526.54314198004, 6564.277929427783, 6564.376384243489, 6572.277049524549, 6584.670766461706, 6065.938460769392, 6104.908426373608, 6118.0, 6132.202813634243, 6137.508999280047, 27831.16506504808, 28236.15291541257, 28811.71188288111, 29251.41497170066, 29370.85314573435, 2013.5469519358173, 2061.7732049474544, 2061.7835127311564, 2062.061761898333, 2065.4113577630305, 18805.341813036615, 19503.219871205136, 19517.0, 19520.219191232332, 19534.0, 2384.988075059631, 2422.588160012802, 2477.4797292568583, 2516.421223118693, 2543.4913017396593, 125802.0, 130560.0, 130827.0, 131474.0, 131579.0, 14060.945429092859, 14880.776788348183, 14948.32732527039, 14984.400623975136, 15149.0, 22517.211897583835, 23310.65034024491, 23429.7657023431, 23540.176093836977, 23777.286681399586, 9367.156955873868, 9417.199538039344, 9609.9039009609, 9614.615415383307, 9702.175315098295, 8411.242988131098, 8473.872891906627, 8561.315094792402, 8576.871346929802, 8578.227959483676, 9017.549122543847, 9076.31927605419, 9150.496722680316, 9198.402103863227, 9392.389494682824, 2513.3339664988794, 2527.646129541866, 2591.313301974978, 2618.6988496323165, 2687.5162470755063, 962.0908241711655, 967.1827305926481, 999.5252255178732, 1000.4197565412044, 1000.949952502372, 19501.902490487457, 20099.497512562302, 20428.591428171352, 23891.436928556395, 25115.372115697253, 1029.5212726082407, 1043.6138628707427, 1051.5530899367739, 1068.983965240522, 1069.6951368859839, 11182.217244792786, 11445.542178312775, 11484.0, 11710.414479276173, 11769.293842369485, 463684.0, 465098.0, 469883.0, 473300.0, 486148.0, 125065.0, 125750.371248145, 126779.0, 129686.0, 131088.0, 1207.3057991654834, 1229.0474881966368, 1243.1173866554848, 1246.1152581666936, 1247.3015111537568, 18444.35444759427, 18708.345207917657, 18910.432687019413, 21483.248086316904, 22338.664920025887, 41889.0, 50814.491855080974, 58167.0, 59950.70024649849, 61207.0, 67774.0, 68265.65867170831, 69023.0, 69069.3093069083, 76330.61834690791, 14728.116313021254, 14970.850291496945, 15047.473338433103, 15051.548453546411, 15119.0, 23570.646440303753, 23574.0, 23579.174728884405, 23667.28998130059, 23830.16594419187, 18696.53258668544, 18744.0, 18790.718139228196, 18792.530186744894, 18805.204672808348, 16573.50279491617, 17093.658126837643, 17319.393821216196, 17489.125543723017, 17825.73261401054, 17710.380136695152, 18538.814611853708, 20145.194192232146, 20254.392368228386, 20278.188872445528, 14186.29068546548, 14747.778783318045, 14994.47519336818, 15017.02389344689, 15024.0, 18616.16227269803, 18926.242950282387, 18946.147423366256, 19050.0, 19127.23491060342], "value": 12057.326343728793, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1331.960041198764, 1370.5956742760884, 1372.5196181336532, 1382.2881216173673, 1394.177435313165, 14916.403343866246, 15534.145621990787, 15641.765373519407, 15651.608709782262, 15658.373665053412, 14875.404983800636, 16007.35970561179, 16013.11927843968, 16021.599460013476, 16047.197640118005, 2777.7083406242355, 2858.1711303721895, 2861.1988643179943, 2871.109955913663, 2872.1383584924542, 2740.8081434299606, 2822.1251412062225, 2823.378856651533, 2823.7882158838065, 2824.4915915135266, 2695.2857492764433, 2794.0, 2833.0792492439937, 2840.0485837244446, 2842.9004984825533, 2703.621492990983, 2744.4373903349765, 2762.2265765585666, 2762.6132341472107, 2764.3918337965615, 2634.776044036259, 2667.8932842686268, 2675.5852842809395, 2679.169457468191, 2693.2189664997322, 14763.261836908112, 14797.630059248604, 14828.925855370655, 14890.851091489054, 14896.0, 7958.522488650699, 8192.426530142893, 8193.631286592057, 8207.917920820775, 8223.21879421454, 5089.160288552384, 5286.629935904488, 5432.6740395576, 5434.538064264502, 5469.617126801126, 1900.6863867461852, 1928.4696708405302, 1932.5941552273898, 1996.2514057228539, 2018.1725492547985, 26111.608325875128, 26185.73814261852, 26308.73691263082, 26311.868440657676, 26324.21027369182, 6658.9001164982565, 6702.497312701566, 6703.731850725916, 6886.621235831977, 7055.188653304833, 16880.493585192464, 16908.0, 16908.239129239213, 17015.404460843813, 17050.31798728037, 7892.816077588408, 8081.555514446644, 8083.676652933935, 8084.82769998347, 8086.353091752646, 5926.851828704317, 6027.517798576104, 6648.933510664928, 7379.594122323217, 7589.316961473494, 4984.800607975641, 5146.330976972969, 5170.457102004236, 5197.766100525486, 5250.159974404077, 1459.3360021190333, 1487.7545205041263, 1492.5522343296968, 1495.7083368743208, 1515.0379509011857, 912.6030176873081, 935.5415846235296, 942.29328003997, 944.504135328944, 946.6733976778, 7695.192004839411, 7780.066392032993, 7819.6481158348015, 7843.607819608997, 7988.440809143421, 716.6022857314241, 719.5251134251369, 730.868443680132, 738.3834498194068, 984.5766320482118, 5274.7626356814035, 5350.411454739976, 5576.860578485489, 5606.6636001840025, 5849.356570777296, 20980.47548811292, 21104.261350852645, 21912.12351505954, 22150.33548993533, 22206.0, 21887.0, 21915.890420547796, 21978.0, 22358.441038974157, 22386.44033899133, 10952.34285942846, 11198.888011119947, 11291.717707057389, 11389.544418223179, 11415.0, 8259.917400826154, 8533.359998000298, 8562.400631955703, 8686.956565217133, 8802.64789408442, 18047.36834210849, 18567.44297671072, 18607.81392186115, 18975.0, 19184.0, 19194.616107678048, 19222.0, 19436.125374357904, 19721.21115155435, 19737.309194178135, 10921.890781092088, 11295.322280663186, 11299.887001129884, 11310.4910279036, 11312.321260724382, 13687.520936767165, 13880.375383107583, 13962.092463989808, 14055.929720351332, 14096.718065638835, 11295.152863535104, 11324.094072474347, 11479.311241325548, 11681.88318116808, 11888.643340699793, 10454.640896683382, 10507.579696812041, 10576.101031412109, 10618.575256989634, 10728.570857165625, 10130.696079117639, 10144.644937427154, 10395.636152734618, 10426.947865260625, 10444.63443779464, 7105.893411598933, 7126.679299431435, 7129.893051604126, 7184.353408193288, 7194.604296763729, 7182.138143422822, 7182.3894968928225, 7218.3503484686635, 7225.963870180615, 7330.560166390033], "value": 6671.9702049303105, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [504.51818513319773, 506.99239511407313, 531.3676724697611, 537.4867002013076, 543.8966596346694, 6397.8080657580285, 6420.935790642092, 6447.419732224104, 6503.0, 6590.736370545178, 6319.98680837668, 6387.616742995424, 6453.161089058416, 6468.159139311882, 6492.500387350869, 5265.18389649603, 5319.255304257407, 5319.335083114611, 5366.785328586871, 5388.0, 5160.948390516103, 5220.164773636219, 5327.760250788724, 5384.973075134619, 5393.838184854441, 5288.92066619001, 5308.973455132719, 5336.519713225809, 5351.57187425007, 5396.406395296514, 5359.303290572239, 5375.516203541661, 5392.595555333346, 5426.782928682848, 5432.619716619838, 4944.752762361867, 4979.381700947207, 5018.071656743514, 5019.4227663818765, 5039.44566097729, 6392.968035159794, 6460.3862633049785, 6461.224653041618, 6489.805305840832, 6508.869822603521, 6197.721102550351, 6250.0, 6250.249970003629, 6290.9685451572905, 6300.0, 6744.156980377453, 6836.794896153074, 6857.588544687334, 6885.827854303632, 6908.965455172692, 5418.864528386783, 5435.402105768362, 5462.426445223274, 5462.617616766828, 5471.179323101527, 7112.928870711278, 7156.318265207724, 7241.2396698346965, 7262.745803896891, 7271.0, 5598.300212473441, 5628.915566266509, 5629.915551266734, 5641.661500309994, 5664.405237450009, 5663.546916246691, 5758.193852860602, 5764.625299355528, 5777.537796976232, 5782.479576838105, 6167.383261673796, 6250.937490625036, 6268.623882567061, 6291.937080629226, 6302.306746257908, 6581.572197807127, 6715.865682686319, 6750.426213771884, 6844.315568443216, 6946.756863509753, 1877.2303355624128, 1895.289266525053, 1969.2516843599626, 2005.2480319880044, 2009.8392128629675, 1450.708869106496, 1457.9489717859824, 1459.4599998000808, 1476.3946781819402, 1488.3079368093888, 5813.912791308134, 5922.200502932049, 5949.464548190684, 5971.552133589911, 6011.0, 6874.731338658231, 6917.342852429011, 6924.203716572558, 6954.687039083254, 7020.648967551602, 5962.701864906738, 5978.624916269196, 5983.940160598426, 5994.700264986734, 6062.120992456069, 3624.5831729350934, 3695.4456831474954, 3708.8516459341863, 3712.5730540988134, 3728.422094575345, 6657.367550082831, 6686.96656516724, 6751.122354093936, 6779.6271205084195, 6779.966100169566, 7036.0, 7061.717531298793, 7150.9284907151305, 7155.141383034069, 7231.385332246713, 6615.735370585123, 6679.699413526403, 6708.6310252936555, 6750.084950728566, 6793.660316984131, 6903.89644155328, 6977.511574189961, 6978.337057979484, 6979.30206979298, 7008.579485230903, 6914.9654251730435, 6946.65266736651, 6949.791506254821, 6956.539126783432, 7012.141782427762, 6735.5958642479645, 6749.763758268437, 6762.932370676427, 6793.490488213305, 6799.456043516606, 5148.665336753099, 5187.974060129826, 5191.897281600957, 5219.947800522098, 5225.320708307896, 6688.799336019927, 6832.350926661959, 6963.0, 7012.964935175291, 7060.576365418091, 6578.342165783383, 6621.404073633204, 6685.431738302299, 6737.764178253738, 6784.0, 6567.9014814778775, 6585.440237579668, 6703.530752847254, 6723.159605049369, 6767.729290828312, 6395.296517382991, 6539.7384104637185, 6577.2436169841085, 6578.276389597237, 6612.206535215805, 6640.535162538769, 6685.130932978682, 6740.427063699444, 6778.356056174655, 6812.693428795816, 6367.439977205614, 6448.967755161382, 6452.773613193403, 6531.608103513804, 6556.409923106943], "value": 5350.383786829894, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [881.1540920716112, 885.3669626217253, 896.2529846021938, 906.8277027364799, 916.0381599320712, 17668.469945901626, 18442.17010234541, 18493.53766155847, 18554.072296385195, 21857.234996775114, 19446.805531944676, 19675.212991480323, 19961.900190499062, 19976.400707978784, 20036.0983755731, 750.0324581290129, 764.3197554176787, 966.0484422843493, 985.4924713772413, 991.1278075293732, 995.2336700740426, 998.0, 998.935069220502, 1000.1099021870541, 1000.5647543318644, 1040.251019266131, 1046.4401545173334, 1048.0567489259652, 1048.7745134796016, 1051.4427353502656, 1037.232447988487, 1037.2946396450411, 1037.9117774989136, 1039.974000649986, 1043.1498328861992, 764.8279137194143, 765.0933643632313, 765.2003656179306, 765.3188662090744, 768.4275214964887, 18288.63422731538, 19173.904130479397, 19286.614267714707, 19339.51651208731, 19456.805431945784, 20830.37508874736, 21280.574388512145, 21292.148314067417, 21298.0, 21907.342779716633, 17462.91268543649, 17490.912545437317, 17497.037662928535, 17607.735883961752, 17616.91191544047, 3833.3483307837732, 3856.7107466940092, 3860.092878173627, 3860.5946375630433, 3862.343401621731, 123812.38093809474, 125793.37103314424, 126513.0, 126603.0, 127675.36162319222, 16999.150042497826, 17084.82915170857, 17394.47816565505, 17402.738958915626, 17506.29974801019, 30213.848930755204, 31023.224419389695, 31071.533926991113, 31167.376652467276, 31286.374272514422, 7842.333401660809, 8727.214550690342, 8869.600867960957, 8880.51157186348, 8894.199522043047, 3550.1302180965827, 3941.329973904386, 4118.238125946709, 4122.690798190148, 4135.110951145458, 5224.138017227115, 5286.788528458896, 5344.866378340573, 5347.545458635982, 5355.946440535623, 1061.7823346214007, 1084.2897901874285, 1085.5874767588266, 1086.364476781076, 1088.0479580367178, 638.958467699598, 650.5023656902473, 658.9011648252705, 664.6577012838392, 669.0666520204288, 10960.28758130719, 11305.434728263554, 11618.244814087057, 11778.469968851423, 12045.096617753703, 659.3604203922188, 660.3198705333514, 663.4857985061616, 670.0617790986462, 684.8287928017995, 5531.363893152339, 5555.972220138954, 5656.43435656431, 5746.511546518593, 5818.865321262398, 113734.0, 113965.4301728486, 114579.0, 115113.54659360232, 115686.42156789162, 101865.0, 101989.49005255074, 102611.0, 104794.47602761937, 107991.0, 90314.0, 90461.54769226111, 92837.53581232051, 94295.0, 96244.51877740707, 10508.264421490423, 10551.683449496528, 10584.629537966135, 10641.414722190353, 10827.133829293794, 42651.7867410661, 42827.357589636806, 43938.78030609954, 44022.11955760931, 44694.3295850556, 53880.0, 54131.18803217876, 55258.44741552533, 55628.0, 57676.13485797632, 18116.547086322946, 18694.626107477503, 18757.155927983, 18958.336458223897, 18964.336248231244, 19546.60906781885, 19730.802691972898, 19962.60074798525, 20229.291974780812, 20807.0, 18910.810891890906, 19154.7126793101, 19277.0, 19372.0, 19428.8057119427, 18039.63920721552, 18795.6240875179, 18907.71638425397, 19055.90472047631, 19199.52001199981, 17362.47912562625, 17409.825901741326, 17459.47621571355, 17636.470905872844, 17677.381291655245, 12071.75856482883, 12133.575324863587, 12438.0, 12553.686157846127, 12739.681507962376, 13087.672808179872, 13639.0, 14252.21612811264, 14495.20276384809, 14573.344199510835], "value": 9079.505217061585, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1479.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 106.0, 99.0, 108.0, 107.0, 111.0, 107.0, 97.0, 107.0, 108.0], "value": 104.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 115.0, 145.0, 171.0, 117.0, 144.0, 142.0, 120.0, 170.0, 123.0], "value": 139.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 162.0, 161.0, 163.0, 162.0, 171.0, 175.0, 163.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 73.0, 167.0, 74.0, 75.0, 74.0, 88.0, 97.0, 73.0], "value": 87.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 155.0, 80.0, 79.0, 79.0, 131.0, 79.0, 80.0, 125.0], "value": 96.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 115.0, 113.0, 114.0, 114.0, 113.0, 119.0, 114.0], "value": 114.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 148.0, 148.0, 148.0, 147.0, 147.0, 148.0, 152.0, 149.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 53.0, 53.0, 53.0, 52.0, 52.0, 53.0, 53.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 38.0, 38.0, 36.0, 37.0, 37.0, 38.0, 37.0, 37.0, 37.0], "value": 37.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 74.0, 75.0, 76.0, 75.0, 73.0, 73.0, 74.0, 75.0], "value": 74.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 124.0, 120.0, 127.0, 116.0, 120.0, 116.0, 123.0, 123.0, 155.0], "value": 124.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 177.0, 173.0, 177.0, 170.0, 172.0, 171.0, 177.0, 171.0, 175.0], "value": 174.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 70.0, 67.0, 63.0, 70.0, 66.0, 64.0, 64.0, 65.0, 62.0], "value": 65.6, "unit": "score"}]}]} 03:50:08 INFO - Return code: 0 03:50:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:50:08 INFO - # TBPL SUCCESS # 03:50:08 INFO - Running post-action listener: _package_coverage_data 03:50:08 INFO - Running post-action listener: _resource_record_post_action 03:50:08 INFO - [mozharness: 2017-09-05 10:50:08.751842Z] Finished run-tests step (success) 03:50:08 INFO - Running post-run listener: _resource_record_post_run 03:50:08 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 391561216; Read time: 20; Write time: 336460 03:50:08 INFO - TinderboxPrint: CPU usage
13.1% 03:50:08 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 03:50:08 INFO - TinderboxPrint: I/O write bytes / time
391,561,216 / 336,460 03:50:08 INFO - TinderboxPrint: CPU idle
8,248.1 (86.9%) 03:50:08 INFO - TinderboxPrint: CPU user
1,194.9 (12.6%) 03:50:08 INFO - TinderboxPrint: Swap in / out
0 / 0 03:50:08 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 106618880; Read time: 0; Write time: 112256 03:50:08 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:50:08 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284942336; Read time: 20; Write time: 224204 03:50:09 INFO - Running post-run listener: _upload_blobber_files 03:50:09 INFO - Blob upload gear active. 03:50:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:50:09 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 03:50:09 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'] 03:50:09 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 03:50:09 INFO - (blobuploader) - INFO - Open directory for files ... 03:50:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:50:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:50:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:50:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:50:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:50:16 INFO - (blobuploader) - INFO - Done attempting. 03:50:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:50:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:50:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:50:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:50:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:50:17 INFO - (blobuploader) - INFO - Done attempting. 03:50:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:50:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:50:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:50:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:50:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:50:18 INFO - (blobuploader) - INFO - Done attempting. 03:50:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:50:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:50:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:50:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:50:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:50:19 INFO - (blobuploader) - INFO - Done attempting. 03:50:19 INFO - (blobuploader) - INFO - Iteration through files over. 03:50:19 INFO - Return code: 0 03:50:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:50:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:50:19 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cdbef7e0fdaf47ef99d6828d95da350d1ced7923bce2ae4865c9c7e169d1a0e6e03a53239cdede893f380c4af7fd708dec1d940394c9fa4b19952125fb7839f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9406dccc78c373e581895cfbab91932e2903933d41bc57950160d8293ac1779de6dd474ca24f917a83868672f69bdd21868ebd8a02397ec4588c1069997c1783", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07c1a3eea5bd9b866dc1ef4ce6e6fe2f8e4713a564ab81dcefd0d3d5e4e48ff01eee69db15c37f84d0e7ed35a72d6820e8729ec0921238eafd9f94fd775ef09d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6332ed1eeddb4ba133c5dcf882ec3fbd2084fdc53d776fbc7f237afc8a3f2ffb913b62830acd33028787d941ec09da55e2df26c5a0dc789b0405bd509d7835d5"} 03:50:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:50:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:50:19 INFO - Contents: 03:50:19 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cdbef7e0fdaf47ef99d6828d95da350d1ced7923bce2ae4865c9c7e169d1a0e6e03a53239cdede893f380c4af7fd708dec1d940394c9fa4b19952125fb7839f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9406dccc78c373e581895cfbab91932e2903933d41bc57950160d8293ac1779de6dd474ca24f917a83868672f69bdd21868ebd8a02397ec4588c1069997c1783", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07c1a3eea5bd9b866dc1ef4ce6e6fe2f8e4713a564ab81dcefd0d3d5e4e48ff01eee69db15c37f84d0e7ed35a72d6820e8729ec0921238eafd9f94fd775ef09d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6332ed1eeddb4ba133c5dcf882ec3fbd2084fdc53d776fbc7f237afc8a3f2ffb913b62830acd33028787d941ec09da55e2df26c5a0dc789b0405bd509d7835d5"} 03:50:19 INFO - Running post-run listener: copy_logs_to_upload_dir 03:50:19 INFO - Copying logs to upload dir... 03:50:19 INFO - mkdir: /builds/slave/test/build/upload/logs 03:50:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.136596 ========= master_lag: 0.16 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-09-05 03:50:19.354781) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-05 03:50:19.363053) ========= 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=eca2ab57546de7b41f256b19000001ef-1504600297.951283-1085524231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cdbef7e0fdaf47ef99d6828d95da350d1ced7923bce2ae4865c9c7e169d1a0e6e03a53239cdede893f380c4af7fd708dec1d940394c9fa4b19952125fb7839f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9406dccc78c373e581895cfbab91932e2903933d41bc57950160d8293ac1779de6dd474ca24f917a83868672f69bdd21868ebd8a02397ec4588c1069997c1783", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07c1a3eea5bd9b866dc1ef4ce6e6fe2f8e4713a564ab81dcefd0d3d5e4e48ff01eee69db15c37f84d0e7ed35a72d6820e8729ec0921238eafd9f94fd775ef09d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6332ed1eeddb4ba133c5dcf882ec3fbd2084fdc53d776fbc7f237afc8a3f2ffb913b62830acd33028787d941ec09da55e2df26c5a0dc789b0405bd509d7835d5"} build_url:https://queue.taskcluster.net/v1/task/ERERdZfKQmW_skdNq1NZbA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011301 build_url: 'https://queue.taskcluster.net/v1/task/ERERdZfKQmW_skdNq1NZbA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cdbef7e0fdaf47ef99d6828d95da350d1ced7923bce2ae4865c9c7e169d1a0e6e03a53239cdede893f380c4af7fd708dec1d940394c9fa4b19952125fb7839f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9406dccc78c373e581895cfbab91932e2903933d41bc57950160d8293ac1779de6dd474ca24f917a83868672f69bdd21868ebd8a02397ec4588c1069997c1783", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07c1a3eea5bd9b866dc1ef4ce6e6fe2f8e4713a564ab81dcefd0d3d5e4e48ff01eee69db15c37f84d0e7ed35a72d6820e8729ec0921238eafd9f94fd775ef09d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6332ed1eeddb4ba133c5dcf882ec3fbd2084fdc53d776fbc7f237afc8a3f2ffb913b62830acd33028787d941ec09da55e2df26c5a0dc789b0405bd509d7835d5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-05 03:50:19.390526) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-05 03:50:19.393838) ========= 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=eca2ab57546de7b41f256b19000001ef-1504600297.951283-1085524231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004665 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-05 03:50:19.474236) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-05 03:50:19.474525) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-05 03:50:19.477806) ========= ========= Total master_lag: 0.35 =========