builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-087 starttime: 1504743234.59 results: success (0) revision: d8e238b811d3dc74515065ae8cab6c74baf0295f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-06 17:13:54.588621) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-06 17:13:54.589120) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-06 17:13:54.589406) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-06 17:13:54.606750) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 17:13:54.607036) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1504743233.781404-573586414 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-06 17:13:54-- 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% 46.9M=0s 2017-09-06 17:13:54 (46.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.164672 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 17:13:54.788801) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 17:13:54.789114) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1504743233.781404-573586414 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017693 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 17:13:54.838474) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 17:13:54.838812) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d8e238b811d3dc74515065ae8cab6c74baf0295f --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 d8e238b811d3dc74515065ae8cab6c74baf0295f --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=ca619d3d7d62c99d832f7b8a000001c4-1504743233.781404-573586414 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-06 17:13:54,893 truncating revision to first 12 chars 2017-09-06 17:13:54,893 Setting DEBUG logging. 2017-09-06 17:13:54,893 attempt 1/10 2017-09-06 17:13:54,893 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d8e238b811d3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-06 17:13:55,289 unpacking tar archive at: mozilla-central-d8e238b811d3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.698551 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 17:13:55.554711) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-06 17:13:55.555045) ========= script_repo_revision: d8e238b811d3dc74515065ae8cab6c74baf0295f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-06 17:13:55.555437) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-06 17:13:55.555709) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-06 17:13:55.568264) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-09-06 17:13:55.568629) ========= /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=ca619d3d7d62c99d832f7b8a000001c4-1504743233.781404-573586414 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:13:55 INFO - MultiFileLogger online at 20170906 17:13:55 in /builds/slave/test 17:13:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 17:13:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:13:55 INFO - {'append_to_log': False, 17:13:55 INFO - 'base_work_dir': '/builds/slave/test', 17:13:55 INFO - 'blob_upload_branch': 'Firefox', 17:13:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:13:55 INFO - 'branch': 'Firefox', 17:13:55 INFO - 'buildbot_json_path': 'buildprops.json', 17:13:55 INFO - 'code_coverage': False, 17:13:55 INFO - 'config_files': ('talos/linux_config.py',), 17:13:55 INFO - 'default_actions': ('clobber', 17:13:55 INFO - 'read-buildbot-config', 17:13:55 INFO - 'download-and-extract', 17:13:55 INFO - 'populate-webroot', 17:13:55 INFO - 'create-virtualenv', 17:13:55 INFO - 'install', 17:13:55 INFO - 'setup-mitmproxy', 17:13:55 INFO - 'run-tests'), 17:13:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:13:55 INFO - 'disable_ccov_upload': False, 17:13:55 INFO - 'disable_stylo': False, 17:13:55 INFO - 'download_minidump_stackwalk': True, 17:13:55 INFO - 'download_symbols': 'ondemand', 17:13:55 INFO - 'enable_stylo': False, 17:13:55 INFO - 'enable_webrender': False, 17:13:55 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 17:13:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:13:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:13:55 INFO - 'gecko_profile': False, 17:13:55 INFO - 'gecko_profile_interval': 0, 17:13:55 INFO - 'installer_path': 'installer.exe', 17:13:55 INFO - 'log_level': 'info', 17:13:55 INFO - 'log_name': 'talos', 17:13:55 INFO - 'log_to_console': True, 17:13:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:13:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:13:55 INFO - 'opt_config_files': (), 17:13:55 INFO - 'pip_index': False, 17:13:55 INFO - 'suite': 'dromaeojs-e10s', 17:13:55 INFO - 'system_bits': '32', 17:13:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:13:55 INFO - 'title': 'talos-linux64-ix-087', 17:13:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:13:55 INFO - 'use_talos_json': True, 17:13:55 INFO - 'verify': 'False', 17:13:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:13:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:13:55 INFO - 'work_dir': 'build'} 17:13:55 INFO - [mozharness: 2017-09-07 00:13:55.762491Z] Running clobber step. 17:13:55 INFO - Running pre-action listener: _resource_record_pre_action 17:13:55 INFO - Running main action method: clobber 17:13:55 INFO - rmtree: /builds/slave/test/build 17:13:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:13:56 INFO - Running post-action listener: _resource_record_post_action 17:13:56 INFO - [mozharness: 2017-09-07 00:13:56.902168Z] Finished clobber step (success) 17:13:56 INFO - [mozharness: 2017-09-07 00:13:56.902264Z] Running read-buildbot-config step. 17:13:56 INFO - Running pre-action listener: _resource_record_pre_action 17:13:56 INFO - Running main action method: read_buildbot_config 17:13:56 INFO - Using buildbot properties: 17:13:56 INFO - { 17:13:56 INFO - "project": "", 17:13:56 INFO - "product": "firefox", 17:13:56 INFO - "who": "kwierso@gmail.com", 17:13:56 INFO - "installer_path": "public/build/target.tar.bz2", 17:13:56 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 17:13:56 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:13:56 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 17:13:56 INFO - "stage_platform": "linux64-stylosequential", 17:13:56 INFO - "basedir": "/builds/slave/test", 17:13:56 INFO - "buildnumber": 234, 17:13:56 INFO - "platform": "ubuntu64_hw_styloseq", 17:13:56 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:13:56 INFO - "slavebuilddir": "test", 17:13:56 INFO - "taskId": "Nzw9EDT3RXC0g-w3mxoS8w", 17:13:56 INFO - "branch": "mozilla-central", 17:13:56 INFO - "script_repo_revision": "production", 17:13:56 INFO - "revision": "d8e238b811d3dc74515065ae8cab6c74baf0295f", 17:13:56 INFO - "slavename": "talos-linux64-ix-087", 17:13:56 INFO - "repo_path": "mozilla-central" 17:13:56 INFO - } 17:13:56 INFO - Finding installer, test and symbols from parent task. 17:13:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nzw9EDT3RXC0g-w3mxoS8w'}, attempt #1 17:13:57 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nzw9EDT3RXC0g-w3mxoS8w'}, attempt #1 17:13:57 INFO - Task dependencies: UKt4CYvxSaGZCXqv81saJw 17:13:57 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UKt4CYvxSaGZCXqv81saJw'}, attempt #1 17:13:58 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/UKt4CYvxSaGZCXqv81saJw/artifacts/public/build/target.tar.bz2 17:13:58 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/UKt4CYvxSaGZCXqv81saJw/artifacts/public/build/target.test_packages.json 17:13:58 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/UKt4CYvxSaGZCXqv81saJw/artifacts/public/build/target.crashreporter-symbols.zip 17:13:58 INFO - Running post-action listener: _resource_record_post_action 17:13:58 INFO - [mozharness: 2017-09-07 00:13:58.319217Z] Finished read-buildbot-config step (success) 17:13:58 INFO - [mozharness: 2017-09-07 00:13:58.319434Z] Running download-and-extract step. 17:13:58 INFO - Running pre-action listener: _resource_record_pre_action 17:13:58 INFO - Running main action method: download_and_extract 17:13:58 INFO - mkdir: /builds/slave/test/build/tests 17:13:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:13:58 INFO - trying https://queue.taskcluster.net/v1/task/UKt4CYvxSaGZCXqv81saJw/artifacts/public/build/target.test_packages.json 17:13:58 INFO - Downloading https://queue.taskcluster.net/v1/task/UKt4CYvxSaGZCXqv81saJw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:13:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UKt4CYvxSaGZCXqv81saJw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:13:58 INFO - Downloaded 989 bytes. 17:13:58 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:13:58 INFO - Using the following test package requirements: 17:13:58 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:13:58 INFO - u'common': [u'target.common.tests.zip'], 17:13:58 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:13:58 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:13:58 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:13:58 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:13:58 INFO - u'mozbase': [u'target.common.tests.zip'], 17:13:58 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:13:58 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:13:58 INFO - u'web-platform': [u'target.common.tests.zip', 17:13:58 INFO - u'target.web-platform.tests.tar.gz'], 17:13:58 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:13:58 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:13:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UKt4CYvxSaGZCXqv81saJw/artifacts/public/build/target.common.tests.zip 17:13:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UKt4CYvxSaGZCXqv81saJw/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:13:58 INFO - Fetch https://queue.taskcluster.net/v1/task/UKt4CYvxSaGZCXqv81saJw/artifacts/public/build/target.common.tests.zip into memory 17:14:00 INFO - Content-Length response header: 55021102 17:14:00 INFO - Bytes received: 55021102 17:14:10 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:14:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UKt4CYvxSaGZCXqv81saJw/artifacts/public/build/target.common.tests.zip 17:14:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UKt4CYvxSaGZCXqv81saJw/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:14:10 INFO - Fetch https://queue.taskcluster.net/v1/task/UKt4CYvxSaGZCXqv81saJw/artifacts/public/build/target.common.tests.zip into memory 17:14:12 INFO - Content-Length response header: 55021102 17:14:12 INFO - Bytes received: 55021102 17:14:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UKt4CYvxSaGZCXqv81saJw/artifacts/public/build/target.talos.tests.zip 17:14:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UKt4CYvxSaGZCXqv81saJw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:14:23 INFO - Fetch https://queue.taskcluster.net/v1/task/UKt4CYvxSaGZCXqv81saJw/artifacts/public/build/target.talos.tests.zip into memory 17:14:24 INFO - Content-Length response header: 14496665 17:14:24 INFO - Bytes received: 14496665 17:14:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:14:25 INFO - trying https://queue.taskcluster.net/v1/task/UKt4CYvxSaGZCXqv81saJw/artifacts/public/build/target.tar.bz2 17:14:25 INFO - Downloading https://queue.taskcluster.net/v1/task/UKt4CYvxSaGZCXqv81saJw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:14:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UKt4CYvxSaGZCXqv81saJw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:14:26 INFO - Downloaded 62756961 bytes. 17:14:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UKt4CYvxSaGZCXqv81saJw/artifacts/public/build/target.tar.bz2 17:14:26 INFO - mkdir: /builds/slave/test/properties 17:14:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:14:26 INFO - Writing to file /builds/slave/test/properties/build_url 17:14:26 INFO - Contents: 17:14:26 INFO - build_url:https://queue.taskcluster.net/v1/task/UKt4CYvxSaGZCXqv81saJw/artifacts/public/build/target.tar.bz2 17:14:26 INFO - Running post-action listener: _resource_record_post_action 17:14:26 INFO - Running post-action listener: find_tests_for_verification 17:14:26 INFO - Running post-action listener: set_extra_try_arguments 17:14:26 INFO - [mozharness: 2017-09-07 00:14:26.215917Z] Finished download-and-extract step (success) 17:14:26 INFO - [mozharness: 2017-09-07 00:14:26.216036Z] Running populate-webroot step. 17:14:26 INFO - Running pre-action listener: _resource_record_pre_action 17:14:26 INFO - Running main action method: populate_webroot 17:14:26 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:14:26 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:14:26 INFO - 'tests': ['tresize', 17:14:26 INFO - 'tcanvasmark']}, 17:14:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:14:26 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:14:26 INFO - 'tests': ['dromaeo_css', 17:14:26 INFO - 'kraken']}, 17:14:26 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:14:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:14:26 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:14:26 INFO - 'talos_options': ['--disable-stylo'], 17:14:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:14:26 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:14:26 INFO - 'tests': ['damp', 'tps']}, 17:14:26 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:14:26 INFO - 'talos_options': ['--disable-stylo'], 17:14:26 INFO - 'tests': ['damp', 'tps']}, 17:14:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:14:26 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:14:26 INFO - 'tests': ['dromaeo_dom']}, 17:14:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:14:26 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:14:26 INFO - 'tests': ['basic_compositor_video', 17:14:26 INFO - 'glvideo']}, 17:14:26 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:14:26 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:14:26 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:14:26 INFO - 'talos_options': ['--disable-stylo'], 17:14:26 INFO - 'tests': ['ts_paint_webext', 17:14:26 INFO - 'tp5o_webext']}, 17:14:26 INFO - 'other-e10s': {'tests': ['a11yr', 17:14:26 INFO - 'ts_paint', 17:14:26 INFO - 'tpaint', 17:14:26 INFO - 'sessionrestore', 17:14:26 INFO - 'sessionrestore_many_windows', 17:14:26 INFO - 'sessionrestore_no_auto_restore', 17:14:26 INFO - 'tabpaint']}, 17:14:26 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:14:26 INFO - 'tests': ['a11yr', 17:14:26 INFO - 'ts_paint', 17:14:26 INFO - 'tpaint', 17:14:26 INFO - 'sessionrestore', 17:14:26 INFO - 'sessionrestore_many_windows', 17:14:26 INFO - 'sessionrestore_no_auto_restore', 17:14:26 INFO - 'tabpaint']}, 17:14:26 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 17:14:26 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 17:14:26 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:14:26 INFO - 'tests': ['bloom_basic_singleton']}, 17:14:26 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:14:26 INFO - 'tests': ['bloom_basic']}, 17:14:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:14:26 INFO - 'tsvgr_opacity', 17:14:26 INFO - 'tart', 17:14:26 INFO - 'tscrollx', 17:14:26 INFO - 'tsvg_static']}, 17:14:26 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:14:26 INFO - 'tests': ['tsvgx', 17:14:26 INFO - 'tsvgr_opacity', 17:14:26 INFO - 'tart', 17:14:26 INFO - 'tscrollx', 17:14:26 INFO - 'tsvg_static']}, 17:14:26 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:14:26 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:14:26 INFO - 'talos_options': ['--disable-stylo'], 17:14:26 INFO - 'tests': ['tp5o']}, 17:14:26 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:14:26 INFO - 'talos_options': ['--mitmproxy', 17:14:26 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:14:26 INFO - '--firstNonBlankPaint'], 17:14:26 INFO - 'tests': ['tp6_google', 17:14:26 INFO - 'tp6_youtube', 17:14:26 INFO - 'tp6_amazon', 17:14:26 INFO - 'tp6_facebook']}, 17:14:26 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:14:26 INFO - 'talos_options': ['--disable-stylo', 17:14:26 INFO - '--mitmproxy', 17:14:26 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:14:26 INFO - '--firstNonBlankPaint'], 17:14:26 INFO - 'tests': ['tp6_google', 17:14:26 INFO - 'tp6_youtube', 17:14:26 INFO - 'tp6_amazon', 17:14:26 INFO - 'tp6_facebook']}, 17:14:26 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:14:26 INFO - 'talos_options': ['--stylo-threads=1', 17:14:26 INFO - '--mitmproxy', 17:14:26 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:14:26 INFO - '--firstNonBlankPaint'], 17:14:26 INFO - 'tests': ['tp6_google', 17:14:26 INFO - 'tp6_youtube', 17:14:26 INFO - 'tp6_amazon', 17:14:26 INFO - 'tp6_facebook']}, 17:14:26 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:14:26 INFO - 'talos_options': ['--xperf_path', 17:14:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:14:26 INFO - 'tests': ['tp5n']}, 17:14:26 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:14:26 INFO - 'talos_options': ['--disable-stylo', 17:14:26 INFO - '--xperf_path', 17:14:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:14:26 INFO - 'tests': ['tp5n']}}} 17:14:26 INFO - Running post-action listener: _resource_record_post_action 17:14:26 INFO - [mozharness: 2017-09-07 00:14:26.231030Z] Finished populate-webroot step (success) 17:14:26 INFO - [mozharness: 2017-09-07 00:14:26.231119Z] Running create-virtualenv step. 17:14:26 INFO - Running pre-action listener: _resource_record_pre_action 17:14:26 INFO - Running main action method: create_virtualenv 17:14:26 INFO - Creating virtualenv /builds/slave/test/build/venv 17:14:26 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:14:26 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 17:14:26 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:14:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:14:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:14:26 INFO - Installing distribute.............................................................................................................................................................................................done. 17:14:27 INFO - Installing pip...............done. 17:14:27 INFO - Return code: 0 17:14:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:14:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:14:27 INFO - Reading from file tmpfile_stdout 17:14:27 INFO - Output received: 17:14:27 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 17:14:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:14:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:14:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:14:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:27 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 0x1cbc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e85a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2028a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202c090>, '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 0x202cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2026f90>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1504743233.781404-573586414', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:14:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:14:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:14:27 INFO - Using env: {'DISPLAY': ':0', 17:14:27 INFO - 'HOME': '/home/cltbld', 17:14:27 INFO - 'LANG': 'en_US.UTF-8', 17:14:27 INFO - 'LANGUAGE': 'en_US:en', 17:14:27 INFO - 'LOGNAME': 'cltbld', 17:14:27 INFO - 'MAIL': '/var/mail/cltbld', 17:14:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:27 INFO - 'MOZ_NO_REMOTE': '1', 17:14:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:14:27 INFO - 'NO_EM_RESTART': '1', 17:14:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:14:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:27 INFO - 'PWD': '/builds/slave/test', 17:14:27 INFO - 'SHELL': '/bin/bash', 17:14:27 INFO - 'SHLVL': '1', 17:14:27 INFO - 'TERM': 'linux', 17:14:27 INFO - 'TMOUT': '86400', 17:14:27 INFO - 'USER': 'cltbld', 17:14:27 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1504743233.781404-573586414', 17:14:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:27 INFO - '_': '/tools/buildbot/bin/python'} 17:14:28 INFO - Ignoring indexes: http://pypi.python.org/simple/ 17:14:28 INFO - Downloading/unpacking pip>=1.5 17:14:28 INFO - Running setup.py egg_info for package pip 17:14:28 INFO - warning: no files found matching 'pip/cacert.pem' 17:14:28 INFO - warning: no files found matching '*.html' under directory 'docs' 17:14:28 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:14:28 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:14:28 INFO - Installing collected packages: pip 17:14:28 INFO - Found existing installation: pip 1.1 17:14:28 INFO - Uninstalling pip: 17:14:28 INFO - Successfully uninstalled pip 17:14:28 INFO - Running setup.py install for pip 17:14:28 INFO - warning: no files found matching 'pip/cacert.pem' 17:14:28 INFO - warning: no files found matching '*.html' under directory 'docs' 17:14:28 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:14:28 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:14:28 INFO - Installing pip script to /builds/slave/test/build/venv/bin 17:14:28 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 17:14:28 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 17:14:28 INFO - Successfully installed pip 17:14:28 INFO - Cleaning up... 17:14:28 INFO - Return code: 0 17:14:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:14:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:14:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:28 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 0x1cbc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e85a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2028a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202c090>, '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 0x202cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2026f90>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1504743233.781404-573586414', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:14:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:14:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:14:28 INFO - Using env: {'DISPLAY': ':0', 17:14:28 INFO - 'HOME': '/home/cltbld', 17:14:28 INFO - 'LANG': 'en_US.UTF-8', 17:14:28 INFO - 'LANGUAGE': 'en_US:en', 17:14:28 INFO - 'LOGNAME': 'cltbld', 17:14:28 INFO - 'MAIL': '/var/mail/cltbld', 17:14:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:28 INFO - 'MOZ_NO_REMOTE': '1', 17:14:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:14:28 INFO - 'NO_EM_RESTART': '1', 17:14:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:14:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:28 INFO - 'PWD': '/builds/slave/test', 17:14:28 INFO - 'SHELL': '/bin/bash', 17:14:28 INFO - 'SHLVL': '1', 17:14:28 INFO - 'TERM': 'linux', 17:14:28 INFO - 'TMOUT': '86400', 17:14:28 INFO - 'USER': 'cltbld', 17:14:28 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1504743233.781404-573586414', 17:14:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:28 INFO - '_': '/tools/buildbot/bin/python'} 17:14:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:28 INFO - Downloading/unpacking psutil>=3.1.1 17:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:14:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:14:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:14:29 INFO - Installing collected packages: psutil 17:14:29 INFO - Running setup.py install for psutil 17:14:29 INFO - building 'psutil._psutil_linux' extension 17:14:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:14:30 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:14:30 INFO - building 'psutil._psutil_posix' extension 17:14:30 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:14:30 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:14:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:14:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:14:30 INFO - Successfully installed psutil 17:14:30 INFO - Cleaning up... 17:14:30 INFO - Return code: 0 17:14:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:14: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')]} 17:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14: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')]} 17:14:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:30 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 0x1cbc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e85a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2028a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202c090>, '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 0x202cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2026f90>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1504743233.781404-573586414', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:14:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:14:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:14:30 INFO - Using env: {'DISPLAY': ':0', 17:14:30 INFO - 'HOME': '/home/cltbld', 17:14:30 INFO - 'LANG': 'en_US.UTF-8', 17:14:30 INFO - 'LANGUAGE': 'en_US:en', 17:14:30 INFO - 'LOGNAME': 'cltbld', 17:14:30 INFO - 'MAIL': '/var/mail/cltbld', 17:14:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:30 INFO - 'MOZ_NO_REMOTE': '1', 17:14:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:14:30 INFO - 'NO_EM_RESTART': '1', 17:14:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:14:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:30 INFO - 'PWD': '/builds/slave/test', 17:14:30 INFO - 'SHELL': '/bin/bash', 17:14:30 INFO - 'SHLVL': '1', 17:14:30 INFO - 'TERM': 'linux', 17:14:30 INFO - 'TMOUT': '86400', 17:14:30 INFO - 'USER': 'cltbld', 17:14:30 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1504743233.781404-573586414', 17:14:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:30 INFO - '_': '/tools/buildbot/bin/python'} 17:14:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:14:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:14:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:14:31 INFO - Installing collected packages: mozsystemmonitor 17:14:31 INFO - Running setup.py install for mozsystemmonitor 17:14:31 INFO - Successfully installed mozsystemmonitor 17:14:31 INFO - Cleaning up... 17:14:31 INFO - Return code: 0 17:14:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:14:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:31 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 0x1cbc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e85a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2028a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202c090>, '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 0x202cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2026f90>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1504743233.781404-573586414', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:14:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:14:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:14:31 INFO - Using env: {'DISPLAY': ':0', 17:14:31 INFO - 'HOME': '/home/cltbld', 17:14:31 INFO - 'LANG': 'en_US.UTF-8', 17:14:31 INFO - 'LANGUAGE': 'en_US:en', 17:14:31 INFO - 'LOGNAME': 'cltbld', 17:14:31 INFO - 'MAIL': '/var/mail/cltbld', 17:14:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:31 INFO - 'MOZ_NO_REMOTE': '1', 17:14:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:14:31 INFO - 'NO_EM_RESTART': '1', 17:14:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:14:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:31 INFO - 'PWD': '/builds/slave/test', 17:14:31 INFO - 'SHELL': '/bin/bash', 17:14:31 INFO - 'SHLVL': '1', 17:14:31 INFO - 'TERM': 'linux', 17:14:31 INFO - 'TMOUT': '86400', 17:14:31 INFO - 'USER': 'cltbld', 17:14:31 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1504743233.781404-573586414', 17:14:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:31 INFO - '_': '/tools/buildbot/bin/python'} 17:14:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:32 INFO - Downloading/unpacking jsonschema==2.5.1 17:14:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:14:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:14:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:33 INFO - Downloading functools32-3.2.3-2.tar.gz 17:14:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:14:33 INFO - warning: no files found matching '*.txt' 17:14:33 INFO - no previously-included directories found matching 'build' 17:14:33 INFO - no previously-included directories found matching 'dist' 17:14:33 INFO - no previously-included directories found matching '.git*' 17:14:33 INFO - Installing collected packages: jsonschema, functools32 17:14:33 INFO - Running setup.py install for functools32 17:14:33 INFO - warning: no files found matching '*.txt' 17:14:33 INFO - no previously-included directories found matching 'build' 17:14:33 INFO - no previously-included directories found matching 'dist' 17:14:33 INFO - no previously-included directories found matching '.git*' 17:14:33 INFO - Successfully installed jsonschema functools32 17:14:33 INFO - Cleaning up... 17:14:33 INFO - Return code: 0 17:14:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:14:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:14:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:14:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:33 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 0x1cbc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e85a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2028a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202c090>, '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 0x202cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2026f90>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1504743233.781404-573586414', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:14:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:14:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:14:33 INFO - Using env: {'DISPLAY': ':0', 17:14:33 INFO - 'HOME': '/home/cltbld', 17:14:33 INFO - 'LANG': 'en_US.UTF-8', 17:14:33 INFO - 'LANGUAGE': 'en_US:en', 17:14:33 INFO - 'LOGNAME': 'cltbld', 17:14:33 INFO - 'MAIL': '/var/mail/cltbld', 17:14:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:33 INFO - 'MOZ_NO_REMOTE': '1', 17:14:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:14:33 INFO - 'NO_EM_RESTART': '1', 17:14:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:14:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:33 INFO - 'PWD': '/builds/slave/test', 17:14:33 INFO - 'SHELL': '/bin/bash', 17:14:33 INFO - 'SHLVL': '1', 17:14:33 INFO - 'TERM': 'linux', 17:14:33 INFO - 'TMOUT': '86400', 17:14:33 INFO - 'USER': 'cltbld', 17:14:33 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1504743233.781404-573586414', 17:14:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:33 INFO - '_': '/tools/buildbot/bin/python'} 17:14:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:14:33 INFO - Cleaning up... 17:14:33 INFO - Return code: 0 17:14:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:14:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:14:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:14:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:33 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 0x1cbc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e85a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2028a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202c090>, '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 0x202cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2026f90>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1504743233.781404-573586414', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:14:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:14:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:14:33 INFO - Using env: {'DISPLAY': ':0', 17:14:33 INFO - 'HOME': '/home/cltbld', 17:14:33 INFO - 'LANG': 'en_US.UTF-8', 17:14:33 INFO - 'LANGUAGE': 'en_US:en', 17:14:33 INFO - 'LOGNAME': 'cltbld', 17:14:33 INFO - 'MAIL': '/var/mail/cltbld', 17:14:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:33 INFO - 'MOZ_NO_REMOTE': '1', 17:14:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:14:33 INFO - 'NO_EM_RESTART': '1', 17:14:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:14:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:33 INFO - 'PWD': '/builds/slave/test', 17:14:33 INFO - 'SHELL': '/bin/bash', 17:14:33 INFO - 'SHLVL': '1', 17:14:33 INFO - 'TERM': 'linux', 17:14:33 INFO - 'TMOUT': '86400', 17:14:33 INFO - 'USER': 'cltbld', 17:14:33 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1504743233.781404-573586414', 17:14:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:33 INFO - '_': '/tools/buildbot/bin/python'} 17:14:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:34 INFO - Downloading/unpacking blobuploader==1.2.4 17:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:35 INFO - Downloading blobuploader-1.2.4.tar.gz 17:14:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:14:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:14:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:14:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:14:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:35 INFO - Downloading docopt-0.6.1.tar.gz 17:14:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:14:35 INFO - Installing collected packages: blobuploader, requests, docopt 17:14:35 INFO - Running setup.py install for blobuploader 17:14:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:14:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:14:35 INFO - Running setup.py install for requests 17:14:36 INFO - Running setup.py install for docopt 17:14:36 INFO - Successfully installed blobuploader requests docopt 17:14:36 INFO - Cleaning up... 17:14:36 INFO - Return code: 0 17:14:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:14:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:14:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:36 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 0x1cbc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e85a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2028a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202c090>, '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 0x202cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2026f90>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1504743233.781404-573586414', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:14:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:14:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:14:36 INFO - Using env: {'DISPLAY': ':0', 17:14:36 INFO - 'HOME': '/home/cltbld', 17:14:36 INFO - 'LANG': 'en_US.UTF-8', 17:14:36 INFO - 'LANGUAGE': 'en_US:en', 17:14:36 INFO - 'LOGNAME': 'cltbld', 17:14:36 INFO - 'MAIL': '/var/mail/cltbld', 17:14:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:36 INFO - 'MOZ_NO_REMOTE': '1', 17:14:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:14:36 INFO - 'NO_EM_RESTART': '1', 17:14:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:14:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:36 INFO - 'PWD': '/builds/slave/test', 17:14:36 INFO - 'SHELL': '/bin/bash', 17:14:36 INFO - 'SHLVL': '1', 17:14:36 INFO - 'TERM': 'linux', 17:14:36 INFO - 'TMOUT': '86400', 17:14:36 INFO - 'USER': 'cltbld', 17:14:36 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1504743233.781404-573586414', 17:14:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:36 INFO - '_': '/tools/buildbot/bin/python'} 17:14:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:14:36 INFO - Running setup.py (path:/tmp/pip-LneHdi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:14:36 INFO - Running setup.py (path:/tmp/pip-AZ0mrl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:14:36 INFO - Running setup.py (path:/tmp/pip-VTOSOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:14:36 INFO - Running setup.py (path:/tmp/pip-wfjv7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:14:36 INFO - Running setup.py (path:/tmp/pip-AgKdvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:14:36 INFO - Running setup.py (path:/tmp/pip-CIv92Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:14:36 INFO - Running setup.py (path:/tmp/pip-zdY55I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:14:37 INFO - Running setup.py (path:/tmp/pip-U95TrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:14:37 INFO - Running setup.py (path:/tmp/pip-gQAfuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:14:37 INFO - Running setup.py (path:/tmp/pip-q6Arbl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:14:37 INFO - Running setup.py (path:/tmp/pip-0KHvEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:14:37 INFO - Running setup.py (path:/tmp/pip-R6xQF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:14:37 INFO - Running setup.py (path:/tmp/pip-9JCshs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:14:37 INFO - Running setup.py (path:/tmp/pip-HK7X3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:14:37 INFO - Running setup.py (path:/tmp/pip-wDpemk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:14:37 INFO - Running setup.py (path:/tmp/pip-8Uel8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:14:37 INFO - Running setup.py (path:/tmp/pip-54qvx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:14:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:14:37 INFO - Running setup.py install for manifestparser 17:14:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:14:37 INFO - Running setup.py install for mozcrash 17:14:37 INFO - Running setup.py install for mozdebug 17:14:38 INFO - Running setup.py install for mozdevice 17:14:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:14:38 INFO - Running setup.py install for mozfile 17:14:38 INFO - Running setup.py install for mozhttpd 17:14:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:14:38 INFO - Running setup.py install for mozinfo 17:14:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:14:38 INFO - Running setup.py install for mozInstall 17:14:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:14:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:14:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:14:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:14:38 INFO - Running setup.py install for mozleak 17:14:38 INFO - Running setup.py install for mozlog 17:14:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:14:38 INFO - Running setup.py install for moznetwork 17:14:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:14:38 INFO - Running setup.py install for mozprocess 17:14:39 INFO - Running setup.py install for mozprofile 17:14:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:14:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:14:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:14:39 INFO - Running setup.py install for mozrunner 17:14:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:14:39 INFO - Running setup.py install for mozscreenshot 17:14:39 INFO - Running setup.py install for moztest 17:14:39 INFO - Running setup.py install for mozversion 17:14:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:14:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:14:39 INFO - Cleaning up... 17:14:39 INFO - Return code: 0 17:14:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:14:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:14:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:39 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 0x1cbc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e85a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2028a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202c090>, '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 0x202cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2026f90>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1504743233.781404-573586414', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:14:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:14:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:14:39 INFO - Using env: {'DISPLAY': ':0', 17:14:39 INFO - 'HOME': '/home/cltbld', 17:14:39 INFO - 'LANG': 'en_US.UTF-8', 17:14:39 INFO - 'LANGUAGE': 'en_US:en', 17:14:39 INFO - 'LOGNAME': 'cltbld', 17:14:39 INFO - 'MAIL': '/var/mail/cltbld', 17:14:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:39 INFO - 'MOZ_NO_REMOTE': '1', 17:14:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:14:39 INFO - 'NO_EM_RESTART': '1', 17:14:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:14:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:39 INFO - 'PWD': '/builds/slave/test', 17:14:39 INFO - 'SHELL': '/bin/bash', 17:14:39 INFO - 'SHLVL': '1', 17:14:39 INFO - 'TERM': 'linux', 17:14:39 INFO - 'TMOUT': '86400', 17:14:39 INFO - 'USER': 'cltbld', 17:14:39 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1504743233.781404-573586414', 17:14:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:39 INFO - '_': '/tools/buildbot/bin/python'} 17:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:14:39 INFO - Running setup.py (path:/tmp/pip-hbvYFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:14:39 INFO - Running setup.py (path:/tmp/pip-SJWYVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:14:39 INFO - Running setup.py (path:/tmp/pip-j6kykD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:14:39 INFO - Running setup.py (path:/tmp/pip-_WWN4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:14:40 INFO - Running setup.py (path:/tmp/pip-F20fV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:14:40 INFO - Running setup.py (path:/tmp/pip-Qn5rV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:14:40 INFO - Running setup.py (path:/tmp/pip-jqyls3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:14:40 INFO - Running setup.py (path:/tmp/pip-B9uFPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:14:40 INFO - Running setup.py (path:/tmp/pip-Ei0WFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:14:40 INFO - Running setup.py (path:/tmp/pip-qeGoEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:14:40 INFO - Running setup.py (path:/tmp/pip-mKCGJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:14:40 INFO - Running setup.py (path:/tmp/pip-tkrq_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:14:40 INFO - Running setup.py (path:/tmp/pip-rXNVcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:14:40 INFO - Running setup.py (path:/tmp/pip-oJylZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:14:40 INFO - Running setup.py (path:/tmp/pip-mwjI5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:14:40 INFO - Running setup.py (path:/tmp/pip-BNWwz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:14:40 INFO - Running setup.py (path:/tmp/pip-OZJjPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:14:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:42 INFO - Downloading blessings-1.6.tar.gz 17:14:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:14:42 INFO - Installing collected packages: blessings 17:14:42 INFO - Running setup.py install for blessings 17:14:42 INFO - Successfully installed blessings 17:14:42 INFO - Cleaning up... 17:14:42 INFO - Return code: 0 17:14:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:14:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:14:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:14:42 INFO - Reading from file tmpfile_stdout 17:14:42 INFO - Current package versions: 17:14:42 INFO - argparse == 1.2.1 17:14:42 INFO - blessings == 1.6 17:14:42 INFO - blobuploader == 1.2.4 17:14:42 INFO - docopt == 0.6.1 17:14:42 INFO - functools32 == 3.2.3-2 17:14:42 INFO - jsonschema == 2.5.1 17:14:42 INFO - manifestparser == 1.1 17:14:42 INFO - mozInstall == 1.13 17:14:42 INFO - mozcrash == 1.0 17:14:42 INFO - mozdebug == 0.1 17:14:42 INFO - mozdevice == 0.51 17:14:42 INFO - mozfile == 1.2 17:14:42 INFO - mozhttpd == 0.7 17:14:42 INFO - mozinfo == 0.10 17:14:42 INFO - mozleak == 0.1 17:14:42 INFO - mozlog == 3.5 17:14:42 INFO - moznetwork == 0.27 17:14:42 INFO - mozprocess == 0.25 17:14:42 INFO - mozprofile == 0.28 17:14:42 INFO - mozrunner == 6.13 17:14:42 INFO - mozscreenshot == 0.1 17:14:42 INFO - mozsystemmonitor == 0.3 17:14:42 INFO - moztest == 0.8 17:14:42 INFO - mozversion == 1.4 17:14:42 INFO - psutil == 3.1.1 17:14:42 INFO - requests == 1.2.3 17:14:42 INFO - wsgiref == 0.1.2 17:14:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:14:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:42 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 0x1cbc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e85a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2028a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202c090>, '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 0x202cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2026f90>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1504743233.781404-573586414', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:14:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:14:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:14:42 INFO - Using env: {'DISPLAY': ':0', 17:14:42 INFO - 'HOME': '/home/cltbld', 17:14:42 INFO - 'LANG': 'en_US.UTF-8', 17:14:42 INFO - 'LANGUAGE': 'en_US:en', 17:14:42 INFO - 'LOGNAME': 'cltbld', 17:14:42 INFO - 'MAIL': '/var/mail/cltbld', 17:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:42 INFO - 'MOZ_NO_REMOTE': '1', 17:14:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:14:42 INFO - 'NO_EM_RESTART': '1', 17:14:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:42 INFO - 'PWD': '/builds/slave/test', 17:14:42 INFO - 'SHELL': '/bin/bash', 17:14:42 INFO - 'SHLVL': '1', 17:14:42 INFO - 'TERM': 'linux', 17:14:42 INFO - 'TMOUT': '86400', 17:14:42 INFO - 'USER': 'cltbld', 17:14:42 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1504743233.781404-573586414', 17:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:42 INFO - '_': '/tools/buildbot/bin/python'} 17:14:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:14:42 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:14:43 INFO - Installing collected packages: simplejson 17:14:43 INFO - Running setup.py install for simplejson 17:14:44 INFO - building 'simplejson._speedups' extension 17:14:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 17:14:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 17:14:44 INFO - Successfully installed simplejson 17:14:44 INFO - Cleaning up... 17:14:44 INFO - Return code: 0 17:14:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:14:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e85a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2028a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202c090>, '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 0x202cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2026f90>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1504743233.781404-573586414', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:14:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:14:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:14:44 INFO - Using env: {'DISPLAY': ':0', 17:14:44 INFO - 'HOME': '/home/cltbld', 17:14:44 INFO - 'LANG': 'en_US.UTF-8', 17:14:44 INFO - 'LANGUAGE': 'en_US:en', 17:14:44 INFO - 'LOGNAME': 'cltbld', 17:14:44 INFO - 'MAIL': '/var/mail/cltbld', 17:14:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:44 INFO - 'MOZ_NO_REMOTE': '1', 17:14:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:14:44 INFO - 'NO_EM_RESTART': '1', 17:14:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:14:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:44 INFO - 'PWD': '/builds/slave/test', 17:14:44 INFO - 'SHELL': '/bin/bash', 17:14:44 INFO - 'SHLVL': '1', 17:14:44 INFO - 'TERM': 'linux', 17:14:44 INFO - 'TMOUT': '86400', 17:14:44 INFO - 'USER': 'cltbld', 17:14:44 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1504743233.781404-573586414', 17:14:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:44 INFO - '_': '/tools/buildbot/bin/python'} 17:14:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:14:45 INFO - Cleaning up... 17:14:45 INFO - Return code: 0 17:14:45 INFO - Running post-action listener: _resource_record_post_action 17:14:45 INFO - Running post-action listener: _start_resource_monitoring 17:14:45 INFO - Starting resource monitoring. 17:14:45 INFO - [mozharness: 2017-09-07 00:14:45.238324Z] Finished create-virtualenv step (success) 17:14:45 INFO - [mozharness: 2017-09-07 00:14:45.238794Z] Running install step. 17:14:45 INFO - Running pre-action listener: _resource_record_pre_action 17:14:45 INFO - Running main action method: install 17:14:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:14:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:14:45 INFO - Reading from file tmpfile_stdout 17:14:45 INFO - Detecting whether we're running mozinstall >=1.0... 17:14:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:14:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:14:45 INFO - Reading from file tmpfile_stdout 17:14:45 INFO - Output received: 17:14:45 INFO - Usage: mozinstall [options] installer 17:14:45 INFO - Options: 17:14:45 INFO - -h, --help show this help message and exit 17:14:45 INFO - -d DEST, --destination=DEST 17:14:45 INFO - Directory to install application into. [default: 17:14:45 INFO - "/builds/slave/test"] 17:14:45 INFO - --app=APP Application being installed. [default: firefox] 17:14:45 INFO - mkdir: /builds/slave/test/build/application 17:14:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:14:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:15:02 INFO - Reading from file tmpfile_stdout 17:15:02 INFO - Output received: 17:15:02 INFO - /builds/slave/test/build/application/firefox/firefox 17:15:02 INFO - Running post-action listener: _resource_record_post_action 17:15:02 INFO - [mozharness: 2017-09-07 00:15:02.929067Z] Finished install step (success) 17:15:02 INFO - [mozharness: 2017-09-07 00:15:02.929319Z] Running setup-mitmproxy step. 17:15:02 INFO - Running pre-action listener: _resource_record_pre_action 17:15:02 INFO - Running main action method: setup_mitmproxy 17:15:02 INFO - Skipping: mitmproxy is not required 17:15:02 INFO - Running post-action listener: _resource_record_post_action 17:15:02 INFO - [mozharness: 2017-09-07 00:15:02.930466Z] Finished setup-mitmproxy step (success) 17:15:02 INFO - [mozharness: 2017-09-07 00:15:02.930683Z] Running run-tests step. 17:15:02 INFO - Running pre-action listener: _resource_record_pre_action 17:15:02 INFO - Running pre-action listener: _set_gcov_prefix 17:15:02 INFO - Running main action method: run_tests 17:15:02 WARNING - Try message not found. 17:15:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:15:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:15:02 INFO - Python 2.7.3 17:15:02 INFO - Return code: 0 17:15:02 INFO - grabbing minidump binary from tooltool 17:15:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:02 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 0x202c090>, '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 0x202cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2026f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:15:02 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:15:02 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:15:02 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:15:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:15:03 INFO - Return code: 0 17:15:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:15:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:15:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:15:03 INFO - ENV: RUST_BACKTRACE is now full 17:15:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:15:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:15:03 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/UKt4CYvxSaGZCXqv81saJw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-087', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:15:03 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/UKt4CYvxSaGZCXqv81saJw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-087 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:15:03 INFO - Using env: {'DISPLAY': ':0', 17:15:03 INFO - 'HOME': '/home/cltbld', 17:15:03 INFO - 'LANG': 'en_US.UTF-8', 17:15:03 INFO - 'LANGUAGE': 'en_US:en', 17:15:03 INFO - 'LOGNAME': 'cltbld', 17:15:03 INFO - 'MAIL': '/var/mail/cltbld', 17:15:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:15:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:15:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:03 INFO - 'MOZ_NO_REMOTE': '1', 17:15:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:15:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:03 INFO - 'NO_EM_RESTART': '1', 17:15:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:03 INFO - 'PWD': '/builds/slave/test', 17:15:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:15:03 INFO - 'RUST_BACKTRACE': 'full', 17:15:03 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:15:03 INFO - 'SHELL': '/bin/bash', 17:15:03 INFO - 'SHLVL': '1', 17:15:03 INFO - 'STYLO_FORCE_ENABLED': '1', 17:15:03 INFO - 'STYLO_THREADS': '1', 17:15:03 INFO - 'TERM': 'linux', 17:15:03 INFO - 'TMOUT': '86400', 17:15:03 INFO - 'USER': 'cltbld', 17:15:03 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1504743233.781404-573586414', 17:15:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:03 INFO - '_': '/tools/buildbot/bin/python'} 17:15:03 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/UKt4CYvxSaGZCXqv81saJw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-087', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:15:03 INFO - mozversion application_buildid: 20170906225137 17:15:03 INFO - mozversion application_changeset: d8e238b811d3dc74515065ae8cab6c74baf0295f 17:15:03 INFO - mozversion application_display_name: Nightly 17:15:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:15:03 INFO - mozversion application_name: Firefox 17:15:03 INFO - mozversion application_remotingname: firefox 17:15:03 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:15:03 INFO - mozversion application_vendor: Mozilla 17:15:03 INFO - mozversion application_version: 57.0a1 17:15:03 INFO - mozversion platform_buildid: 20170906225137 17:15:03 INFO - mozversion platform_changeset: d8e238b811d3dc74515065ae8cab6c74baf0295f 17:15:03 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:15:03 INFO - mozversion platform_version: 57.0a1 17:15:03 INFO - using testdate: 1504743303 17:15:03 INFO - actual date: 1504743303 17:15:03 INFO - starting webserver on 'localhost:43064' 17:15:03 INFO - SUITE-START | Running 2 tests 17:15:03 INFO - TEST-START | dromaeo_css 17:15:03 INFO - Initialising browser for dromaeo_css test... 17:15:03 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43064/getInfo.html -profile /tmp/tmpCAXexX/profile 17:15:03 INFO - TEST-INFO | started process 14921 (/builds/slave/test/build/application/firefox/firefox http://localhost:43064/getInfo.html) 17:15:09 INFO - TEST-INFO | 14921: exit 0 17:15:09 INFO - Browser initialized. 17:15:09 INFO - Running cycle 1/1 for dromaeo_css test... 17:15:09 INFO - Using env: {'DISPLAY': ':0', 17:15:09 INFO - 'HOME': '/home/cltbld', 17:15:09 INFO - 'JSGC_DISABLE_POISONING': '1', 17:15:09 INFO - 'LANG': 'en_US.UTF-8', 17:15:09 INFO - 'LANGUAGE': 'en_US:en', 17:15:09 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:15:09 INFO - 'LOGNAME': 'cltbld', 17:15:09 INFO - 'MAIL': '/var/mail/cltbld', 17:15:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:15:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:15:09 INFO - 'MOZ_CRASHREPORTER': '1', 17:15:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:09 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:15:09 INFO - 'MOZ_NO_REMOTE': '1', 17:15:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:15:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:09 INFO - 'NO_EM_RESTART': '1', 17:15:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:09 INFO - 'PWD': '/builds/slave/test', 17:15:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:15:09 INFO - 'RUST_BACKTRACE': 'full', 17:15:09 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:15:09 INFO - 'SHELL': '/bin/bash', 17:15:09 INFO - 'SHLVL': '1', 17:15:09 INFO - 'STYLO_FORCE_ENABLED': '1', 17:15:09 INFO - 'STYLO_THREADS': '1', 17:15:09 INFO - 'TERM': 'linux', 17:15:09 INFO - 'TMOUT': '86400', 17:15:09 INFO - 'USER': 'cltbld', 17:15:09 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1504743233.781404-573586414', 17:15:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:09 INFO - '_': '/tools/buildbot/bin/python'} 17:15:09 INFO - TEST-INFO | started process 15109 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCAXexX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:15:10 INFO - PID 15109 | 17:15:10 INFO - PID 15109 | (/builds/slave/test/build/application/firefox/firefox:15162): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:15:10 INFO - PID 15109 | 17:15:20 INFO - PID 15109 | RSS: Main: 170885120 17:15:20 INFO - PID 15109 | 17:18:17 INFO - PID 15109 | Cycle 1(1): loaded http://localhost:43064/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43064/tests/dromaeo/cssquery-ext.html) 17:18:19 INFO - PID 15109 | RSS: Main: 174129152 17:18:19 INFO - PID 15109 | 17:21:20 INFO - PID 15109 | Cycle 1(1): loaded http://localhost:43064/tests/dromaeo/cssquery-ext.html (next: http://localhost:43064/tests/dromaeo/cssquery-jquery.html) 17:21:21 INFO - PID 15109 | RSS: Main: 171024384 17:21:21 INFO - PID 15109 | 17:24:23 INFO - PID 15109 | Cycle 1(1): loaded http://localhost:43064/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43064/tests/dromaeo/cssquery-mootools.html) 17:24:23 INFO - PID 15109 | RSS: Main: 173191168 17:24:23 INFO - PID 15109 | 17:27:25 INFO - PID 15109 | Cycle 1(1): loaded http://localhost:43064/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43064/tests/dromaeo/cssquery-prototype.html) 17:27:26 INFO - PID 15109 | RSS: Main: 171851776 17:27:26 INFO - PID 15109 | 17:30:29 INFO - PID 15109 | Cycle 1(1): loaded http://localhost:43064/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43064/tests/dromaeo/cssquery-yui.html) 17:30:30 INFO - PID 15109 | RSS: Main: 173166592 17:30:30 INFO - PID 15109 | 17:33:31 INFO - PID 15109 | Cycle 1(1): loaded http://localhost:43064/tests/dromaeo/cssquery-yui.html (next: http://localhost:43064/tests/dromaeo/cssquery-dojo.html) 17:33:31 INFO - PID 15109 | RSS: Main: 175759360 17:33:31 INFO - PID 15109 | 17:33:31 INFO - PID 15109 | __start_tp_report 17:33:31 INFO - PID 15109 | _x_x_mozilla_page_load 17:33:31 INFO - PID 15109 | _x_x_mozilla_page_load_details 17:33:31 INFO - PID 15109 | |i|pagename|runs| 17:33:31 INFO - PID 15109 | |0;dojo.html;3235.547023416722;3262.4127657021736;3292.292157186205;3292.7365810735146;3351.899443016709;6394.232692076951;6499.3175716549795;6506.186726659168;6532.771353002646;6540.247871494779;6278.591891527048;6404.42360187583;6407.935920640793;6417.13368695226;6429.935700642992;5896.88206235875;5958.672273024982;6009.248843894513;6016.639001659914;6042.546808989321;5735.684537350444;5746.195532625436;5804;5847.532197424217;5913.172155898178;5789.305283366002;5790.565707571928;5794.536437085044;5805.477507024367;5874.73563689635;5797.536197104221;5809.331926828384;5879.353271140171;5887.823365299005;5902.996490596566;5751.051076572402;5815.912761308584;5855;5930;5936.5547583931375;6434.034894765776;6477.352264773532;6489.643069631168;6494.350564943515;6513.283538810727;6815.659217039129;6827.965860170717;6833.794986150423;6893.172819261721;6932.306769323078;6701.530892837503;6864.347886950732;6913.446924246048;6918.273581273944;6999.720011199546;6460.289368169498;6471;6505.577137486048;6507.284198738135;6510.121133646944;7094.787156385317;7110.822229444305;7114.324139206767;7184.209736928934;7194.568325900463;6619.139511863524;6708.563943343667;6798.558093723892;6800.693968771318;6897.55165914224;6769.695363708645;6812.659367031629;6830.59016459014;6839.658017099126;6872.037914691947;6888;6929.272426395257;6959.304069593101;6967.93032069683;6991.335823096798;6708.3291670833505;6925.792226233221;6932;7016.228214896358;7043.084399028094;5396.946030539723;5397.865053373697;5418.160185171305;5420.864478388072;5424.457554244623;4692.554207350297;4712.764361781966;4723.6929599575915;4724.267738500538;4741.0754902794315;5934.584579079423;5997.610155339976;6006.579539432285;6008.519318454513;6010.2186715726675;6860.828479288058;6870.5534140281725;6967.372936435644;6974.128233970754;6979.93020069803;5632.155176723442;5926.140709597084;5972.46247837688;5978.760849565969;5980.880382392328;5816.941830581724;5826.126081087871;5829.7376618052285;5877.206577112121;5907.586468947133;6549.770758023542;6645.3022432643875;6648.867022659617;6661.300563440769;6680.432163266177;6744.662766861736;6750.594964302158;6828.487863410165;6830.556013859084;6860.176778786477;6481.4814814815645;6584.045313429621;6605.207375115017;6638.336166383516;6647.3352664735075;6701.229358623626;6715.429188518835;6738.090357801634;6835.213950395768;6840.144981877265;6932.925396563541;6965.616891071039;6975.337342952412;6978.581285122909;7025.437964962688;6649.767258145942;6651;6670.733170673118;6763.2898545652;6779.15260592426;6474.5791523550815;6603.636799976048;6614.90077648826;6656.633885136364;6750.5274630775375;6541.280459149585;6626.635535045619;6627;6642.667866606554;6653.600783952978;6622.006698995189;6695.698693558704;6795.558288711218;6797.1843378794865;6835.248122706399;6469.676516174267;6476.384743449365;6502.577332473374;6558.409743123142;6582.308857569887 17:33:31 INFO - PID 15109 | |1;ext.html;853.6585365853658;877.6182360673108;901.4095767272439;905.492923962581;1132.9376884271371;31506.68493315066;32515.51226731598;41968.160636787245;42912.356314655226;42914.57085429152;43928.12143757123;44058.77970610143;44131.338029929495;44165.7791711041;44280;7742.574158421285;7948.284654381105;7951.443398962075;7955;7956.403269754763;7812.882806757903;7924.80187995299;7926.603669816515;7927.920720792805;7931.563763992978;7898.2101789820845;7943.046834379882;7944.920550794476;7951.165127661599;7952;7888.723894663688;7905.407094467881;7906.960465197666;7915.050193976702;7928.6035698214855;7651.808704782369;7661.42539309554;7677.50096243748;7719.768406947801;7749.612519374009;38464.80767596144;38507;38660.226795464216;38850.805745971375;38915.416268755995;3591.8742844000335;3634.5638523377365;3636.654517820803;3639.5268615080136;3639.7816131032223;32120.678793212235;32176.35647287041;32420;32420.18949526257;32440.351192976243;4934.654574179809;5102.540771330561;5110.66780659256;5129.0767661820855;5136.691798492103;187742.06128969404;188156;189785;189871;189909;49484.257736133986;49487.50512494829;49541.25688114681;49568.75215623899;49659.25511117336;52012.73993630007;52045;52070.21894671583;52146.21780673293;52184.47815521796;12650.367481625883;12955.222686638832;14051.227182504856;14351.856481435052;14358.282085895873;11804.88195118055;11948.402579870972;11989;12005.819912701316;12080.57717979884;14645.48740794067;14660.120392776254;14694.748811762132;14704.485343012942;14811.259437028106;5771.220885180447;5882.617629854131;5902.704864756745;5989.161517387569;6098.69506524672;983.9508024598885;989.8218320702342;1010.2625083688948;1023.5905637744813;1031.8813336466253;23347.7665223349;23383.415414614432;23604.763952360256;23662;23693;1109.672646569264;1109.8890110988837;1110.0509064749683;1115.66530040989;1124.6401151631562;12179.939100304442;12376.257424554555;12511.93744031274;12558.497660093677;12657.683557911127;238411.6158838424;241372;241715;242251;242285;54607.72696136494;55023;55083;55292.44707552953;55306.17040744392;1433.7562614355584;1446.1395469695515;1466.9266536673124;1467.882569394446;1470.919099449519;22633.88683056574;22701.545969080857;22789.658155127356;23072.884635577386;23157.305280841603;37789.81105094567;37988.43017354687;38062.80968595139;38099.619003810716;38157;208801;209000;210405;210654;210759;35843;37165.81417092897;39043.2191356177;39135.6086439132;39220.60779392169;48115;48561;48819.5118048815;48867;49095;35294.47058294179;35314.293714126085;35375.469367958984;35549.644503554635;36176.276474469836;34089.48865767065;34865.47701784526;34911.65088349084;35087;35252;39136.80431597824;39209.215815684096;39497.210055799296;39557.80221098876;39565.2086958265;33819.830900845336;34143.4878476828;34396.65603344035;34632.480512792834;35164.82417587896;23819.761802382447;25006.249812505655;25058.874705626356;25419.872900636117;26049.218523444328 17:33:31 INFO - PID 15109 | |2;jquery.html;570.5293133165139;572.3360901354429;572.513363640905;574.8187474739409;588.764494202319;22167.778322216775;22181.556368872614;22962.19632312867;22996.540069198607;23031;23534.29397118089;25384.365390865238;25418.364540886487;25429.23712288634;25484.872575637142;6715.865682686331;6869.278725733801;6869.587824730532;6871;6871.828204294908;6144.784932527363;6741.898871516931;6744.460443164535;6746.966265168668;6805.55763875349;6700.664966751668;6704.860173770447;6706.597604143767;6708.094407255031;6708.12794336738;6652.800415987528;6702.865942681119;6706.83232919176;6707.899381509281;6709.563878347892;6203.131561581382;6205.193324867739;6210.534209934273;6219.253689557282;6222.346653601352;28798;29025.274368140756;29816.10551683453;30009.399812003638;30148.397032059456;2068.979310206894;2101.88600041978;2103.2848831397246;2103.5267064910427;2106.494441334084;19396.515087122934;19846;19896.104675289647;19921.402357929284;19937;2387.08815804442;2406.2179791567637;2443.9022439102414;2445.339758265276;2448.8897999590063;140724;141225;143818.28090859478;144713;144833;14271.78592321116;15019.24903754808;15034.323455444313;15066.09603423798;15071.472498462721;22433.88783056107;23031;23142.652860207112;23165.073397064265;23739.287821365386;9630.422174669542;9734.902650973541;9767.511624418892;9816.067473589997;9866.55600497965;8733.301335893113;8734.563271836383;8737.868931966026;8767.868481972775;8862;9264.583093760797;9442.622295108256;9484.95665476797;9503.144716975505;9560.235181185488;2742.80800343978;2762.668479782439;2795.203367040384;2797.412543365875;2848.3875966667265;988.6243227573619;990.2078337330107;996.8554559588819;1003.1824063388315;1005.5877090392904;18490;18533.907330463262;18712.438626841216;18845;19013.61972760565;1041.6354276003337;1047.3035431438161;1048.0829274384914;1052.1845569683555;1068.8236440987305;10103.14123299513;10108.595656173818;10143.34068285559;10146.695599132037;10404.479776011169;474394;476280;476684;487932;489472;113433.4328328353;113462.43268783603;117548;119147.80852191367;119512.40243798899;1181;1187.2520312203258;1212.5816593275306;1214.265369451469;1215.604928398274;16563.00621962638;16760;16939.15304234808;17093;21143.577128457036;58199.70900145642;58242.41757582539;59114.704426479315;59637;60814.391856080874;68866;69018.65490672515;69378;69538.30461695521;69916.6504167476;14491.130532168103;14794.77807832905;14833.184174870486;14903.478378256708;14910.627234319229;23350.18274360389;23426.414339641644;23649.881750591136;23713.644295335238;23716;18604.7209291858;18968.146433410253;18980.810191898458;18987.620247594696;19019.144138513522;16292.51122466328;16990.830091698925;16996.660066798842;17211.31154753796;17668.469945901645;17915.10424478797;18174.72737908906;18381.356652517097;18427.631447371245;19508.414747557596;14539.20034398076;14571.41714331415;14600.561983140522;14639;14661.266936653337;18110.18504167342;19159.904200478908;19164.520886977378;19249.61500769949;19292.61414771725 17:33:31 INFO - PID 15109 | |3;mootools.html;1345.7173993461372;1391.986080139199;1398.622371959571;1399.6430910117917;1402.193738600305;15119.319630616621;15768.605784855385;15798.4470543531;15819;15844;15781.684366312667;16079.598010049755;16089.034657920532;16092.83907160928;16100.83899161008;2733.371324595344;2802.565602331642;2805.1584524642626;2805.3968396794685;2807.5507918732906;2806.985965070182;2936.5448355504823;2938.911832645024;2940.0738767288344;2941.4558306713325;2782.5826126081147;2832.858357082148;2838.7161283871656;2867.713228677126;2868.8278703277765;2754.559270516728;2769.0585201031645;2787.4007088475873;2790.6093146959442;2793.106206014076;2641.973580264192;2649.496595646821;2653;2663.387420893205;2664.2140568532136;14806.481773137995;15268.618284542865;15291.694166116728;15338.616534586614;15415.92292038544;8016.398770092266;8287.917120828835;8290.709825156091;8305.294050005758;8311.584420778998;5361.249425080492;5415.158845992342;5459.208414779874;5540.335159780811;5568.192612071268;1987.920483180671;1995.600879824041;2001.609686111209;2031.4108908416542;2041.989790051055;26700.465990680077;26863.194104176906;26987.190384288504;27079.323016924536;27135;7053.470989675795;7233.168185658611;7341.963290183515;7422.96288518554;7440.069991251094;17211.311547538207;17451.301947922195;17514.824851751575;17531.386401475887;17569;8017.398695097891;8134.837303253902;8173.141820108922;8183.95908020456;8194.795130121795;7395.26047395267;7532.661030253652;7541.811454713676;7585.127710313274;7603.923960760321;5091.261767043758;5299.311089558333;5303.071962406563;5344.812931547377;5360.892782144335;1485.5469081929898;1486.613480495079;1491.7538606129867;1498.5878883307178;1518.3395223077775;917.5687426909342;943.773494361362;951.7668171298076;957.3968399908152;960.4573416019927;7742.225777422325;7742.496737712031;7775.105862825734;7779.961100194463;7786.377089832799;733.5158795195252;744.0401881572818;747.7382915979364;748.2405358561065;750.9924900751032;5254.500822421864;5283.815066472655;5355.571554275726;5431.293931788842;5436.565074794007;21190.89404552998;22201.333959981228;22394.44013899633;22464.663030054562;22503.437414064778;21577.244796432362;21725.67411488829;22084.116635334405;22318.888405557867;22349.217777377715;11407.258528195807;11541.076713863038;11632.651020469399;11637.185397022127;11666.358350290646;8226.753197404087;8227.177282271725;8291.62687679068;8333.583320834055;8400.579971001547;18816.341428049953;18913.243470261037;18923;19013.80986190176;19220.327288544835;19327.710084348466;19399;19399.2240310386;19480.610387791883;19636.312729054414;12175.634730958085;12324.568640097554;12416.255024698547;12430.751384972069;12443.37783110859;13978.30108494551;14076;14085.929570352493;14138.858611413754;14163.433462661378;11210.943945280222;11232.157588180755;11288.322700637988;11380.317180969168;11545.538178472767;10802.405867677353;10870.565177393131;10967.232293739362;11048.613298534834;11275.66173014811;9718.854217186888;9937.701868943943;9942.850857237003;9972;9983;7005.299470052954;7024.121984751906;7041.26066763003;7051.435885129074;7091.11361079865;6990;6993.300669932966;7061.399781018671;7097.219305876246;7149.392301654418 17:33:31 INFO - PID 15109 | |4;prototype.html;492.7312171159266;504.4854248666358;529.3721805448248;532.6431291035007;533.8985592737382;6411.679416029203;6425.775097871576;6435.742570297189;6471.70877310521;6492.513061520387;6006.639601623895;6215.638057538129;6287.7799277025315;6312.33720459352;6321.52588555859;5047.217681259411;5070.797168113271;5097.796088156488;5147.216795655199;5171.534561889429;5044.268581055745;5079.222272204717;5083.79664813407;5101.821436249732;5187.221916712486;5201.921971170435;5282.841514754564;5312.867178320554;5332.306800115999;5341.519263266306;5271.15661494161;5316.840494785162;5340.973295133538;5376.865578360533;5380.408155102936;4900.803967841282;4904.215325547931;4964.354633897607;4979.800807967713;4982.252662100714;6253.280872699653;6337.429631333202;6369.299377068519;6394.6482943438095;6424.132742079806;6040.48655864252;6101.481374083208;6116.204893363879;6127.908081378783;6146.416090471443;6682.398584127403;6711.557015241747;6729.399771122475;6747.966260168668;6798.694058767367;5354.464553544653;5399.811006614749;5400.675959442407;5437.102878025121;5438.5377242934;7130.358267755875;7174.677139528734;7207.4503981643675;7219.494635375526;7219.530730502501;5560.805371811967;5561.109222864246;5566.165075238747;5594.636348637326;5596.776128954878;5649.858753531113;5657.434256574392;5669.829905102853;5671.404502527258;5695.316562012585;6125.785597504066;6137.539684523678;6146.170267013986;6150.923588372017;6157.692115394302;6737.932620673829;6772.5936443813525;6773.288804675537;6860.176778786577;6864.7940561783225;1829.7072468404992;1869.4391682495468;1908.4751693284459;1951.7853036166011;1954.7067939808858;1441.992790036043;1454.934527946245;1465.2893346726828;1471.7645176771666;1477.519806063034;5897.852553686193;5905.822825315247;5906.232189815297;5907.409259074144;5929.5769015436845;6739.157605299338;6831.9658401707675;6891.310868913169;6917.481188910851;6922.550034247758;5953.583249172603;5963.344032156459;5966.791162309385;5989.580729348903;6012.699365031731;3597.9280414391565;3637.2361804021452;3641.417373220272;3671.14607123401;3681.8527258909344;6680.732770689216;6702.765403210864;6708.329167083252;6751.25736169021;6751.763688270887;7081.787546373617;7105;7109.857802843914;7136.678849451787;7146.3568278855155;6675.332466753286;6675.899861502178;6717.1267735194115;6732.360425759643;6751.729930802811;6807.319268073153;6873.347032031949;6907.930920690729;6909.2745261746795;6934.930650693428;6747.763828265987;6758.7296508139125;6774.3225677431865;6808.489363297674;6814.795556133324;6504.479641628753;6598.3401659833635;6647.833804154935;6686.1642294713165;6686.99695045747;4999.900002000012;5004.1492946198505;5017.222330538772;5072.289879416959;5089.618278629192;6443.548951573345;6834.334609502199;6891.414229790524;6892;6899.413549848319;6439.839004024937;6448.484121270381;6453.6766763964;6521.64130972801;6539.6403197824575;6448.387403196689;6526.608403495806;6544.476441884733;6560;6580.473562114924;6417.614943103429;6436.420722135031;6450.290468048417;6481.203909107133;6549.24683661385;6535.745167917061;6537.444317233088;6709.718695643504;6730.93269067303;6749.696263668048;6510.688705509665;6511.590711436798;6520.576162549419;6521.619663777497;6530.314316996647 17:33:31 INFO - PID 15109 | |5;yui.html;911.2026976395654;922.5387306346827;931.9860202096966;938.63862412971;940.5344354544497;16891.23989420476;17380.21789019494;17386.13069346534;17433.738493922585;21667.566648667016;20305.289314873982;21314.89342553289;21357.99999999996;21422.57154856902;21492;923.8845144356956;949.6391371278904;952.2572393533055;952.3190918493276;952.5618215620788;936.7002559181064;985.2561316206254;996.7059717383353;1005.2360206243271;1007.8034783217275;1061.1828891753346;1061.6602687140119;1065.147881694645;1065.2223876570108;1065.254321974617;1056.3450660590445;1056.3872953686844;1059.5602824827688;1062.7024433158729;1063.1441689439998;776.2160218179623;777.3742137579246;778.5017588743209;779.2986312318901;780.5784876166863;19674.80325196744;19794.109265083105;19947.700784488243;19959.80040199594;20072.197112115497;20843.16627334905;21075.789242107538;21080.15679372823;21445.142194312208;21776.34670959858;16836.158192090348;17379;17388.56528586783;17554.91222543892;17569.648607027786;3778.4332350147697;3812.066043819282;3825.005498570392;3825.923481530354;3826.2730081284744;119759;120631.3968430161;121661;124021;125089;16495.752563711554;16731.581710457092;17191.398301059402;17191.91404042997;17208.225629846685;30904;30908;30956.535651965238;31091.84454077715;31113.222169445944;8536.402451828313;8624;8657.740267791976;8660.913390866137;8662.177093176138;4153.127843152972;4236.385724069993;4237.110206856533;4239.51245606753;4255.87232383029;5160.509751573594;5238;5281.260623512711;5281.260623512711;5299;967.583938906277;989.1443901025705;1003.2375394700081;1008.5159123620704;1011.0445628880784;687.1685260834446;689.9068625735562;716.7706333973183;720.4452571519901;725.2747252747253;10852.348859068481;10928.672139835817;11006.229563930608;11426.828597571042;11703;686.2348481443155;696.6586372677453;700.9334113259232;714.6819665249018;720.0854914258862;5200.401953775288;5290.127129023745;5309.8938021239355;5343.86640333987;5988.04191329394;105835;108167;110481.89518104876;111226;114431;95739.52130239444;98365;99462.50268748609;100837;105607.4719626397;83261;85273;85588.57205713932;85866.57066714752;87291.56354218315;11307.434628268718;11734.589289374831;11773.470193841127;12016.923559927738;12207.267563946192;36957;38037.61962380341;38113;38727.419088713126;41623.58376416318;50068.499315007844;68861;70036;70602.64698676474;76273.61863190649;17726.734098988785;17744.201510932297;17888.28446862111;17927.551811204823;17966.640667186846;21116.57766844685;21240.575188496452;21772.89113554422;21848.89075554612;21901.233456829574;16521.33914643449;16522.66954660876;16693.499195024167;16871.578210544834;17003.234854431827;16560.834391655928;16592.75110873362;16688.582785430463;18170.45488635343;18371.448856534324;15940;16266.674666506367;16467.25897334599;16768;17227.31090756356;12627.873721263037;12939.353032348157;13049.086563940433;13365.26491043002;14607;13524.526641567498;13673.589792306248;13715.451381944611;13776.517821876587;14241.857581424054 17:33:31 INFO - PID 15109 | __end_tp_report 17:33:31 INFO - PID 15109 | __start_cc_report 17:33:31 INFO - PID 15109 | _x_x_mozilla_cycle_collect,368 17:33:31 INFO - PID 15109 | __end_cc_report 17:33:31 INFO - PID 15109 | __startTimestamp1504744411938__endTimestamp 17:33:31 INFO - PID 15109 | 17:33:31 INFO - PID 15109 | ------- Summary: start ------- 17:33:31 INFO - PID 15109 | Number of tests: 6 17:33:31 INFO - PID 15109 | 17:33:31 INFO - PID 15109 | [#0] dojo.html Cycles:165 Average:6320.76 Median:6558.41 stddev:757.31 (11.5%) stddev-sans-first:719.92 17:33:31 INFO - PID 15109 | Values: 3235.5 3262.4 3292.3 3292.7 3351.9 6394.2 6499.3 6506.2 6532.8 6540.2 6278.6 6404.4 6407.9 6417.1 6429.9 5896.9 5958.7 6009.2 6016.6 6042.5 5735.7 5746.2 5804.0 5847.5 5913.2 5789.3 5790.6 5794.5 5805.5 5874.7 5797.5 5809.3 5879.4 5887.8 5903.0 5751.1 5815.9 5855.0 5930.0 5936.6 6434.0 6477.4 6489.6 6494.4 6513.3 6815.7 6828.0 6833.8 6893.2 6932.3 6701.5 6864.3 6913.4 6918.3 6999.7 6460.3 6471.0 6505.6 6507.3 6510.1 7094.8 7110.8 7114.3 7184.2 7194.6 6619.1 6708.6 6798.6 6800.7 6897.6 6769.7 6812.7 6830.6 6839.7 6872.0 6888.0 6929.3 6959.3 6967.9 6991.3 6708.3 6925.8 6932.0 7016.2 7043.1 5396.9 5397.9 5418.2 5420.9 5424.5 4692.6 4712.8 4723.7 4724.3 4741.1 5934.6 5997.6 6006.6 6008.5 6010.2 6860.8 6870.6 6967.4 6974.1 6979.9 5632.2 5926.1 5972.5 5978.8 5980.9 5816.9 5826.1 5829.7 5877.2 5907.6 6549.8 6645.3 6648.9 6661.3 6680.4 6744.7 6750.6 6828.5 6830.6 6860.2 6481.5 6584.0 6605.2 6638.3 6647.3 6701.2 6715.4 6738.1 6835.2 6840.1 6932.9 6965.6 6975.3 6978.6 7025.4 6649.8 6651.0 6670.7 6763.3 6779.2 6474.6 6603.6 6614.9 6656.6 6750.5 6541.3 6626.6 6627.0 6642.7 6653.6 6622.0 6695.7 6795.6 6797.2 6835.2 6469.7 6476.4 6502.6 6558.4 6582.3 17:33:31 INFO - PID 15109 | 17:33:31 INFO - PID 15109 | [#1] ext.html Cycles:180 Average:38949.57 Median:3639.65 stddev:55647.76 (1528.9%) stddev-sans-first:55730.34 17:33:31 INFO - PID 15109 | Values: 853.7 877.6 901.4 905.5 1132.9 31506.7 32515.5 41968.2 42912.4 42914.6 43928.1 44058.8 44131.3 44165.8 44280.0 7742.6 7948.3 7951.4 7955.0 7956.4 7812.9 7924.8 7926.6 7927.9 7931.6 7898.2 7943.0 7944.9 7951.2 7952.0 7888.7 7905.4 7907.0 7915.1 7928.6 7651.8 7661.4 7677.5 7719.8 7749.6 38464.8 38507.0 38660.2 38850.8 38915.4 3591.9 3634.6 3636.7 3639.5 3639.8 32120.7 32176.4 32420.0 32420.2 32440.4 4934.7 5102.5 5110.7 5129.1 5136.7 187742.1 188156.0 189785.0 189871.0 189909.0 49484.3 49487.5 49541.3 49568.8 49659.3 52012.7 52045.0 52070.2 52146.2 52184.5 12650.4 12955.2 14051.2 14351.9 14358.3 11804.9 11948.4 11989.0 12005.8 12080.6 14645.5 14660.1 14694.7 14704.5 14811.3 5771.2 5882.6 5902.7 5989.2 6098.7 984.0 989.8 1010.3 1023.6 1031.9 23347.8 23383.4 23604.8 23662.0 23693.0 1109.7 1109.9 1110.1 1115.7 1124.6 12179.9 12376.3 12511.9 12558.5 12657.7 238411.6 241372.0 241715.0 242251.0 242285.0 54607.7 55023.0 55083.0 55292.4 55306.2 1433.8 1446.1 1466.9 1467.9 1470.9 22633.9 22701.5 22789.7 23072.9 23157.3 37789.8 37988.4 38062.8 38099.6 38157.0 208801.0 209000.0 210405.0 210654.0 210759.0 35843.0 37165.8 39043.2 39135.6 39220.6 48115.0 48561.0 48819.5 48867.0 49095.0 35294.5 35314.3 35375.5 35549.6 36176.3 34089.5 34865.5 34911.7 35087.0 35252.0 39136.8 39209.2 39497.2 39557.8 39565.2 33819.8 34143.5 34396.7 34632.5 35164.8 23819.8 25006.2 25058.9 25419.9 26049.2 17:33:31 INFO - PID 15109 | 17:33:31 INFO - PID 15109 | [#2] jquery.html Cycles:180 Average:34706.78 Median:23257.63 stddev:81391.42 (350.0%) stddev-sans-first:81579.39 17:33:31 INFO - PID 15109 | Values: 570.5 572.3 572.5 574.8 588.8 22167.8 22181.6 22962.2 22996.5 23031.0 23534.3 25384.4 25418.4 25429.2 25484.9 6715.9 6869.3 6869.6 6871.0 6871.8 6144.8 6741.9 6744.5 6747.0 6805.6 6700.7 6704.9 6706.6 6708.1 6708.1 6652.8 6702.9 6706.8 6707.9 6709.6 6203.1 6205.2 6210.5 6219.3 6222.3 28798.0 29025.3 29816.1 30009.4 30148.4 2069.0 2101.9 2103.3 2103.5 2106.5 19396.5 19846.0 19896.1 19921.4 19937.0 2387.1 2406.2 2443.9 2445.3 2448.9 140724.0 141225.0 143818.3 144713.0 144833.0 14271.8 15019.2 15034.3 15066.1 15071.5 22433.9 23031.0 23142.7 23165.1 23739.3 9630.4 9734.9 9767.5 9816.1 9866.6 8733.3 8734.6 8737.9 8767.9 8862.0 9264.6 9442.6 9485.0 9503.1 9560.2 2742.8 2762.7 2795.2 2797.4 2848.4 988.6 990.2 996.9 1003.2 1005.6 18490.0 18533.9 18712.4 18845.0 19013.6 1041.6 1047.3 1048.1 1052.2 1068.8 10103.1 10108.6 10143.3 10146.7 10404.5 474394.0 476280.0 476684.0 487932.0 489472.0 113433.4 113462.4 117548.0 119147.8 119512.4 1181.0 1187.3 1212.6 1214.3 1215.6 16563.0 16760.0 16939.2 17093.0 21143.6 58199.7 58242.4 59114.7 59637.0 60814.4 68866.0 69018.7 69378.0 69538.3 69916.7 14491.1 14794.8 14833.2 14903.5 14910.6 23350.2 23426.4 23649.9 23713.6 23716.0 18604.7 18968.1 18980.8 18987.6 19019.1 16292.5 16990.8 16996.7 17211.3 17668.5 17915.1 18174.7 18381.4 18427.6 19508.4 14539.2 14571.4 14600.6 14639.0 14661.3 18110.2 19159.9 19164.5 19249.6 19292.6 17:33:31 INFO - PID 15109 | 17:33:31 INFO - PID 15109 | [#3] mootools.html Cycles:180 Average:9506.01 Median:2743.97 stddev:6824.15 (248.7%) stddev-sans-first:6815.75 17:33:31 INFO - PID 15109 | Values: 1345.7 1392.0 1398.6 1399.6 1402.2 15119.3 15768.6 15798.4 15819.0 15844.0 15781.7 16079.6 16089.0 16092.8 16100.8 2733.4 2802.6 2805.2 2805.4 2807.6 2807.0 2936.5 2938.9 2940.1 2941.5 2782.6 2832.9 2838.7 2867.7 2868.8 2754.6 2769.1 2787.4 2790.6 2793.1 2642.0 2649.5 2653.0 2663.4 2664.2 14806.5 15268.6 15291.7 15338.6 15415.9 8016.4 8287.9 8290.7 8305.3 8311.6 5361.2 5415.2 5459.2 5540.3 5568.2 1987.9 1995.6 2001.6 2031.4 2042.0 26700.5 26863.2 26987.2 27079.3 27135.0 7053.5 7233.2 7342.0 7423.0 7440.1 17211.3 17451.3 17514.8 17531.4 17569.0 8017.4 8134.8 8173.1 8184.0 8194.8 7395.3 7532.7 7541.8 7585.1 7603.9 5091.3 5299.3 5303.1 5344.8 5360.9 1485.5 1486.6 1491.8 1498.6 1518.3 917.6 943.8 951.8 957.4 960.5 7742.2 7742.5 7775.1 7780.0 7786.4 733.5 744.0 747.7 748.2 751.0 5254.5 5283.8 5355.6 5431.3 5436.6 21190.9 22201.3 22394.4 22464.7 22503.4 21577.2 21725.7 22084.1 22318.9 22349.2 11407.3 11541.1 11632.7 11637.2 11666.4 8226.8 8227.2 8291.6 8333.6 8400.6 18816.3 18913.2 18923.0 19013.8 19220.3 19327.7 19399.0 19399.2 19480.6 19636.3 12175.6 12324.6 12416.3 12430.8 12443.4 13978.3 14076.0 14085.9 14138.9 14163.4 11210.9 11232.2 11288.3 11380.3 11545.5 10802.4 10870.6 10967.2 11048.6 11275.7 9718.9 9937.7 9942.9 9972.0 9983.0 7005.3 7024.1 7041.3 7051.4 7091.1 6990.0 6993.3 7061.4 7097.2 7149.4 17:33:31 INFO - PID 15109 | 17:33:31 INFO - PID 15109 | [#4] prototype.html Cycles:180 Average:5723.26 Median:6329.48 stddev:1544.53 (24.4%) stddev-sans-first:1498.14 17:33:31 INFO - PID 15109 | Values: 492.7 504.5 529.4 532.6 533.9 6411.7 6425.8 6435.7 6471.7 6492.5 6006.6 6215.6 6287.8 6312.3 6321.5 5047.2 5070.8 5097.8 5147.2 5171.5 5044.3 5079.2 5083.8 5101.8 5187.2 5201.9 5282.8 5312.9 5332.3 5341.5 5271.2 5316.8 5341.0 5376.9 5380.4 4900.8 4904.2 4964.4 4979.8 4982.3 6253.3 6337.4 6369.3 6394.6 6424.1 6040.5 6101.5 6116.2 6127.9 6146.4 6682.4 6711.6 6729.4 6748.0 6798.7 5354.5 5399.8 5400.7 5437.1 5438.5 7130.4 7174.7 7207.5 7219.5 7219.5 5560.8 5561.1 5566.2 5594.6 5596.8 5649.9 5657.4 5669.8 5671.4 5695.3 6125.8 6137.5 6146.2 6150.9 6157.7 6737.9 6772.6 6773.3 6860.2 6864.8 1829.7 1869.4 1908.5 1951.8 1954.7 1442.0 1454.9 1465.3 1471.8 1477.5 5897.9 5905.8 5906.2 5907.4 5929.6 6739.2 6832.0 6891.3 6917.5 6922.6 5953.6 5963.3 5966.8 5989.6 6012.7 3597.9 3637.2 3641.4 3671.1 3681.9 6680.7 6702.8 6708.3 6751.3 6751.8 7081.8 7105.0 7109.9 7136.7 7146.4 6675.3 6675.9 6717.1 6732.4 6751.7 6807.3 6873.3 6907.9 6909.3 6934.9 6747.8 6758.7 6774.3 6808.5 6814.8 6504.5 6598.3 6647.8 6686.2 6687.0 4999.9 5004.1 5017.2 5072.3 5089.6 6443.5 6834.3 6891.4 6892.0 6899.4 6439.8 6448.5 6453.7 6521.6 6539.6 6448.4 6526.6 6544.5 6560.0 6580.5 6417.6 6436.4 6450.3 6481.2 6549.2 6535.7 6537.4 6709.7 6730.9 6749.7 6510.7 6511.6 6520.6 6521.6 6530.3 17:33:31 INFO - PID 15109 | 17:33:31 INFO - PID 15109 | [#5] yui.html Cycles:180 Average:23469.94 Median:21178.58 stddev:31822.77 (150.3%) stddev-sans-first:31866.96 17:33:31 INFO - PID 15109 | Values: 911.2 922.5 932.0 938.6 940.5 16891.2 17380.2 17386.1 17433.7 21667.6 20305.3 21314.9 21358.0 21422.6 21492.0 923.9 949.6 952.3 952.3 952.6 936.7 985.3 996.7 1005.2 1007.8 1061.2 1061.7 1065.1 1065.2 1065.3 1056.3 1056.4 1059.6 1062.7 1063.1 776.2 777.4 778.5 779.3 780.6 19674.8 19794.1 19947.7 19959.8 20072.2 20843.2 21075.8 21080.2 21445.1 21776.3 16836.2 17379.0 17388.6 17554.9 17569.6 3778.4 3812.1 3825.0 3825.9 3826.3 119759.0 120631.4 121661.0 124021.0 125089.0 16495.8 16731.6 17191.4 17191.9 17208.2 30904.0 30908.0 30956.5 31091.8 31113.2 8536.4 8624.0 8657.7 8660.9 8662.2 4153.1 4236.4 4237.1 4239.5 4255.9 5160.5 5238.0 5281.3 5281.3 5299.0 967.6 989.1 1003.2 1008.5 1011.0 687.2 689.9 716.8 720.4 725.3 10852.3 10928.7 11006.2 11426.8 11703.0 686.2 696.7 700.9 714.7 720.1 5200.4 5290.1 5309.9 5343.9 5988.0 105835.0 108167.0 110481.9 111226.0 114431.0 95739.5 98365.0 99462.5 100837.0 105607.5 83261.0 85273.0 85588.6 85866.6 87291.6 11307.4 11734.6 11773.5 12016.9 12207.3 36957.0 38037.6 38113.0 38727.4 41623.6 50068.5 68861.0 70036.0 70602.6 76273.6 17726.7 17744.2 17888.3 17927.6 17966.6 21116.6 21240.6 21772.9 21848.9 21901.2 16521.3 16522.7 16693.5 16871.6 17003.2 16560.8 16592.8 16688.6 18170.5 18371.4 15940.0 16266.7 16467.3 16768.0 17227.3 12627.9 12939.4 13049.1 13365.3 14607.0 13524.5 13673.6 13715.5 13776.5 14241.9 17:33:31 INFO - PID 15109 | -------- Summary: end -------- 17:33:31 INFO - PID 15109 | 17:33:32 INFO - TEST-INFO | 15109: exit 0 17:33:32 INFO - TEST-OK | dromaeo_css | took 1109311ms 17:33:32 INFO - TEST-START | kraken 17:33:32 INFO - Initialising browser for kraken test... 17:33:32 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43064/getInfo.html -profile /tmp/tmpz3MZ3A/profile 17:33:32 INFO - TEST-INFO | started process 15488 (/builds/slave/test/build/application/firefox/firefox http://localhost:43064/getInfo.html) 17:33:38 INFO - TEST-INFO | 15488: exit 0 17:33:38 INFO - Browser initialized. 17:33:38 INFO - Running cycle 1/1 for kraken test... 17:33:38 INFO - Using env: {'DISPLAY': ':0', 17:33:38 INFO - 'HOME': '/home/cltbld', 17:33:38 INFO - 'JSGC_DISABLE_POISONING': '1', 17:33:38 INFO - 'LANG': 'en_US.UTF-8', 17:33:38 INFO - 'LANGUAGE': 'en_US:en', 17:33:38 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:33:38 INFO - 'LOGNAME': 'cltbld', 17:33:38 INFO - 'MAIL': '/var/mail/cltbld', 17:33:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:33:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:33:38 INFO - 'MOZ_CRASHREPORTER': '1', 17:33:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:33:38 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:33:38 INFO - 'MOZ_NO_REMOTE': '1', 17:33:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:33:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:33:38 INFO - 'NO_EM_RESTART': '1', 17:33:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:33:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:33:38 INFO - 'PWD': '/builds/slave/test', 17:33:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:33:38 INFO - 'RUST_BACKTRACE': 'full', 17:33:38 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:33:38 INFO - 'SHELL': '/bin/bash', 17:33:38 INFO - 'SHLVL': '1', 17:33:38 INFO - 'STYLO_FORCE_ENABLED': '1', 17:33:38 INFO - 'STYLO_THREADS': '1', 17:33:38 INFO - 'TERM': 'linux', 17:33:38 INFO - 'TMOUT': '86400', 17:33:38 INFO - 'USER': 'cltbld', 17:33:38 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1504743233.781404-573586414', 17:33:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:33:38 INFO - '_': '/tools/buildbot/bin/python'} 17:33:38 INFO - TEST-INFO | started process 15673 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz3MZ3A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:33:39 INFO - PID 15673 | 17:33:39 INFO - PID 15673 | (/builds/slave/test/build/application/firefox/firefox:15726): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:33:39 INFO - PID 15673 | 17:33:50 INFO - PID 15673 | RSS: Main: 167018496 17:33:50 INFO - PID 15673 | 17:33:52 INFO - PID 15673 | Cycle 1(1): loaded http://localhost:43064/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43064/tests/kraken/driver.html?testName=audio-beat-detection) 17:33:53 INFO - PID 15673 | RSS: Main: 172670976 17:33:53 INFO - PID 15673 | 17:33:56 INFO - PID 15673 | Cycle 1(1): loaded http://localhost:43064/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43064/tests/kraken/driver.html?testName=audio-dft) 17:33:56 INFO - PID 15673 | RSS: Main: 173264896 17:33:56 INFO - PID 15673 | 17:33:59 INFO - PID 15673 | Cycle 1(1): loaded http://localhost:43064/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43064/tests/kraken/driver.html?testName=audio-fft) 17:34:00 INFO - PID 15673 | RSS: Main: 167960576 17:34:00 INFO - PID 15673 | 17:34:02 INFO - PID 15673 | Cycle 1(1): loaded http://localhost:43064/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43064/tests/kraken/driver.html?testName=audio-oscillator) 17:34:03 INFO - PID 15673 | RSS: Main: 168660992 17:34:03 INFO - PID 15673 | 17:34:05 INFO - PID 15673 | Cycle 1(1): loaded http://localhost:43064/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43064/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:34:06 INFO - PID 15673 | RSS: Main: 168968192 17:34:06 INFO - PID 15673 | 17:34:09 INFO - PID 15673 | Cycle 1(1): loaded http://localhost:43064/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43064/tests/kraken/driver.html?testName=imaging-darkroom) 17:34:09 INFO - PID 15673 | RSS: Main: 171134976 17:34:09 INFO - PID 15673 | 17:34:13 INFO - PID 15673 | Cycle 1(1): loaded http://localhost:43064/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43064/tests/kraken/driver.html?testName=imaging-desaturate) 17:34:14 INFO - PID 15673 | RSS: Main: 171409408 17:34:14 INFO - PID 15673 | 17:34:16 INFO - PID 15673 | Cycle 1(1): loaded http://localhost:43064/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43064/tests/kraken/driver.html?testName=json-parse-financial) 17:34:17 INFO - PID 15673 | RSS: Main: 171769856 17:34:17 INFO - PID 15673 | 17:34:19 INFO - PID 15673 | Cycle 1(1): loaded http://localhost:43064/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43064/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:34:19 INFO - PID 15673 | RSS: Main: 171556864 17:34:19 INFO - PID 15673 | 17:34:21 INFO - PID 15673 | Cycle 1(1): loaded http://localhost:43064/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43064/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:34:22 INFO - PID 15673 | RSS: Main: 172228608 17:34:22 INFO - PID 15673 | 17:34:24 INFO - PID 15673 | Cycle 1(1): loaded http://localhost:43064/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43064/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:34:24 INFO - PID 15673 | RSS: Main: 172503040 17:34:24 INFO - PID 15673 | 17:34:27 INFO - PID 15673 | Cycle 1(1): loaded http://localhost:43064/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43064/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:34:28 INFO - PID 15673 | RSS: Main: 172769280 17:34:28 INFO - PID 15673 | 17:34:31 INFO - PID 15673 | Cycle 1(1): loaded http://localhost:43064/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43064/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:34:31 INFO - PID 15673 | RSS: Main: 172191744 17:34:31 INFO - PID 15673 | 17:34:33 INFO - PID 15673 | Cycle 1(1): loaded http://localhost:43064/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43064/tests/kraken/driver.html?testName=ai-astar) 17:34:33 INFO - PID 15673 | RSS: Main: 173694976 17:34:33 INFO - PID 15673 | 17:34:33 INFO - PID 15673 | __start_tp_report 17:34:33 INFO - PID 15673 | _x_x_mozilla_page_load 17:34:33 INFO - PID 15673 | _x_x_mozilla_page_load_details 17:34:33 INFO - PID 15673 | |i|pagename|runs| 17:34:33 INFO - PID 15673 | |0;ai-astar;99;107;100;107;108;109;108;99;108;107 17:34:33 INFO - PID 15673 | |1;audio-beat-detection;152;120;152;171;118;146;154;117;176;119 17:34:33 INFO - PID 15673 | |2;audio-dft;163;163;161;164;163;163;168;167;161;164 17:34:33 INFO - PID 15673 | |3;audio-fft;75;79;75;178;74;75;73;73;145;76 17:34:33 INFO - PID 15673 | |4;audio-oscillator;80;82;133;79;79;79;130;79;78;125 17:34:33 INFO - PID 15673 | |5;imaging-gaussian-blur;114;114;113;113;113;114;113;114;114;116 17:34:33 INFO - PID 15673 | |6;imaging-darkroom;148;151;148;150;149;148;148;149;148;148 17:34:33 INFO - PID 15673 | |7;imaging-desaturate;94;94;93;94;94;93;94;94;95;94 17:34:33 INFO - PID 15673 | |8;json-parse-financial;53;55;54;52;51;53;52;53;52;54 17:34:33 INFO - PID 15673 | |9;json-stringify-tinderbox;37;37;38;38;40;38;37;37;38;37 17:34:33 INFO - PID 15673 | |10;stanford-crypto-aes;76;76;75;75;74;80;76;76;80;76 17:34:33 INFO - PID 15673 | |11;stanford-crypto-ccm;122;123;127;125;118;126;124;131;121;163 17:34:33 INFO - PID 15673 | |12;stanford-crypto-pbkdf2;181;179;180;185;180;186;178;182;176;178 17:34:33 INFO - PID 15673 | |13;stanford-crypto-sha256-iterative;66;69;66;66;65;72;67;70;67;65 17:34:33 INFO - PID 15673 | __end_tp_report 17:34:33 INFO - PID 15673 | __start_cc_report 17:34:33 INFO - PID 15673 | _x_x_mozilla_cycle_collect,959 17:34:33 INFO - PID 15673 | __end_cc_report 17:34:33 INFO - PID 15673 | __startTimestamp1504744473967__endTimestamp 17:34:33 INFO - PID 15673 | 17:34:33 INFO - PID 15673 | ------- Summary: start ------- 17:34:33 INFO - PID 15673 | Number of tests: 14 17:34:33 INFO - PID 15673 | 17:34:33 INFO - PID 15673 | [#0] ai-astar Cycles:10 Average:105.20 Median:108.00 stddev:4.10 (3.8%) stddev-sans-first:3.69 17:34:33 INFO - PID 15673 | Values: 99.0 107.0 100.0 107.0 108.0 109.0 108.0 99.0 108.0 107.0 17:34:33 INFO - PID 15673 | 17:34:33 INFO - PID 15673 | [#1] audio-beat-detection Cycles:10 Average:142.50 Median:152.00 stddev:22.53 (14.8%) stddev-sans-first:23.63 17:34:33 INFO - PID 15673 | Values: 152.0 120.0 152.0 171.0 118.0 146.0 154.0 117.0 176.0 119.0 17:34:33 INFO - PID 15673 | 17:34:33 INFO - PID 15673 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.50 stddev:2.26 (1.4%) stddev-sans-first:2.39 17:34:33 INFO - PID 15673 | Values: 163.0 163.0 161.0 164.0 163.0 163.0 168.0 167.0 161.0 164.0 17:34:33 INFO - PID 15673 | 17:34:33 INFO - PID 15673 | [#3] audio-fft Cycles:10 Average:92.30 Median:75.00 stddev:37.33 (49.8%) stddev-sans-first:39.07 17:34:33 INFO - PID 15673 | Values: 75.0 79.0 75.0 178.0 74.0 75.0 73.0 73.0 145.0 76.0 17:34:33 INFO - PID 15673 | 17:34:33 INFO - PID 15673 | [#4] audio-oscillator Cycles:10 Average:94.40 Median:79.00 stddev:24.20 (30.6%) stddev-sans-first:25.10 17:34:33 INFO - PID 15673 | Values: 80.0 82.0 133.0 79.0 79.0 79.0 130.0 79.0 78.0 125.0 17:34:33 INFO - PID 15673 | 17:34:33 INFO - PID 15673 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.92 (0.8%) stddev-sans-first:0.97 17:34:33 INFO - PID 15673 | Values: 114.0 114.0 113.0 113.0 113.0 114.0 113.0 114.0 114.0 116.0 17:34:33 INFO - PID 15673 | 17:34:33 INFO - PID 15673 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:148.50 stddev:1.06 (0.7%) stddev-sans-first:1.09 17:34:33 INFO - PID 15673 | Values: 148.0 151.0 148.0 150.0 149.0 148.0 148.0 149.0 148.0 148.0 17:34:33 INFO - PID 15673 | 17:34:33 INFO - PID 15673 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 17:34:33 INFO - PID 15673 | Values: 94.0 94.0 93.0 94.0 94.0 93.0 94.0 94.0 95.0 94.0 17:34:33 INFO - PID 15673 | 17:34:33 INFO - PID 15673 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.00 stddev:1.20 (2.3%) stddev-sans-first:1.27 17:34:33 INFO - PID 15673 | Values: 53.0 55.0 54.0 52.0 51.0 53.0 52.0 53.0 52.0 54.0 17:34:33 INFO - PID 15673 | 17:34:33 INFO - PID 15673 | [#9] json-stringify-tinderbox Cycles:10 Average:37.70 Median:38.00 stddev:0.95 (2.5%) stddev-sans-first:0.97 17:34:33 INFO - PID 15673 | Values: 37.0 37.0 38.0 38.0 40.0 38.0 37.0 37.0 38.0 37.0 17:34:33 INFO - PID 15673 | 17:34:33 INFO - PID 15673 | [#10] stanford-crypto-aes Cycles:10 Average:76.40 Median:76.00 stddev:2.01 (2.6%) stddev-sans-first:2.13 17:34:33 INFO - PID 15673 | Values: 76.0 76.0 75.0 75.0 74.0 80.0 76.0 76.0 80.0 76.0 17:34:33 INFO - PID 15673 | 17:34:33 INFO - PID 15673 | [#11] stanford-crypto-ccm Cycles:10 Average:128.00 Median:125.50 stddev:12.80 (10.2%) stddev-sans-first:13.39 17:34:33 INFO - PID 15673 | Values: 122.0 123.0 127.0 125.0 118.0 126.0 124.0 131.0 121.0 163.0 17:34:33 INFO - PID 15673 | 17:34:33 INFO - PID 15673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.50 Median:180.50 stddev:3.14 (1.7%) stddev-sans-first:3.32 17:34:33 INFO - PID 15673 | Values: 181.0 179.0 180.0 185.0 180.0 186.0 178.0 182.0 176.0 178.0 17:34:33 INFO - PID 15673 | 17:34:33 INFO - PID 15673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:2.31 (3.5%) stddev-sans-first:2.40 17:34:33 INFO - PID 15673 | Values: 66.0 69.0 66.0 66.0 65.0 72.0 67.0 70.0 67.0 65.0 17:34:33 INFO - PID 15673 | -------- Summary: end -------- 17:34:33 INFO - PID 15673 | 17:34:34 INFO - PID 15673 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:34:34 INFO - TEST-INFO | 15673: exit 0 17:34:34 INFO - TEST-OK | kraken | took 62097ms 17:34:34 INFO - SUITE-END | took 1171s 17:34:35 INFO - Completed test suite (00:19:31) 17:34:35 INFO - javascript benchmark 17:34:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8684.326982345214, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3235.547023416722, 3262.4127657021736, 3292.292157186205, 3292.7365810735146, 3351.899443016709, 6394.232692076951, 6499.3175716549795, 6506.186726659168, 6532.771353002646, 6540.247871494779, 6278.591891527048, 6404.42360187583, 6407.935920640793, 6417.13368695226, 6429.935700642992, 5896.88206235875, 5958.672273024982, 6009.248843894513, 6016.639001659914, 6042.546808989321, 5735.684537350444, 5746.195532625436, 5804.0, 5847.532197424217, 5913.172155898178, 5789.305283366002, 5790.565707571928, 5794.536437085044, 5805.477507024367, 5874.73563689635, 5797.536197104221, 5809.331926828384, 5879.353271140171, 5887.823365299005, 5902.996490596566, 5751.051076572402, 5815.912761308584, 5855.0, 5930.0, 5936.5547583931375, 6434.034894765776, 6477.352264773532, 6489.643069631168, 6494.350564943515, 6513.283538810727, 6815.659217039129, 6827.965860170717, 6833.794986150423, 6893.172819261721, 6932.306769323078, 6701.530892837503, 6864.347886950732, 6913.446924246048, 6918.273581273944, 6999.720011199546, 6460.289368169498, 6471.0, 6505.577137486048, 6507.284198738135, 6510.121133646944, 7094.787156385317, 7110.822229444305, 7114.324139206767, 7184.209736928934, 7194.568325900463, 6619.139511863524, 6708.563943343667, 6798.558093723892, 6800.693968771318, 6897.55165914224, 6769.695363708645, 6812.659367031629, 6830.59016459014, 6839.658017099126, 6872.037914691947, 6888.0, 6929.272426395257, 6959.304069593101, 6967.93032069683, 6991.335823096798, 6708.3291670833505, 6925.792226233221, 6932.0, 7016.228214896358, 7043.084399028094, 5396.946030539723, 5397.865053373697, 5418.160185171305, 5420.864478388072, 5424.457554244623, 4692.554207350297, 4712.764361781966, 4723.6929599575915, 4724.267738500538, 4741.0754902794315, 5934.584579079423, 5997.610155339976, 6006.579539432285, 6008.519318454513, 6010.2186715726675, 6860.828479288058, 6870.5534140281725, 6967.372936435644, 6974.128233970754, 6979.93020069803, 5632.155176723442, 5926.140709597084, 5972.46247837688, 5978.760849565969, 5980.880382392328, 5816.941830581724, 5826.126081087871, 5829.7376618052285, 5877.206577112121, 5907.586468947133, 6549.770758023542, 6645.3022432643875, 6648.867022659617, 6661.300563440769, 6680.432163266177, 6744.662766861736, 6750.594964302158, 6828.487863410165, 6830.556013859084, 6860.176778786477, 6481.4814814815645, 6584.045313429621, 6605.207375115017, 6638.336166383516, 6647.3352664735075, 6701.229358623626, 6715.429188518835, 6738.090357801634, 6835.213950395768, 6840.144981877265, 6932.925396563541, 6965.616891071039, 6975.337342952412, 6978.581285122909, 7025.437964962688, 6649.767258145942, 6651.0, 6670.733170673118, 6763.2898545652, 6779.15260592426, 6474.5791523550815, 6603.636799976048, 6614.90077648826, 6656.633885136364, 6750.5274630775375, 6541.280459149585, 6626.635535045619, 6627.0, 6642.667866606554, 6653.600783952978, 6622.006698995189, 6695.698693558704, 6795.558288711218, 6797.1843378794865, 6835.248122706399, 6469.676516174267, 6476.384743449365, 6502.577332473374, 6558.409743123142, 6582.308857569887], "value": 6263.875525453586, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [853.6585365853658, 877.6182360673108, 901.4095767272439, 905.492923962581, 1132.9376884271371, 31506.68493315066, 32515.51226731598, 41968.160636787245, 42912.356314655226, 42914.57085429152, 43928.12143757123, 44058.77970610143, 44131.338029929495, 44165.7791711041, 44280.0, 7742.574158421285, 7948.284654381105, 7951.443398962075, 7955.0, 7956.403269754763, 7812.882806757903, 7924.80187995299, 7926.603669816515, 7927.920720792805, 7931.563763992978, 7898.2101789820845, 7943.046834379882, 7944.920550794476, 7951.165127661599, 7952.0, 7888.723894663688, 7905.407094467881, 7906.960465197666, 7915.050193976702, 7928.6035698214855, 7651.808704782369, 7661.42539309554, 7677.50096243748, 7719.768406947801, 7749.612519374009, 38464.80767596144, 38507.0, 38660.226795464216, 38850.805745971375, 38915.416268755995, 3591.8742844000335, 3634.5638523377365, 3636.654517820803, 3639.5268615080136, 3639.7816131032223, 32120.678793212235, 32176.35647287041, 32420.0, 32420.18949526257, 32440.351192976243, 4934.654574179809, 5102.540771330561, 5110.66780659256, 5129.0767661820855, 5136.691798492103, 187742.06128969404, 188156.0, 189785.0, 189871.0, 189909.0, 49484.257736133986, 49487.50512494829, 49541.25688114681, 49568.75215623899, 49659.25511117336, 52012.73993630007, 52045.0, 52070.21894671583, 52146.21780673293, 52184.47815521796, 12650.367481625883, 12955.222686638832, 14051.227182504856, 14351.856481435052, 14358.282085895873, 11804.88195118055, 11948.402579870972, 11989.0, 12005.819912701316, 12080.57717979884, 14645.48740794067, 14660.120392776254, 14694.748811762132, 14704.485343012942, 14811.259437028106, 5771.220885180447, 5882.617629854131, 5902.704864756745, 5989.161517387569, 6098.69506524672, 983.9508024598885, 989.8218320702342, 1010.2625083688948, 1023.5905637744813, 1031.8813336466253, 23347.7665223349, 23383.415414614432, 23604.763952360256, 23662.0, 23693.0, 1109.672646569264, 1109.8890110988837, 1110.0509064749683, 1115.66530040989, 1124.6401151631562, 12179.939100304442, 12376.257424554555, 12511.93744031274, 12558.497660093677, 12657.683557911127, 238411.6158838424, 241372.0, 241715.0, 242251.0, 242285.0, 54607.72696136494, 55023.0, 55083.0, 55292.44707552953, 55306.17040744392, 1433.7562614355584, 1446.1395469695515, 1466.9266536673124, 1467.882569394446, 1470.919099449519, 22633.88683056574, 22701.545969080857, 22789.658155127356, 23072.884635577386, 23157.305280841603, 37789.81105094567, 37988.43017354687, 38062.80968595139, 38099.619003810716, 38157.0, 208801.0, 209000.0, 210405.0, 210654.0, 210759.0, 35843.0, 37165.81417092897, 39043.2191356177, 39135.6086439132, 39220.60779392169, 48115.0, 48561.0, 48819.5118048815, 48867.0, 49095.0, 35294.47058294179, 35314.293714126085, 35375.469367958984, 35549.644503554635, 36176.276474469836, 34089.48865767065, 34865.47701784526, 34911.65088349084, 35087.0, 35252.0, 39136.80431597824, 39209.215815684096, 39497.210055799296, 39557.80221098876, 39565.2086958265, 33819.830900845336, 34143.4878476828, 34396.65603344035, 34632.480512792834, 35164.82417587896, 23819.761802382447, 25006.249812505655, 25058.874705626356, 25419.872900636117, 26049.218523444328], "value": 17606.249555373466, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.5293133165139, 572.3360901354429, 572.513363640905, 574.8187474739409, 588.764494202319, 22167.778322216775, 22181.556368872614, 22962.19632312867, 22996.540069198607, 23031.0, 23534.29397118089, 25384.365390865238, 25418.364540886487, 25429.23712288634, 25484.872575637142, 6715.865682686331, 6869.278725733801, 6869.587824730532, 6871.0, 6871.828204294908, 6144.784932527363, 6741.898871516931, 6744.460443164535, 6746.966265168668, 6805.55763875349, 6700.664966751668, 6704.860173770447, 6706.597604143767, 6708.094407255031, 6708.12794336738, 6652.800415987528, 6702.865942681119, 6706.83232919176, 6707.899381509281, 6709.563878347892, 6203.131561581382, 6205.193324867739, 6210.534209934273, 6219.253689557282, 6222.346653601352, 28798.0, 29025.274368140756, 29816.10551683453, 30009.399812003638, 30148.397032059456, 2068.979310206894, 2101.88600041978, 2103.2848831397246, 2103.5267064910427, 2106.494441334084, 19396.515087122934, 19846.0, 19896.104675289647, 19921.402357929284, 19937.0, 2387.08815804442, 2406.2179791567637, 2443.9022439102414, 2445.339758265276, 2448.8897999590063, 140724.0, 141225.0, 143818.28090859478, 144713.0, 144833.0, 14271.78592321116, 15019.24903754808, 15034.323455444313, 15066.09603423798, 15071.472498462721, 22433.88783056107, 23031.0, 23142.652860207112, 23165.073397064265, 23739.287821365386, 9630.422174669542, 9734.902650973541, 9767.511624418892, 9816.067473589997, 9866.55600497965, 8733.301335893113, 8734.563271836383, 8737.868931966026, 8767.868481972775, 8862.0, 9264.583093760797, 9442.622295108256, 9484.95665476797, 9503.144716975505, 9560.235181185488, 2742.80800343978, 2762.668479782439, 2795.203367040384, 2797.412543365875, 2848.3875966667265, 988.6243227573619, 990.2078337330107, 996.8554559588819, 1003.1824063388315, 1005.5877090392904, 18490.0, 18533.907330463262, 18712.438626841216, 18845.0, 19013.61972760565, 1041.6354276003337, 1047.3035431438161, 1048.0829274384914, 1052.1845569683555, 1068.8236440987305, 10103.14123299513, 10108.595656173818, 10143.34068285559, 10146.695599132037, 10404.479776011169, 474394.0, 476280.0, 476684.0, 487932.0, 489472.0, 113433.4328328353, 113462.43268783603, 117548.0, 119147.80852191367, 119512.40243798899, 1181.0, 1187.2520312203258, 1212.5816593275306, 1214.265369451469, 1215.604928398274, 16563.00621962638, 16760.0, 16939.15304234808, 17093.0, 21143.577128457036, 58199.70900145642, 58242.41757582539, 59114.704426479315, 59637.0, 60814.391856080874, 68866.0, 69018.65490672515, 69378.0, 69538.30461695521, 69916.6504167476, 14491.130532168103, 14794.77807832905, 14833.184174870486, 14903.478378256708, 14910.627234319229, 23350.18274360389, 23426.414339641644, 23649.881750591136, 23713.644295335238, 23716.0, 18604.7209291858, 18968.146433410253, 18980.810191898458, 18987.620247594696, 19019.144138513522, 16292.51122466328, 16990.830091698925, 16996.660066798842, 17211.31154753796, 17668.469945901645, 17915.10424478797, 18174.72737908906, 18381.356652517097, 18427.631447371245, 19508.414747557596, 14539.20034398076, 14571.41714331415, 14600.561983140522, 14639.0, 14661.266936653337, 18110.18504167342, 19159.904200478908, 19164.520886977378, 19249.61500769949, 19292.61414771725], "value": 12029.763165306658, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1345.7173993461372, 1391.986080139199, 1398.622371959571, 1399.6430910117917, 1402.193738600305, 15119.319630616621, 15768.605784855385, 15798.4470543531, 15819.0, 15844.0, 15781.684366312667, 16079.598010049755, 16089.034657920532, 16092.83907160928, 16100.83899161008, 2733.371324595344, 2802.565602331642, 2805.1584524642626, 2805.3968396794685, 2807.5507918732906, 2806.985965070182, 2936.5448355504823, 2938.911832645024, 2940.0738767288344, 2941.4558306713325, 2782.5826126081147, 2832.858357082148, 2838.7161283871656, 2867.713228677126, 2868.8278703277765, 2754.559270516728, 2769.0585201031645, 2787.4007088475873, 2790.6093146959442, 2793.106206014076, 2641.973580264192, 2649.496595646821, 2653.0, 2663.387420893205, 2664.2140568532136, 14806.481773137995, 15268.618284542865, 15291.694166116728, 15338.616534586614, 15415.92292038544, 8016.398770092266, 8287.917120828835, 8290.709825156091, 8305.294050005758, 8311.584420778998, 5361.249425080492, 5415.158845992342, 5459.208414779874, 5540.335159780811, 5568.192612071268, 1987.920483180671, 1995.600879824041, 2001.609686111209, 2031.4108908416542, 2041.989790051055, 26700.465990680077, 26863.194104176906, 26987.190384288504, 27079.323016924536, 27135.0, 7053.470989675795, 7233.168185658611, 7341.963290183515, 7422.96288518554, 7440.069991251094, 17211.311547538207, 17451.301947922195, 17514.824851751575, 17531.386401475887, 17569.0, 8017.398695097891, 8134.837303253902, 8173.141820108922, 8183.95908020456, 8194.795130121795, 7395.26047395267, 7532.661030253652, 7541.811454713676, 7585.127710313274, 7603.923960760321, 5091.261767043758, 5299.311089558333, 5303.071962406563, 5344.812931547377, 5360.892782144335, 1485.5469081929898, 1486.613480495079, 1491.7538606129867, 1498.5878883307178, 1518.3395223077775, 917.5687426909342, 943.773494361362, 951.7668171298076, 957.3968399908152, 960.4573416019927, 7742.225777422325, 7742.496737712031, 7775.105862825734, 7779.961100194463, 7786.377089832799, 733.5158795195252, 744.0401881572818, 747.7382915979364, 748.2405358561065, 750.9924900751032, 5254.500822421864, 5283.815066472655, 5355.571554275726, 5431.293931788842, 5436.565074794007, 21190.89404552998, 22201.333959981228, 22394.44013899633, 22464.663030054562, 22503.437414064778, 21577.244796432362, 21725.67411488829, 22084.116635334405, 22318.888405557867, 22349.217777377715, 11407.258528195807, 11541.076713863038, 11632.651020469399, 11637.185397022127, 11666.358350290646, 8226.753197404087, 8227.177282271725, 8291.62687679068, 8333.583320834055, 8400.579971001547, 18816.341428049953, 18913.243470261037, 18923.0, 19013.80986190176, 19220.327288544835, 19327.710084348466, 19399.0, 19399.2240310386, 19480.610387791883, 19636.312729054414, 12175.634730958085, 12324.568640097554, 12416.255024698547, 12430.751384972069, 12443.37783110859, 13978.30108494551, 14076.0, 14085.929570352493, 14138.858611413754, 14163.433462661378, 11210.943945280222, 11232.157588180755, 11288.322700637988, 11380.317180969168, 11545.538178472767, 10802.405867677353, 10870.565177393131, 10967.232293739362, 11048.613298534834, 11275.66173014811, 9718.854217186888, 9937.701868943943, 9942.850857237003, 9972.0, 9983.0, 7005.299470052954, 7024.121984751906, 7041.26066763003, 7051.435885129074, 7091.11361079865, 6990.0, 6993.300669932966, 7061.399781018671, 7097.219305876246, 7149.392301654418], "value": 6755.96886539546, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.7312171159266, 504.4854248666358, 529.3721805448248, 532.6431291035007, 533.8985592737382, 6411.679416029203, 6425.775097871576, 6435.742570297189, 6471.70877310521, 6492.513061520387, 6006.639601623895, 6215.638057538129, 6287.7799277025315, 6312.33720459352, 6321.52588555859, 5047.217681259411, 5070.797168113271, 5097.796088156488, 5147.216795655199, 5171.534561889429, 5044.268581055745, 5079.222272204717, 5083.79664813407, 5101.821436249732, 5187.221916712486, 5201.921971170435, 5282.841514754564, 5312.867178320554, 5332.306800115999, 5341.519263266306, 5271.15661494161, 5316.840494785162, 5340.973295133538, 5376.865578360533, 5380.408155102936, 4900.803967841282, 4904.215325547931, 4964.354633897607, 4979.800807967713, 4982.252662100714, 6253.280872699653, 6337.429631333202, 6369.299377068519, 6394.6482943438095, 6424.132742079806, 6040.48655864252, 6101.481374083208, 6116.204893363879, 6127.908081378783, 6146.416090471443, 6682.398584127403, 6711.557015241747, 6729.399771122475, 6747.966260168668, 6798.694058767367, 5354.464553544653, 5399.811006614749, 5400.675959442407, 5437.102878025121, 5438.5377242934, 7130.358267755875, 7174.677139528734, 7207.4503981643675, 7219.494635375526, 7219.530730502501, 5560.805371811967, 5561.109222864246, 5566.165075238747, 5594.636348637326, 5596.776128954878, 5649.858753531113, 5657.434256574392, 5669.829905102853, 5671.404502527258, 5695.316562012585, 6125.785597504066, 6137.539684523678, 6146.170267013986, 6150.923588372017, 6157.692115394302, 6737.932620673829, 6772.5936443813525, 6773.288804675537, 6860.176778786577, 6864.7940561783225, 1829.7072468404992, 1869.4391682495468, 1908.4751693284459, 1951.7853036166011, 1954.7067939808858, 1441.992790036043, 1454.934527946245, 1465.2893346726828, 1471.7645176771666, 1477.519806063034, 5897.852553686193, 5905.822825315247, 5906.232189815297, 5907.409259074144, 5929.5769015436845, 6739.157605299338, 6831.9658401707675, 6891.310868913169, 6917.481188910851, 6922.550034247758, 5953.583249172603, 5963.344032156459, 5966.791162309385, 5989.580729348903, 6012.699365031731, 3597.9280414391565, 3637.2361804021452, 3641.417373220272, 3671.14607123401, 3681.8527258909344, 6680.732770689216, 6702.765403210864, 6708.329167083252, 6751.25736169021, 6751.763688270887, 7081.787546373617, 7105.0, 7109.857802843914, 7136.678849451787, 7146.3568278855155, 6675.332466753286, 6675.899861502178, 6717.1267735194115, 6732.360425759643, 6751.729930802811, 6807.319268073153, 6873.347032031949, 6907.930920690729, 6909.2745261746795, 6934.930650693428, 6747.763828265987, 6758.7296508139125, 6774.3225677431865, 6808.489363297674, 6814.795556133324, 6504.479641628753, 6598.3401659833635, 6647.833804154935, 6686.1642294713165, 6686.99695045747, 4999.900002000012, 5004.1492946198505, 5017.222330538772, 5072.289879416959, 5089.618278629192, 6443.548951573345, 6834.334609502199, 6891.414229790524, 6892.0, 6899.413549848319, 6439.839004024937, 6448.484121270381, 6453.6766763964, 6521.64130972801, 6539.6403197824575, 6448.387403196689, 6526.608403495806, 6544.476441884733, 6560.0, 6580.473562114924, 6417.614943103429, 6436.420722135031, 6450.290468048417, 6481.203909107133, 6549.24683661385, 6535.745167917061, 6537.444317233088, 6709.718695643504, 6730.93269067303, 6749.696263668048, 6510.688705509665, 6511.590711436798, 6520.576162549419, 6521.619663777497, 6530.314316996647], "value": 5276.443731746083, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [911.2026976395654, 922.5387306346827, 931.9860202096966, 938.63862412971, 940.5344354544497, 16891.23989420476, 17380.21789019494, 17386.13069346534, 17433.738493922585, 21667.566648667016, 20305.289314873982, 21314.89342553289, 21357.99999999996, 21422.57154856902, 21492.0, 923.8845144356956, 949.6391371278904, 952.2572393533055, 952.3190918493276, 952.5618215620788, 936.7002559181064, 985.2561316206254, 996.7059717383353, 1005.2360206243271, 1007.8034783217275, 1061.1828891753346, 1061.6602687140119, 1065.147881694645, 1065.2223876570108, 1065.254321974617, 1056.3450660590445, 1056.3872953686844, 1059.5602824827688, 1062.7024433158729, 1063.1441689439998, 776.2160218179623, 777.3742137579246, 778.5017588743209, 779.2986312318901, 780.5784876166863, 19674.80325196744, 19794.109265083105, 19947.700784488243, 19959.80040199594, 20072.197112115497, 20843.16627334905, 21075.789242107538, 21080.15679372823, 21445.142194312208, 21776.34670959858, 16836.158192090348, 17379.0, 17388.56528586783, 17554.91222543892, 17569.648607027786, 3778.4332350147697, 3812.066043819282, 3825.005498570392, 3825.923481530354, 3826.2730081284744, 119759.0, 120631.3968430161, 121661.0, 124021.0, 125089.0, 16495.752563711554, 16731.581710457092, 17191.398301059402, 17191.91404042997, 17208.225629846685, 30904.0, 30908.0, 30956.535651965238, 31091.84454077715, 31113.222169445944, 8536.402451828313, 8624.0, 8657.740267791976, 8660.913390866137, 8662.177093176138, 4153.127843152972, 4236.385724069993, 4237.110206856533, 4239.51245606753, 4255.87232383029, 5160.509751573594, 5238.0, 5281.260623512711, 5281.260623512711, 5299.0, 967.583938906277, 989.1443901025705, 1003.2375394700081, 1008.5159123620704, 1011.0445628880784, 687.1685260834446, 689.9068625735562, 716.7706333973183, 720.4452571519901, 725.2747252747253, 10852.348859068481, 10928.672139835817, 11006.229563930608, 11426.828597571042, 11703.0, 686.2348481443155, 696.6586372677453, 700.9334113259232, 714.6819665249018, 720.0854914258862, 5200.401953775288, 5290.127129023745, 5309.8938021239355, 5343.86640333987, 5988.04191329394, 105835.0, 108167.0, 110481.89518104876, 111226.0, 114431.0, 95739.52130239444, 98365.0, 99462.50268748609, 100837.0, 105607.4719626397, 83261.0, 85273.0, 85588.57205713932, 85866.57066714752, 87291.56354218315, 11307.434628268718, 11734.589289374831, 11773.470193841127, 12016.923559927738, 12207.267563946192, 36957.0, 38037.61962380341, 38113.0, 38727.419088713126, 41623.58376416318, 50068.499315007844, 68861.0, 70036.0, 70602.64698676474, 76273.61863190649, 17726.734098988785, 17744.201510932297, 17888.28446862111, 17927.551811204823, 17966.640667186846, 21116.57766844685, 21240.575188496452, 21772.89113554422, 21848.89075554612, 21901.233456829574, 16521.33914643449, 16522.66954660876, 16693.499195024167, 16871.578210544834, 17003.234854431827, 16560.834391655928, 16592.75110873362, 16688.582785430463, 18170.45488635343, 18371.448856534324, 15940.0, 16266.674666506367, 16467.25897334599, 16768.0, 17227.31090756356, 12627.873721263037, 12939.353032348157, 13049.086563940433, 13365.26491043002, 14607.0, 13524.526641567498, 13673.589792306248, 13715.451381944611, 13776.517821876587, 14241.857581424054], "value": 9069.774416616494, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1497.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 107.0, 100.0, 107.0, 108.0, 109.0, 108.0, 99.0, 108.0, 107.0], "value": 105.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 120.0, 152.0, 171.0, 118.0, 146.0, 154.0, 117.0, 176.0, 119.0], "value": 142.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 161.0, 164.0, 163.0, 163.0, 168.0, 167.0, 161.0, 164.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 79.0, 75.0, 178.0, 74.0, 75.0, 73.0, 73.0, 145.0, 76.0], "value": 92.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 82.0, 133.0, 79.0, 79.0, 79.0, 130.0, 79.0, 78.0, 125.0], "value": 94.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 113.0, 113.0, 114.0, 113.0, 114.0, 114.0, 116.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 151.0, 148.0, 150.0, 149.0, 148.0, 148.0, 149.0, 148.0, 148.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 94.0, 94.0, 93.0, 94.0, 94.0, 95.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 54.0, 52.0, 51.0, 53.0, 52.0, 53.0, 52.0, 54.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 37.0, 38.0, 38.0, 40.0, 38.0, 37.0, 37.0, 38.0, 37.0], "value": 37.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 75.0, 74.0, 80.0, 76.0, 76.0, 80.0, 76.0], "value": 76.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 123.0, 127.0, 125.0, 118.0, 126.0, 124.0, 131.0, 121.0, 163.0], "value": 128.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 179.0, 180.0, 185.0, 180.0, 186.0, 178.0, 182.0, 176.0, 178.0], "value": 180.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 66.0, 66.0, 65.0, 72.0, 67.0, 70.0, 67.0, 65.0], "value": 67.3, "unit": "score"}]}]} 17:34:35 INFO - Return code: 0 17:34:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:34:35 INFO - # TBPL SUCCESS # 17:34:35 INFO - Running post-action listener: _package_coverage_data 17:34:35 INFO - Running post-action listener: _resource_record_post_action 17:34:35 INFO - [mozharness: 2017-09-07 00:34:35.269505Z] Finished run-tests step (success) 17:34:35 INFO - Running post-run listener: _resource_record_post_run 17:34:35 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 391680000; Read time: 0; Write time: 320060 17:34:35 INFO - TinderboxPrint: CPU usage
13.1% 17:34:35 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 17:34:35 INFO - TinderboxPrint: I/O write bytes / time
391,680,000 / 320,060 17:34:35 INFO - TinderboxPrint: CPU idle
8,243.6 (86.9%) 17:34:35 INFO - TinderboxPrint: CPU user
1,193.0 (12.6%) 17:34:35 INFO - TinderboxPrint: Swap in / out
0 / 0 17:34:35 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107270144; Read time: 0; Write time: 84692 17:34:35 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:34:35 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 284364800; Read time: 0; Write time: 235368 17:34:35 INFO - Running post-run listener: _upload_blobber_files 17:34:35 INFO - Blob upload gear active. 17:34:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:34:35 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 17:34:35 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'] 17:34:35 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 17:34:36 INFO - (blobuploader) - INFO - Open directory for files ... 17:34:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:34:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:34:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:34:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:34:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:34:37 INFO - (blobuploader) - INFO - Done attempting. 17:34:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:34:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:34:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:34:38 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:34:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:34:38 INFO - (blobuploader) - INFO - Done attempting. 17:34:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:34:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:34:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:34:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:34:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:34:45 INFO - (blobuploader) - INFO - Done attempting. 17:34:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:34:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:34:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:34:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:34:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:34:46 INFO - (blobuploader) - INFO - Done attempting. 17:34:46 INFO - (blobuploader) - INFO - Iteration through files over. 17:34:46 INFO - Return code: 0 17:34:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:34:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:34:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b6b162ae21e66854b2009f8330e5e2a3010b778ab177ff85fd0b682e8de7bced25e883936acf1eb016db404c279504e26497a91b8dbae2c08c057e1785920b50", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/441381d654ce941af2321e78d7a4aad4bce5f8e3e18b8f6b730c04bad5166748f408762c0249d30d7a06d0c2ff84873d16e36e7cedba6792c9bb2086211ee2e6", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08c68a21f7aaf77c3c1c35b96ce32ce1191244affe86a6f763cb7fa684683183523ed01cb8021b19d6ffa9a19ff801db3bf40c27b06420830f68a11cff1eba24", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e2320273084c3229055b9f58a1e12e74855ac7f969ecfbb65b15484dfa0603da22434ab048da663ae2f22cf43a39a91dd4fff09d21500b2cddacb44057009ad0"} 17:34:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:34:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:34:46 INFO - Contents: 17:34:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b6b162ae21e66854b2009f8330e5e2a3010b778ab177ff85fd0b682e8de7bced25e883936acf1eb016db404c279504e26497a91b8dbae2c08c057e1785920b50", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/441381d654ce941af2321e78d7a4aad4bce5f8e3e18b8f6b730c04bad5166748f408762c0249d30d7a06d0c2ff84873d16e36e7cedba6792c9bb2086211ee2e6", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08c68a21f7aaf77c3c1c35b96ce32ce1191244affe86a6f763cb7fa684683183523ed01cb8021b19d6ffa9a19ff801db3bf40c27b06420830f68a11cff1eba24", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e2320273084c3229055b9f58a1e12e74855ac7f969ecfbb65b15484dfa0603da22434ab048da663ae2f22cf43a39a91dd4fff09d21500b2cddacb44057009ad0"} 17:34:46 INFO - Running post-run listener: copy_logs_to_upload_dir 17:34:46 INFO - Copying logs to upload dir... 17:34:46 INFO - mkdir: /builds/slave/test/build/upload/logs 17:34:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.719541 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-09-06 17:34:46.323185) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-06 17:34:46.329055) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1504743233.781404-573586414 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b6b162ae21e66854b2009f8330e5e2a3010b778ab177ff85fd0b682e8de7bced25e883936acf1eb016db404c279504e26497a91b8dbae2c08c057e1785920b50", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/441381d654ce941af2321e78d7a4aad4bce5f8e3e18b8f6b730c04bad5166748f408762c0249d30d7a06d0c2ff84873d16e36e7cedba6792c9bb2086211ee2e6", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08c68a21f7aaf77c3c1c35b96ce32ce1191244affe86a6f763cb7fa684683183523ed01cb8021b19d6ffa9a19ff801db3bf40c27b06420830f68a11cff1eba24", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e2320273084c3229055b9f58a1e12e74855ac7f969ecfbb65b15484dfa0603da22434ab048da663ae2f22cf43a39a91dd4fff09d21500b2cddacb44057009ad0"} build_url:https://queue.taskcluster.net/v1/task/UKt4CYvxSaGZCXqv81saJw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011474 build_url: 'https://queue.taskcluster.net/v1/task/UKt4CYvxSaGZCXqv81saJw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b6b162ae21e66854b2009f8330e5e2a3010b778ab177ff85fd0b682e8de7bced25e883936acf1eb016db404c279504e26497a91b8dbae2c08c057e1785920b50", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/441381d654ce941af2321e78d7a4aad4bce5f8e3e18b8f6b730c04bad5166748f408762c0249d30d7a06d0c2ff84873d16e36e7cedba6792c9bb2086211ee2e6", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08c68a21f7aaf77c3c1c35b96ce32ce1191244affe86a6f763cb7fa684683183523ed01cb8021b19d6ffa9a19ff801db3bf40c27b06420830f68a11cff1eba24", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e2320273084c3229055b9f58a1e12e74855ac7f969ecfbb65b15484dfa0603da22434ab048da663ae2f22cf43a39a91dd4fff09d21500b2cddacb44057009ad0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-06 17:34:46.357555) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 17:34:46.357889) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1504743233.781404-573586414 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004519 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 17:34:46.442511) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-06 17:34:46.442851) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-06 17:34:46.443120) ========= ========= Total master_lag: 0.20 =========