builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-002 starttime: 1504743432.15 results: success (0) revision: d8e238b811d3dc74515065ae8cab6c74baf0295f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-06 17:17:12.148077) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-06 17:17:12.148554) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-06 17:17:12.148854) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-06 17:17:12.166645) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 17:17:12.166991) ========= 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=a0d2d2de893abaa8702a9954000001a7-1504743430.942407-390765886 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-06 17:17:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 106M=0s 2017-09-06 17:17:12 (106 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.121092 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 17:17:12.308317) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 17:17:12.308668) ========= 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=a0d2d2de893abaa8702a9954000001a7-1504743430.942407-390765886 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018608 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 17:17:12.361967) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-06 17:17:12.362325) ========= 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=a0d2d2de893abaa8702a9954000001a7-1504743430.942407-390765886 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-06 17:17:12,259 truncating revision to first 12 chars 2017-09-06 17:17:12,259 Setting DEBUG logging. 2017-09-06 17:17:12,259 attempt 1/10 2017-09-06 17:17:12,259 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:17:13,193 unpacking tar archive at: mozilla-central-d8e238b811d3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.319427 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-06 17:17:13.701821) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-06 17:17:13.702149) ========= script_repo_revision: d8e238b811d3dc74515065ae8cab6c74baf0295f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-06 17:17:13.702513) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-06 17:17:13.702778) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-06 17:17:13.715981) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-09-06 17:17:13.716278) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=a0d2d2de893abaa8702a9954000001a7-1504743430.942407-390765886 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:17:13 INFO - MultiFileLogger online at 20170906 17:17:13 in /builds/slave/test 17:17:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 17:17:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:17:13 INFO - {'append_to_log': False, 17:17:13 INFO - 'base_work_dir': '/builds/slave/test', 17:17:13 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:17:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:17:13 INFO - 'branch': 'Firefox-Non-PGO', 17:17:13 INFO - 'buildbot_json_path': 'buildprops.json', 17:17:13 INFO - 'code_coverage': False, 17:17:13 INFO - 'config_files': ('talos/linux_config.py',), 17:17:13 INFO - 'default_actions': ('clobber', 17:17:13 INFO - 'read-buildbot-config', 17:17:13 INFO - 'download-and-extract', 17:17:13 INFO - 'populate-webroot', 17:17:13 INFO - 'create-virtualenv', 17:17:13 INFO - 'install', 17:17:13 INFO - 'setup-mitmproxy', 17:17:13 INFO - 'run-tests'), 17:17:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:17:13 INFO - 'disable_ccov_upload': False, 17:17:13 INFO - 'disable_stylo': False, 17:17:13 INFO - 'download_minidump_stackwalk': True, 17:17:13 INFO - 'download_symbols': 'ondemand', 17:17:13 INFO - 'enable_stylo': False, 17:17:13 INFO - 'enable_webrender': False, 17:17:13 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 17:17:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:17:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:17:13 INFO - 'gecko_profile': False, 17:17:13 INFO - 'gecko_profile_interval': 0, 17:17:13 INFO - 'installer_path': 'installer.exe', 17:17:13 INFO - 'log_level': 'info', 17:17:13 INFO - 'log_name': 'talos', 17:17:13 INFO - 'log_to_console': True, 17:17:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:17:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:17:13 INFO - 'opt_config_files': (), 17:17:13 INFO - 'pip_index': False, 17:17:13 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 17:17:13 INFO - 'system_bits': '32', 17:17:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:17:13 INFO - 'title': 'talos-linux64-ix-002', 17:17:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:17:13 INFO - 'use_talos_json': True, 17:17:13 INFO - 'verify': 'False', 17:17:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:17:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:17:13 INFO - 'work_dir': 'build'} 17:17:13 INFO - [mozharness: 2017-09-07 00:17:13.751730Z] Running clobber step. 17:17:13 INFO - Running pre-action listener: _resource_record_pre_action 17:17:13 INFO - Running main action method: clobber 17:17:13 INFO - rmtree: /builds/slave/test/build 17:17:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:17:14 INFO - Running post-action listener: _resource_record_post_action 17:17:14 INFO - [mozharness: 2017-09-07 00:17:14.761927Z] Finished clobber step (success) 17:17:14 INFO - [mozharness: 2017-09-07 00:17:14.762024Z] Running read-buildbot-config step. 17:17:14 INFO - Running pre-action listener: _resource_record_pre_action 17:17:14 INFO - Running main action method: read_buildbot_config 17:17:14 INFO - Using buildbot properties: 17:17:14 INFO - { 17:17:14 INFO - "project": "", 17:17:14 INFO - "product": "firefox", 17:17:14 INFO - "who": "kwierso@gmail.com", 17:17:14 INFO - "installer_path": "public/build/target.tar.bz2", 17:17:14 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 17:17:14 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:17:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 17:17:14 INFO - "stage_platform": "linux64", 17:17:14 INFO - "basedir": "/builds/slave/test", 17:17:14 INFO - "buildnumber": 0, 17:17:14 INFO - "platform": "ubuntu64_hw", 17:17:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:17:14 INFO - "slavebuilddir": "test", 17:17:14 INFO - "taskId": "WDZ4_wUXR1W6Mm1ZsHhJoQ", 17:17:14 INFO - "branch": "mozilla-central", 17:17:14 INFO - "script_repo_revision": "production", 17:17:14 INFO - "revision": "d8e238b811d3dc74515065ae8cab6c74baf0295f", 17:17:14 INFO - "slavename": "talos-linux64-ix-002", 17:17:14 INFO - "repo_path": "mozilla-central" 17:17:14 INFO - } 17:17:14 INFO - Finding installer, test and symbols from parent task. 17:17:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WDZ4_wUXR1W6Mm1ZsHhJoQ'}, attempt #1 17:17:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WDZ4_wUXR1W6Mm1ZsHhJoQ'}, attempt #1 17:17:15 INFO - Task dependencies: UKt4CYvxSaGZCXqv81saJw 17:17:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UKt4CYvxSaGZCXqv81saJw'}, attempt #1 17:17:16 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/UKt4CYvxSaGZCXqv81saJw/artifacts/public/build/target.tar.bz2 17:17:16 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/UKt4CYvxSaGZCXqv81saJw/artifacts/public/build/target.test_packages.json 17:17:16 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/UKt4CYvxSaGZCXqv81saJw/artifacts/public/build/target.crashreporter-symbols.zip 17:17:16 INFO - Running post-action listener: _resource_record_post_action 17:17:16 INFO - [mozharness: 2017-09-07 00:17:16.174251Z] Finished read-buildbot-config step (success) 17:17:16 INFO - [mozharness: 2017-09-07 00:17:16.174467Z] Running download-and-extract step. 17:17:16 INFO - Running pre-action listener: _resource_record_pre_action 17:17:16 INFO - Running main action method: download_and_extract 17:17:16 INFO - mkdir: /builds/slave/test/build/tests 17:17:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:16 INFO - trying https://queue.taskcluster.net/v1/task/UKt4CYvxSaGZCXqv81saJw/artifacts/public/build/target.test_packages.json 17:17:16 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:17:16 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:17:16 INFO - Downloaded 989 bytes. 17:17:16 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:17:16 INFO - Using the following test package requirements: 17:17:16 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:17:16 INFO - u'common': [u'target.common.tests.zip'], 17:17:16 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:17:16 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:17:16 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:17:16 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:17:16 INFO - u'mozbase': [u'target.common.tests.zip'], 17:17:16 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:17:16 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:17:16 INFO - u'web-platform': [u'target.common.tests.zip', 17:17:16 INFO - u'target.web-platform.tests.tar.gz'], 17:17:16 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:17:16 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:17:16 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:17:16 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:17:16 INFO - Fetch https://queue.taskcluster.net/v1/task/UKt4CYvxSaGZCXqv81saJw/artifacts/public/build/target.common.tests.zip into memory 17:17:17 INFO - Content-Length response header: 55021102 17:17:17 INFO - Bytes received: 55021102 17:17:28 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:17:28 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:17:28 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:17:28 INFO - Fetch https://queue.taskcluster.net/v1/task/UKt4CYvxSaGZCXqv81saJw/artifacts/public/build/target.common.tests.zip into memory 17:17:29 INFO - Content-Length response header: 55021102 17:17:29 INFO - Bytes received: 55021102 17:17:41 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:17:41 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:17:41 INFO - Fetch https://queue.taskcluster.net/v1/task/UKt4CYvxSaGZCXqv81saJw/artifacts/public/build/target.talos.tests.zip into memory 17:17:42 INFO - Content-Length response header: 14496665 17:17:42 INFO - Bytes received: 14496665 17:17: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:17:42 INFO - trying https://queue.taskcluster.net/v1/task/UKt4CYvxSaGZCXqv81saJw/artifacts/public/build/target.tar.bz2 17:17:42 INFO - Downloading https://queue.taskcluster.net/v1/task/UKt4CYvxSaGZCXqv81saJw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:17:42 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:17:43 INFO - Downloaded 62756961 bytes. 17:17:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UKt4CYvxSaGZCXqv81saJw/artifacts/public/build/target.tar.bz2 17:17:43 INFO - mkdir: /builds/slave/test/properties 17:17:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:17:43 INFO - Writing to file /builds/slave/test/properties/build_url 17:17:43 INFO - Contents: 17:17:43 INFO - build_url:https://queue.taskcluster.net/v1/task/UKt4CYvxSaGZCXqv81saJw/artifacts/public/build/target.tar.bz2 17:17:43 INFO - Running post-action listener: _resource_record_post_action 17:17:43 INFO - Running post-action listener: find_tests_for_verification 17:17:43 INFO - Running post-action listener: set_extra_try_arguments 17:17:43 INFO - [mozharness: 2017-09-07 00:17:43.812413Z] Finished download-and-extract step (success) 17:17:43 INFO - [mozharness: 2017-09-07 00:17:43.812510Z] Running populate-webroot step. 17:17:43 INFO - Running pre-action listener: _resource_record_pre_action 17:17:43 INFO - Running main action method: populate_webroot 17:17:43 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:17:43 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:17:43 INFO - 'tests': ['tresize', 17:17:43 INFO - 'tcanvasmark']}, 17:17:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:17:43 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:17:43 INFO - 'tests': ['dromaeo_css', 17:17:43 INFO - 'kraken']}, 17:17:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:17:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:17:43 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:17:43 INFO - 'talos_options': ['--disable-stylo'], 17:17:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:17:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:17:43 INFO - 'tests': ['damp', 'tps']}, 17:17:43 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:17:43 INFO - 'talos_options': ['--disable-stylo'], 17:17:43 INFO - 'tests': ['damp', 'tps']}, 17:17:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:17:43 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:17:43 INFO - 'tests': ['dromaeo_dom']}, 17:17:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:17:43 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:17:43 INFO - 'tests': ['basic_compositor_video', 17:17:43 INFO - 'glvideo']}, 17:17:43 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:17:43 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:17:43 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:17:43 INFO - 'talos_options': ['--disable-stylo'], 17:17:43 INFO - 'tests': ['ts_paint_webext', 17:17:43 INFO - 'tp5o_webext']}, 17:17:43 INFO - 'other-e10s': {'tests': ['a11yr', 17:17:43 INFO - 'ts_paint', 17:17:43 INFO - 'tpaint', 17:17:43 INFO - 'sessionrestore', 17:17:43 INFO - 'sessionrestore_many_windows', 17:17:43 INFO - 'sessionrestore_no_auto_restore', 17:17:43 INFO - 'tabpaint']}, 17:17:43 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:17:43 INFO - 'tests': ['a11yr', 17:17:43 INFO - 'ts_paint', 17:17:43 INFO - 'tpaint', 17:17:43 INFO - 'sessionrestore', 17:17:43 INFO - 'sessionrestore_many_windows', 17:17:43 INFO - 'sessionrestore_no_auto_restore', 17:17:43 INFO - 'tabpaint']}, 17:17:43 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 17:17:43 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 17:17:43 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:17:43 INFO - 'tests': ['bloom_basic_singleton']}, 17:17:43 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:17:43 INFO - 'tests': ['bloom_basic']}, 17:17:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:17:43 INFO - 'tsvgr_opacity', 17:17:43 INFO - 'tart', 17:17:43 INFO - 'tscrollx', 17:17:43 INFO - 'tsvg_static']}, 17:17:43 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:17:43 INFO - 'tests': ['tsvgx', 17:17:43 INFO - 'tsvgr_opacity', 17:17:43 INFO - 'tart', 17:17:43 INFO - 'tscrollx', 17:17:43 INFO - 'tsvg_static']}, 17:17:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:17:43 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:17:43 INFO - 'talos_options': ['--disable-stylo'], 17:17:43 INFO - 'tests': ['tp5o']}, 17:17:43 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:17:43 INFO - 'talos_options': ['--mitmproxy', 17:17:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:17:43 INFO - '--firstNonBlankPaint'], 17:17:43 INFO - 'tests': ['tp6_google', 17:17:43 INFO - 'tp6_youtube', 17:17:43 INFO - 'tp6_amazon', 17:17:43 INFO - 'tp6_facebook']}, 17:17:43 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:17:43 INFO - 'talos_options': ['--disable-stylo', 17:17:43 INFO - '--mitmproxy', 17:17:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:17:43 INFO - '--firstNonBlankPaint'], 17:17:43 INFO - 'tests': ['tp6_google', 17:17:43 INFO - 'tp6_youtube', 17:17:43 INFO - 'tp6_amazon', 17:17:43 INFO - 'tp6_facebook']}, 17:17:43 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:17:43 INFO - 'talos_options': ['--stylo-threads=1', 17:17:43 INFO - '--mitmproxy', 17:17:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:17:43 INFO - '--firstNonBlankPaint'], 17:17:43 INFO - 'tests': ['tp6_google', 17:17:43 INFO - 'tp6_youtube', 17:17:43 INFO - 'tp6_amazon', 17:17:43 INFO - 'tp6_facebook']}, 17:17:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:17:43 INFO - 'talos_options': ['--xperf_path', 17:17:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:17:43 INFO - 'tests': ['tp5n']}, 17:17:43 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:17:43 INFO - 'talos_options': ['--disable-stylo', 17:17:43 INFO - '--xperf_path', 17:17:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:17:43 INFO - 'tests': ['tp5n']}}} 17:17:43 INFO - Running post-action listener: _resource_record_post_action 17:17:43 INFO - [mozharness: 2017-09-07 00:17:43.827515Z] Finished populate-webroot step (success) 17:17:43 INFO - [mozharness: 2017-09-07 00:17:43.827605Z] Running create-virtualenv step. 17:17:43 INFO - Running pre-action listener: _resource_record_pre_action 17:17:43 INFO - Running main action method: create_virtualenv 17:17:43 INFO - Creating virtualenv /builds/slave/test/build/venv 17:17:43 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:17:43 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 17:17:43 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:17:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:17:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:17:44 INFO - Installing distribute.............................................................................................................................................................................................done. 17:17:44 INFO - Installing pip...............done. 17:17:44 INFO - Return code: 0 17:17:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:17:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:17:44 INFO - Reading from file tmpfile_stdout 17:17:44 INFO - Output received: 17:17:44 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 17:17:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:17: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:17:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17: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:17:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2823a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ca090>, '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 0x29cad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c4f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1504743430.942407-390765886', '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:17:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:17:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:17:44 INFO - Using env: {'DISPLAY': ':0', 17:17:44 INFO - 'HOME': '/home/cltbld', 17:17:44 INFO - 'LANG': 'en_US.UTF-8', 17:17:44 INFO - 'LANGUAGE': 'en_US:en', 17:17:44 INFO - 'LOGNAME': 'cltbld', 17:17:44 INFO - 'MAIL': '/var/mail/cltbld', 17:17:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:44 INFO - 'MOZ_NO_REMOTE': '1', 17:17:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:44 INFO - 'NO_EM_RESTART': '1', 17:17:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:44 INFO - 'PWD': '/builds/slave/test', 17:17:44 INFO - 'SHELL': '/bin/bash', 17:17:44 INFO - 'SHLVL': '1', 17:17:44 INFO - 'TERM': 'linux', 17:17:44 INFO - 'TMOUT': '86400', 17:17:44 INFO - 'USER': 'cltbld', 17:17:44 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1504743430.942407-390765886', 17:17:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:44 INFO - '_': '/tools/buildbot/bin/python'} 17:17:46 INFO - Ignoring indexes: http://pypi.python.org/simple/ 17:17:46 INFO - Downloading/unpacking pip>=1.5 17:17:46 INFO - Running setup.py egg_info for package pip 17:17:46 INFO - warning: no files found matching 'pip/cacert.pem' 17:17:46 INFO - warning: no files found matching '*.html' under directory 'docs' 17:17:46 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:17:46 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:17:46 INFO - Installing collected packages: pip 17:17:46 INFO - Found existing installation: pip 1.1 17:17:46 INFO - Uninstalling pip: 17:17:46 INFO - Successfully uninstalled pip 17:17:46 INFO - Running setup.py install for pip 17:17:46 INFO - warning: no files found matching 'pip/cacert.pem' 17:17:46 INFO - warning: no files found matching '*.html' under directory 'docs' 17:17:46 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:17:46 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:17:46 INFO - Installing pip script to /builds/slave/test/build/venv/bin 17:17:46 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 17:17:46 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 17:17:46 INFO - Successfully installed pip 17:17:46 INFO - Cleaning up... 17:17:46 INFO - Return code: 0 17:17:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:17:46 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:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:46 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:17:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:46 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 0x265a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2823a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ca090>, '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 0x29cad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c4f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1504743430.942407-390765886', '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:17:46 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:17:46 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:17:46 INFO - Using env: {'DISPLAY': ':0', 17:17:46 INFO - 'HOME': '/home/cltbld', 17:17:46 INFO - 'LANG': 'en_US.UTF-8', 17:17:46 INFO - 'LANGUAGE': 'en_US:en', 17:17:46 INFO - 'LOGNAME': 'cltbld', 17:17:46 INFO - 'MAIL': '/var/mail/cltbld', 17:17:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:46 INFO - 'MOZ_NO_REMOTE': '1', 17:17:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:46 INFO - 'NO_EM_RESTART': '1', 17:17:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:46 INFO - 'PWD': '/builds/slave/test', 17:17:46 INFO - 'SHELL': '/bin/bash', 17:17:46 INFO - 'SHLVL': '1', 17:17:46 INFO - 'TERM': 'linux', 17:17:46 INFO - 'TMOUT': '86400', 17:17:46 INFO - 'USER': 'cltbld', 17:17:46 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1504743430.942407-390765886', 17:17:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:46 INFO - '_': '/tools/buildbot/bin/python'} 17:17:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:46 INFO - Downloading/unpacking psutil>=3.1.1 17:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:17:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:17:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:17:47 INFO - Installing collected packages: psutil 17:17:47 INFO - Running setup.py install for psutil 17:17:47 INFO - building 'psutil._psutil_linux' extension 17:17:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:17:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:17:47 INFO - building 'psutil._psutil_posix' extension 17:17:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:17:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:17:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:17:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:17:47 INFO - Successfully installed psutil 17:17:47 INFO - Cleaning up... 17:17:47 INFO - Return code: 0 17:17:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:48 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 0x265a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2823a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ca090>, '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 0x29cad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c4f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1504743430.942407-390765886', '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:17:48 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:17:48 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:17:48 INFO - Using env: {'DISPLAY': ':0', 17:17:48 INFO - 'HOME': '/home/cltbld', 17:17:48 INFO - 'LANG': 'en_US.UTF-8', 17:17:48 INFO - 'LANGUAGE': 'en_US:en', 17:17:48 INFO - 'LOGNAME': 'cltbld', 17:17:48 INFO - 'MAIL': '/var/mail/cltbld', 17:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:48 INFO - 'MOZ_NO_REMOTE': '1', 17:17:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:48 INFO - 'NO_EM_RESTART': '1', 17:17:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:48 INFO - 'PWD': '/builds/slave/test', 17:17:48 INFO - 'SHELL': '/bin/bash', 17:17:48 INFO - 'SHLVL': '1', 17:17:48 INFO - 'TERM': 'linux', 17:17:48 INFO - 'TMOUT': '86400', 17:17:48 INFO - 'USER': 'cltbld', 17:17:48 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1504743430.942407-390765886', 17:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:48 INFO - '_': '/tools/buildbot/bin/python'} 17:17:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:17:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:17:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:17:49 INFO - Installing collected packages: mozsystemmonitor 17:17:49 INFO - Running setup.py install for mozsystemmonitor 17:17:49 INFO - Successfully installed mozsystemmonitor 17:17:49 INFO - Cleaning up... 17:17:49 INFO - Return code: 0 17:17:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:17:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2823a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ca090>, '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 0x29cad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c4f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1504743430.942407-390765886', '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:17:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:17:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:17:49 INFO - Using env: {'DISPLAY': ':0', 17:17:49 INFO - 'HOME': '/home/cltbld', 17:17:49 INFO - 'LANG': 'en_US.UTF-8', 17:17:49 INFO - 'LANGUAGE': 'en_US:en', 17:17:49 INFO - 'LOGNAME': 'cltbld', 17:17:49 INFO - 'MAIL': '/var/mail/cltbld', 17:17:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:49 INFO - 'MOZ_NO_REMOTE': '1', 17:17:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:49 INFO - 'NO_EM_RESTART': '1', 17:17:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:49 INFO - 'PWD': '/builds/slave/test', 17:17:49 INFO - 'SHELL': '/bin/bash', 17:17:49 INFO - 'SHLVL': '1', 17:17:49 INFO - 'TERM': 'linux', 17:17:49 INFO - 'TMOUT': '86400', 17:17:49 INFO - 'USER': 'cltbld', 17:17:49 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1504743430.942407-390765886', 17:17:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:49 INFO - '_': '/tools/buildbot/bin/python'} 17:17:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:49 INFO - Downloading/unpacking jsonschema==2.5.1 17:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:17:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:50 INFO - Downloading functools32-3.2.3-2.tar.gz 17:17:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:17:50 INFO - warning: no files found matching '*.txt' 17:17:50 INFO - no previously-included directories found matching 'build' 17:17:50 INFO - no previously-included directories found matching 'dist' 17:17:50 INFO - no previously-included directories found matching '.git*' 17:17:50 INFO - Installing collected packages: jsonschema, functools32 17:17:51 INFO - Running setup.py install for functools32 17:17:51 INFO - warning: no files found matching '*.txt' 17:17:51 INFO - no previously-included directories found matching 'build' 17:17:51 INFO - no previously-included directories found matching 'dist' 17:17:51 INFO - no previously-included directories found matching '.git*' 17:17:51 INFO - Successfully installed jsonschema functools32 17:17:51 INFO - Cleaning up... 17:17:51 INFO - Return code: 0 17:17:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:17:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x265a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2823a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ca090>, '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 0x29cad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c4f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1504743430.942407-390765886', '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:17:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:17:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:17:51 INFO - Using env: {'DISPLAY': ':0', 17:17:51 INFO - 'HOME': '/home/cltbld', 17:17:51 INFO - 'LANG': 'en_US.UTF-8', 17:17:51 INFO - 'LANGUAGE': 'en_US:en', 17:17:51 INFO - 'LOGNAME': 'cltbld', 17:17:51 INFO - 'MAIL': '/var/mail/cltbld', 17:17:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:51 INFO - 'MOZ_NO_REMOTE': '1', 17:17:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:51 INFO - 'NO_EM_RESTART': '1', 17:17:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:51 INFO - 'PWD': '/builds/slave/test', 17:17:51 INFO - 'SHELL': '/bin/bash', 17:17:51 INFO - 'SHLVL': '1', 17:17:51 INFO - 'TERM': 'linux', 17:17:51 INFO - 'TMOUT': '86400', 17:17:51 INFO - 'USER': 'cltbld', 17:17:51 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1504743430.942407-390765886', 17:17:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:51 INFO - '_': '/tools/buildbot/bin/python'} 17:17:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:17:51 INFO - Cleaning up... 17:17:51 INFO - Return code: 0 17:17:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:17:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2823a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ca090>, '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 0x29cad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c4f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1504743430.942407-390765886', '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:17:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:17:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:17:51 INFO - Using env: {'DISPLAY': ':0', 17:17:51 INFO - 'HOME': '/home/cltbld', 17:17:51 INFO - 'LANG': 'en_US.UTF-8', 17:17:51 INFO - 'LANGUAGE': 'en_US:en', 17:17:51 INFO - 'LOGNAME': 'cltbld', 17:17:51 INFO - 'MAIL': '/var/mail/cltbld', 17:17:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:51 INFO - 'MOZ_NO_REMOTE': '1', 17:17:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:51 INFO - 'NO_EM_RESTART': '1', 17:17:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:51 INFO - 'PWD': '/builds/slave/test', 17:17:51 INFO - 'SHELL': '/bin/bash', 17:17:51 INFO - 'SHLVL': '1', 17:17:51 INFO - 'TERM': 'linux', 17:17:51 INFO - 'TMOUT': '86400', 17:17:51 INFO - 'USER': 'cltbld', 17:17:51 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1504743430.942407-390765886', 17:17:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:51 INFO - '_': '/tools/buildbot/bin/python'} 17:17:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:51 INFO - Downloading/unpacking blobuploader==1.2.4 17:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:52 INFO - Downloading blobuploader-1.2.4.tar.gz 17:17:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:17:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:17:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:53 INFO - Downloading docopt-0.6.1.tar.gz 17:17:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:17:53 INFO - Installing collected packages: blobuploader, requests, docopt 17:17:53 INFO - Running setup.py install for blobuploader 17:17:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:17:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:17:53 INFO - Running setup.py install for requests 17:17:53 INFO - Running setup.py install for docopt 17:17:53 INFO - Successfully installed blobuploader requests docopt 17:17:53 INFO - Cleaning up... 17:17:53 INFO - Return code: 0 17:17:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:17:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2823a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ca090>, '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 0x29cad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c4f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1504743430.942407-390765886', '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:17:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:17:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:17:53 INFO - Using env: {'DISPLAY': ':0', 17:17:53 INFO - 'HOME': '/home/cltbld', 17:17:53 INFO - 'LANG': 'en_US.UTF-8', 17:17:53 INFO - 'LANGUAGE': 'en_US:en', 17:17:53 INFO - 'LOGNAME': 'cltbld', 17:17:53 INFO - 'MAIL': '/var/mail/cltbld', 17:17:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:53 INFO - 'MOZ_NO_REMOTE': '1', 17:17:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:53 INFO - 'NO_EM_RESTART': '1', 17:17:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:53 INFO - 'PWD': '/builds/slave/test', 17:17:53 INFO - 'SHELL': '/bin/bash', 17:17:53 INFO - 'SHLVL': '1', 17:17:53 INFO - 'TERM': 'linux', 17:17:53 INFO - 'TMOUT': '86400', 17:17:53 INFO - 'USER': 'cltbld', 17:17:53 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1504743430.942407-390765886', 17:17:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:53 INFO - '_': '/tools/buildbot/bin/python'} 17:17:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:17:54 INFO - Running setup.py (path:/tmp/pip-mMp1uS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:17:54 INFO - Running setup.py (path:/tmp/pip-p9d_Da-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:17:54 INFO - Running setup.py (path:/tmp/pip-zqnXxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:17:54 INFO - Running setup.py (path:/tmp/pip-c63m5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:17:54 INFO - Running setup.py (path:/tmp/pip-KWyYYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:17:54 INFO - Running setup.py (path:/tmp/pip-h0DKy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:17:54 INFO - Running setup.py (path:/tmp/pip-UHlkgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:17:54 INFO - Running setup.py (path:/tmp/pip-nPaP6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:17:54 INFO - Running setup.py (path:/tmp/pip-qCbqlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:17:54 INFO - Running setup.py (path:/tmp/pip-OvZiWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:17:54 INFO - Running setup.py (path:/tmp/pip-QIl9qh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:17:54 INFO - Running setup.py (path:/tmp/pip-Uh2ZTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:17:54 INFO - Running setup.py (path:/tmp/pip-iXzQSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:17:54 INFO - Running setup.py (path:/tmp/pip-1wyNde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:55 INFO - Running setup.py (path:/tmp/pip-pSPQWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:17:55 INFO - Running setup.py (path:/tmp/pip-z8C5ux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:17:55 INFO - Running setup.py (path:/tmp/pip-N2pyHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:17:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:17:55 INFO - Running setup.py install for manifestparser 17:17:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:17:55 INFO - Running setup.py install for mozcrash 17:17:55 INFO - Running setup.py install for mozdebug 17:17:55 INFO - Running setup.py install for mozdevice 17:17:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:17:55 INFO - Running setup.py install for mozfile 17:17:55 INFO - Running setup.py install for mozhttpd 17:17:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:17:55 INFO - Running setup.py install for mozinfo 17:17:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:17:55 INFO - Running setup.py install for mozInstall 17:17:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:17:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:17:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:17:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:17:56 INFO - Running setup.py install for mozleak 17:17:56 INFO - Running setup.py install for mozlog 17:17:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:17:56 INFO - Running setup.py install for moznetwork 17:17:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:17:56 INFO - Running setup.py install for mozprocess 17:17:56 INFO - Running setup.py install for mozprofile 17:17:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:17:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:17:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:17:56 INFO - Running setup.py install for mozrunner 17:17:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:17:56 INFO - Running setup.py install for mozscreenshot 17:17:56 INFO - Running setup.py install for moztest 17:17:56 INFO - Running setup.py install for mozversion 17:17:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:17:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:17:56 INFO - Cleaning up... 17:17:57 INFO - Return code: 0 17:17:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:17:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:57 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 0x265a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2823a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ca090>, '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 0x29cad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c4f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1504743430.942407-390765886', '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:17:57 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:17:57 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:17:57 INFO - Using env: {'DISPLAY': ':0', 17:17:57 INFO - 'HOME': '/home/cltbld', 17:17:57 INFO - 'LANG': 'en_US.UTF-8', 17:17:57 INFO - 'LANGUAGE': 'en_US:en', 17:17:57 INFO - 'LOGNAME': 'cltbld', 17:17:57 INFO - 'MAIL': '/var/mail/cltbld', 17:17:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:57 INFO - 'MOZ_NO_REMOTE': '1', 17:17:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:57 INFO - 'NO_EM_RESTART': '1', 17:17:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:57 INFO - 'PWD': '/builds/slave/test', 17:17:57 INFO - 'SHELL': '/bin/bash', 17:17:57 INFO - 'SHLVL': '1', 17:17:57 INFO - 'TERM': 'linux', 17:17:57 INFO - 'TMOUT': '86400', 17:17:57 INFO - 'USER': 'cltbld', 17:17:57 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1504743430.942407-390765886', 17:17:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:57 INFO - '_': '/tools/buildbot/bin/python'} 17:17:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:17:57 INFO - Running setup.py (path:/tmp/pip-FyXZi_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:17:57 INFO - Running setup.py (path:/tmp/pip-H0k2dx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:17:57 INFO - Running setup.py (path:/tmp/pip-Q5WHB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:17:57 INFO - Running setup.py (path:/tmp/pip-3Bj_Wa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:17:57 INFO - Running setup.py (path:/tmp/pip-O7_N8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:17:57 INFO - Running setup.py (path:/tmp/pip-CJKjFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:17:57 INFO - Running setup.py (path:/tmp/pip-3tFDgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:17:57 INFO - Running setup.py (path:/tmp/pip-VxacUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:17:57 INFO - Running setup.py (path:/tmp/pip-_5ZT6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:17:57 INFO - Running setup.py (path:/tmp/pip-1rstu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:17:57 INFO - Running setup.py (path:/tmp/pip-6z7zld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:17:58 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:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:17:58 INFO - Running setup.py (path:/tmp/pip-JbgX6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:17:58 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:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:17:58 INFO - Running setup.py (path:/tmp/pip-pg6Mlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:17:58 INFO - Running setup.py (path:/tmp/pip-sKd66f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:58 INFO - Running setup.py (path:/tmp/pip-blbVpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:17:58 INFO - Running setup.py (path:/tmp/pip-r6xRhI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:17:58 INFO - Running setup.py (path:/tmp/pip-zCbppC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:17:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:59 INFO - Downloading blessings-1.6.tar.gz 17:17:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:17:59 INFO - Installing collected packages: blessings 17:17:59 INFO - Running setup.py install for blessings 17:17:59 INFO - Successfully installed blessings 17:17:59 INFO - Cleaning up... 17:17:59 INFO - Return code: 0 17:17:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:17:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:17:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:17:59 INFO - Reading from file tmpfile_stdout 17:17:59 INFO - Current package versions: 17:17:59 INFO - argparse == 1.2.1 17:17:59 INFO - blessings == 1.6 17:17:59 INFO - blobuploader == 1.2.4 17:17:59 INFO - docopt == 0.6.1 17:17:59 INFO - functools32 == 3.2.3-2 17:17:59 INFO - jsonschema == 2.5.1 17:17:59 INFO - manifestparser == 1.1 17:17:59 INFO - mozInstall == 1.13 17:17:59 INFO - mozcrash == 1.0 17:17:59 INFO - mozdebug == 0.1 17:17:59 INFO - mozdevice == 0.51 17:17:59 INFO - mozfile == 1.2 17:17:59 INFO - mozhttpd == 0.7 17:17:59 INFO - mozinfo == 0.10 17:17:59 INFO - mozleak == 0.1 17:17:59 INFO - mozlog == 3.5 17:17:59 INFO - moznetwork == 0.27 17:17:59 INFO - mozprocess == 0.25 17:17:59 INFO - mozprofile == 0.28 17:17:59 INFO - mozrunner == 6.13 17:17:59 INFO - mozscreenshot == 0.1 17:17:59 INFO - mozsystemmonitor == 0.3 17:17:59 INFO - moztest == 0.8 17:17:59 INFO - mozversion == 1.4 17:17:59 INFO - psutil == 3.1.1 17:17:59 INFO - requests == 1.2.3 17:17:59 INFO - wsgiref == 0.1.2 17:17:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:17:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2823a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ca090>, '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 0x29cad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c4f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1504743430.942407-390765886', '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:17:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:17:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:17:59 INFO - Using env: {'DISPLAY': ':0', 17:17:59 INFO - 'HOME': '/home/cltbld', 17:17:59 INFO - 'LANG': 'en_US.UTF-8', 17:17:59 INFO - 'LANGUAGE': 'en_US:en', 17:17:59 INFO - 'LOGNAME': 'cltbld', 17:17:59 INFO - 'MAIL': '/var/mail/cltbld', 17:17:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:59 INFO - 'MOZ_NO_REMOTE': '1', 17:17:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:59 INFO - 'NO_EM_RESTART': '1', 17:17:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:59 INFO - 'PWD': '/builds/slave/test', 17:17:59 INFO - 'SHELL': '/bin/bash', 17:17:59 INFO - 'SHLVL': '1', 17:17:59 INFO - 'TERM': 'linux', 17:17:59 INFO - 'TMOUT': '86400', 17:17:59 INFO - 'USER': 'cltbld', 17:17:59 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1504743430.942407-390765886', 17:17:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:59 INFO - '_': '/tools/buildbot/bin/python'} 17:18:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:18:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:18:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:18:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:18:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:18:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:18:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:18:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:18:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:18:00 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:18:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:18:01 INFO - Installing collected packages: simplejson 17:18:01 INFO - Running setup.py install for simplejson 17:18:01 INFO - building 'simplejson._speedups' extension 17:18:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 17:18:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 17:18:02 INFO - Successfully installed simplejson 17:18:02 INFO - Cleaning up... 17:18:02 INFO - Return code: 0 17:18:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:18: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:18:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18: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:18:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2823a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ca090>, '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 0x29cad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c4f90>, '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': 'a0d2d2de893abaa8702a9954000001a7-1504743430.942407-390765886', '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:18:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:18:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:18:02 INFO - Using env: {'DISPLAY': ':0', 17:18:02 INFO - 'HOME': '/home/cltbld', 17:18:02 INFO - 'LANG': 'en_US.UTF-8', 17:18:02 INFO - 'LANGUAGE': 'en_US:en', 17:18:02 INFO - 'LOGNAME': 'cltbld', 17:18:02 INFO - 'MAIL': '/var/mail/cltbld', 17:18:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:02 INFO - 'MOZ_NO_REMOTE': '1', 17:18:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:02 INFO - 'NO_EM_RESTART': '1', 17:18:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:02 INFO - 'PWD': '/builds/slave/test', 17:18:02 INFO - 'SHELL': '/bin/bash', 17:18:02 INFO - 'SHLVL': '1', 17:18:02 INFO - 'TERM': 'linux', 17:18:02 INFO - 'TMOUT': '86400', 17:18:02 INFO - 'USER': 'cltbld', 17:18:02 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1504743430.942407-390765886', 17:18:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:02 INFO - '_': '/tools/buildbot/bin/python'} 17:18:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:18:02 INFO - Cleaning up... 17:18:02 INFO - Return code: 0 17:18:02 INFO - Running post-action listener: _resource_record_post_action 17:18:02 INFO - Running post-action listener: _start_resource_monitoring 17:18:02 INFO - Starting resource monitoring. 17:18:02 INFO - [mozharness: 2017-09-07 00:18:02.678579Z] Finished create-virtualenv step (success) 17:18:02 INFO - [mozharness: 2017-09-07 00:18:02.679091Z] Running install step. 17:18:02 INFO - Running pre-action listener: _resource_record_pre_action 17:18:02 INFO - Running main action method: install 17:18:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:18:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:18:02 INFO - Reading from file tmpfile_stdout 17:18:02 INFO - Detecting whether we're running mozinstall >=1.0... 17:18:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:18:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:18:03 INFO - Reading from file tmpfile_stdout 17:18:03 INFO - Output received: 17:18:03 INFO - Usage: mozinstall [options] installer 17:18:03 INFO - Options: 17:18:03 INFO - -h, --help show this help message and exit 17:18:03 INFO - -d DEST, --destination=DEST 17:18:03 INFO - Directory to install application into. [default: 17:18:03 INFO - "/builds/slave/test"] 17:18:03 INFO - --app=APP Application being installed. [default: firefox] 17:18:03 INFO - mkdir: /builds/slave/test/build/application 17:18:03 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:18:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:18:19 INFO - Reading from file tmpfile_stdout 17:18:19 INFO - Output received: 17:18:19 INFO - /builds/slave/test/build/application/firefox/firefox 17:18:19 INFO - Running post-action listener: _resource_record_post_action 17:18:19 INFO - [mozharness: 2017-09-07 00:18:19.917587Z] Finished install step (success) 17:18:19 INFO - [mozharness: 2017-09-07 00:18:19.917841Z] Running setup-mitmproxy step. 17:18:19 INFO - Running pre-action listener: _resource_record_pre_action 17:18:19 INFO - Running main action method: setup_mitmproxy 17:18:19 INFO - Skipping: mitmproxy is not required 17:18:19 INFO - Running post-action listener: _resource_record_post_action 17:18:19 INFO - [mozharness: 2017-09-07 00:18:19.918977Z] Finished setup-mitmproxy step (success) 17:18:19 INFO - [mozharness: 2017-09-07 00:18:19.919199Z] Running run-tests step. 17:18:19 INFO - Running pre-action listener: _resource_record_pre_action 17:18:19 INFO - Running pre-action listener: _set_gcov_prefix 17:18:19 INFO - Running main action method: run_tests 17:18:19 WARNING - Try message not found. 17:18:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:18:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:18:19 INFO - Python 2.7.3 17:18:19 INFO - Return code: 0 17:18:19 INFO - grabbing minidump binary from tooltool 17:18:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:18:19 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ca090>, '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 0x29cad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29c4f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:18:19 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:18:19 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:18:19 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:18:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:18:20 INFO - Return code: 0 17:18:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:18:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:18:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:18:20 INFO - ENV: RUST_BACKTRACE is now full 17:18:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:18:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:18:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-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-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 17:18:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-stylo-disabled-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-002 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 17:18:20 INFO - Using env: {'DISPLAY': ':0', 17:18:20 INFO - 'HOME': '/home/cltbld', 17:18:20 INFO - 'LANG': 'en_US.UTF-8', 17:18:20 INFO - 'LANGUAGE': 'en_US:en', 17:18:20 INFO - 'LOGNAME': 'cltbld', 17:18:20 INFO - 'MAIL': '/var/mail/cltbld', 17:18:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:18:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:18:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:20 INFO - 'MOZ_NO_REMOTE': '1', 17:18:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:18:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:20 INFO - 'NO_EM_RESTART': '1', 17:18:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:20 INFO - 'PWD': '/builds/slave/test', 17:18:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:18:20 INFO - 'RUST_BACKTRACE': 'full', 17:18:20 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:18:20 INFO - 'SHELL': '/bin/bash', 17:18:20 INFO - 'SHLVL': '1', 17:18:20 INFO - 'TERM': 'linux', 17:18:20 INFO - 'TMOUT': '86400', 17:18:20 INFO - 'USER': 'cltbld', 17:18:20 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1504743430.942407-390765886', 17:18:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:20 INFO - '_': '/tools/buildbot/bin/python'} 17:18:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-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-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 17:18:20 INFO - mozversion application_buildid: 20170906225137 17:18:20 INFO - mozversion application_changeset: d8e238b811d3dc74515065ae8cab6c74baf0295f 17:18:20 INFO - mozversion application_display_name: Nightly 17:18:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:18:20 INFO - mozversion application_name: Firefox 17:18:20 INFO - mozversion application_remotingname: firefox 17:18:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:18:20 INFO - mozversion application_vendor: Mozilla 17:18:20 INFO - mozversion application_version: 57.0a1 17:18:20 INFO - mozversion platform_buildid: 20170906225137 17:18:20 INFO - mozversion platform_changeset: d8e238b811d3dc74515065ae8cab6c74baf0295f 17:18:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:18:20 INFO - mozversion platform_version: 57.0a1 17:18:20 INFO - using testdate: 1504743500 17:18:20 INFO - actual date: 1504743500 17:18:20 INFO - starting webserver on 'localhost:41182' 17:18:20 INFO - SUITE-START | Running 2 tests 17:18:20 INFO - TEST-START | dromaeo_css 17:18:20 INFO - Initialising browser for dromaeo_css test... 17:18:20 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41182/getInfo.html -profile /tmp/tmpAIXbJr/profile 17:18:20 INFO - TEST-INFO | started process 7940 (/builds/slave/test/build/application/firefox/firefox http://localhost:41182/getInfo.html) 17:18:26 INFO - TEST-INFO | 7940: exit 0 17:18:26 INFO - Browser initialized. 17:18:26 INFO - Running cycle 1/1 for dromaeo_css test... 17:18:26 INFO - Using env: {'DISPLAY': ':0', 17:18:26 INFO - 'HOME': '/home/cltbld', 17:18:26 INFO - 'JSGC_DISABLE_POISONING': '1', 17:18:26 INFO - 'LANG': 'en_US.UTF-8', 17:18:26 INFO - 'LANGUAGE': 'en_US:en', 17:18:26 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:18:26 INFO - 'LOGNAME': 'cltbld', 17:18:26 INFO - 'MAIL': '/var/mail/cltbld', 17:18:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:18:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:18:26 INFO - 'MOZ_CRASHREPORTER': '1', 17:18:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:26 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:18:26 INFO - 'MOZ_NO_REMOTE': '1', 17:18:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:18:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:26 INFO - 'NO_EM_RESTART': '1', 17:18:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:26 INFO - 'PWD': '/builds/slave/test', 17:18:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:18:26 INFO - 'RUST_BACKTRACE': 'full', 17:18:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:18:26 INFO - 'SHELL': '/bin/bash', 17:18:26 INFO - 'SHLVL': '1', 17:18:26 INFO - 'STYLO_FORCE_DISABLED': '1', 17:18:26 INFO - 'TERM': 'linux', 17:18:26 INFO - 'TMOUT': '86400', 17:18:26 INFO - 'USER': 'cltbld', 17:18:26 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1504743430.942407-390765886', 17:18:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:26 INFO - '_': '/tools/buildbot/bin/python'} 17:18:26 INFO - TEST-INFO | started process 8133 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAIXbJr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:18:27 INFO - PID 8133 | 17:18:27 INFO - PID 8133 | (/builds/slave/test/build/application/firefox/firefox:8185): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:18:27 INFO - PID 8133 | 17:18:37 INFO - PID 8133 | RSS: Main: 169021440 17:18:37 INFO - PID 8133 | 17:21:34 INFO - PID 8133 | Cycle 1(1): loaded http://localhost:41182/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41182/tests/dromaeo/cssquery-ext.html) 17:21:35 INFO - PID 8133 | RSS: Main: 172658688 17:21:35 INFO - PID 8133 | 17:24:37 INFO - PID 8133 | Cycle 1(1): loaded http://localhost:41182/tests/dromaeo/cssquery-ext.html (next: http://localhost:41182/tests/dromaeo/cssquery-jquery.html) 17:24:38 INFO - PID 8133 | RSS: Main: 169332736 17:24:38 INFO - PID 8133 | 17:27:39 INFO - PID 8133 | Cycle 1(1): loaded http://localhost:41182/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41182/tests/dromaeo/cssquery-mootools.html) 17:27:40 INFO - PID 8133 | RSS: Main: 171520000 17:27:40 INFO - PID 8133 | 17:30:42 INFO - PID 8133 | Cycle 1(1): loaded http://localhost:41182/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41182/tests/dromaeo/cssquery-prototype.html) 17:30:42 INFO - PID 8133 | RSS: Main: 169590784 17:30:42 INFO - PID 8133 | 17:33:45 INFO - PID 8133 | Cycle 1(1): loaded http://localhost:41182/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41182/tests/dromaeo/cssquery-yui.html) 17:33:46 INFO - PID 8133 | RSS: Main: 171589632 17:33:46 INFO - PID 8133 | 17:36:48 INFO - PID 8133 | Cycle 1(1): loaded http://localhost:41182/tests/dromaeo/cssquery-yui.html (next: http://localhost:41182/tests/dromaeo/cssquery-dojo.html) 17:36:48 INFO - PID 8133 | RSS: Main: 174141440 17:36:48 INFO - PID 8133 | 17:36:48 INFO - PID 8133 | __start_tp_report 17:36:48 INFO - PID 8133 | _x_x_mozilla_page_load 17:36:48 INFO - PID 8133 | _x_x_mozilla_page_load_details 17:36:48 INFO - PID 8133 | |i|pagename|runs| 17:36:48 INFO - PID 8133 | |0;dojo.html;3302.5211344355075;3321.3357328534285;3333.2333563280445;3340.7327413806897;3367.2592029753446;6460.998545225486;6499.057636642689;6503.999999999994;6543.214814222294;6545.639989800559;6253.030780229061;6371.585846919958;6398.808035758923;6401.679916004193;6420.1974753155855;5880.470757631823;5914.290285165786;5919.674417907014;5941.346451890288;5944.227250457456;5892.646441213519;5933.584649074545;5989.820305390824;6006.309274433453;6007.669578173199;5906.232189815297;5941.792037278675;5993.071073983518;5998.4901283390745;6017.879642407149;5448.645838020516;5696.6866822324755;5809.186713860063;5841.795537156222;5965.403459654043;5819.854503637401;5820.82537523875;5912.113183022538;5920.141579470996;5958.225430694026;6218.378162183791;6318.652474113922;6376.0754690570075;6434.163558737381;6510.64191469469;6876.106106206161;6884.896726549106;6914.688839002257;6915.930840691579;6917.377436030782;6910.827229319257;7013.298670132997;7015.333543313377;7017.3684368407085;7022.262662420423;6408.903866442007;6415;6433.131527243809;6514.5114116441455;6524.77163299287;6926.168859736864;7030.6484675766005;7047.365737083687;7073.115860517435;7090;6672.2994085621285;6734.8989765153565;6740.662966851638;6745.797626071226;6754.3921047106;6906.205786334636;6970;7005.579665220103;7006.299370062953;7022.403095736818;6895.9656051592665;6914.792556223321;6970.965145174343;7007;7016.684249208798;6923.584584924921;6928.480363972722;6935.722571097201;7012.018317435563;7023.964880175567;5336.0661884170895;5422.5119739223655;5486.643368181056;5522.66863988162;5533.00405926937;4849.054434385332;4861.538153875376;4896.167651499253;4904.215325547895;4906.607471402279;6022.337542870281;6035.336113027563;6111.113888486234;6117.143599896018;6121.143039974407;6840.281770414035;6933.826654333682;6946.79159625212;6999.265077166926;7034.788956331318;6124.785632502841;6147.170132032118;6150.661713605705;6155.753769849156;6157.876842463125;6001.399860013964;6033.336333003366;6045.063015232646;6080.513558915276;6093.238345206849;6677.3656502632175;6750.122484077038;6849.212340580797;6867.484938629623;6881.759138430131;6739.93260067393;6830.077939478306;6956.373926346653;7059.647017649199;7081.504294699527;6636.13730215069;6729.158855143107;6736.292689267752;6737.461003119641;6739.93260067393;6823.727050917908;6828.897566536605;6869.519133660596;6886.8622627546165;6934.994425808331;7006.089208402875;7016.614086225307;7088.539244949062;7091.11361079865;7092.326229008236;6560.606363618198;6609.900851487328;6672.199336079701;6729.89905151433;6836.897446538206;6799.626020568719;6806.2513123557355;6810.625415601991;6813.8977915330315;6818.386345228953;6694.564853284521;6743.055972163999;6782.660866956731;6788.219354774066;6791.932080679328;6745.831354215988;6777.491688123312;6788.456923446014;6804.353586409283;6918.273581274095;6415.230172379344;6502.577332473374;6510.804675859732;6585.20977482686;6668.899966500603 17:36:48 INFO - PID 8133 | |1;ext.html;829.8298848736009;863.0980625246617;882.2589025218815;888.4447220487198;1127.7349822791648;31521.84239078807;32111;41896;42136.78931605338;42525.36211956823;42498.36252456208;42511.36232956508;42685;42716;42778.57221427785;7414.443916706242;7795.493292935955;8070.55611941343;8097.433179677425;8108.432409731321;7677.769666910001;7689.346405555534;7693.923060769404;7721.382289416833;7821.335186509154;7758.6896524138965;7764.456488045839;7797.181295963899;7802.180771019046;7831.608419579026;7705.961470192669;7716.151223365453;7721.575313357763;7781.766547003599;7856.882146767803;7877.172896845806;7909.841803163905;7919.247671471201;7936.047674279123;7941.801454963615;38433.807830960664;38697.41953870694;38821;38900.416493752615;38972.22055558873;3481.860725570974;3488.0582242794558;3526.1537231064617;3527.9294414111832;3529.6293889141525;31643.683563164304;31729.524057139162;31767.682323176705;31861.203469913205;31880.84059579687;4955.380577427822;5145.434002259748;5162.148245539482;5162.793488260465;5203;194620;194762;195962;196185.99999999857;196234;48927.51072489301;49143.754281228365;49193.26210106851;49225.50774492209;49437.50562494329;51190.74404627953;51207.48792512027;51236.74381628068;51287.74356128195;51470;13137.277449740355;14142;14387;14391.712165756626;14422.495212667507;10744.355338679705;11645.301281923112;11916.821247681291;11937.164398492023;12004.099692522921;13930;14059.929700351433;14175.858241417454;14201.928990354982;14285.857141428452;5621.297337832771;5748.137779333133;5844.444777746107;5852.385499522574;5852.619579727304;1002.5288114586133;1006.6426418621284;1012.6860673191334;1025.4565080507193;1034.177828626244;22541.77458225397;28332.291692707848;28613.57079643807;28953.13140605785;29003.12990610285;1084.1272775415707;1084.1760262200626;1103.3269705479652;1104.6575561575937;1107.8615173103362;11998.220115692453;12248.326342051272;12256.448459819152;12307.69230769238;12373.319467429377;242436;244700;244881;245148;245657;51100.488995109576;51309.23036154461;51483.48516514787;51558.74220628873;51594.22608660873;1435.7559214933278;1444.826620805489;1451.8765904897991;1460.5983354577363;1463.1440607244667;22325;22558.66162007604;22693.88653056724;22725.772742272366;23131.190408335628;37242.8137859309;37624.43563346497;37732.81133594424;37734.24531509409;37741.4338784924;151542;151944;152626;153516;153566.23216883844;33219;35106.29787404289;36753.448698270084;36977.44533832048;37066;44617;46177.53822461867;46182.538174617825;46205.76897115493;47320;34428;34670.13324666904;34722.826385867906;34808.47787283243;34994.650053500154;33263.66736332606;33527.664723352456;33721;33871.15322116967;34239.65760342365;37341;38417.2712227956;38768;38843;38876.416853746654;32945.67054329426;33129.66870331266;33227.50158747669;33636.66363336433;33880.83059584686;23785.52428951446;23789;23910.28269151928;24185.39536511601;24518.877405612857 17:36:48 INFO - PID 8133 | |2;jquery.html;574.8189320364082;577.093962478908;595.4164918379987;596.6449962272447;600.9338972713002;22086.779132208674;22614.547709045808;22689;22746.862656867153;22755.431114222112;25252.494950100987;25696.614550781705;25899.611505827426;25915.611265831027;25947.610785838227;6624.27133015368;6787.151606049244;6791.864162716743;6792.252852186256;6804.659767011654;6353.809385718436;6608.471322294205;6658.866822663568;6664.333566643345;6667.233268174149;6607.603543787364;6608.702608382634;6609.768658096968;6626.9668651656675;6627;6597.736090556372;6616.503762217853;6626.900596491057;6631.104800851896;6638.336166383371;6111.480524155452;6134.723937422827;6136.7545298188015;6146.323904370515;6159;29230.415391692048;29414.558781618292;29567.70432295671;29613.85193074021;29892.402151956838;2071.482129467633;2127.563849410867;2129.9787002130092;2131.147540983619;2131.7441906971108;19003.619927601372;19612.215511379527;19647.80352196474;19656.90171549133;19664.705029424425;2318.8840557972203;2352.9882350588136;2373.1100837186054;2373.9050437982633;2434.415740222352;139062;141551;145253.82119268324;145386;145471.2726436361;14370.712585748226;14691.632709182357;14718.33767480466;14978.625534361729;15365.154916479478;23271;23434.17980370713;23446.882765586404;23456.17903373408;23462.178823741087;9473.126661469794;9600.807983840285;9636.180924621345;9644.083812037845;9996.50017499122;7648.732294369782;8045.115037345888;8330.916690833013;8528.488290702453;8587.871181932276;9305.162535371848;9523.19052880513;9538.236941044699;9551.331406801457;9561.330706850455;2695.9595606065923;2735.3161709572605;2759.379139693553;2759.599858020616;2812.9578056329174;959.6737109382843;974.2352253480983;978.1538968792086;986.5708416838698;994.9801003979879;19320.32378866733;19694;19942.30201942925;20010.69983950242;20171;1030.3096925060227;1030.3766221436074;1031.128696251666;1049.150188347441;1056.8943105689523;10733.624323148651;11193.496292666687;11226;11341.546338146547;11381.804910484445;440214;456841.71579142555;461715;464743;470434;108864;112480.43759781148;113366;113694;115078;1130.152385710717;1150.7468356961456;1170.0990237517065;1171.1099564331;1172.695099274195;17816.732749009036;17845.643087138444;18080.72878906844;18226.544336391697;18370.173342199367;53440.46559534355;53952.730236348565;55487.72256138855;55598.72200638971;56263.71868140633;70528;70848.29151708417;71025;71191.28808711846;71748.28251717416;14197.645058873612;14582.270886455422;14650.63373415673;14655.047421917541;14670.973031888092;22823.429414264778;23209.18767843185;23300.184493542645;23621.409464763517;23644.172453964027;17791.288348466434;18264.178111985257;18289.542761431072;18433.72349414733;18482.907585461988;14854.183019934007;14891.553253402415;15171.620709482351;15216.771748423562;15373.461928832437;18894.244230230637;18954.620907582048;19051;19151.425457236306;19159.233630654617;14070.507532236323;14392.640183995483;14413.85586144125;14684.70630587361;14865.702685946004;18223.45329640113;18232;18352.265909363476;18490.260389584266;18504.259829606664 17:36:48 INFO - PID 8133 | |3;mootools.html;1379.517168990853;1423.1034448297578;1426.365267455982;1426.8430472648013;1428.164523753604;14941.252937353129;15598.610034749137;15615.219239038031;15616.921915390421;15875.047497150179;15660.686786264268;15993;15998.76001859973;16007.119608421532;16013.679726405466;2702.6081218223344;2760.5307097793325;2761.8342899425998;2762.1023167470553;2763.9447211055767;2775.4449110177943;2870;2871;2873.5402335626304;2878.913632591026;2757.7104404037586;2778.7360200780895;2779.1662501249643;2805.3267215868145;2810.9578356324673;2724.1418953029734;2771.5565509518483;2777.722227777216;2778.597103419993;2789.205076553193;2654.1241390341333;2657.8803953822126;2675;2676.183763951994;2676.625272461857;15163.241837908061;15423.537293881202;15450.459233926871;15507.224638768017;15540.067595944167;7892.210778922119;8179.4274400791965;8187;8218.958905205436;8223.05434874985;5420.289290030805;5474.698891560963;5578.135389014709;5611.242482264883;5637.408072152406;1949.39568733693;1970.103602860695;1976.6540855350256;2023.6964455331818;2033.1054336092072;26457;26605.334866628487;26627.334316642045;26674.466510670067;26682.19953401401;6782.355676210752;6915.585064896122;6941.548799328028;7077.787666370017;7095.545413190283;17264.482065538054;17265.39571115005;17273.65452690939;17294.04882731462;17322.22050007753;7771.33943614799;8015.278624923785;8023.117457079717;8027.919720802834;8045.195480452025;7241.167265764505;7254.854902901912;7445.739399121005;7451.739189128354;7455.25447455261;5234.738263086831;5401.513863752281;5414.07960646691;5419.430959749169;5467.45325467458;1545.119282009244;1546.914919679406;1548.5664014076076;1549.1789351643422;1562.898411603242;927.6428574998539;941.9576119074658;944.7732544189345;945.7824700318965;952.0289304908954;8065.395095367753;8069.556174410346;8081.111077781439;8140.511569305861;8248.54632995179;716.2300526933567;738.6196109003868;746.220199891115;750.5196674128562;754.0536626533665;4910.091633047898;5251.789928402897;5501.587380946445;5816.185733997244;5911.113332999998;22307.107715691516;22644.320670379915;22644.547109057727;22807.087716491485;22817.88591057034;21408.78591214099;21905.452363691034;22413.887930560242;22448.551028979327;22469;11231.382273974847;11427.371494567713;11438.599649012245;11440.828387574193;11511.53953841837;8441.470836602035;8594.65621375138;8641.697540586048;8684.39209255346;8873.645054198018;18372.081395929883;18563.35028274004;18788.718169227745;18924.905375473587;19202.711959320342;18528.536786579905;18932.905335473235;19180;19220.231190752773;19366.61266774685;11666.70833229176;11812.82280765772;11821.349825759666;11957.162998590364;11968.222065565711;14023.228722420365;14189.645258868612;14212.715745684822;14221.288935553388;14232.715345693236;11268.718282042686;11364.318140911571;11466.77066458683;11469.254498457907;11578.76842463163;10589.523471443958;10608.681739547827;10662;10717.839232411365;10848.566057357617;9668.274879384215;9871.111599956039;9872.555734991798;9873.456959867277;9888.110070093726;7318.890216646648;7345.77962661121;7364.189939106801;7366.558006519626;7424.480286379901;7476.5514069156025;7515.361194298327;7611.543307401574;7718.92281077182;7736.1103473099065 17:36:48 INFO - PID 8133 | |4;prototype.html;468.57359802579657;498.65592741008703;499.5578912662294;508.78376689906804;529.4996228564006;6242.313345531988;6405.26339470961;6438.1308523349335;6438.195225596801;6502.31725668805;6214.757048590277;6264.373562643734;6281.748730050804;6291;6317.842053948642;5004.84985450437;5028.094942910284;5064.898702025957;5087.949120508803;5137.383513978328;4981.352424184869;5071.898562028758;5083.313752643383;5093.312402825627;5141.562967147778;4992.500749924997;5005.724685142316;5013.874653133665;5045.545900868921;5115.9744201278945;4989.950100499003;5019.222020586797;5031.974840125813;5078.8414923657665;5096.413912400048;4514.932276015862;4550.476695180064;4553.612942899857;4561.429821272341;4562.817487300504;6207.658578778165;6226.657533835637;6261.561690681654;6326.65203413812;6332.366763323676;5720.742566584514;5789.681567513785;5828.854278643025;5830.387809280007;5867.618604790675;6583.242927063353;6611.404973552403;6690.297518760557;6702.692974869854;6747.730090796363;4943.406791185045;4962.776675049631;4972.900541989176;4996.375453068366;5009.774560144766;6855.828604284833;7026.613536255504;7070.222275549737;7082.822929426806;7089.255628159072;5050.2324186534415;5063.797448102035;5094.108531007059;5121.564667003272;5140;5171.172612382076;5173.870653233624;5182.481751824787;5192.143296356135;5210;5704.201411802351;5714.428557144252;5816.592838501264;5819.214406055213;5824.165387902797;6634.502412318999;6634.668266586651;6674.899876501856;6764.864702705919;6779.559328643622;1693.3988434105715;1715.382462313566;1747.3010795681828;1749.4751574527845;1755.1487528548644;1221.2062159596155;1221.987780122205;1239.2997956154743;1254.8494180698192;1258.7230809221955;5783.681897495678;5812.941870581325;5876.764929402776;5933.842900634421;5992.13114098462;6585.440237579859;6880.483963702743;6882.621455819978;6889.139932218273;6893.379595836399;5887.76448942046;5938.040446652594;5993.9700301498215;6000.579959402888;6005.729742161526;3643.9635603644156;3660.5973342932257;3666.4866918631415;3676.9632303677154;3678.6321367863;6512.479001679854;6641.867162656817;6705.295943925915;6717.227518835396;6738.528303018839;7061.576305421691;7066.222715501291;7076.2923707628825;7079.858282904558;7130.750423735144;6704;6706.865862682816;6719.832004199837;6725.730970761213;6822.147231596051;6889.414399776075;6954.860902781815;6956.443484521327;6985.720571177096;7027.9297207027275;6808.319168083152;6842.657867106725;6863.588184708933;6883.690233939585;6912.619805910723;6722.697478613376;6727.629980351127;6778;6784.2876497967;6798.456123510206;5069.822556210515;5086.694798312114;5087.923681144712;5094.395265491358;5133.1786914095055;6639.435647969976;6859.382655561023;6927.030215769695;6949.803090578391;6993.755218567326;6269.216347956505;6456.483481321389;6498.74005039812;6602.40578347951;6625.503087268377;6484.967575162283;6587.80236592903;6607.942729163311;6612.5040621952585;6669.199696036312;6324.209473815773;6575.80272591823;6589.374009469093;6610.867782644224;6685.164354455693;6677.2988836173445;6682.131322927989;6756.662166891734;6763.5941843489545;6766.763163289262;6512.381323774234;6531.706073226811;6553.5084868634085;6567.638779867153;6592.637404942774 17:36:48 INFO - PID 8133 | |5;yui.html;876.5880036382902;900.1898291537619;907.4237858959559;914.305128102642;935;17942.282308707654;18713.90643046783;18734.156962936668;18749.43751687448;21605.67591486129;20351.491212719688;21345.786542134574;21459.141634334646;21501.677474837852;21512.354629361103;969.2052516936116;986.1962500562055;992.900709929005;992.9602815887356;995.6813819577739;909.3452714045876;990.8166989107002;991.3605724307818;1000.8348622477282;1001.484235618657;1003.0170432975651;1063.2557209953025;1063.3194755356578;1063.388551582839;1065.4512925843196;1052.9315594486334;1053.3627155570884;1053.489057806963;1059.5496913811637;1060.8037513060108;769.5651956644477;769.819092513259;770.1605250277169;770.5261264322457;772.0311009682869;19722.802771972383;19790.208391664317;20057.8997105015;20060.29788957394;20324.593508129903;21504.139834406604;21511.67732484014;21715;22046.448838778997;22063.66904496434;17613.823861761346;17615;17772.822271777248;17829.910850445794;17881.37415190475;3722.9069273268115;3737.1591391936868;3740.0462881965195;3745.1573395985956;3750.49368335274;132453;133185;133826;135397;136462.31768841192;16238.918805405898;16312.265948032367;16713.832861671228;16745.16274186286;16830.410935617194;29313;29781.255468613457;29942.700572993992;30500.38999220003;30566.08301750951;7597.2022937590755;7921.722739704082;8547.74356769298;8888;8907.10928907117;4161.542230354658;4228.429162063144;4230.386593943861;4231.534531201565;4237.533871274219;5159.638825282269;5216.58267338612;5233.084210263189;5252.185911183773;5291.550218231493;1050.7950949564915;1065.5950738719237;1076.1283360478037;1077.9784404312027;1078.5439656463711;689.7723751162105;701.680735265453;716.7849645106447;717.9748708795167;725.6516871901517;10859.511321990529;11371.260868043717;11397.145214108976;11505.424728763528;11697.2981621103;695.4366962760181;698.6017969757189;707.1584814071239;709.2623671381808;713.0409599089216;5090.88000639866;5150.896982060338;5169.4830516948;5191.766370513336;5202.9913466038115;109669;109928;110012.89987100026;110130;112791;96071;97098;99529.50235248778;103652.48173759083;104693.47653261686;85309.57345213358;85817;87815.56092219625;89280.5535972316;89476.10523894678;11938.64184074479;12090.637280881587;12191.146619736888;12292.201006934522;12453.315067671003;40667.389989150775;41394.58605413907;41765.1646967065;42489.36265955951;42552.361714573686;54750.17874731962;54887;55184.44815551793;55732;56182;15613.76579351288;18037.098145092954;18426.907865460587;18450.26198952027;18505.81494185041;18343.908280458512;19771.308004219783;19822.80177198267;19988.10053547565;20030.39908802738;17416;17555.912220438815;17556.736648950533;19364.225430983166;19921.601567968268;17640.38258660941;17739.645207095527;17874.821251787314;17969.281228750704;18848.811511884705;17906.91046544759;17940.461786146436;17949.461516154537;17956.91021544884;17985.370512032016;14235.501757438855;14389.064710793766;14468.565943021726;14472.131672099707;14588.85411145875;13567.728645427234;13684.794728078889;13687.657808554866;13769.173849569059;13777.448902044207 17:36:48 INFO - PID 8133 | __end_tp_report 17:36:48 INFO - PID 8133 | __start_cc_report 17:36:48 INFO - PID 8133 | _x_x_mozilla_cycle_collect,388 17:36:48 INFO - PID 8133 | __end_cc_report 17:36:48 INFO - PID 8133 | __startTimestamp1504744608539__endTimestamp 17:36:48 INFO - PID 8133 | 17:36:48 INFO - PID 8133 | ------- Summary: start ------- 17:36:48 INFO - PID 8133 | Number of tests: 6 17:36:48 INFO - PID 8133 | 17:36:48 INFO - PID 8133 | [#0] dojo.html Cycles:165 Average:6383.63 Median:6668.90 stddev:750.17 (11.2%) stddev-sans-first:712.47 17:36:48 INFO - PID 8133 | Values: 3302.5 3321.3 3333.2 3340.7 3367.3 6461.0 6499.1 6504.0 6543.2 6545.6 6253.0 6371.6 6398.8 6401.7 6420.2 5880.5 5914.3 5919.7 5941.3 5944.2 5892.6 5933.6 5989.8 6006.3 6007.7 5906.2 5941.8 5993.1 5998.5 6017.9 5448.6 5696.7 5809.2 5841.8 5965.4 5819.9 5820.8 5912.1 5920.1 5958.2 6218.4 6318.7 6376.1 6434.2 6510.6 6876.1 6884.9 6914.7 6915.9 6917.4 6910.8 7013.3 7015.3 7017.4 7022.3 6408.9 6415.0 6433.1 6514.5 6524.8 6926.2 7030.6 7047.4 7073.1 7090.0 6672.3 6734.9 6740.7 6745.8 6754.4 6906.2 6970.0 7005.6 7006.3 7022.4 6896.0 6914.8 6971.0 7007.0 7016.7 6923.6 6928.5 6935.7 7012.0 7024.0 5336.1 5422.5 5486.6 5522.7 5533.0 4849.1 4861.5 4896.2 4904.2 4906.6 6022.3 6035.3 6111.1 6117.1 6121.1 6840.3 6933.8 6946.8 6999.3 7034.8 6124.8 6147.2 6150.7 6155.8 6157.9 6001.4 6033.3 6045.1 6080.5 6093.2 6677.4 6750.1 6849.2 6867.5 6881.8 6739.9 6830.1 6956.4 7059.6 7081.5 6636.1 6729.2 6736.3 6737.5 6739.9 6823.7 6828.9 6869.5 6886.9 6935.0 7006.1 7016.6 7088.5 7091.1 7092.3 6560.6 6609.9 6672.2 6729.9 6836.9 6799.6 6806.3 6810.6 6813.9 6818.4 6694.6 6743.1 6782.7 6788.2 6791.9 6745.8 6777.5 6788.5 6804.4 6918.3 6415.2 6502.6 6510.8 6585.2 6668.9 17:36:48 INFO - PID 8133 | 17:36:48 INFO - PID 8133 | [#1] ext.html Cycles:180 Average:37221.15 Median:35050.47 stddev:52228.86 (149.0%) stddev-sans-first:52303.90 17:36:48 INFO - PID 8133 | Values: 829.8 863.1 882.3 888.4 1127.7 31521.8 32111.0 41896.0 42136.8 42525.4 42498.4 42511.4 42685.0 42716.0 42778.6 7414.4 7795.5 8070.6 8097.4 8108.4 7677.8 7689.3 7693.9 7721.4 7821.3 7758.7 7764.5 7797.2 7802.2 7831.6 7706.0 7716.2 7721.6 7781.8 7856.9 7877.2 7909.8 7919.2 7936.0 7941.8 38433.8 38697.4 38821.0 38900.4 38972.2 3481.9 3488.1 3526.2 3527.9 3529.6 31643.7 31729.5 31767.7 31861.2 31880.8 4955.4 5145.4 5162.1 5162.8 5203.0 194620.0 194762.0 195962.0 196186.0 196234.0 48927.5 49143.8 49193.3 49225.5 49437.5 51190.7 51207.5 51236.7 51287.7 51470.0 13137.3 14142.0 14387.0 14391.7 14422.5 10744.4 11645.3 11916.8 11937.2 12004.1 13930.0 14059.9 14175.9 14201.9 14285.9 5621.3 5748.1 5844.4 5852.4 5852.6 1002.5 1006.6 1012.7 1025.5 1034.2 22541.8 28332.3 28613.6 28953.1 29003.1 1084.1 1084.2 1103.3 1104.7 1107.9 11998.2 12248.3 12256.4 12307.7 12373.3 242436.0 244700.0 244881.0 245148.0 245657.0 51100.5 51309.2 51483.5 51558.7 51594.2 1435.8 1444.8 1451.9 1460.6 1463.1 22325.0 22558.7 22693.9 22725.8 23131.2 37242.8 37624.4 37732.8 37734.2 37741.4 151542.0 151944.0 152626.0 153516.0 153566.2 33219.0 35106.3 36753.4 36977.4 37066.0 44617.0 46177.5 46182.5 46205.8 47320.0 34428.0 34670.1 34722.8 34808.5 34994.7 33263.7 33527.7 33721.0 33871.2 34239.7 37341.0 38417.3 38768.0 38843.0 38876.4 32945.7 33129.7 33227.5 33636.7 33880.8 23785.5 23789.0 23910.3 24185.4 24518.9 17:36:48 INFO - PID 8133 | 17:36:48 INFO - PID 8133 | [#2] jquery.html Cycles:180 Average:33882.80 Median:23440.53 stddev:77917.72 (332.4%) stddev-sans-first:78096.17 17:36:48 INFO - PID 8133 | Values: 574.8 577.1 595.4 596.6 600.9 22086.8 22614.5 22689.0 22746.9 22755.4 25252.5 25696.6 25899.6 25915.6 25947.6 6624.3 6787.2 6791.9 6792.3 6804.7 6353.8 6608.5 6658.9 6664.3 6667.2 6607.6 6608.7 6609.8 6627.0 6627.0 6597.7 6616.5 6626.9 6631.1 6638.3 6111.5 6134.7 6136.8 6146.3 6159.0 29230.4 29414.6 29567.7 29613.9 29892.4 2071.5 2127.6 2130.0 2131.1 2131.7 19003.6 19612.2 19647.8 19656.9 19664.7 2318.9 2353.0 2373.1 2373.9 2434.4 139062.0 141551.0 145253.8 145386.0 145471.3 14370.7 14691.6 14718.3 14978.6 15365.2 23271.0 23434.2 23446.9 23456.2 23462.2 9473.1 9600.8 9636.2 9644.1 9996.5 7648.7 8045.1 8330.9 8528.5 8587.9 9305.2 9523.2 9538.2 9551.3 9561.3 2696.0 2735.3 2759.4 2759.6 2813.0 959.7 974.2 978.2 986.6 995.0 19320.3 19694.0 19942.3 20010.7 20171.0 1030.3 1030.4 1031.1 1049.2 1056.9 10733.6 11193.5 11226.0 11341.5 11381.8 440214.0 456841.7 461715.0 464743.0 470434.0 108864.0 112480.4 113366.0 113694.0 115078.0 1130.2 1150.7 1170.1 1171.1 1172.7 17816.7 17845.6 18080.7 18226.5 18370.2 53440.5 53952.7 55487.7 55598.7 56263.7 70528.0 70848.3 71025.0 71191.3 71748.3 14197.6 14582.3 14650.6 14655.0 14671.0 22823.4 23209.2 23300.2 23621.4 23644.2 17791.3 18264.2 18289.5 18433.7 18482.9 14854.2 14891.6 15171.6 15216.8 15373.5 18894.2 18954.6 19051.0 19151.4 19159.2 14070.5 14392.6 14413.9 14684.7 14865.7 18223.5 18232.0 18352.3 18490.3 18504.3 17:36:48 INFO - PID 8133 | 17:36:48 INFO - PID 8133 | [#3] mootools.html Cycles:180 Average:9494.86 Median:2713.38 stddev:6786.41 (250.1%) stddev-sans-first:6778.05 17:36:48 INFO - PID 8133 | Values: 1379.5 1423.1 1426.4 1426.8 1428.2 14941.3 15598.6 15615.2 15616.9 15875.0 15660.7 15993.0 15998.8 16007.1 16013.7 2702.6 2760.5 2761.8 2762.1 2763.9 2775.4 2870.0 2871.0 2873.5 2878.9 2757.7 2778.7 2779.2 2805.3 2811.0 2724.1 2771.6 2777.7 2778.6 2789.2 2654.1 2657.9 2675.0 2676.2 2676.6 15163.2 15423.5 15450.5 15507.2 15540.1 7892.2 8179.4 8187.0 8219.0 8223.1 5420.3 5474.7 5578.1 5611.2 5637.4 1949.4 1970.1 1976.7 2023.7 2033.1 26457.0 26605.3 26627.3 26674.5 26682.2 6782.4 6915.6 6941.5 7077.8 7095.5 17264.5 17265.4 17273.7 17294.0 17322.2 7771.3 8015.3 8023.1 8027.9 8045.2 7241.2 7254.9 7445.7 7451.7 7455.3 5234.7 5401.5 5414.1 5419.4 5467.5 1545.1 1546.9 1548.6 1549.2 1562.9 927.6 942.0 944.8 945.8 952.0 8065.4 8069.6 8081.1 8140.5 8248.5 716.2 738.6 746.2 750.5 754.1 4910.1 5251.8 5501.6 5816.2 5911.1 22307.1 22644.3 22644.5 22807.1 22817.9 21408.8 21905.5 22413.9 22448.6 22469.0 11231.4 11427.4 11438.6 11440.8 11511.5 8441.5 8594.7 8641.7 8684.4 8873.6 18372.1 18563.4 18788.7 18924.9 19202.7 18528.5 18932.9 19180.0 19220.2 19366.6 11666.7 11812.8 11821.3 11957.2 11968.2 14023.2 14189.6 14212.7 14221.3 14232.7 11268.7 11364.3 11466.8 11469.3 11578.8 10589.5 10608.7 10662.0 10717.8 10848.6 9668.3 9871.1 9872.6 9873.5 9888.1 7318.9 7345.8 7364.2 7366.6 7424.5 7476.6 7515.4 7611.5 7718.9 7736.1 17:36:48 INFO - PID 8133 | 17:36:48 INFO - PID 8133 | [#4] prototype.html Cycles:180 Average:5630.91 Median:6266.79 stddev:1592.77 (25.4%) stddev-sans-first:1549.39 17:36:48 INFO - PID 8133 | Values: 468.6 498.7 499.6 508.8 529.5 6242.3 6405.3 6438.1 6438.2 6502.3 6214.8 6264.4 6281.7 6291.0 6317.8 5004.8 5028.1 5064.9 5087.9 5137.4 4981.4 5071.9 5083.3 5093.3 5141.6 4992.5 5005.7 5013.9 5045.5 5116.0 4990.0 5019.2 5032.0 5078.8 5096.4 4514.9 4550.5 4553.6 4561.4 4562.8 6207.7 6226.7 6261.6 6326.7 6332.4 5720.7 5789.7 5828.9 5830.4 5867.6 6583.2 6611.4 6690.3 6702.7 6747.7 4943.4 4962.8 4972.9 4996.4 5009.8 6855.8 7026.6 7070.2 7082.8 7089.3 5050.2 5063.8 5094.1 5121.6 5140.0 5171.2 5173.9 5182.5 5192.1 5210.0 5704.2 5714.4 5816.6 5819.2 5824.2 6634.5 6634.7 6674.9 6764.9 6779.6 1693.4 1715.4 1747.3 1749.5 1755.1 1221.2 1222.0 1239.3 1254.8 1258.7 5783.7 5812.9 5876.8 5933.8 5992.1 6585.4 6880.5 6882.6 6889.1 6893.4 5887.8 5938.0 5994.0 6000.6 6005.7 3644.0 3660.6 3666.5 3677.0 3678.6 6512.5 6641.9 6705.3 6717.2 6738.5 7061.6 7066.2 7076.3 7079.9 7130.8 6704.0 6706.9 6719.8 6725.7 6822.1 6889.4 6954.9 6956.4 6985.7 7027.9 6808.3 6842.7 6863.6 6883.7 6912.6 6722.7 6727.6 6778.0 6784.3 6798.5 5069.8 5086.7 5087.9 5094.4 5133.2 6639.4 6859.4 6927.0 6949.8 6993.8 6269.2 6456.5 6498.7 6602.4 6625.5 6485.0 6587.8 6607.9 6612.5 6669.2 6324.2 6575.8 6589.4 6610.9 6685.2 6677.3 6682.1 6756.7 6763.6 6766.8 6512.4 6531.7 6553.5 6567.6 6592.6 17:36:48 INFO - PID 8133 | 17:36:48 INFO - PID 8133 | [#5] yui.html Cycles:180 Average:23735.62 Median:20059.10 stddev:32664.98 (162.8%) stddev-sans-first:32711.51 17:36:48 INFO - PID 8133 | Values: 876.6 900.2 907.4 914.3 935.0 17942.3 18713.9 18734.2 18749.4 21605.7 20351.5 21345.8 21459.1 21501.7 21512.4 969.2 986.2 992.9 993.0 995.7 909.3 990.8 991.4 1000.8 1001.5 1003.0 1063.3 1063.3 1063.4 1065.5 1052.9 1053.4 1053.5 1059.5 1060.8 769.6 769.8 770.2 770.5 772.0 19722.8 19790.2 20057.9 20060.3 20324.6 21504.1 21511.7 21715.0 22046.4 22063.7 17613.8 17615.0 17772.8 17829.9 17881.4 3722.9 3737.2 3740.0 3745.2 3750.5 132453.0 133185.0 133826.0 135397.0 136462.3 16238.9 16312.3 16713.8 16745.2 16830.4 29313.0 29781.3 29942.7 30500.4 30566.1 7597.2 7921.7 8547.7 8888.0 8907.1 4161.5 4228.4 4230.4 4231.5 4237.5 5159.6 5216.6 5233.1 5252.2 5291.6 1050.8 1065.6 1076.1 1078.0 1078.5 689.8 701.7 716.8 718.0 725.7 10859.5 11371.3 11397.1 11505.4 11697.3 695.4 698.6 707.2 709.3 713.0 5090.9 5150.9 5169.5 5191.8 5203.0 109669.0 109928.0 110012.9 110130.0 112791.0 96071.0 97098.0 99529.5 103652.5 104693.5 85309.6 85817.0 87815.6 89280.6 89476.1 11938.6 12090.6 12191.1 12292.2 12453.3 40667.4 41394.6 41765.2 42489.4 42552.4 54750.2 54887.0 55184.4 55732.0 56182.0 15613.8 18037.1 18426.9 18450.3 18505.8 18343.9 19771.3 19822.8 19988.1 20030.4 17416.0 17555.9 17556.7 19364.2 19921.6 17640.4 17739.6 17874.8 17969.3 18848.8 17906.9 17940.5 17949.5 17956.9 17985.4 14235.5 14389.1 14468.6 14472.1 14588.9 13567.7 13684.8 13687.7 13769.2 13777.4 17:36:48 INFO - PID 8133 | -------- Summary: end -------- 17:36:48 INFO - PID 8133 | 17:36:49 INFO - TEST-INFO | 8133: exit 0 17:36:49 INFO - TEST-OK | dromaeo_css | took 1109037ms 17:36:49 INFO - TEST-START | kraken 17:36:49 INFO - Initialising browser for kraken test... 17:36:49 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41182/getInfo.html -profile /tmp/tmpDbQzWR/profile 17:36:49 INFO - TEST-INFO | started process 8510 (/builds/slave/test/build/application/firefox/firefox http://localhost:41182/getInfo.html) 17:36:54 INFO - TEST-INFO | 8510: exit 0 17:36:54 INFO - Browser initialized. 17:36:54 INFO - Running cycle 1/1 for kraken test... 17:36:54 INFO - Using env: {'DISPLAY': ':0', 17:36:55 INFO - 'HOME': '/home/cltbld', 17:36:55 INFO - 'JSGC_DISABLE_POISONING': '1', 17:36:55 INFO - 'LANG': 'en_US.UTF-8', 17:36:55 INFO - 'LANGUAGE': 'en_US:en', 17:36:55 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:36:55 INFO - 'LOGNAME': 'cltbld', 17:36:55 INFO - 'MAIL': '/var/mail/cltbld', 17:36:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:36:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:36:55 INFO - 'MOZ_CRASHREPORTER': '1', 17:36:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:55 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:36:55 INFO - 'MOZ_NO_REMOTE': '1', 17:36:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:36:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:55 INFO - 'NO_EM_RESTART': '1', 17:36:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:55 INFO - 'PWD': '/builds/slave/test', 17:36:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:36:55 INFO - 'RUST_BACKTRACE': 'full', 17:36:55 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:36:55 INFO - 'SHELL': '/bin/bash', 17:36:55 INFO - 'SHLVL': '1', 17:36:55 INFO - 'STYLO_FORCE_DISABLED': '1', 17:36:55 INFO - 'TERM': 'linux', 17:36:55 INFO - 'TMOUT': '86400', 17:36:55 INFO - 'USER': 'cltbld', 17:36:55 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1504743430.942407-390765886', 17:36:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:55 INFO - '_': '/tools/buildbot/bin/python'} 17:36:55 INFO - TEST-INFO | started process 8705 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDbQzWR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:36:55 INFO - PID 8705 | 17:36:55 INFO - PID 8705 | (/builds/slave/test/build/application/firefox/firefox:8758): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:36:55 INFO - PID 8705 | 17:37:06 INFO - PID 8705 | RSS: Main: 168525824 17:37:06 INFO - PID 8705 | 17:37:08 INFO - PID 8705 | Cycle 1(1): loaded http://localhost:41182/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41182/tests/kraken/driver.html?testName=audio-beat-detection) 17:37:09 INFO - PID 8705 | RSS: Main: 174551040 17:37:09 INFO - PID 8705 | 17:37:12 INFO - PID 8705 | Cycle 1(1): loaded http://localhost:41182/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41182/tests/kraken/driver.html?testName=audio-dft) 17:37:13 INFO - PID 8705 | RSS: Main: 174972928 17:37:13 INFO - PID 8705 | 17:37:16 INFO - PID 8705 | Cycle 1(1): loaded http://localhost:41182/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41182/tests/kraken/driver.html?testName=audio-fft) 17:37:16 INFO - PID 8705 | RSS: Main: 169144320 17:37:16 INFO - PID 8705 | 17:37:18 INFO - PID 8705 | Cycle 1(1): loaded http://localhost:41182/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41182/tests/kraken/driver.html?testName=audio-oscillator) 17:37:19 INFO - PID 8705 | RSS: Main: 170283008 17:37:19 INFO - PID 8705 | 17:37:21 INFO - PID 8705 | Cycle 1(1): loaded http://localhost:41182/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41182/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:37:22 INFO - PID 8705 | RSS: Main: 170536960 17:37:22 INFO - PID 8705 | 17:37:25 INFO - PID 8705 | Cycle 1(1): loaded http://localhost:41182/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41182/tests/kraken/driver.html?testName=imaging-darkroom) 17:37:26 INFO - PID 8705 | RSS: Main: 172953600 17:37:26 INFO - PID 8705 | 17:37:29 INFO - PID 8705 | Cycle 1(1): loaded http://localhost:41182/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41182/tests/kraken/driver.html?testName=imaging-desaturate) 17:37:30 INFO - PID 8705 | RSS: Main: 173871104 17:37:30 INFO - PID 8705 | 17:37:33 INFO - PID 8705 | Cycle 1(1): loaded http://localhost:41182/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41182/tests/kraken/driver.html?testName=json-parse-financial) 17:37:33 INFO - PID 8705 | RSS: Main: 173494272 17:37:33 INFO - PID 8705 | 17:37:35 INFO - PID 8705 | Cycle 1(1): loaded http://localhost:41182/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41182/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:37:35 INFO - PID 8705 | RSS: Main: 172605440 17:37:35 INFO - PID 8705 | 17:37:37 INFO - PID 8705 | Cycle 1(1): loaded http://localhost:41182/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41182/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:37:38 INFO - PID 8705 | RSS: Main: 173613056 17:37:38 INFO - PID 8705 | 17:37:40 INFO - PID 8705 | Cycle 1(1): loaded http://localhost:41182/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41182/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:37:40 INFO - PID 8705 | RSS: Main: 170196992 17:37:40 INFO - PID 8705 | 17:37:43 INFO - PID 8705 | Cycle 1(1): loaded http://localhost:41182/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41182/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:37:44 INFO - PID 8705 | RSS: Main: 171061248 17:37:44 INFO - PID 8705 | 17:37:47 INFO - PID 8705 | Cycle 1(1): loaded http://localhost:41182/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41182/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:37:47 INFO - PID 8705 | RSS: Main: 170811392 17:37:47 INFO - PID 8705 | 17:37:49 INFO - PID 8705 | Cycle 1(1): loaded http://localhost:41182/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41182/tests/kraken/driver.html?testName=ai-astar) 17:37:49 INFO - PID 8705 | RSS: Main: 172544000 17:37:49 INFO - PID 8705 | 17:37:49 INFO - PID 8705 | __start_tp_report 17:37:49 INFO - PID 8705 | _x_x_mozilla_page_load 17:37:49 INFO - PID 8705 | _x_x_mozilla_page_load_details 17:37:49 INFO - PID 8705 | |i|pagename|runs| 17:37:49 INFO - PID 8705 | |0;ai-astar;100;106;101;106;106;114;106;98;109;108 17:37:49 INFO - PID 8705 | |1;audio-beat-detection;141;115;141;180;119;150;150;118;174;121 17:37:49 INFO - PID 8705 | |2;audio-dft;163;163;163;163;163;164;162;166;165;164 17:37:49 INFO - PID 8705 | |3;audio-fft;75;74;77;171;76;74;74;73;146;80 17:37:49 INFO - PID 8705 | |4;audio-oscillator;80;79;127;78;80;80;125;79;79;141 17:37:49 INFO - PID 8705 | |5;imaging-gaussian-blur;114;114;114;114;114;114;114;114;114;114 17:37:49 INFO - PID 8705 | |6;imaging-darkroom;149;146;148;149;148;147;149;148;148;147 17:37:49 INFO - PID 8705 | |7;imaging-desaturate;95;94;94;94;93;94;96;93;94;97 17:37:49 INFO - PID 8705 | |8;json-parse-financial;53;54;55;53;52;53;52;52;52;55 17:37:49 INFO - PID 8705 | |9;json-stringify-tinderbox;39;38;37;38;37;37;37;37;37;37 17:37:49 INFO - PID 8705 | |10;stanford-crypto-aes;74;75;76;75;73;74;76;76;74;75 17:37:49 INFO - PID 8705 | |11;stanford-crypto-ccm;119;126;119;118;131;125;123;124;132;160 17:37:49 INFO - PID 8705 | |12;stanford-crypto-pbkdf2;173;168;181;184;183;173;171;173;174;172 17:37:49 INFO - PID 8705 | |13;stanford-crypto-sha256-iterative;66;65;67;76;64;65;64;63;63;65 17:37:49 INFO - PID 8705 | __end_tp_report 17:37:49 INFO - PID 8705 | __start_cc_report 17:37:49 INFO - PID 8705 | _x_x_mozilla_cycle_collect,975 17:37:49 INFO - PID 8705 | __end_cc_report 17:37:49 INFO - PID 8705 | __startTimestamp1504744669917__endTimestamp 17:37:49 INFO - PID 8705 | 17:37:49 INFO - PID 8705 | ------- Summary: start ------- 17:37:49 INFO - PID 8705 | Number of tests: 14 17:37:49 INFO - PID 8705 | 17:37:49 INFO - PID 8705 | [#0] ai-astar Cycles:10 Average:105.40 Median:107.00 stddev:4.70 (4.4%) stddev-sans-first:4.56 17:37:49 INFO - PID 8705 | Values: 100.0 106.0 101.0 106.0 106.0 114.0 106.0 98.0 109.0 108.0 17:37:49 INFO - PID 8705 | 17:37:49 INFO - PID 8705 | [#1] audio-beat-detection Cycles:10 Average:140.90 Median:145.50 stddev:23.24 (16.0%) stddev-sans-first:24.65 17:37:49 INFO - PID 8705 | Values: 141.0 115.0 141.0 180.0 119.0 150.0 150.0 118.0 174.0 121.0 17:37:49 INFO - PID 8705 | 17:37:49 INFO - PID 8705 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.50 stddev:1.17 (0.7%) stddev-sans-first:1.22 17:37:49 INFO - PID 8705 | Values: 163.0 163.0 163.0 163.0 163.0 164.0 162.0 166.0 165.0 164.0 17:37:49 INFO - PID 8705 | 17:37:49 INFO - PID 8705 | [#3] audio-fft Cycles:10 Average:92.00 Median:74.50 stddev:35.60 (47.8%) stddev-sans-first:37.22 17:37:49 INFO - PID 8705 | Values: 75.0 74.0 77.0 171.0 76.0 74.0 74.0 73.0 146.0 80.0 17:37:49 INFO - PID 8705 | 17:37:49 INFO - PID 8705 | [#4] audio-oscillator Cycles:10 Average:94.80 Median:79.00 stddev:25.32 (32.1%) stddev-sans-first:26.29 17:37:49 INFO - PID 8705 | Values: 80.0 79.0 127.0 78.0 80.0 80.0 125.0 79.0 79.0 141.0 17:37:49 INFO - PID 8705 | 17:37:49 INFO - PID 8705 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 17:37:49 INFO - PID 8705 | Values: 114.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 17:37:49 INFO - PID 8705 | 17:37:49 INFO - PID 8705 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.99 (0.7%) stddev-sans-first:0.97 17:37:49 INFO - PID 8705 | Values: 149.0 146.0 148.0 149.0 148.0 147.0 149.0 148.0 148.0 147.0 17:37:49 INFO - PID 8705 | 17:37:49 INFO - PID 8705 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.00 stddev:1.26 (1.3%) stddev-sans-first:1.32 17:37:49 INFO - PID 8705 | Values: 95.0 94.0 94.0 94.0 93.0 94.0 96.0 93.0 94.0 97.0 17:37:49 INFO - PID 8705 | 17:37:49 INFO - PID 8705 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:53.00 stddev:1.20 (2.3%) stddev-sans-first:1.27 17:37:49 INFO - PID 8705 | Values: 53.0 54.0 55.0 53.0 52.0 53.0 52.0 52.0 52.0 55.0 17:37:49 INFO - PID 8705 | 17:37:49 INFO - PID 8705 | [#9] json-stringify-tinderbox Cycles:10 Average:37.40 Median:37.00 stddev:0.70 (1.9%) stddev-sans-first:0.44 17:37:49 INFO - PID 8705 | Values: 39.0 38.0 37.0 38.0 37.0 37.0 37.0 37.0 37.0 37.0 17:37:49 INFO - PID 8705 | 17:37:49 INFO - PID 8705 | [#10] stanford-crypto-aes Cycles:10 Average:74.80 Median:75.00 stddev:1.03 (1.4%) stddev-sans-first:1.05 17:37:49 INFO - PID 8705 | Values: 74.0 75.0 76.0 75.0 73.0 74.0 76.0 76.0 74.0 75.0 17:37:49 INFO - PID 8705 | 17:37:49 INFO - PID 8705 | [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:125.50 stddev:12.31 (9.8%) stddev-sans-first:12.65 17:37:49 INFO - PID 8705 | Values: 119.0 126.0 119.0 118.0 131.0 125.0 123.0 124.0 132.0 160.0 17:37:49 INFO - PID 8705 | 17:37:49 INFO - PID 8705 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.20 Median:173.50 stddev:5.45 (3.1%) stddev-sans-first:5.73 17:37:49 INFO - PID 8705 | Values: 173.0 168.0 181.0 184.0 183.0 173.0 171.0 173.0 174.0 172.0 17:37:49 INFO - PID 8705 | 17:37:49 INFO - PID 8705 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:65.00 stddev:3.79 (5.8%) stddev-sans-first:4.02 17:37:49 INFO - PID 8705 | Values: 66.0 65.0 67.0 76.0 64.0 65.0 64.0 63.0 63.0 65.0 17:37:49 INFO - PID 8705 | -------- Summary: end -------- 17:37:49 INFO - PID 8705 | 17:37:50 INFO - PID 8705 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:37:50 INFO - TEST-INFO | 8705: exit 0 17:37:50 INFO - TEST-OK | kraken | took 61306ms 17:37:50 INFO - SUITE-END | took 1170s 17:37:51 INFO - Completed test suite (00:19:30) 17:37:51 INFO - javascript benchmark 17:37:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8635.18543942564, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3302.5211344355075, 3321.3357328534285, 3333.2333563280445, 3340.7327413806897, 3367.2592029753446, 6460.998545225486, 6499.057636642689, 6503.999999999994, 6543.214814222294, 6545.639989800559, 6253.030780229061, 6371.585846919958, 6398.808035758923, 6401.679916004193, 6420.1974753155855, 5880.470757631823, 5914.290285165786, 5919.674417907014, 5941.346451890288, 5944.227250457456, 5892.646441213519, 5933.584649074545, 5989.820305390824, 6006.309274433453, 6007.669578173199, 5906.232189815297, 5941.792037278675, 5993.071073983518, 5998.4901283390745, 6017.879642407149, 5448.645838020516, 5696.6866822324755, 5809.186713860063, 5841.795537156222, 5965.403459654043, 5819.854503637401, 5820.82537523875, 5912.113183022538, 5920.141579470996, 5958.225430694026, 6218.378162183791, 6318.652474113922, 6376.0754690570075, 6434.163558737381, 6510.64191469469, 6876.106106206161, 6884.896726549106, 6914.688839002257, 6915.930840691579, 6917.377436030782, 6910.827229319257, 7013.298670132997, 7015.333543313377, 7017.3684368407085, 7022.262662420423, 6408.903866442007, 6415.0, 6433.131527243809, 6514.5114116441455, 6524.77163299287, 6926.168859736864, 7030.6484675766005, 7047.365737083687, 7073.115860517435, 7090.0, 6672.2994085621285, 6734.8989765153565, 6740.662966851638, 6745.797626071226, 6754.3921047106, 6906.205786334636, 6970.0, 7005.579665220103, 7006.299370062953, 7022.403095736818, 6895.9656051592665, 6914.792556223321, 6970.965145174343, 7007.0, 7016.684249208798, 6923.584584924921, 6928.480363972722, 6935.722571097201, 7012.018317435563, 7023.964880175567, 5336.0661884170895, 5422.5119739223655, 5486.643368181056, 5522.66863988162, 5533.00405926937, 4849.054434385332, 4861.538153875376, 4896.167651499253, 4904.215325547895, 4906.607471402279, 6022.337542870281, 6035.336113027563, 6111.113888486234, 6117.143599896018, 6121.143039974407, 6840.281770414035, 6933.826654333682, 6946.79159625212, 6999.265077166926, 7034.788956331318, 6124.785632502841, 6147.170132032118, 6150.661713605705, 6155.753769849156, 6157.876842463125, 6001.399860013964, 6033.336333003366, 6045.063015232646, 6080.513558915276, 6093.238345206849, 6677.3656502632175, 6750.122484077038, 6849.212340580797, 6867.484938629623, 6881.759138430131, 6739.93260067393, 6830.077939478306, 6956.373926346653, 7059.647017649199, 7081.504294699527, 6636.13730215069, 6729.158855143107, 6736.292689267752, 6737.461003119641, 6739.93260067393, 6823.727050917908, 6828.897566536605, 6869.519133660596, 6886.8622627546165, 6934.994425808331, 7006.089208402875, 7016.614086225307, 7088.539244949062, 7091.11361079865, 7092.326229008236, 6560.606363618198, 6609.900851487328, 6672.199336079701, 6729.89905151433, 6836.897446538206, 6799.626020568719, 6806.2513123557355, 6810.625415601991, 6813.8977915330315, 6818.386345228953, 6694.564853284521, 6743.055972163999, 6782.660866956731, 6788.219354774066, 6791.932080679328, 6745.831354215988, 6777.491688123312, 6788.456923446014, 6804.353586409283, 6918.273581274095, 6415.230172379344, 6502.577332473374, 6510.804675859732, 6585.20977482686, 6668.899966500603], "value": 6328.337233267001, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [829.8298848736009, 863.0980625246617, 882.2589025218815, 888.4447220487198, 1127.7349822791648, 31521.84239078807, 32111.0, 41896.0, 42136.78931605338, 42525.36211956823, 42498.36252456208, 42511.36232956508, 42685.0, 42716.0, 42778.57221427785, 7414.443916706242, 7795.493292935955, 8070.55611941343, 8097.433179677425, 8108.432409731321, 7677.769666910001, 7689.346405555534, 7693.923060769404, 7721.382289416833, 7821.335186509154, 7758.6896524138965, 7764.456488045839, 7797.181295963899, 7802.180771019046, 7831.608419579026, 7705.961470192669, 7716.151223365453, 7721.575313357763, 7781.766547003599, 7856.882146767803, 7877.172896845806, 7909.841803163905, 7919.247671471201, 7936.047674279123, 7941.801454963615, 38433.807830960664, 38697.41953870694, 38821.0, 38900.416493752615, 38972.22055558873, 3481.860725570974, 3488.0582242794558, 3526.1537231064617, 3527.9294414111832, 3529.6293889141525, 31643.683563164304, 31729.524057139162, 31767.682323176705, 31861.203469913205, 31880.84059579687, 4955.380577427822, 5145.434002259748, 5162.148245539482, 5162.793488260465, 5203.0, 194620.0, 194762.0, 195962.0, 196185.99999999857, 196234.0, 48927.51072489301, 49143.754281228365, 49193.26210106851, 49225.50774492209, 49437.50562494329, 51190.74404627953, 51207.48792512027, 51236.74381628068, 51287.74356128195, 51470.0, 13137.277449740355, 14142.0, 14387.0, 14391.712165756626, 14422.495212667507, 10744.355338679705, 11645.301281923112, 11916.821247681291, 11937.164398492023, 12004.099692522921, 13930.0, 14059.929700351433, 14175.858241417454, 14201.928990354982, 14285.857141428452, 5621.297337832771, 5748.137779333133, 5844.444777746107, 5852.385499522574, 5852.619579727304, 1002.5288114586133, 1006.6426418621284, 1012.6860673191334, 1025.4565080507193, 1034.177828626244, 22541.77458225397, 28332.291692707848, 28613.57079643807, 28953.13140605785, 29003.12990610285, 1084.1272775415707, 1084.1760262200626, 1103.3269705479652, 1104.6575561575937, 1107.8615173103362, 11998.220115692453, 12248.326342051272, 12256.448459819152, 12307.69230769238, 12373.319467429377, 242436.0, 244700.0, 244881.0, 245148.0, 245657.0, 51100.488995109576, 51309.23036154461, 51483.48516514787, 51558.74220628873, 51594.22608660873, 1435.7559214933278, 1444.826620805489, 1451.8765904897991, 1460.5983354577363, 1463.1440607244667, 22325.0, 22558.66162007604, 22693.88653056724, 22725.772742272366, 23131.190408335628, 37242.8137859309, 37624.43563346497, 37732.81133594424, 37734.24531509409, 37741.4338784924, 151542.0, 151944.0, 152626.0, 153516.0, 153566.23216883844, 33219.0, 35106.29787404289, 36753.448698270084, 36977.44533832048, 37066.0, 44617.0, 46177.53822461867, 46182.538174617825, 46205.76897115493, 47320.0, 34428.0, 34670.13324666904, 34722.826385867906, 34808.47787283243, 34994.650053500154, 33263.66736332606, 33527.664723352456, 33721.0, 33871.15322116967, 34239.65760342365, 37341.0, 38417.2712227956, 38768.0, 38843.0, 38876.416853746654, 32945.67054329426, 33129.66870331266, 33227.50158747669, 33636.66363336433, 33880.83059584686, 23785.52428951446, 23789.0, 23910.28269151928, 24185.39536511601, 24518.877405612857], "value": 17257.86813198276, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.8189320364082, 577.093962478908, 595.4164918379987, 596.6449962272447, 600.9338972713002, 22086.779132208674, 22614.547709045808, 22689.0, 22746.862656867153, 22755.431114222112, 25252.494950100987, 25696.614550781705, 25899.611505827426, 25915.611265831027, 25947.610785838227, 6624.27133015368, 6787.151606049244, 6791.864162716743, 6792.252852186256, 6804.659767011654, 6353.809385718436, 6608.471322294205, 6658.866822663568, 6664.333566643345, 6667.233268174149, 6607.603543787364, 6608.702608382634, 6609.768658096968, 6626.9668651656675, 6627.0, 6597.736090556372, 6616.503762217853, 6626.900596491057, 6631.104800851896, 6638.336166383371, 6111.480524155452, 6134.723937422827, 6136.7545298188015, 6146.323904370515, 6159.0, 29230.415391692048, 29414.558781618292, 29567.70432295671, 29613.85193074021, 29892.402151956838, 2071.482129467633, 2127.563849410867, 2129.9787002130092, 2131.147540983619, 2131.7441906971108, 19003.619927601372, 19612.215511379527, 19647.80352196474, 19656.90171549133, 19664.705029424425, 2318.8840557972203, 2352.9882350588136, 2373.1100837186054, 2373.9050437982633, 2434.415740222352, 139062.0, 141551.0, 145253.82119268324, 145386.0, 145471.2726436361, 14370.712585748226, 14691.632709182357, 14718.33767480466, 14978.625534361729, 15365.154916479478, 23271.0, 23434.17980370713, 23446.882765586404, 23456.17903373408, 23462.178823741087, 9473.126661469794, 9600.807983840285, 9636.180924621345, 9644.083812037845, 9996.50017499122, 7648.732294369782, 8045.115037345888, 8330.916690833013, 8528.488290702453, 8587.871181932276, 9305.162535371848, 9523.19052880513, 9538.236941044699, 9551.331406801457, 9561.330706850455, 2695.9595606065923, 2735.3161709572605, 2759.379139693553, 2759.599858020616, 2812.9578056329174, 959.6737109382843, 974.2352253480983, 978.1538968792086, 986.5708416838698, 994.9801003979879, 19320.32378866733, 19694.0, 19942.30201942925, 20010.69983950242, 20171.0, 1030.3096925060227, 1030.3766221436074, 1031.128696251666, 1049.150188347441, 1056.8943105689523, 10733.624323148651, 11193.496292666687, 11226.0, 11341.546338146547, 11381.804910484445, 440214.0, 456841.71579142555, 461715.0, 464743.0, 470434.0, 108864.0, 112480.43759781148, 113366.0, 113694.0, 115078.0, 1130.152385710717, 1150.7468356961456, 1170.0990237517065, 1171.1099564331, 1172.695099274195, 17816.732749009036, 17845.643087138444, 18080.72878906844, 18226.544336391697, 18370.173342199367, 53440.46559534355, 53952.730236348565, 55487.72256138855, 55598.72200638971, 56263.71868140633, 70528.0, 70848.29151708417, 71025.0, 71191.28808711846, 71748.28251717416, 14197.645058873612, 14582.270886455422, 14650.63373415673, 14655.047421917541, 14670.973031888092, 22823.429414264778, 23209.18767843185, 23300.184493542645, 23621.409464763517, 23644.172453964027, 17791.288348466434, 18264.178111985257, 18289.542761431072, 18433.72349414733, 18482.907585461988, 14854.183019934007, 14891.553253402415, 15171.620709482351, 15216.771748423562, 15373.461928832437, 18894.244230230637, 18954.620907582048, 19051.0, 19151.425457236306, 19159.233630654617, 14070.507532236323, 14392.640183995483, 14413.85586144125, 14684.70630587361, 14865.702685946004, 18223.45329640113, 18232.0, 18352.265909363476, 18490.260389584266, 18504.259829606664], "value": 11920.270923411736, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1379.517168990853, 1423.1034448297578, 1426.365267455982, 1426.8430472648013, 1428.164523753604, 14941.252937353129, 15598.610034749137, 15615.219239038031, 15616.921915390421, 15875.047497150179, 15660.686786264268, 15993.0, 15998.76001859973, 16007.119608421532, 16013.679726405466, 2702.6081218223344, 2760.5307097793325, 2761.8342899425998, 2762.1023167470553, 2763.9447211055767, 2775.4449110177943, 2870.0, 2871.0, 2873.5402335626304, 2878.913632591026, 2757.7104404037586, 2778.7360200780895, 2779.1662501249643, 2805.3267215868145, 2810.9578356324673, 2724.1418953029734, 2771.5565509518483, 2777.722227777216, 2778.597103419993, 2789.205076553193, 2654.1241390341333, 2657.8803953822126, 2675.0, 2676.183763951994, 2676.625272461857, 15163.241837908061, 15423.537293881202, 15450.459233926871, 15507.224638768017, 15540.067595944167, 7892.210778922119, 8179.4274400791965, 8187.0, 8218.958905205436, 8223.05434874985, 5420.289290030805, 5474.698891560963, 5578.135389014709, 5611.242482264883, 5637.408072152406, 1949.39568733693, 1970.103602860695, 1976.6540855350256, 2023.6964455331818, 2033.1054336092072, 26457.0, 26605.334866628487, 26627.334316642045, 26674.466510670067, 26682.19953401401, 6782.355676210752, 6915.585064896122, 6941.548799328028, 7077.787666370017, 7095.545413190283, 17264.482065538054, 17265.39571115005, 17273.65452690939, 17294.04882731462, 17322.22050007753, 7771.33943614799, 8015.278624923785, 8023.117457079717, 8027.919720802834, 8045.195480452025, 7241.167265764505, 7254.854902901912, 7445.739399121005, 7451.739189128354, 7455.25447455261, 5234.738263086831, 5401.513863752281, 5414.07960646691, 5419.430959749169, 5467.45325467458, 1545.119282009244, 1546.914919679406, 1548.5664014076076, 1549.1789351643422, 1562.898411603242, 927.6428574998539, 941.9576119074658, 944.7732544189345, 945.7824700318965, 952.0289304908954, 8065.395095367753, 8069.556174410346, 8081.111077781439, 8140.511569305861, 8248.54632995179, 716.2300526933567, 738.6196109003868, 746.220199891115, 750.5196674128562, 754.0536626533665, 4910.091633047898, 5251.789928402897, 5501.587380946445, 5816.185733997244, 5911.113332999998, 22307.107715691516, 22644.320670379915, 22644.547109057727, 22807.087716491485, 22817.88591057034, 21408.78591214099, 21905.452363691034, 22413.887930560242, 22448.551028979327, 22469.0, 11231.382273974847, 11427.371494567713, 11438.599649012245, 11440.828387574193, 11511.53953841837, 8441.470836602035, 8594.65621375138, 8641.697540586048, 8684.39209255346, 8873.645054198018, 18372.081395929883, 18563.35028274004, 18788.718169227745, 18924.905375473587, 19202.711959320342, 18528.536786579905, 18932.905335473235, 19180.0, 19220.231190752773, 19366.61266774685, 11666.70833229176, 11812.82280765772, 11821.349825759666, 11957.162998590364, 11968.222065565711, 14023.228722420365, 14189.645258868612, 14212.715745684822, 14221.288935553388, 14232.715345693236, 11268.718282042686, 11364.318140911571, 11466.77066458683, 11469.254498457907, 11578.76842463163, 10589.523471443958, 10608.681739547827, 10662.0, 10717.839232411365, 10848.566057357617, 9668.274879384215, 9871.111599956039, 9872.555734991798, 9873.456959867277, 9888.110070093726, 7318.890216646648, 7345.77962661121, 7364.189939106801, 7366.558006519626, 7424.480286379901, 7476.5514069156025, 7515.361194298327, 7611.543307401574, 7718.92281077182, 7736.1103473099065], "value": 6763.213635710858, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [468.57359802579657, 498.65592741008703, 499.5578912662294, 508.78376689906804, 529.4996228564006, 6242.313345531988, 6405.26339470961, 6438.1308523349335, 6438.195225596801, 6502.31725668805, 6214.757048590277, 6264.373562643734, 6281.748730050804, 6291.0, 6317.842053948642, 5004.84985450437, 5028.094942910284, 5064.898702025957, 5087.949120508803, 5137.383513978328, 4981.352424184869, 5071.898562028758, 5083.313752643383, 5093.312402825627, 5141.562967147778, 4992.500749924997, 5005.724685142316, 5013.874653133665, 5045.545900868921, 5115.9744201278945, 4989.950100499003, 5019.222020586797, 5031.974840125813, 5078.8414923657665, 5096.413912400048, 4514.932276015862, 4550.476695180064, 4553.612942899857, 4561.429821272341, 4562.817487300504, 6207.658578778165, 6226.657533835637, 6261.561690681654, 6326.65203413812, 6332.366763323676, 5720.742566584514, 5789.681567513785, 5828.854278643025, 5830.387809280007, 5867.618604790675, 6583.242927063353, 6611.404973552403, 6690.297518760557, 6702.692974869854, 6747.730090796363, 4943.406791185045, 4962.776675049631, 4972.900541989176, 4996.375453068366, 5009.774560144766, 6855.828604284833, 7026.613536255504, 7070.222275549737, 7082.822929426806, 7089.255628159072, 5050.2324186534415, 5063.797448102035, 5094.108531007059, 5121.564667003272, 5140.0, 5171.172612382076, 5173.870653233624, 5182.481751824787, 5192.143296356135, 5210.0, 5704.201411802351, 5714.428557144252, 5816.592838501264, 5819.214406055213, 5824.165387902797, 6634.502412318999, 6634.668266586651, 6674.899876501856, 6764.864702705919, 6779.559328643622, 1693.3988434105715, 1715.382462313566, 1747.3010795681828, 1749.4751574527845, 1755.1487528548644, 1221.2062159596155, 1221.987780122205, 1239.2997956154743, 1254.8494180698192, 1258.7230809221955, 5783.681897495678, 5812.941870581325, 5876.764929402776, 5933.842900634421, 5992.13114098462, 6585.440237579859, 6880.483963702743, 6882.621455819978, 6889.139932218273, 6893.379595836399, 5887.76448942046, 5938.040446652594, 5993.9700301498215, 6000.579959402888, 6005.729742161526, 3643.9635603644156, 3660.5973342932257, 3666.4866918631415, 3676.9632303677154, 3678.6321367863, 6512.479001679854, 6641.867162656817, 6705.295943925915, 6717.227518835396, 6738.528303018839, 7061.576305421691, 7066.222715501291, 7076.2923707628825, 7079.858282904558, 7130.750423735144, 6704.0, 6706.865862682816, 6719.832004199837, 6725.730970761213, 6822.147231596051, 6889.414399776075, 6954.860902781815, 6956.443484521327, 6985.720571177096, 7027.9297207027275, 6808.319168083152, 6842.657867106725, 6863.588184708933, 6883.690233939585, 6912.619805910723, 6722.697478613376, 6727.629980351127, 6778.0, 6784.2876497967, 6798.456123510206, 5069.822556210515, 5086.694798312114, 5087.923681144712, 5094.395265491358, 5133.1786914095055, 6639.435647969976, 6859.382655561023, 6927.030215769695, 6949.803090578391, 6993.755218567326, 6269.216347956505, 6456.483481321389, 6498.74005039812, 6602.40578347951, 6625.503087268377, 6484.967575162283, 6587.80236592903, 6607.942729163311, 6612.5040621952585, 6669.199696036312, 6324.209473815773, 6575.80272591823, 6589.374009469093, 6610.867782644224, 6685.164354455693, 6677.2988836173445, 6682.131322927989, 6756.662166891734, 6763.5941843489545, 6766.763163289262, 6512.381323774234, 6531.706073226811, 6553.5084868634085, 6567.638779867153, 6592.637404942774], "value": 5154.5425474229005, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [876.5880036382902, 900.1898291537619, 907.4237858959559, 914.305128102642, 935.0, 17942.282308707654, 18713.90643046783, 18734.156962936668, 18749.43751687448, 21605.67591486129, 20351.491212719688, 21345.786542134574, 21459.141634334646, 21501.677474837852, 21512.354629361103, 969.2052516936116, 986.1962500562055, 992.900709929005, 992.9602815887356, 995.6813819577739, 909.3452714045876, 990.8166989107002, 991.3605724307818, 1000.8348622477282, 1001.484235618657, 1003.0170432975651, 1063.2557209953025, 1063.3194755356578, 1063.388551582839, 1065.4512925843196, 1052.9315594486334, 1053.3627155570884, 1053.489057806963, 1059.5496913811637, 1060.8037513060108, 769.5651956644477, 769.819092513259, 770.1605250277169, 770.5261264322457, 772.0311009682869, 19722.802771972383, 19790.208391664317, 20057.8997105015, 20060.29788957394, 20324.593508129903, 21504.139834406604, 21511.67732484014, 21715.0, 22046.448838778997, 22063.66904496434, 17613.823861761346, 17615.0, 17772.822271777248, 17829.910850445794, 17881.37415190475, 3722.9069273268115, 3737.1591391936868, 3740.0462881965195, 3745.1573395985956, 3750.49368335274, 132453.0, 133185.0, 133826.0, 135397.0, 136462.31768841192, 16238.918805405898, 16312.265948032367, 16713.832861671228, 16745.16274186286, 16830.410935617194, 29313.0, 29781.255468613457, 29942.700572993992, 30500.38999220003, 30566.08301750951, 7597.2022937590755, 7921.722739704082, 8547.74356769298, 8888.0, 8907.10928907117, 4161.542230354658, 4228.429162063144, 4230.386593943861, 4231.534531201565, 4237.533871274219, 5159.638825282269, 5216.58267338612, 5233.084210263189, 5252.185911183773, 5291.550218231493, 1050.7950949564915, 1065.5950738719237, 1076.1283360478037, 1077.9784404312027, 1078.5439656463711, 689.7723751162105, 701.680735265453, 716.7849645106447, 717.9748708795167, 725.6516871901517, 10859.511321990529, 11371.260868043717, 11397.145214108976, 11505.424728763528, 11697.2981621103, 695.4366962760181, 698.6017969757189, 707.1584814071239, 709.2623671381808, 713.0409599089216, 5090.88000639866, 5150.896982060338, 5169.4830516948, 5191.766370513336, 5202.9913466038115, 109669.0, 109928.0, 110012.89987100026, 110130.0, 112791.0, 96071.0, 97098.0, 99529.50235248778, 103652.48173759083, 104693.47653261686, 85309.57345213358, 85817.0, 87815.56092219625, 89280.5535972316, 89476.10523894678, 11938.64184074479, 12090.637280881587, 12191.146619736888, 12292.201006934522, 12453.315067671003, 40667.389989150775, 41394.58605413907, 41765.1646967065, 42489.36265955951, 42552.361714573686, 54750.17874731962, 54887.0, 55184.44815551793, 55732.0, 56182.0, 15613.76579351288, 18037.098145092954, 18426.907865460587, 18450.26198952027, 18505.81494185041, 18343.908280458512, 19771.308004219783, 19822.80177198267, 19988.10053547565, 20030.39908802738, 17416.0, 17555.912220438815, 17556.736648950533, 19364.225430983166, 19921.601567968268, 17640.38258660941, 17739.645207095527, 17874.821251787314, 17969.281228750704, 18848.811511884705, 17906.91046544759, 17940.461786146436, 17949.461516154537, 17956.91021544884, 17985.370512032016, 14235.501757438855, 14389.064710793766, 14468.565943021726, 14472.131672099707, 14588.85411145875, 13567.728645427234, 13684.794728078889, 13687.657808554866, 13769.173849569059, 13777.448902044207], "value": 9134.807907553972, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1487.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 106.0, 101.0, 106.0, 106.0, 114.0, 106.0, 98.0, 109.0, 108.0], "value": 105.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 115.0, 141.0, 180.0, 119.0, 150.0, 150.0, 118.0, 174.0, 121.0], "value": 140.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 163.0, 163.0, 164.0, 162.0, 166.0, 165.0, 164.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 77.0, 171.0, 76.0, 74.0, 74.0, 73.0, 146.0, 80.0], "value": 92.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 127.0, 78.0, 80.0, 80.0, 125.0, 79.0, 79.0, 141.0], "value": 94.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 146.0, 148.0, 149.0, 148.0, 147.0, 149.0, 148.0, 148.0, 147.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 93.0, 94.0, 96.0, 93.0, 94.0, 97.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 55.0, 53.0, 52.0, 53.0, 52.0, 52.0, 52.0, 55.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 38.0, 37.0, 38.0, 37.0, 37.0, 37.0, 37.0, 37.0, 37.0], "value": 37.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 75.0, 73.0, 74.0, 76.0, 76.0, 74.0, 75.0], "value": 74.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 126.0, 119.0, 118.0, 131.0, 125.0, 123.0, 124.0, 132.0, 160.0], "value": 127.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 168.0, 181.0, 184.0, 183.0, 173.0, 171.0, 173.0, 174.0, 172.0], "value": 175.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 67.0, 76.0, 64.0, 65.0, 64.0, 63.0, 63.0, 65.0], "value": 65.8, "unit": "score"}]}]} 17:37:51 INFO - Return code: 0 17:37:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:37:51 INFO - # TBPL SUCCESS # 17:37:51 INFO - Running post-action listener: _package_coverage_data 17:37:51 INFO - Running post-action listener: _resource_record_post_action 17:37:51 INFO - [mozharness: 2017-09-07 00:37:51.192908Z] Finished run-tests step (success) 17:37:51 INFO - Running post-run listener: _resource_record_post_run 17:37:51 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 394907648; Read time: 0; Write time: 307980 17:37:51 INFO - TinderboxPrint: CPU usage
13.1% 17:37:51 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 17:37:51 INFO - TinderboxPrint: I/O write bytes / time
394,907,648 / 307,980 17:37:51 INFO - TinderboxPrint: CPU idle
8,230.3 (86.9%) 17:37:51 INFO - TinderboxPrint: CPU user
1,192.5 (12.6%) 17:37:51 INFO - TinderboxPrint: Swap in / out
0 / 0 17:37:51 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 112070656; Read time: 0; Write time: 100468 17:37:51 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:37:51 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 282836992; Read time: 0; Write time: 207512 17:37:51 INFO - Running post-run listener: _upload_blobber_files 17:37:51 INFO - Blob upload gear active. 17:37:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:37:51 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:37:51 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:37:51 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:37:52 INFO - (blobuploader) - INFO - Open directory for files ... 17:37:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 17:37:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:37:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:37:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 17:37:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:37:53 INFO - (blobuploader) - INFO - Done attempting. 17:37:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:37:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:37:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:37:54 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:37:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:37:54 INFO - (blobuploader) - INFO - Done attempting. 17:37:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 17:37:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:37:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:37:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 17:37:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:37:55 INFO - (blobuploader) - INFO - Done attempting. 17:37:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:37:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:37:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:38:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:38:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:38:02 INFO - (blobuploader) - INFO - Done attempting. 17:38:02 INFO - (blobuploader) - INFO - Iteration through files over. 17:38:02 INFO - Return code: 0 17:38:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:38:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:38:02 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e2b47d1288dc5e8f988e8dbbe0ebaf960bf9aeeef5ad0cc8075d740288ca8e8fe417d38cc9c1f1db11f4094cdc7b4ed55737d28a5fe49d7d088c72f79b5b841", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b5a58c01a31c7853b7821694a1d193f91747290ad58eebdbffc688bc447ad053b749a64afb62ab12880eaf0d1394156cfd3bfd7ed563eddd343a59eee77546cc", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/828d93827b3cf3d16be66cac49d71233cc27ccb8cefbb078869a782b7122ba55974ce36ded761ed5afc6d8cf1b9fc7d820c44b4362f9e38746ef0064ce041aa3", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aec60665e9a5a50b9a3209326c7d81eb30316d7579ecfd0319e6d5f7085935be96668b201aace238cc011dfababb0fb4afcc7723a3a78d06eadca0db927a214f"} 17:38:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:38:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:38:02 INFO - Contents: 17:38:02 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e2b47d1288dc5e8f988e8dbbe0ebaf960bf9aeeef5ad0cc8075d740288ca8e8fe417d38cc9c1f1db11f4094cdc7b4ed55737d28a5fe49d7d088c72f79b5b841", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b5a58c01a31c7853b7821694a1d193f91747290ad58eebdbffc688bc447ad053b749a64afb62ab12880eaf0d1394156cfd3bfd7ed563eddd343a59eee77546cc", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/828d93827b3cf3d16be66cac49d71233cc27ccb8cefbb078869a782b7122ba55974ce36ded761ed5afc6d8cf1b9fc7d820c44b4362f9e38746ef0064ce041aa3", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aec60665e9a5a50b9a3209326c7d81eb30316d7579ecfd0319e6d5f7085935be96668b201aace238cc011dfababb0fb4afcc7723a3a78d06eadca0db927a214f"} 17:38:02 INFO - Running post-run listener: copy_logs_to_upload_dir 17:38:02 INFO - Copying logs to upload dir... 17:38:02 INFO - mkdir: /builds/slave/test/build/upload/logs 17:38:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.787764 ========= master_lag: 0.17 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-09-06 17:38:02.669473) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-06 17:38:02.676434) ========= 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=a0d2d2de893abaa8702a9954000001a7-1504743430.942407-390765886 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e2b47d1288dc5e8f988e8dbbe0ebaf960bf9aeeef5ad0cc8075d740288ca8e8fe417d38cc9c1f1db11f4094cdc7b4ed55737d28a5fe49d7d088c72f79b5b841", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b5a58c01a31c7853b7821694a1d193f91747290ad58eebdbffc688bc447ad053b749a64afb62ab12880eaf0d1394156cfd3bfd7ed563eddd343a59eee77546cc", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/828d93827b3cf3d16be66cac49d71233cc27ccb8cefbb078869a782b7122ba55974ce36ded761ed5afc6d8cf1b9fc7d820c44b4362f9e38746ef0064ce041aa3", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aec60665e9a5a50b9a3209326c7d81eb30316d7579ecfd0319e6d5f7085935be96668b201aace238cc011dfababb0fb4afcc7723a3a78d06eadca0db927a214f"} build_url:https://queue.taskcluster.net/v1/task/UKt4CYvxSaGZCXqv81saJw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011652 build_url: 'https://queue.taskcluster.net/v1/task/UKt4CYvxSaGZCXqv81saJw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e2b47d1288dc5e8f988e8dbbe0ebaf960bf9aeeef5ad0cc8075d740288ca8e8fe417d38cc9c1f1db11f4094cdc7b4ed55737d28a5fe49d7d088c72f79b5b841", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b5a58c01a31c7853b7821694a1d193f91747290ad58eebdbffc688bc447ad053b749a64afb62ab12880eaf0d1394156cfd3bfd7ed563eddd343a59eee77546cc", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/828d93827b3cf3d16be66cac49d71233cc27ccb8cefbb078869a782b7122ba55974ce36ded761ed5afc6d8cf1b9fc7d820c44b4362f9e38746ef0064ce041aa3", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aec60665e9a5a50b9a3209326c7d81eb30316d7579ecfd0319e6d5f7085935be96668b201aace238cc011dfababb0fb4afcc7723a3a78d06eadca0db927a214f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-06 17:38:02.712039) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 17:38:02.712375) ========= 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=a0d2d2de893abaa8702a9954000001a7-1504743430.942407-390765886 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004634 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 17:38:02.797853) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-06 17:38:02.798196) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-06 17:38:02.798507) ========= ========= Total master_lag: 0.35 =========