builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-061 starttime: 1504746271.79 results: success (0) revision: d8e238b811d3dc74515065ae8cab6c74baf0295f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-06 18:04:31.793593) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-06 18:04:31.794016) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-06 18:04:31.794286) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-06 18:04:31.813007) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 18:04:31.813378) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1504746270.959390-84819962 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-06 18:04:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.1M=0s 2017-09-06 18:04:31 (50.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.128434 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 18:04:31.960416) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 18:04:31.960944) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1504746270.959390-84819962 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020061 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 18:04:32.011382) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 18:04:32.011712) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1504746270.959390-84819962 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-06 18:04:32,061 truncating revision to first 12 chars 2017-09-06 18:04:32,061 Setting DEBUG logging. 2017-09-06 18:04:32,061 attempt 1/10 2017-09-06 18:04:32,061 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 18:04:32,666 unpacking tar archive at: mozilla-central-d8e238b811d3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.917351 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 18:04:32.945177) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-06 18:04:32.945540) ========= script_repo_revision: d8e238b811d3dc74515065ae8cab6c74baf0295f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-06 18:04:32.945942) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-06 18:04:32.946237) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-06 18:04:32.958761) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-09-06 18:04:32.959213) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=516f8d7ca085b4d087ab0a71000001a4-1504746270.959390-84819962 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:04:33 INFO - MultiFileLogger online at 20170906 18:04:33 in /builds/slave/test 18:04:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:04:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:04:33 INFO - {'append_to_log': False, 18:04:33 INFO - 'base_work_dir': '/builds/slave/test', 18:04:33 INFO - 'blob_upload_branch': 'Firefox', 18:04:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:04:33 INFO - 'branch': 'Firefox', 18:04:33 INFO - 'buildbot_json_path': 'buildprops.json', 18:04:33 INFO - 'code_coverage': False, 18:04:33 INFO - 'config_files': ('talos/linux_config.py',), 18:04:33 INFO - 'default_actions': ('clobber', 18:04:33 INFO - 'read-buildbot-config', 18:04:33 INFO - 'download-and-extract', 18:04:33 INFO - 'populate-webroot', 18:04:33 INFO - 'create-virtualenv', 18:04:33 INFO - 'install', 18:04:33 INFO - 'setup-mitmproxy', 18:04:33 INFO - 'run-tests'), 18:04:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:04:33 INFO - 'disable_ccov_upload': False, 18:04:33 INFO - 'disable_stylo': False, 18:04:33 INFO - 'download_minidump_stackwalk': True, 18:04:33 INFO - 'download_symbols': 'ondemand', 18:04:33 INFO - 'enable_stylo': False, 18:04:33 INFO - 'enable_webrender': False, 18:04:33 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 18:04:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:04:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:04:33 INFO - 'gecko_profile': False, 18:04:33 INFO - 'gecko_profile_interval': 0, 18:04:33 INFO - 'installer_path': 'installer.exe', 18:04:33 INFO - 'log_level': 'info', 18:04:33 INFO - 'log_name': 'talos', 18:04:33 INFO - 'log_to_console': True, 18:04:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:04:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:04:33 INFO - 'opt_config_files': (), 18:04:33 INFO - 'pip_index': False, 18:04:33 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 18:04:33 INFO - 'system_bits': '32', 18:04:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:04:33 INFO - 'title': 'talos-linux64-ix-061', 18:04:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:04:33 INFO - 'use_talos_json': True, 18:04:33 INFO - 'verify': 'False', 18:04:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:04:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:04:33 INFO - 'work_dir': 'build'} 18:04:33 INFO - [mozharness: 2017-09-07 01:04:33.155177Z] Running clobber step. 18:04:33 INFO - Running pre-action listener: _resource_record_pre_action 18:04:33 INFO - Running main action method: clobber 18:04:33 INFO - rmtree: /builds/slave/test/build 18:04:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:04:34 INFO - Running post-action listener: _resource_record_post_action 18:04:34 INFO - [mozharness: 2017-09-07 01:04:34.273879Z] Finished clobber step (success) 18:04:34 INFO - [mozharness: 2017-09-07 01:04:34.273976Z] Running read-buildbot-config step. 18:04:34 INFO - Running pre-action listener: _resource_record_pre_action 18:04:34 INFO - Running main action method: read_buildbot_config 18:04:34 INFO - Using buildbot properties: 18:04:34 INFO - { 18:04:34 INFO - "project": "", 18:04:34 INFO - "product": "firefox", 18:04:34 INFO - "who": "kwierso@gmail.com", 18:04:34 INFO - "installer_path": "public/build/target.tar.bz2", 18:04:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 18:04:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 18:04:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 18:04:34 INFO - "stage_platform": "linux64-pgo", 18:04:34 INFO - "basedir": "/builds/slave/test", 18:04:34 INFO - "buildnumber": 1, 18:04:34 INFO - "platform": "ubuntu64_hw", 18:04:34 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:04:34 INFO - "slavebuilddir": "test", 18:04:34 INFO - "taskId": "a8YZiu81S8-hGRra-FIH8A", 18:04:34 INFO - "branch": "mozilla-central", 18:04:34 INFO - "script_repo_revision": "production", 18:04:34 INFO - "revision": "d8e238b811d3dc74515065ae8cab6c74baf0295f", 18:04:34 INFO - "slavename": "talos-linux64-ix-061", 18:04:34 INFO - "repo_path": "mozilla-central" 18:04:34 INFO - } 18:04:34 INFO - Finding installer, test and symbols from parent task. 18:04:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a8YZiu81S8-hGRra-FIH8A'}, attempt #1 18:04:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a8YZiu81S8-hGRra-FIH8A'}, attempt #1 18:04:35 INFO - Task dependencies: ccxe2CkMRWeKQ6akbP-iGA 18:04:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA'}, attempt #1 18:04:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.tar.bz2 18:04:35 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.test_packages.json 18:04:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.crashreporter-symbols.zip 18:04:35 INFO - Running post-action listener: _resource_record_post_action 18:04:35 INFO - [mozharness: 2017-09-07 01:04:35.737142Z] Finished read-buildbot-config step (success) 18:04:35 INFO - [mozharness: 2017-09-07 01:04:35.737370Z] Running download-and-extract step. 18:04:35 INFO - Running pre-action listener: _resource_record_pre_action 18:04:35 INFO - Running main action method: download_and_extract 18:04:35 INFO - mkdir: /builds/slave/test/build/tests 18:04:35 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')]} 18:04:35 INFO - trying https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.test_packages.json 18:04:35 INFO - Downloading https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:04:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:04:36 INFO - Downloaded 989 bytes. 18:04:36 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:04:36 INFO - Using the following test package requirements: 18:04:36 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:04:36 INFO - u'common': [u'target.common.tests.zip'], 18:04:36 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:04:36 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:04:36 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:04:36 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:04:36 INFO - u'mozbase': [u'target.common.tests.zip'], 18:04:36 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:04:36 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:04:36 INFO - u'web-platform': [u'target.common.tests.zip', 18:04:36 INFO - u'target.web-platform.tests.tar.gz'], 18:04:36 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:04:36 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:04:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.common.tests.zip 18:04:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:04:36 INFO - Fetch https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.common.tests.zip into memory 18:04:37 INFO - Content-Length response header: 55692002 18:04:37 INFO - Bytes received: 55692002 18:04:48 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:04:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.common.tests.zip 18:04:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:04:48 INFO - Fetch https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.common.tests.zip into memory 18:04:49 INFO - Content-Length response header: 55692002 18:04:49 INFO - Bytes received: 55692002 18:05:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.talos.tests.zip 18:05:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:05:01 INFO - Fetch https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.talos.tests.zip into memory 18:05:01 INFO - Content-Length response header: 14496665 18:05:01 INFO - Bytes received: 14496665 18:05: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')]} 18:05:02 INFO - trying https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.tar.bz2 18:05:02 INFO - Downloading https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:05:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:05:03 INFO - Downloaded 63485315 bytes. 18:05:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.tar.bz2 18:05:03 INFO - mkdir: /builds/slave/test/properties 18:05:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:05:03 INFO - Writing to file /builds/slave/test/properties/build_url 18:05:03 INFO - Contents: 18:05:03 INFO - build_url:https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.tar.bz2 18:05:03 INFO - Running post-action listener: _resource_record_post_action 18:05:03 INFO - Running post-action listener: find_tests_for_verification 18:05:03 INFO - Running post-action listener: set_extra_try_arguments 18:05:03 INFO - [mozharness: 2017-09-07 01:05:03.336114Z] Finished download-and-extract step (success) 18:05:03 INFO - [mozharness: 2017-09-07 01:05:03.336210Z] Running populate-webroot step. 18:05:03 INFO - Running pre-action listener: _resource_record_pre_action 18:05:03 INFO - Running main action method: populate_webroot 18:05:03 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:05:03 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:05:03 INFO - 'tests': ['tresize', 18:05:03 INFO - 'tcanvasmark']}, 18:05:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:05:03 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:05:03 INFO - 'tests': ['dromaeo_css', 18:05:03 INFO - 'kraken']}, 18:05:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:05:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:05:03 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:05:03 INFO - 'talos_options': ['--disable-stylo'], 18:05:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:05:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:05:03 INFO - 'tests': ['damp', 'tps']}, 18:05:03 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:05:03 INFO - 'talos_options': ['--disable-stylo'], 18:05:03 INFO - 'tests': ['damp', 'tps']}, 18:05:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:05:03 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:05:03 INFO - 'tests': ['dromaeo_dom']}, 18:05:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:05:03 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:05:03 INFO - 'tests': ['basic_compositor_video', 18:05:03 INFO - 'glvideo']}, 18:05:03 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:05:03 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:05:03 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:05:03 INFO - 'talos_options': ['--disable-stylo'], 18:05:03 INFO - 'tests': ['ts_paint_webext', 18:05:03 INFO - 'tp5o_webext']}, 18:05:03 INFO - 'other-e10s': {'tests': ['a11yr', 18:05:03 INFO - 'ts_paint', 18:05:03 INFO - 'tpaint', 18:05:03 INFO - 'sessionrestore', 18:05:03 INFO - 'sessionrestore_many_windows', 18:05:03 INFO - 'sessionrestore_no_auto_restore', 18:05:03 INFO - 'tabpaint']}, 18:05:03 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:05:03 INFO - 'tests': ['a11yr', 18:05:03 INFO - 'ts_paint', 18:05:03 INFO - 'tpaint', 18:05:03 INFO - 'sessionrestore', 18:05:03 INFO - 'sessionrestore_many_windows', 18:05:03 INFO - 'sessionrestore_no_auto_restore', 18:05:03 INFO - 'tabpaint']}, 18:05:03 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 18:05:03 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 18:05:03 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:05:03 INFO - 'tests': ['bloom_basic_singleton']}, 18:05:03 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:05:03 INFO - 'tests': ['bloom_basic']}, 18:05:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:05:03 INFO - 'tsvgr_opacity', 18:05:03 INFO - 'tart', 18:05:03 INFO - 'tscrollx', 18:05:03 INFO - 'tsvg_static']}, 18:05:03 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:05:03 INFO - 'tests': ['tsvgx', 18:05:03 INFO - 'tsvgr_opacity', 18:05:03 INFO - 'tart', 18:05:03 INFO - 'tscrollx', 18:05:03 INFO - 'tsvg_static']}, 18:05:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:05:03 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:05:03 INFO - 'talos_options': ['--disable-stylo'], 18:05:03 INFO - 'tests': ['tp5o']}, 18:05:03 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:05:03 INFO - 'talos_options': ['--mitmproxy', 18:05:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:05:03 INFO - '--firstNonBlankPaint'], 18:05:03 INFO - 'tests': ['tp6_google', 18:05:03 INFO - 'tp6_youtube', 18:05:03 INFO - 'tp6_amazon', 18:05:03 INFO - 'tp6_facebook']}, 18:05:03 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:05:03 INFO - 'talos_options': ['--disable-stylo', 18:05:03 INFO - '--mitmproxy', 18:05:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:05:03 INFO - '--firstNonBlankPaint'], 18:05:03 INFO - 'tests': ['tp6_google', 18:05:03 INFO - 'tp6_youtube', 18:05:03 INFO - 'tp6_amazon', 18:05:03 INFO - 'tp6_facebook']}, 18:05:03 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:05:03 INFO - 'talos_options': ['--stylo-threads=1', 18:05:03 INFO - '--mitmproxy', 18:05:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:05:03 INFO - '--firstNonBlankPaint'], 18:05:03 INFO - 'tests': ['tp6_google', 18:05:03 INFO - 'tp6_youtube', 18:05:03 INFO - 'tp6_amazon', 18:05:03 INFO - 'tp6_facebook']}, 18:05:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:05:03 INFO - 'talos_options': ['--xperf_path', 18:05:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:05:03 INFO - 'tests': ['tp5n']}, 18:05:03 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:05:03 INFO - 'talos_options': ['--disable-stylo', 18:05:03 INFO - '--xperf_path', 18:05:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:05:03 INFO - 'tests': ['tp5n']}}} 18:05:03 INFO - Running post-action listener: _resource_record_post_action 18:05:03 INFO - [mozharness: 2017-09-07 01:05:03.351050Z] Finished populate-webroot step (success) 18:05:03 INFO - [mozharness: 2017-09-07 01:05:03.351139Z] Running create-virtualenv step. 18:05:03 INFO - Running pre-action listener: _resource_record_pre_action 18:05:03 INFO - Running main action method: create_virtualenv 18:05:03 INFO - Creating virtualenv /builds/slave/test/build/venv 18:05:03 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:05:03 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 18:05:03 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:05:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:05:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:05:03 INFO - Installing distribute.............................................................................................................................................................................................done. 18:05:04 INFO - Installing pip...............done. 18:05:04 INFO - Return code: 0 18:05:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:05:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:05:04 INFO - Reading from file tmpfile_stdout 18:05:04 INFO - Output received: 18:05:04 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 18:05:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:05:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:05:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff4090>, '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 0xff4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfeef90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1504746270.959390-84819962', '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 18:05:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:05:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:05:04 INFO - Using env: {'DISPLAY': ':0', 18:05:04 INFO - 'HOME': '/home/cltbld', 18:05:04 INFO - 'LANG': 'en_US.UTF-8', 18:05:04 INFO - 'LANGUAGE': 'en_US:en', 18:05:04 INFO - 'LOGNAME': 'cltbld', 18:05:04 INFO - 'MAIL': '/var/mail/cltbld', 18:05:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:04 INFO - 'MOZ_NO_REMOTE': '1', 18:05:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:05:04 INFO - 'NO_EM_RESTART': '1', 18:05:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:05:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:04 INFO - 'PWD': '/builds/slave/test', 18:05:04 INFO - 'SHELL': '/bin/bash', 18:05:04 INFO - 'SHLVL': '1', 18:05:04 INFO - 'TERM': 'linux', 18:05:04 INFO - 'TMOUT': '86400', 18:05:04 INFO - 'USER': 'cltbld', 18:05:04 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504746270.959390-84819962', 18:05:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:04 INFO - '_': '/tools/buildbot/bin/python'} 18:05:05 INFO - Ignoring indexes: http://pypi.python.org/simple/ 18:05:05 INFO - Downloading/unpacking pip>=1.5 18:05:05 INFO - Running setup.py egg_info for package pip 18:05:05 INFO - warning: no files found matching 'pip/cacert.pem' 18:05:05 INFO - warning: no files found matching '*.html' under directory 'docs' 18:05:05 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 18:05:05 INFO - no previously-included directories found matching 'docs/_build/_sources' 18:05:05 INFO - Installing collected packages: pip 18:05:05 INFO - Found existing installation: pip 1.1 18:05:05 INFO - Uninstalling pip: 18:05:05 INFO - Successfully uninstalled pip 18:05:05 INFO - Running setup.py install for pip 18:05:05 INFO - warning: no files found matching 'pip/cacert.pem' 18:05:05 INFO - warning: no files found matching '*.html' under directory 'docs' 18:05:05 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 18:05:05 INFO - no previously-included directories found matching 'docs/_build/_sources' 18:05:05 INFO - Installing pip script to /builds/slave/test/build/venv/bin 18:05:05 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 18:05:05 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 18:05:05 INFO - Successfully installed pip 18:05:05 INFO - Cleaning up... 18:05:05 INFO - Return code: 0 18:05:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:05:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xc841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff4090>, '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 0xff4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfeef90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1504746270.959390-84819962', '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 18:05:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:05:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:05:05 INFO - Using env: {'DISPLAY': ':0', 18:05:05 INFO - 'HOME': '/home/cltbld', 18:05:05 INFO - 'LANG': 'en_US.UTF-8', 18:05:05 INFO - 'LANGUAGE': 'en_US:en', 18:05:05 INFO - 'LOGNAME': 'cltbld', 18:05:05 INFO - 'MAIL': '/var/mail/cltbld', 18:05:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:05 INFO - 'MOZ_NO_REMOTE': '1', 18:05:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:05:05 INFO - 'NO_EM_RESTART': '1', 18:05:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:05:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:05 INFO - 'PWD': '/builds/slave/test', 18:05:05 INFO - 'SHELL': '/bin/bash', 18:05:05 INFO - 'SHLVL': '1', 18:05:05 INFO - 'TERM': 'linux', 18:05:05 INFO - 'TMOUT': '86400', 18:05:05 INFO - 'USER': 'cltbld', 18:05:05 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504746270.959390-84819962', 18:05:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:05 INFO - '_': '/tools/buildbot/bin/python'} 18:05:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:05 INFO - Downloading/unpacking psutil>=3.1.1 18:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:05:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:05:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:05:06 INFO - Installing collected packages: psutil 18:05:06 INFO - Running setup.py install for psutil 18:05:07 INFO - building 'psutil._psutil_linux' extension 18:05:07 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 18:05:07 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 18:05:07 INFO - building 'psutil._psutil_posix' extension 18:05:07 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 18:05:07 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 18:05:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:05:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:05:07 INFO - Successfully installed psutil 18:05:07 INFO - Cleaning up... 18:05:07 INFO - Return code: 0 18:05:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:05:07 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')]} 18:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:07 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')]} 18:05:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:07 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 0xc841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff4090>, '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 0xff4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfeef90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1504746270.959390-84819962', '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 18:05:07 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 18:05:07 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 18:05:07 INFO - Using env: {'DISPLAY': ':0', 18:05:07 INFO - 'HOME': '/home/cltbld', 18:05:07 INFO - 'LANG': 'en_US.UTF-8', 18:05:07 INFO - 'LANGUAGE': 'en_US:en', 18:05:07 INFO - 'LOGNAME': 'cltbld', 18:05:07 INFO - 'MAIL': '/var/mail/cltbld', 18:05:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:07 INFO - 'MOZ_NO_REMOTE': '1', 18:05:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:05:07 INFO - 'NO_EM_RESTART': '1', 18:05:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:05:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:07 INFO - 'PWD': '/builds/slave/test', 18:05:07 INFO - 'SHELL': '/bin/bash', 18:05:07 INFO - 'SHLVL': '1', 18:05:07 INFO - 'TERM': 'linux', 18:05:07 INFO - 'TMOUT': '86400', 18:05:07 INFO - 'USER': 'cltbld', 18:05:07 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504746270.959390-84819962', 18:05:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:07 INFO - '_': '/tools/buildbot/bin/python'} 18:05:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:05:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:05:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:05:08 INFO - Installing collected packages: mozsystemmonitor 18:05:08 INFO - Running setup.py install for mozsystemmonitor 18:05:08 INFO - Successfully installed mozsystemmonitor 18:05:08 INFO - Cleaning up... 18:05:09 INFO - Return code: 0 18:05:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:05:09 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')]} 18:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:09 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')]} 18:05:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:09 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 0xc841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff4090>, '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 0xff4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfeef90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1504746270.959390-84819962', '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 18:05:09 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 18:05:09 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 18:05:09 INFO - Using env: {'DISPLAY': ':0', 18:05:09 INFO - 'HOME': '/home/cltbld', 18:05:09 INFO - 'LANG': 'en_US.UTF-8', 18:05:09 INFO - 'LANGUAGE': 'en_US:en', 18:05:09 INFO - 'LOGNAME': 'cltbld', 18:05:09 INFO - 'MAIL': '/var/mail/cltbld', 18:05:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:09 INFO - 'MOZ_NO_REMOTE': '1', 18:05:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:05:09 INFO - 'NO_EM_RESTART': '1', 18:05:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:05:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:09 INFO - 'PWD': '/builds/slave/test', 18:05:09 INFO - 'SHELL': '/bin/bash', 18:05:09 INFO - 'SHLVL': '1', 18:05:09 INFO - 'TERM': 'linux', 18:05:09 INFO - 'TMOUT': '86400', 18:05:09 INFO - 'USER': 'cltbld', 18:05:09 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504746270.959390-84819962', 18:05:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:09 INFO - '_': '/tools/buildbot/bin/python'} 18:05:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:09 INFO - Downloading/unpacking jsonschema==2.5.1 18:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:05:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:05:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:10 INFO - Downloading functools32-3.2.3-2.tar.gz 18:05:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:05:10 INFO - warning: no files found matching '*.txt' 18:05:10 INFO - no previously-included directories found matching 'build' 18:05:10 INFO - no previously-included directories found matching 'dist' 18:05:10 INFO - no previously-included directories found matching '.git*' 18:05:10 INFO - Installing collected packages: jsonschema, functools32 18:05:10 INFO - Running setup.py install for functools32 18:05:10 INFO - warning: no files found matching '*.txt' 18:05:10 INFO - no previously-included directories found matching 'build' 18:05:10 INFO - no previously-included directories found matching 'dist' 18:05:10 INFO - no previously-included directories found matching '.git*' 18:05:10 INFO - Successfully installed jsonschema functools32 18:05:10 INFO - Cleaning up... 18:05:10 INFO - Return code: 0 18:05:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:05:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:05:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:05:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff4090>, '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 0xff4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfeef90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1504746270.959390-84819962', '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 18:05:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:05:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:05:10 INFO - Using env: {'DISPLAY': ':0', 18:05:10 INFO - 'HOME': '/home/cltbld', 18:05:10 INFO - 'LANG': 'en_US.UTF-8', 18:05:10 INFO - 'LANGUAGE': 'en_US:en', 18:05:10 INFO - 'LOGNAME': 'cltbld', 18:05:10 INFO - 'MAIL': '/var/mail/cltbld', 18:05:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:10 INFO - 'MOZ_NO_REMOTE': '1', 18:05:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:05:10 INFO - 'NO_EM_RESTART': '1', 18:05:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:05:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:10 INFO - 'PWD': '/builds/slave/test', 18:05:10 INFO - 'SHELL': '/bin/bash', 18:05:10 INFO - 'SHLVL': '1', 18:05:10 INFO - 'TERM': 'linux', 18:05:10 INFO - 'TMOUT': '86400', 18:05:10 INFO - 'USER': 'cltbld', 18:05:10 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504746270.959390-84819962', 18:05:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:10 INFO - '_': '/tools/buildbot/bin/python'} 18:05:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:05:10 INFO - Cleaning up... 18:05:10 INFO - Return code: 0 18:05:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:05:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:05:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:05:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff4090>, '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 0xff4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfeef90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1504746270.959390-84819962', '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 18:05:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:05:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:05:10 INFO - Using env: {'DISPLAY': ':0', 18:05:10 INFO - 'HOME': '/home/cltbld', 18:05:10 INFO - 'LANG': 'en_US.UTF-8', 18:05:10 INFO - 'LANGUAGE': 'en_US:en', 18:05:10 INFO - 'LOGNAME': 'cltbld', 18:05:10 INFO - 'MAIL': '/var/mail/cltbld', 18:05:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:10 INFO - 'MOZ_NO_REMOTE': '1', 18:05:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:05:10 INFO - 'NO_EM_RESTART': '1', 18:05:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:05:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:10 INFO - 'PWD': '/builds/slave/test', 18:05:10 INFO - 'SHELL': '/bin/bash', 18:05:10 INFO - 'SHLVL': '1', 18:05:10 INFO - 'TERM': 'linux', 18:05:10 INFO - 'TMOUT': '86400', 18:05:10 INFO - 'USER': 'cltbld', 18:05:10 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504746270.959390-84819962', 18:05:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:10 INFO - '_': '/tools/buildbot/bin/python'} 18:05:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:11 INFO - Downloading/unpacking blobuploader==1.2.4 18:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:12 INFO - Downloading blobuploader-1.2.4.tar.gz 18:05:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:05:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:05:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:12 INFO - Downloading docopt-0.6.1.tar.gz 18:05:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:05:12 INFO - Installing collected packages: blobuploader, requests, docopt 18:05:12 INFO - Running setup.py install for blobuploader 18:05:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:05:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:05:12 INFO - Running setup.py install for requests 18:05:13 INFO - Running setup.py install for docopt 18:05:13 INFO - Successfully installed blobuploader requests docopt 18:05:13 INFO - Cleaning up... 18:05:13 INFO - Return code: 0 18:05:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:05:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:05:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff4090>, '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 0xff4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfeef90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1504746270.959390-84819962', '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 18:05:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:05:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:05:13 INFO - Using env: {'DISPLAY': ':0', 18:05:13 INFO - 'HOME': '/home/cltbld', 18:05:13 INFO - 'LANG': 'en_US.UTF-8', 18:05:13 INFO - 'LANGUAGE': 'en_US:en', 18:05:13 INFO - 'LOGNAME': 'cltbld', 18:05:13 INFO - 'MAIL': '/var/mail/cltbld', 18:05:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:13 INFO - 'MOZ_NO_REMOTE': '1', 18:05:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:05:13 INFO - 'NO_EM_RESTART': '1', 18:05:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:05:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:13 INFO - 'PWD': '/builds/slave/test', 18:05:13 INFO - 'SHELL': '/bin/bash', 18:05:13 INFO - 'SHLVL': '1', 18:05:13 INFO - 'TERM': 'linux', 18:05:13 INFO - 'TMOUT': '86400', 18:05:13 INFO - 'USER': 'cltbld', 18:05:13 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504746270.959390-84819962', 18:05:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:13 INFO - '_': '/tools/buildbot/bin/python'} 18:05:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:05:13 INFO - Running setup.py (path:/tmp/pip-Fg6i0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:05:13 INFO - Running setup.py (path:/tmp/pip-LcaU5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:05:13 INFO - Running setup.py (path:/tmp/pip-6cQ4yD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:05:13 INFO - Running setup.py (path:/tmp/pip-t5VtsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:05:13 INFO - Running setup.py (path:/tmp/pip-7q6xNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:05:13 INFO - Running setup.py (path:/tmp/pip-hI2toE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:05:14 INFO - Running setup.py (path:/tmp/pip-pYS1CT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:05:14 INFO - Running setup.py (path:/tmp/pip-bCtvUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:05:14 INFO - Running setup.py (path:/tmp/pip-233gid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:05:14 INFO - Running setup.py (path:/tmp/pip-Tjvmnc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:05:14 INFO - Running setup.py (path:/tmp/pip-h7_OYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:05:14 INFO - Running setup.py (path:/tmp/pip-UIgqqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:05:14 INFO - Running setup.py (path:/tmp/pip-D7QOGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:05:14 INFO - Running setup.py (path:/tmp/pip-Fe7hGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:05:14 INFO - Running setup.py (path:/tmp/pip-z3Sped-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:05:14 INFO - Running setup.py (path:/tmp/pip-sBwvWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:05:14 INFO - Running setup.py (path:/tmp/pip-SytVTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:05:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:05:14 INFO - Running setup.py install for manifestparser 18:05:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:05:14 INFO - Running setup.py install for mozcrash 18:05:15 INFO - Running setup.py install for mozdebug 18:05:15 INFO - Running setup.py install for mozdevice 18:05:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:05:15 INFO - Running setup.py install for mozfile 18:05:15 INFO - Running setup.py install for mozhttpd 18:05:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:05:15 INFO - Running setup.py install for mozinfo 18:05:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:05:15 INFO - Running setup.py install for mozInstall 18:05:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:05:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:05:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:05:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:05:15 INFO - Running setup.py install for mozleak 18:05:15 INFO - Running setup.py install for mozlog 18:05:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:05:15 INFO - Running setup.py install for moznetwork 18:05:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:05:15 INFO - Running setup.py install for mozprocess 18:05:16 INFO - Running setup.py install for mozprofile 18:05:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:05:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:05:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:05:16 INFO - Running setup.py install for mozrunner 18:05:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:05:16 INFO - Running setup.py install for mozscreenshot 18:05:16 INFO - Running setup.py install for moztest 18:05:16 INFO - Running setup.py install for mozversion 18:05:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:05:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:05:16 INFO - Cleaning up... 18:05:16 INFO - Return code: 0 18:05:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:05: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')]} 18:05:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05: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')]} 18:05:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff4090>, '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 0xff4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfeef90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1504746270.959390-84819962', '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 18:05:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:05:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:05:16 INFO - Using env: {'DISPLAY': ':0', 18:05:16 INFO - 'HOME': '/home/cltbld', 18:05:16 INFO - 'LANG': 'en_US.UTF-8', 18:05:16 INFO - 'LANGUAGE': 'en_US:en', 18:05:16 INFO - 'LOGNAME': 'cltbld', 18:05:16 INFO - 'MAIL': '/var/mail/cltbld', 18:05:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:16 INFO - 'MOZ_NO_REMOTE': '1', 18:05:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:05:16 INFO - 'NO_EM_RESTART': '1', 18:05:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:05:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:16 INFO - 'PWD': '/builds/slave/test', 18:05:16 INFO - 'SHELL': '/bin/bash', 18:05:16 INFO - 'SHLVL': '1', 18:05:16 INFO - 'TERM': 'linux', 18:05:16 INFO - 'TMOUT': '86400', 18:05:16 INFO - 'USER': 'cltbld', 18:05:16 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504746270.959390-84819962', 18:05:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:16 INFO - '_': '/tools/buildbot/bin/python'} 18:05:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:05:16 INFO - Running setup.py (path:/tmp/pip-HZVVuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:05:16 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:05:16 INFO - Running setup.py (path:/tmp/pip-F8TQFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:05:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:05:16 INFO - Running setup.py (path:/tmp/pip-43t3_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:05:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:05:17 INFO - Running setup.py (path:/tmp/pip-ed6Uor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:05:17 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)) 18:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:05:17 INFO - Running setup.py (path:/tmp/pip-F1nZyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:05:17 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)) 18:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:05:17 INFO - Running setup.py (path:/tmp/pip-Lwc6AA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:05:17 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)) 18:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:05:17 INFO - Running setup.py (path:/tmp/pip-qQyovS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:05:17 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)) 18:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:05:17 INFO - Running setup.py (path:/tmp/pip-fe9v6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:05:17 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)) 18:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:05:17 INFO - Running setup.py (path:/tmp/pip-NmD3jh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:05:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:05:17 INFO - Running setup.py (path:/tmp/pip-9YcY3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:05:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:05:17 INFO - Running setup.py (path:/tmp/pip-mqstEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:05:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:05:17 INFO - Running setup.py (path:/tmp/pip-sPvzbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:05:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:05:17 INFO - Running setup.py (path:/tmp/pip-zFem09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:05:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:05:17 INFO - Running setup.py (path:/tmp/pip-I48bTn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:05:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:05:17 INFO - Running setup.py (path:/tmp/pip-QkCj8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:05:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:05:17 INFO - Running setup.py (path:/tmp/pip-Er4t0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:05:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:05:17 INFO - Running setup.py (path:/tmp/pip-bcr1Uc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:05:18 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)) 18:05:18 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)) 18:05:18 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)) 18:05:18 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)) 18:05:18 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)) 18:05:18 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)) 18:05:18 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)) 18:05:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:05:18 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 18:05:18 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 18:05:18 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 18:05:18 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 18:05:19 INFO - Downloading blessings-1.6.tar.gz 18:05:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:05:19 INFO - Installing collected packages: blessings 18:05:19 INFO - Running setup.py install for blessings 18:05:19 INFO - Successfully installed blessings 18:05:19 INFO - Cleaning up... 18:05:19 INFO - Return code: 0 18:05:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:05:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:05:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:05:19 INFO - Reading from file tmpfile_stdout 18:05:19 INFO - Current package versions: 18:05:19 INFO - argparse == 1.2.1 18:05:19 INFO - blessings == 1.6 18:05:19 INFO - blobuploader == 1.2.4 18:05:19 INFO - docopt == 0.6.1 18:05:19 INFO - functools32 == 3.2.3-2 18:05:19 INFO - jsonschema == 2.5.1 18:05:19 INFO - manifestparser == 1.1 18:05:19 INFO - mozInstall == 1.13 18:05:19 INFO - mozcrash == 1.0 18:05:19 INFO - mozdebug == 0.1 18:05:19 INFO - mozdevice == 0.51 18:05:19 INFO - mozfile == 1.2 18:05:19 INFO - mozhttpd == 0.7 18:05:19 INFO - mozinfo == 0.10 18:05:19 INFO - mozleak == 0.1 18:05:19 INFO - mozlog == 3.5 18:05:19 INFO - moznetwork == 0.27 18:05:19 INFO - mozprocess == 0.25 18:05:19 INFO - mozprofile == 0.28 18:05:19 INFO - mozrunner == 6.13 18:05:19 INFO - mozscreenshot == 0.1 18:05:19 INFO - mozsystemmonitor == 0.3 18:05:19 INFO - moztest == 0.8 18:05:19 INFO - mozversion == 1.4 18:05:19 INFO - psutil == 3.1.1 18:05:19 INFO - requests == 1.2.3 18:05:19 INFO - wsgiref == 0.1.2 18:05:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:05: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')]} 18:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05: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')]} 18:05:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff4090>, '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 0xff4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfeef90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1504746270.959390-84819962', '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 18:05:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:05:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:05:19 INFO - Using env: {'DISPLAY': ':0', 18:05:19 INFO - 'HOME': '/home/cltbld', 18:05:19 INFO - 'LANG': 'en_US.UTF-8', 18:05:19 INFO - 'LANGUAGE': 'en_US:en', 18:05:19 INFO - 'LOGNAME': 'cltbld', 18:05:19 INFO - 'MAIL': '/var/mail/cltbld', 18:05:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:19 INFO - 'MOZ_NO_REMOTE': '1', 18:05:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:05:19 INFO - 'NO_EM_RESTART': '1', 18:05:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:05:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:19 INFO - 'PWD': '/builds/slave/test', 18:05:19 INFO - 'SHELL': '/bin/bash', 18:05:19 INFO - 'SHLVL': '1', 18:05:19 INFO - 'TERM': 'linux', 18:05:19 INFO - 'TMOUT': '86400', 18:05:19 INFO - 'USER': 'cltbld', 18:05:19 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504746270.959390-84819962', 18:05:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:19 INFO - '_': '/tools/buildbot/bin/python'} 18:05:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:05:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:05:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:05:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:05:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:05:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:05:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:05:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:05:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:05:19 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 18:05:21 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)) 18:05:21 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)) 18:05:21 INFO - Installing collected packages: simplejson 18:05:21 INFO - Running setup.py install for simplejson 18:05:21 INFO - building 'simplejson._speedups' extension 18:05:21 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 18:05:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 18:05:22 INFO - Successfully installed simplejson 18:05:22 INFO - Cleaning up... 18:05:22 INFO - Return code: 0 18:05:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:05:22 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')]} 18:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:22 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')]} 18:05:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:22 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 0xc841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff4090>, '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 0xff4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfeef90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1504746270.959390-84819962', '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 18:05:22 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 18:05:22 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 18:05:22 INFO - Using env: {'DISPLAY': ':0', 18:05:22 INFO - 'HOME': '/home/cltbld', 18:05:22 INFO - 'LANG': 'en_US.UTF-8', 18:05:22 INFO - 'LANGUAGE': 'en_US:en', 18:05:22 INFO - 'LOGNAME': 'cltbld', 18:05:22 INFO - 'MAIL': '/var/mail/cltbld', 18:05:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:22 INFO - 'MOZ_NO_REMOTE': '1', 18:05:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:05:22 INFO - 'NO_EM_RESTART': '1', 18:05:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:05:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:22 INFO - 'PWD': '/builds/slave/test', 18:05:22 INFO - 'SHELL': '/bin/bash', 18:05:22 INFO - 'SHLVL': '1', 18:05:22 INFO - 'TERM': 'linux', 18:05:22 INFO - 'TMOUT': '86400', 18:05:22 INFO - 'USER': 'cltbld', 18:05:22 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504746270.959390-84819962', 18:05:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:22 INFO - '_': '/tools/buildbot/bin/python'} 18:05:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:05:22 INFO - Cleaning up... 18:05:22 INFO - Return code: 0 18:05:22 INFO - Running post-action listener: _resource_record_post_action 18:05:22 INFO - Running post-action listener: _start_resource_monitoring 18:05:22 INFO - Starting resource monitoring. 18:05:22 INFO - [mozharness: 2017-09-07 01:05:22.307923Z] Finished create-virtualenv step (success) 18:05:22 INFO - [mozharness: 2017-09-07 01:05:22.308444Z] Running install step. 18:05:22 INFO - Running pre-action listener: _resource_record_pre_action 18:05:22 INFO - Running main action method: install 18:05:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:05:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:05:22 INFO - Reading from file tmpfile_stdout 18:05:22 INFO - Detecting whether we're running mozinstall >=1.0... 18:05:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:05:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:05:22 INFO - Reading from file tmpfile_stdout 18:05:22 INFO - Output received: 18:05:22 INFO - Usage: mozinstall [options] installer 18:05:22 INFO - Options: 18:05:22 INFO - -h, --help show this help message and exit 18:05:22 INFO - -d DEST, --destination=DEST 18:05:22 INFO - Directory to install application into. [default: 18:05:22 INFO - "/builds/slave/test"] 18:05:22 INFO - --app=APP Application being installed. [default: firefox] 18:05:22 INFO - mkdir: /builds/slave/test/build/application 18:05:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:05:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:05:39 INFO - Reading from file tmpfile_stdout 18:05:39 INFO - Output received: 18:05:39 INFO - /builds/slave/test/build/application/firefox/firefox 18:05:39 INFO - Running post-action listener: _resource_record_post_action 18:05:39 INFO - [mozharness: 2017-09-07 01:05:39.008644Z] Finished install step (success) 18:05:39 INFO - [mozharness: 2017-09-07 01:05:39.008861Z] Running setup-mitmproxy step. 18:05:39 INFO - Running pre-action listener: _resource_record_pre_action 18:05:39 INFO - Running main action method: setup_mitmproxy 18:05:39 INFO - Skipping: mitmproxy is not required 18:05:39 INFO - Running post-action listener: _resource_record_post_action 18:05:39 INFO - [mozharness: 2017-09-07 01:05:39.009735Z] Finished setup-mitmproxy step (success) 18:05:39 INFO - [mozharness: 2017-09-07 01:05:39.009950Z] Running run-tests step. 18:05:39 INFO - Running pre-action listener: _resource_record_pre_action 18:05:39 INFO - Running pre-action listener: _set_gcov_prefix 18:05:39 INFO - Running main action method: run_tests 18:05:39 WARNING - Try message not found. 18:05:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:05:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:05:39 INFO - Python 2.7.3 18:05:39 INFO - Return code: 0 18:05:39 INFO - grabbing minidump binary from tooltool 18:05:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:05:39 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 0xff4090>, '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 0xff4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfeef90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:05:39 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 18:05:39 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 18:05:39 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 18:05:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:05:39 INFO - Return code: 0 18:05:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:05:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:05:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:05:39 INFO - ENV: RUST_BACKTRACE is now full 18:05:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:05:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:05:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 18:05:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 18:05:39 INFO - Using env: {'DISPLAY': ':0', 18:05:39 INFO - 'HOME': '/home/cltbld', 18:05:39 INFO - 'LANG': 'en_US.UTF-8', 18:05:39 INFO - 'LANGUAGE': 'en_US:en', 18:05:39 INFO - 'LOGNAME': 'cltbld', 18:05:39 INFO - 'MAIL': '/var/mail/cltbld', 18:05:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:05:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:05:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:39 INFO - 'MOZ_NO_REMOTE': '1', 18:05:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:05:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:05:39 INFO - 'NO_EM_RESTART': '1', 18:05:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:05:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:39 INFO - 'PWD': '/builds/slave/test', 18:05:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:05:39 INFO - 'RUST_BACKTRACE': 'full', 18:05:39 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:05:39 INFO - 'SHELL': '/bin/bash', 18:05:39 INFO - 'SHLVL': '1', 18:05:39 INFO - 'TERM': 'linux', 18:05:39 INFO - 'TMOUT': '86400', 18:05:39 INFO - 'USER': 'cltbld', 18:05:39 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504746270.959390-84819962', 18:05:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:39 INFO - '_': '/tools/buildbot/bin/python'} 18:05:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 18:05:39 INFO - mozversion application_buildid: 20170906225137 18:05:39 INFO - mozversion application_changeset: d8e238b811d3dc74515065ae8cab6c74baf0295f 18:05:39 INFO - mozversion application_display_name: Nightly 18:05:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:05:39 INFO - mozversion application_name: Firefox 18:05:39 INFO - mozversion application_remotingname: firefox 18:05:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:05:39 INFO - mozversion application_vendor: Mozilla 18:05:39 INFO - mozversion application_version: 57.0a1 18:05:39 INFO - mozversion platform_buildid: 20170906225137 18:05:39 INFO - mozversion platform_changeset: d8e238b811d3dc74515065ae8cab6c74baf0295f 18:05:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:05:39 INFO - mozversion platform_version: 57.0a1 18:05:39 INFO - using testdate: 1504746339 18:05:39 INFO - actual date: 1504746339 18:05:39 INFO - starting webserver on 'localhost:56417' 18:05:39 INFO - SUITE-START | Running 2 tests 18:05:39 INFO - TEST-START | dromaeo_css 18:05:39 INFO - Initialising browser for dromaeo_css test... 18:05:39 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56417/getInfo.html -profile /tmp/tmpsxPGYH/profile 18:05:39 INFO - TEST-INFO | started process 11053 (/builds/slave/test/build/application/firefox/firefox http://localhost:56417/getInfo.html) 18:05:45 INFO - TEST-INFO | 11053: exit 0 18:05:45 INFO - Browser initialized. 18:05:45 INFO - Running cycle 1/1 for dromaeo_css test... 18:05:45 INFO - Using env: {'DISPLAY': ':0', 18:05:45 INFO - 'HOME': '/home/cltbld', 18:05:45 INFO - 'JSGC_DISABLE_POISONING': '1', 18:05:45 INFO - 'LANG': 'en_US.UTF-8', 18:05:45 INFO - 'LANGUAGE': 'en_US:en', 18:05:45 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 18:05:45 INFO - 'LOGNAME': 'cltbld', 18:05:45 INFO - 'MAIL': '/var/mail/cltbld', 18:05:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:05:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:05:45 INFO - 'MOZ_CRASHREPORTER': '1', 18:05:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:45 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 18:05:45 INFO - 'MOZ_NO_REMOTE': '1', 18:05:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:05:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:05:45 INFO - 'NO_EM_RESTART': '1', 18:05:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:05:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:45 INFO - 'PWD': '/builds/slave/test', 18:05:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:05:45 INFO - 'RUST_BACKTRACE': 'full', 18:05:45 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:05:45 INFO - 'SHELL': '/bin/bash', 18:05:45 INFO - 'SHLVL': '1', 18:05:45 INFO - 'STYLO_FORCE_DISABLED': '1', 18:05:45 INFO - 'TERM': 'linux', 18:05:45 INFO - 'TMOUT': '86400', 18:05:45 INFO - 'USER': 'cltbld', 18:05:45 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504746270.959390-84819962', 18:05:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:45 INFO - '_': '/tools/buildbot/bin/python'} 18:05:45 INFO - TEST-INFO | started process 11257 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsxPGYH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:05:46 INFO - PID 11257 | 18:05:46 INFO - PID 11257 | (/builds/slave/test/build/application/firefox/firefox:11310): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:05:46 INFO - PID 11257 | 18:05:56 INFO - PID 11257 | RSS: Main: 161644544 18:05:56 INFO - PID 11257 | 18:08:51 INFO - PID 11257 | Cycle 1(1): loaded http://localhost:56417/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56417/tests/dromaeo/cssquery-ext.html) 18:08:53 INFO - PID 11257 | RSS: Main: 166211584 18:08:53 INFO - PID 11257 | 18:11:55 INFO - PID 11257 | Cycle 1(1): loaded http://localhost:56417/tests/dromaeo/cssquery-ext.html (next: http://localhost:56417/tests/dromaeo/cssquery-jquery.html) 18:11:55 INFO - PID 11257 | RSS: Main: 162795520 18:11:55 INFO - PID 11257 | 18:14:57 INFO - PID 11257 | Cycle 1(1): loaded http://localhost:56417/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56417/tests/dromaeo/cssquery-mootools.html) 18:14:57 INFO - PID 11257 | RSS: Main: 164909056 18:14:57 INFO - PID 11257 | 18:17:59 INFO - PID 11257 | Cycle 1(1): loaded http://localhost:56417/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56417/tests/dromaeo/cssquery-prototype.html) 18:18:00 INFO - PID 11257 | RSS: Main: 163487744 18:18:00 INFO - PID 11257 | 18:21:03 INFO - PID 11257 | Cycle 1(1): loaded http://localhost:56417/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56417/tests/dromaeo/cssquery-yui.html) 18:21:03 INFO - PID 11257 | RSS: Main: 164777984 18:21:03 INFO - PID 11257 | 18:24:05 INFO - PID 11257 | Cycle 1(1): loaded http://localhost:56417/tests/dromaeo/cssquery-yui.html (next: http://localhost:56417/tests/dromaeo/cssquery-dojo.html) 18:24:05 INFO - PID 11257 | RSS: Main: 167432192 18:24:05 INFO - PID 11257 | 18:24:05 INFO - PID 11257 | __start_tp_report 18:24:05 INFO - PID 11257 | _x_x_mozilla_page_load 18:24:05 INFO - PID 11257 | _x_x_mozilla_page_load_details 18:24:05 INFO - PID 11257 | |i|pagename|runs| 18:24:05 INFO - PID 11257 | |0;dojo.html;3833.1183827719624;3890.5720370759227;3899.629535194157;3903.1803321302527;3936.2324346752393;6278.215223097113;6320.051992201172;6387.457066149372;6397.584157029795;6438.806835794928;6301.810945671626;6425.453836423898;6427.2287325521;6436.581622194566;6477;5669.177969194464;5742.655440673562;5756.510696590794;5776.566757493184;5781.913271300913;5791.884162316772;5806.361300256968;5817.62185457946;5857.824265272048;5862.179294898718;54.48699091116059;5724.427557244284;5770.9422905770825;5868.618539794921;5870.471657550819;5726.885462290773;5735.512481439041;5748.310202775694;5796.391378905197;5802.680852553108;5736;5751.367349591584;5816.796412125555;5819.301683797929;5825.038868586678;6320.841978950517;6333.398327158912;6389;6410.230772307353;6493.70778314977;6865.862682746367;6924.826879328057;6930.272321406281;7039.507234493588;7042.0493233413345;6882.862342753167;6967.268436814163;6982.615956122411;7013.859722805515;7065.364117229423;6452.612843229421;6465;6471.9968404896845;6510.93489065108;6525;7121.750738724223;7137.357637812622;7202.603856787875;7253.56478611285;7266.309700578437;6837.931620683829;6867.416269617139;6875.278095799969;6958.304169583002;6968.512204145661;6815.625140617214;6878.174619045646;6936.375726184668;7022.6488675566015;7054.717811287491;6895;6916.308369163044;6930.584164950119;6961.199462061826;7016.5088443808445;6917.481188910851;6920.723171073201;6955.65221738911;7013.368796808311;7051.541649792747;5056.393232812086;5076.593872490192;5145.897082058338;5147.459516750687;5160.948390516121;4504.301833215857;4558.931616025762;4564.109998550251;4572.5198854119835;4575.084983003413;6357.300696923335;6484.675766211671;6524.543281970216;6537.705803238866;6540.018997150465;6983.685734141975;6994.300569942965;7008.719651213894;7020.543664661781;7060.117485314336;6375.71309291083;6470.870582588322;6487;6545.934540654628;6557.639329836905;5537.833864984057;5618.381977982419;5632.662040277514;5638.069718496402;5639.069553523705;7182.96408517954;7208.171060328024;7229.385502232264;7254.202037775841;7267.091613548307;6945.47908906834;6959;6961.37347638715;7053;7061.364477197077;7004.264552221944;7121.394681451928;7132.714691412493;7144.24985376528;7235.493515454078;6893.138357705287;6952.756653517103;6961.164660240804;6968.581885086911;6988.580685158907;6969;6983.266756990442;7005.684744186422;7048.753293634698;7056.1179852518435;6692.866142677021;6707.798766037026;6714.865702686016;6789;6838.076859624086;6615.272320044695;6737.326267373223;6742.730290788313;6746.595204287759;6747.6626168692355;6739.696713647995;6743.831404214934;6745.696443660146;6754.020667003355;6758.222804377559;6682.264950855305;6723.025161351675;6829.078074459884;6838.829029274308;6842.828929276808;6398.776042838478;6421.165248517663;6443.033544968105;6452.677366131768;6460.838479038061 18:24:05 INFO - PID 11257 | |1;ext.html;882.5454890731272;938.1228551304536;957.2724729205804;966.5360626899088;981.4651015196717;41905;42718.35922461165;43007.78496107523;43030.78484607572;43143.78428107859;39211.803940980324;39417;39467.80266098673;39519.20961580767;39538.60461395385;7280.089988751392;7368.484206105575;7411.0736157980255;7414.962925185367;7415.517991330573;7334.376577990877;7431.665575049135;7438.739644112457;7439.330460258576;7439.628018599075;7848.215178482134;8073.596320183968;8093.595320233994;8095.392845536609;8102.635381407821;7961.402894782886;8023.919760802376;8035;8040.798980025487;8049.51702897828;7731.574763388011;7872.72445464406;7890.289873911318;7894.960525197394;7912.841743165162;37617.811910940545;37627.623723762685;37673.24653506942;37683;37751.244975100344;3624.257027309395;3685.7972811495356;3687.1519550503535;3687.797171155585;3693.242885208526;32716;32728.181795455064;32901.17747056319;32978.17554561155;33020.33959320824;5502.376798844351;5515.117581186991;5530.5299049580835;5534.225208470817;5634.408387119375;206671.9999999985;206907;207408;207436;208106;48147.27779083316;48493.27260091101;48715;49005;49050.264246036335;52044.73977630088;52155;52344;52463;52534.21198682023;15608.921955390151;15824.76262856058;15829.604259893364;15845;15883.126428046568;12906.870931290567;12928.418221180069;12964.870351296555;12971.675708107185;12972.870271297355;14037;14243.287835608178;14332.283385830668;14388.640283992983;14420.278986050656;5499.395066542677;5594.552435805126;5624.184493248456;5648.802291919763;5694.402087780806;1079.8434227037035;1084.6691759013577;1088.2273585754203;1089.1450211584026;1095.4960718069776;23731.406714831923;24487.755122448903;24489.265452000487;24564.87717561401;24712.629310560354;1175.8882906124077;1188.7919614067503;1189.9762004759857;1206.90344772418;1210.1105687319814;16984.66030679404;17537.947723136396;17659.117044148;17991.370302039366;18420.88159861633;286609;288383;289033;289358;290078;58431.12353314704;61404.385956139864;61876;63500.047499287546;63673.68163159154;1500.482333594908;1525.6872341170033;1534.1638806850294;1541;1561.8750499959976;30068.24829379283;30245.546316804826;30346.241343966576;30454.23864403319;31098.378032439676;40026;40171.39742903917;40252.1949561013;40261;40262.79868600638;176251;177025.1148744248;178444;178471;178541;36292.27415451729;36364.81817590895;36437.45343819898;36551.26897462089;36958.260834783694;43935.56064439315;44136.558634413246;44157.33763993607;44193.77903110464;44658.55341446544;32942.34115317728;33029.834850826555;33121.66878331282;33203;33435.83282083574;30452.23869403194;30892.53661195039;31024;31145.532817008218;31326.530102048942;38215.235695286494;38300.42549361706;38361.616383835804;38567.80716096402;38637.42043869288;34468.31063378769;35255.47116793199;35737.28525429529;35892.82053589715;35963.46054809232;26126;26312.736872631027;26881.827704893345;27084;27305.863470682518 18:24:05 INFO - PID 11257 | |2;jquery.html;569.5756661287342;574.6552068758748;590.5098768022536;592.9318128415232;604.8487878030492;22588.88705556472;23058.423539411502;23417.648735268944;23513.412164695892;23640.172593959192;23392.298231053053;25986.350341241432;26133;26251.3437164071;26319.078832240877;6798.354156355138;6960.547564408297;6967.163940327167;6968.581885086885;7029.929700702979;6249.218847644044;6548.246951600556;6549.934500655004;6774.153230846145;6836.726530938757;6474.514411419139;6492.480601551864;6493.026046093077;6505.60966342021;6528.151340325751;6516.609003459784;6521.282658907517;6525.445337146348;6532.281449040625;6538.673066346663;6069.544784141207;6075.726592303357;6081;6139.662318572477;6139.785107521216;28770.568441473395;29590;30019.69980300191;30074.849625751733;30257.697423025707;2189.5292512109813;2222.1111555377815;2241.5965126277265;2242.7757224277607;2248.213125406111;20390;21109.8944505278;21121.68317475239;21128.471788205265;21139.682904756442;2522.571162902311;2535.32813804342;2600.5189040027653;2604.817662763607;2613.5426300397353;137656.31171844178;143249;143310.28344858313;143491;143711.28144359315;15438.691226175413;15742.842571574138;15892.52322430329;16144.75782863258;16263.430779922646;25991.870040650054;48448.7577562117;49785.25322120171;50178.74910625423;50202.49797502051;10923.781524369628;10974.341539507655;11025.779484410426;11808.645740627622;11887;9579.521023948913;9609.231261499064;9679.854802177973;9746.31775775689;9747.805043899083;11819.822702659296;11936.791693536723;12100.273983561014;12212;12239.062624969943;3630.6913912317223;4062.7451764270522;4397.824087036547;4528.414606825493;4581.610563102107;1028.2031425645184;1056.1286938275953;1056.6513050693252;1057.1120258982492;1058.6136060337922;21336.466588335417;21422.250221242495;21566.24518141889;22388.88805555962;22615.773842261697;1118.4351902289293;1119.2948442481347;1124.0501775999267;1136.7896939066134;1137.7838210739933;12083;12109.636710898687;12136.635900922987;12218.633440996606;12331.876681233252;478635;492453;497601;498725;560569;124671;127197;128277;128280;129181;1236.2458900070949;1252.461441580111;1282.3908643394313;1287.5107459165645;1288.0532808385829;19564.510887227934;19896.910824363233;23210.071597135924;24188.395290117183;24472.87763561171;61139.38860611515;61543;61757.38242617696;61813;63768.362316376246;84019.15980840358;85250.1474985267;85279.14720852712;86466.1353386458;88024.5598772002;16044.598885027968;16318.673626527641;16369.754453683443;16511.752323714914;16595.50213493597;25031.874840625682;25141.371465713502;25318.240452786446;25463.490730185662;25497.61753573661;19424.320148794723;19610.90194549075;19640.607187856447;19641;20751.169953201705;16669.83330166683;17164.313427462763;17424.47726568205;17551.473455796346;17618.11909404499;20624;20773.27293544719;20814.687779683012;21104.155833766476;21194.894025529775;15966.12186329763;16011.919940400223;16058;16068.43760468378;16143.75784363212;19790.802091978894;20368.08343624511;20592.176312947315;20652;20698.896505517376 18:24:05 INFO - PID 11257 | |3;mootools.html;1448.7102579484103;1484.7104814561164;1488.8511148885113;1506.141499345373;1523.0633160606228;16647.33410663572;16659;17328.220230089646;17359.392421265275;17363.218655160515;17288.82711172888;17778;17787.82212177878;17813.465596032107;17814.109294535287;2708.674959004922;2757.531219692647;2758.1036163247027;2759.6826364968083;2763.5301998660275;2646.7220941801124;2701.9594706079424;2721.18364490653;2734.753872151506;2813.22636275025;2700.729927007303;2718.796090293226;2731.4673638640475;2745.931351716213;2749.5188342040165;2630.973690263092;2645.722199169079;2649.165512863461;2651.231142968537;2653.4825708986755;2612.596411301588;2639.920802375932;2641.418887844671;2653.9867300663373;2657.0434643528315;16524.25640846165;16803.411880584244;16864.072476013815;16940.745888811678;16950;7529.284717951786;7767.067951845758;7797.727079552188;7800.960995195044;7810.492317999312;5146.716930568818;5156.432792392834;5177.145770947789;5223.399309079467;5313.840584782462;2143.95712085759;2149.7312835895514;2184.7050648162453;2185.868847869133;2229.2754854672135;30665.540016899766;30885.691143088505;30938.690613093808;30983.53524697109;30996.845015775;6483.4164925156965;6513.576617519846;6537.215534135934;6600.966995164993;6655.23464801554;19581;19617.019149042775;19619.411417657495;19628.901855490632;19653.50866228356;8075.798105047304;8320.417570769989;8320.500769953822;8322.791930201793;8328.458650187718;7170.103737032871;7268.0914885639295;7310.086239220098;7342.48602597813;7346.77959661211;5248.291480650139;5381.596380271495;5395.568354531628;5411.323584551931;5448.727563621803;1426.12293439536;1433.8924580656492;1442.5455981365835;1503.624093976506;1528.808898887639;948.800751842107;958.2573505533128;981.4727077774759;991.1971303244395;994.22450488619;8710.041895391501;9032.412893161923;9250.213731832735;9395.57719902606;9404.059594040542;1066.2003497376968;1078.099786678117;1081.8918108189275;1084.4577711144427;1110.1729211737145;5333.653312534673;5425.620206585501;5755.9424405756245;5801.593888427854;5890.322612899486;24520.632190517157;25498.617520737203;25549.105781297938;25689.87155064213;25702;24052.39869003254;25165.496690066462;25240.116595919055;25263.242102736946;25330;11994.64016079519;12478.126531142732;12729.172603780724;12739.55411560591;12764.489420423264;9071.455712657262;9376;9492.905070949202;9571.138597526256;9777.16894063984;19897.104630291382;19914.402567922985;20214.090365933862;20673.379798606067;20950.58098838045;20843.478913027295;21191.046402912216;21597.892010539847;21731.022104005675;21803.345899622404;13852.307384630929;13855.930720346334;13897.652558686113;13959.581212563638;14142.78785818193;15550.533483995498;15678.9216053919;15689.215539222765;15697.136657483492;15701.607459813597;12069.336186509827;12121.333326667118;12256.325902075472;12309.569165079538;12397.690057748629;12101.878981210075;12390.442430090487;12401.62795116148;12536.623901282976;12614.621561353175;10892.074173695324;10914.672559823219;10950.34297942126;10951.288166269167;10954.123670106532;7799.6100194988885;7922.286994170552;7952.284294413531;8025.638846251816;8108.148644392254;7304.452166087458;7484;7554.169041405551;7557.508761930457;7636.350910172698 18:24:05 INFO - PID 11257 | |4;prototype.html;548.9121740521513;550.1472717288203;569.7578529125122;569.8347479231021;573.4523530028823;6258.624482531051;6294.716737746801;6322.589031712947;6324.557280990332;6347.682615869211;6205.007198848185;6224;6248.937510624893;6250.781222657208;6302.1177035215;5105.6936583805;5106.668066575679;5111.488851114877;5118.334616499868;5139.152039913429;4853.272009198613;5092.083424983502;5127.692338459686;5134.741988212874;5138.254953031808;4948.604111671076;4955.529224723646;4967.850964471054;4980.302757613937;4988.900221995558;4969.18008528596;4973.378327709036;4986.4514903360605;4988.052270068712;4998.125328067574;4414.933775993362;4488.768086977371;4502.234620114556;4502.504724480337;4505.481869584974;6139.969300153515;6147.44672979434;6157.353477884847;6173.876522469571;6186.443220110166;5872.412758724094;5878.265216847894;5902.852428689274;5903.232579764646;5912.379200183962;6732.576272541881;6734.158230221223;6753.966230168818;6754.108849522142;6766.763163289311;5076.832328564414;5078.248004438463;5083.525777524514;5084.46613105626;5093.363329583802;6671.2654709775325;6864.279250678706;6908.827279318007;6957.61733104679;7048.647567621599;5185.611079169077;5189.948100519022;5214.97392513035;5225.790968361223;5226.5818734501145;5257.764425360037;5281.762320695578;5281.973590132102;5292.867678308073;5293.735313234323;5785.884282314414;5830.883382332329;5838.649681019152;5855.707214639251;5877.353491115974;6581.901271480931;6637.435817955431;6676.899846502306;6693.598384096969;6703.731850726014;1809.095452273863;1827.601884558314;1836.4307064809952;1837.4487653703836;1839.5033340998123;1216.3127832774453;1271.5867343113525;1275.8963496575582;1300.7268473620645;1302.8957683385306;6284.717187726564;6293.653849038255;6322.111901180832;6337.271213810379;6369.585976911486;6704.6982885769285;6742.292059333699;6773.322667733188;6786.796396108125;6795.150606174228;5989.64062156272;6138.570300079041;6189.381061893775;6205.596636218631;6276.905846412307;3536.328097661436;3558.7153027757718;3580.013092733558;3584.426491761306;3607.981960090235;6899.862002760017;6957.199922008933;6986.231514533397;6987.755428559976;7008.369246767714;6933.341332573397;6954.895676564855;7025.262347453444;7043.859122817515;7058.188308344606;6962.408195303355;7009.7897063088185;7043.823904402533;7049.929500704928;7058.364747172779;6733.494987875831;6735.360140786617;6763.5941843489545;6773.593584384953;6789.626570538668;6580.5064620154635;6583.210014798064;6613.14029176204;6641.169853768279;6673.766418175534;6851.280615535297;6881.552699074544;6902.446094944702;6919.238883722887;6994.790156295319;5140.614453916046;5173.1722924331925;5178.119719647744;5183.688978661293;5191.974040129926;6516.067769503837;6544.574602650812;6746.8650626988165;6794.524383293122;6821.420179284816;6480.282725077764;6490.870182596416;6503.764469602016;6514;6590.538662293593;6492.805215843532;6496.675166241764;6499.870002600016;6503;6634.445738390657;6464.741410343534;6477;6518.217813862367;6591.868162636624;6599.274079851117;6539.803805885831;6580.440662543738;6646.241809648942;6647.069410282467;6706.798796036127;6422.486201103994;6430.1319321892815;6431.774887878902;6435.165977696334;6531.804045878631 18:24:05 INFO - PID 11257 | |5;yui.html;985.216752681618;999.0359303272343;1019.23557332001;1032.0866033560296;1032.210359075307;18697.81302186981;19293;19870.10584523696;19895.40313790585;19898;21146.048427820748;22091.116355345766;22117.115315387404;22148.88925555374;22163.667544986798;1084.8698156221265;1086.4241951765537;1091.0507858163369;1093.535247519805;1095.7370231144548;1091.9945400273027;1092.268180319184;1092.3391348234322;1092.421016861061;1095.413953534859;1145.1010956399227;1150.7813515432042;1150.9194356395055;1151.4070253819248;1156.2773266708307;1140.657802659203;1145.032447581792;1145.37004647444;1145.484531960621;1146.8222425524057;838.9161083891623;842.5197637346715;843.6541018182577;845.1506236232608;846.3779122345071;17780.555486112822;18113.45659630213;18145.818541814544;20345.593088138154;20561.38315850527;22963.7703622965;23085.884570577207;23245.883770581208;23322.300330990096;23433.41416464585;18032.729509057375;18181.72727409077;18272.269109235614;18342.174602142935;18375.72436413455;3971.8609848655447;3988.8603898863403;3993.6206060424215;3999.320115580358;4002.819873105688;146912.99999999892;148828;148987;149429.25285373614;149520.2523987373;17439.389621363192;17486.912565437346;18030.00834954064;18055.909720451575;18357.449276521726;33306.66693333036;33758.49362259568;33887.661123388454;34150.65849341475;34548.13629659228;7983.081945576333;8489.278411334983;9246.4914429707;9438.056194380644;9473.621055157717;4725.763711814396;4813.03739252151;4819.3012013258585;4820.5420485054565;4830.2996065571;5787.479126878601;5864.765409383662;5869;5876.206712093898;5888.882222355614;1262.501311981762;1264.462603393554;1292.5476083370745;1294.449858810002;1302.798066299725;741.1995045351116;757.9886301705479;760.2967255288836;777.40916903154;787.6534324897027;12922.741545169043;13056.151350162208;13501.392437340342;14053;14182.929085354508;729.099562040879;738.4314078159787;747.8856503809285;752.3943225703362;761.6191904047976;6228.47058000066;7220.566765994057;7278.344948954619;7314.853702925911;7336.082989626297;129871.35064324617;130717.34641326733;131460;132060;139060.30469847587;114258.42870785759;119193.40403298101;119730;121487.39256303661;123464.38267808604;102901;103064;103441;103753.48123259486;105728.47135764272;13124;13277.269750163834;13286.003549734001;13754.793678095037;13898.16611003343;47936;48484.272735908286;51179.97640047253;51909.48090519047;52248.47751522588;80837.59581202056;84627.5768621153;87155.56422217848;87186.56406717926;88078.55960720155;16695.74956375631;20159.697604536235;20702.171913123308;20811.583768324246;20825.89587052055;21597.784022159576;21726;22941.770582293964;23713.762862371157;24016.87991560031;19285;19859.900700496404;19917.402477925687;20307.187712491334;20763.273285434938;20865.269715559883;20933.476663083544;21210.893945530173;21700.565988679824;22032.228871989402;20606.484837878572;21381.679274811202;21457.46356341104;21591.38623957751;21731;15422.922885385502;15556.611084722972;15860.20698965024;16114.27485763167;16175.838241617434;15164.469243576423;15352;15621.45324913668;15779.447719329768;15817.604559885634 18:24:05 INFO - PID 11257 | __end_tp_report 18:24:05 INFO - PID 11257 | __start_cc_report 18:24:05 INFO - PID 11257 | _x_x_mozilla_cycle_collect,339 18:24:05 INFO - PID 11257 | __end_cc_report 18:24:05 INFO - PID 11257 | __startTimestamp1504747445630__endTimestamp 18:24:05 INFO - PID 11257 | 18:24:05 INFO - PID 11257 | ------- Summary: start ------- 18:24:05 INFO - PID 11257 | Number of tests: 6 18:24:05 INFO - PID 11257 | 18:24:05 INFO - PID 11257 | [#0] dojo.html Cycles:165 Average:6371.24 Median:6692.87 stddev:915.31 (13.7%) stddev-sans-first:896.20 18:24:05 INFO - PID 11257 | Values: 3833.1 3890.6 3899.6 3903.2 3936.2 6278.2 6320.1 6387.5 6397.6 6438.8 6301.8 6425.5 6427.2 6436.6 6477.0 5669.2 5742.7 5756.5 5776.6 5781.9 5791.9 5806.4 5817.6 5857.8 5862.2 54.5 5724.4 5770.9 5868.6 5870.5 5726.9 5735.5 5748.3 5796.4 5802.7 5736.0 5751.4 5816.8 5819.3 5825.0 6320.8 6333.4 6389.0 6410.2 6493.7 6865.9 6924.8 6930.3 7039.5 7042.0 6882.9 6967.3 6982.6 7013.9 7065.4 6452.6 6465.0 6472.0 6510.9 6525.0 7121.8 7137.4 7202.6 7253.6 7266.3 6837.9 6867.4 6875.3 6958.3 6968.5 6815.6 6878.2 6936.4 7022.6 7054.7 6895.0 6916.3 6930.6 6961.2 7016.5 6917.5 6920.7 6955.7 7013.4 7051.5 5056.4 5076.6 5145.9 5147.5 5160.9 4504.3 4558.9 4564.1 4572.5 4575.1 6357.3 6484.7 6524.5 6537.7 6540.0 6983.7 6994.3 7008.7 7020.5 7060.1 6375.7 6470.9 6487.0 6545.9 6557.6 5537.8 5618.4 5632.7 5638.1 5639.1 7183.0 7208.2 7229.4 7254.2 7267.1 6945.5 6959.0 6961.4 7053.0 7061.4 7004.3 7121.4 7132.7 7144.2 7235.5 6893.1 6952.8 6961.2 6968.6 6988.6 6969.0 6983.3 7005.7 7048.8 7056.1 6692.9 6707.8 6714.9 6789.0 6838.1 6615.3 6737.3 6742.7 6746.6 6747.7 6739.7 6743.8 6745.7 6754.0 6758.2 6682.3 6723.0 6829.1 6838.8 6842.8 6398.8 6421.2 6443.0 6452.7 6460.8 18:24:05 INFO - PID 11257 | 18:24:05 INFO - PID 11257 | [#1] ext.html Cycles:180 Average:40244.80 Median:3686.47 stddev:59717.31 (1619.9%) stddev-sans-first:59811.69 18:24:05 INFO - PID 11257 | Values: 882.5 938.1 957.3 966.5 981.5 41905.0 42718.4 43007.8 43030.8 43143.8 39211.8 39417.0 39467.8 39519.2 39538.6 7280.1 7368.5 7411.1 7415.0 7415.5 7334.4 7431.7 7438.7 7439.3 7439.6 7848.2 8073.6 8093.6 8095.4 8102.6 7961.4 8023.9 8035.0 8040.8 8049.5 7731.6 7872.7 7890.3 7895.0 7912.8 37617.8 37627.6 37673.2 37683.0 37751.2 3624.3 3685.8 3687.2 3687.8 3693.2 32716.0 32728.2 32901.2 32978.2 33020.3 5502.4 5515.1 5530.5 5534.2 5634.4 206672.0 206907.0 207408.0 207436.0 208106.0 48147.3 48493.3 48715.0 49005.0 49050.3 52044.7 52155.0 52344.0 52463.0 52534.2 15608.9 15824.8 15829.6 15845.0 15883.1 12906.9 12928.4 12964.9 12971.7 12972.9 14037.0 14243.3 14332.3 14388.6 14420.3 5499.4 5594.6 5624.2 5648.8 5694.4 1079.8 1084.7 1088.2 1089.1 1095.5 23731.4 24487.8 24489.3 24564.9 24712.6 1175.9 1188.8 1190.0 1206.9 1210.1 16984.7 17537.9 17659.1 17991.4 18420.9 286609.0 288383.0 289033.0 289358.0 290078.0 58431.1 61404.4 61876.0 63500.0 63673.7 1500.5 1525.7 1534.2 1541.0 1561.9 30068.2 30245.5 30346.2 30454.2 31098.4 40026.0 40171.4 40252.2 40261.0 40262.8 176251.0 177025.1 178444.0 178471.0 178541.0 36292.3 36364.8 36437.5 36551.3 36958.3 43935.6 44136.6 44157.3 44193.8 44658.6 32942.3 33029.8 33121.7 33203.0 33435.8 30452.2 30892.5 31024.0 31145.5 31326.5 38215.2 38300.4 38361.6 38567.8 38637.4 34468.3 35255.5 35737.3 35892.8 35963.5 26126.0 26312.7 26881.8 27084.0 27305.9 18:24:05 INFO - PID 11257 | 18:24:05 INFO - PID 11257 | [#2] jquery.html Cycles:180 Average:37634.74 Median:12418.55 stddev:85630.44 (689.5%) stddev-sans-first:85825.44 18:24:05 INFO - PID 11257 | Values: 569.6 574.7 590.5 592.9 604.8 22588.9 23058.4 23417.6 23513.4 23640.2 23392.3 25986.4 26133.0 26251.3 26319.1 6798.4 6960.5 6967.2 6968.6 7029.9 6249.2 6548.2 6549.9 6774.2 6836.7 6474.5 6492.5 6493.0 6505.6 6528.2 6516.6 6521.3 6525.4 6532.3 6538.7 6069.5 6075.7 6081.0 6139.7 6139.8 28770.6 29590.0 30019.7 30074.8 30257.7 2189.5 2222.1 2241.6 2242.8 2248.2 20390.0 21109.9 21121.7 21128.5 21139.7 2522.6 2535.3 2600.5 2604.8 2613.5 137656.3 143249.0 143310.3 143491.0 143711.3 15438.7 15742.8 15892.5 16144.8 16263.4 25991.9 48448.8 49785.3 50178.7 50202.5 10923.8 10974.3 11025.8 11808.6 11887.0 9579.5 9609.2 9679.9 9746.3 9747.8 11819.8 11936.8 12100.3 12212.0 12239.1 3630.7 4062.7 4397.8 4528.4 4581.6 1028.2 1056.1 1056.7 1057.1 1058.6 21336.5 21422.3 21566.2 22388.9 22615.8 1118.4 1119.3 1124.1 1136.8 1137.8 12083.0 12109.6 12136.6 12218.6 12331.9 478635.0 492453.0 497601.0 498725.0 560569.0 124671.0 127197.0 128277.0 128280.0 129181.0 1236.2 1252.5 1282.4 1287.5 1288.1 19564.5 19896.9 23210.1 24188.4 24472.9 61139.4 61543.0 61757.4 61813.0 63768.4 84019.2 85250.1 85279.1 86466.1 88024.6 16044.6 16318.7 16369.8 16511.8 16595.5 25031.9 25141.4 25318.2 25463.5 25497.6 19424.3 19610.9 19640.6 19641.0 20751.2 16669.8 17164.3 17424.5 17551.5 17618.1 20624.0 20773.3 20814.7 21104.2 21194.9 15966.1 16011.9 16058.0 16068.4 16143.8 19790.8 20368.1 20592.2 20652.0 20698.9 18:24:05 INFO - PID 11257 | 18:24:05 INFO - PID 11257 | [#3] mootools.html Cycles:180 Average:10356.51 Median:2621.79 stddev:7808.67 (297.8%) stddev-sans-first:7801.90 18:24:05 INFO - PID 11257 | Values: 1448.7 1484.7 1488.9 1506.1 1523.1 16647.3 16659.0 17328.2 17359.4 17363.2 17288.8 17778.0 17787.8 17813.5 17814.1 2708.7 2757.5 2758.1 2759.7 2763.5 2646.7 2702.0 2721.2 2734.8 2813.2 2700.7 2718.8 2731.5 2745.9 2749.5 2631.0 2645.7 2649.2 2651.2 2653.5 2612.6 2639.9 2641.4 2654.0 2657.0 16524.3 16803.4 16864.1 16940.7 16950.0 7529.3 7767.1 7797.7 7801.0 7810.5 5146.7 5156.4 5177.1 5223.4 5313.8 2144.0 2149.7 2184.7 2185.9 2229.3 30665.5 30885.7 30938.7 30983.5 30996.8 6483.4 6513.6 6537.2 6601.0 6655.2 19581.0 19617.0 19619.4 19628.9 19653.5 8075.8 8320.4 8320.5 8322.8 8328.5 7170.1 7268.1 7310.1 7342.5 7346.8 5248.3 5381.6 5395.6 5411.3 5448.7 1426.1 1433.9 1442.5 1503.6 1528.8 948.8 958.3 981.5 991.2 994.2 8710.0 9032.4 9250.2 9395.6 9404.1 1066.2 1078.1 1081.9 1084.5 1110.2 5333.7 5425.6 5755.9 5801.6 5890.3 24520.6 25498.6 25549.1 25689.9 25702.0 24052.4 25165.5 25240.1 25263.2 25330.0 11994.6 12478.1 12729.2 12739.6 12764.5 9071.5 9376.0 9492.9 9571.1 9777.2 19897.1 19914.4 20214.1 20673.4 20950.6 20843.5 21191.0 21597.9 21731.0 21803.3 13852.3 13855.9 13897.7 13959.6 14142.8 15550.5 15678.9 15689.2 15697.1 15701.6 12069.3 12121.3 12256.3 12309.6 12397.7 12101.9 12390.4 12401.6 12536.6 12614.6 10892.1 10914.7 10950.3 10951.3 10954.1 7799.6 7922.3 7952.3 8025.6 8108.1 7304.5 7484.0 7554.2 7557.5 7636.4 18:24:05 INFO - PID 11257 | 18:24:05 INFO - PID 11257 | [#4] prototype.html Cycles:180 Average:5644.64 Median:6289.19 stddev:1575.09 (25.0%) stddev-sans-first:1532.37 18:24:05 INFO - PID 11257 | Values: 548.9 550.1 569.8 569.8 573.5 6258.6 6294.7 6322.6 6324.6 6347.7 6205.0 6224.0 6248.9 6250.8 6302.1 5105.7 5106.7 5111.5 5118.3 5139.2 4853.3 5092.1 5127.7 5134.7 5138.3 4948.6 4955.5 4967.9 4980.3 4988.9 4969.2 4973.4 4986.5 4988.1 4998.1 4414.9 4488.8 4502.2 4502.5 4505.5 6140.0 6147.4 6157.4 6173.9 6186.4 5872.4 5878.3 5902.9 5903.2 5912.4 6732.6 6734.2 6754.0 6754.1 6766.8 5076.8 5078.2 5083.5 5084.5 5093.4 6671.3 6864.3 6908.8 6957.6 7048.6 5185.6 5189.9 5215.0 5225.8 5226.6 5257.8 5281.8 5282.0 5292.9 5293.7 5785.9 5830.9 5838.6 5855.7 5877.4 6581.9 6637.4 6676.9 6693.6 6703.7 1809.1 1827.6 1836.4 1837.4 1839.5 1216.3 1271.6 1275.9 1300.7 1302.9 6284.7 6293.7 6322.1 6337.3 6369.6 6704.7 6742.3 6773.3 6786.8 6795.2 5989.6 6138.6 6189.4 6205.6 6276.9 3536.3 3558.7 3580.0 3584.4 3608.0 6899.9 6957.2 6986.2 6987.8 7008.4 6933.3 6954.9 7025.3 7043.9 7058.2 6962.4 7009.8 7043.8 7049.9 7058.4 6733.5 6735.4 6763.6 6773.6 6789.6 6580.5 6583.2 6613.1 6641.2 6673.8 6851.3 6881.6 6902.4 6919.2 6994.8 5140.6 5173.2 5178.1 5183.7 5192.0 6516.1 6544.6 6746.9 6794.5 6821.4 6480.3 6490.9 6503.8 6514.0 6590.5 6492.8 6496.7 6499.9 6503.0 6634.4 6464.7 6477.0 6518.2 6591.9 6599.3 6539.8 6580.4 6646.2 6647.1 6706.8 6422.5 6430.1 6431.8 6435.2 6531.8 18:24:05 INFO - PID 11257 | 18:24:05 INFO - PID 11257 | [#5] yui.html Cycles:180 Average:27720.68 Median:20233.44 stddev:38798.33 (191.8%) stddev-sans-first:38855.24 18:24:05 INFO - PID 11257 | Values: 985.2 999.0 1019.2 1032.1 1032.2 18697.8 19293.0 19870.1 19895.4 19898.0 21146.0 22091.1 22117.1 22148.9 22163.7 1084.9 1086.4 1091.1 1093.5 1095.7 1092.0 1092.3 1092.3 1092.4 1095.4 1145.1 1150.8 1150.9 1151.4 1156.3 1140.7 1145.0 1145.4 1145.5 1146.8 838.9 842.5 843.7 845.2 846.4 17780.6 18113.5 18145.8 20345.6 20561.4 22963.8 23085.9 23245.9 23322.3 23433.4 18032.7 18181.7 18272.3 18342.2 18375.7 3971.9 3988.9 3993.6 3999.3 4002.8 146913.0 148828.0 148987.0 149429.3 149520.3 17439.4 17486.9 18030.0 18055.9 18357.4 33306.7 33758.5 33887.7 34150.7 34548.1 7983.1 8489.3 9246.5 9438.1 9473.6 4725.8 4813.0 4819.3 4820.5 4830.3 5787.5 5864.8 5869.0 5876.2 5888.9 1262.5 1264.5 1292.5 1294.4 1302.8 741.2 758.0 760.3 777.4 787.7 12922.7 13056.2 13501.4 14053.0 14182.9 729.1 738.4 747.9 752.4 761.6 6228.5 7220.6 7278.3 7314.9 7336.1 129871.4 130717.3 131460.0 132060.0 139060.3 114258.4 119193.4 119730.0 121487.4 123464.4 102901.0 103064.0 103441.0 103753.5 105728.5 13124.0 13277.3 13286.0 13754.8 13898.2 47936.0 48484.3 51180.0 51909.5 52248.5 80837.6 84627.6 87155.6 87186.6 88078.6 16695.7 20159.7 20702.2 20811.6 20825.9 21597.8 21726.0 22941.8 23713.8 24016.9 19285.0 19859.9 19917.4 20307.2 20763.3 20865.3 20933.5 21210.9 21700.6 22032.2 20606.5 21381.7 21457.5 21591.4 21731.0 15422.9 15556.6 15860.2 16114.3 16175.8 15164.5 15352.0 15621.5 15779.4 15817.6 18:24:05 INFO - PID 11257 | -------- Summary: end -------- 18:24:05 INFO - PID 11257 | 18:24:06 INFO - TEST-INFO | 11257: exit 0 18:24:06 INFO - TEST-OK | dromaeo_css | took 1106929ms 18:24:06 INFO - TEST-START | kraken 18:24:06 INFO - Initialising browser for kraken test... 18:24:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56417/getInfo.html -profile /tmp/tmpAtD9e1/profile 18:24:06 INFO - TEST-INFO | started process 11638 (/builds/slave/test/build/application/firefox/firefox http://localhost:56417/getInfo.html) 18:24:12 INFO - TEST-INFO | 11638: exit 0 18:24:12 INFO - Browser initialized. 18:24:12 INFO - Running cycle 1/1 for kraken test... 18:24:12 INFO - Using env: {'DISPLAY': ':0', 18:24:12 INFO - 'HOME': '/home/cltbld', 18:24:12 INFO - 'JSGC_DISABLE_POISONING': '1', 18:24:12 INFO - 'LANG': 'en_US.UTF-8', 18:24:12 INFO - 'LANGUAGE': 'en_US:en', 18:24:12 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 18:24:12 INFO - 'LOGNAME': 'cltbld', 18:24:12 INFO - 'MAIL': '/var/mail/cltbld', 18:24:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:24:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:24:12 INFO - 'MOZ_CRASHREPORTER': '1', 18:24:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:12 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 18:24:12 INFO - 'MOZ_NO_REMOTE': '1', 18:24:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:24:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:24:12 INFO - 'NO_EM_RESTART': '1', 18:24:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:24:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:12 INFO - 'PWD': '/builds/slave/test', 18:24:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:24:12 INFO - 'RUST_BACKTRACE': 'full', 18:24:12 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:24:12 INFO - 'SHELL': '/bin/bash', 18:24:12 INFO - 'SHLVL': '1', 18:24:12 INFO - 'STYLO_FORCE_DISABLED': '1', 18:24:12 INFO - 'TERM': 'linux', 18:24:12 INFO - 'TMOUT': '86400', 18:24:12 INFO - 'USER': 'cltbld', 18:24:12 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504746270.959390-84819962', 18:24:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:12 INFO - '_': '/tools/buildbot/bin/python'} 18:24:12 INFO - TEST-INFO | started process 11841 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAtD9e1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:24:13 INFO - PID 11841 | 18:24:13 INFO - PID 11841 | (/builds/slave/test/build/application/firefox/firefox:11894): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:24:13 INFO - PID 11841 | 18:24:23 INFO - PID 11841 | RSS: Main: 161951744 18:24:23 INFO - PID 11841 | 18:24:25 INFO - PID 11841 | Cycle 1(1): loaded http://localhost:56417/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56417/tests/kraken/driver.html?testName=audio-beat-detection) 18:24:26 INFO - PID 11841 | RSS: Main: 168054784 18:24:26 INFO - PID 11841 | 18:24:29 INFO - PID 11841 | Cycle 1(1): loaded http://localhost:56417/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56417/tests/kraken/driver.html?testName=audio-dft) 18:24:29 INFO - PID 11841 | RSS: Main: 172281856 18:24:29 INFO - PID 11841 | 18:24:32 INFO - PID 11841 | Cycle 1(1): loaded http://localhost:56417/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56417/tests/kraken/driver.html?testName=audio-fft) 18:24:33 INFO - PID 11841 | RSS: Main: 165191680 18:24:33 INFO - PID 11841 | 18:24:35 INFO - PID 11841 | Cycle 1(1): loaded http://localhost:56417/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56417/tests/kraken/driver.html?testName=audio-oscillator) 18:24:36 INFO - PID 11841 | RSS: Main: 166752256 18:24:36 INFO - PID 11841 | 18:24:38 INFO - PID 11841 | Cycle 1(1): loaded http://localhost:56417/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56417/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:24:38 INFO - PID 11841 | RSS: Main: 166842368 18:24:38 INFO - PID 11841 | 18:24:41 INFO - PID 11841 | Cycle 1(1): loaded http://localhost:56417/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56417/tests/kraken/driver.html?testName=imaging-darkroom) 18:24:42 INFO - PID 11841 | RSS: Main: 166928384 18:24:42 INFO - PID 11841 | 18:24:45 INFO - PID 11841 | Cycle 1(1): loaded http://localhost:56417/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56417/tests/kraken/driver.html?testName=imaging-desaturate) 18:24:46 INFO - PID 11841 | RSS: Main: 169897984 18:24:46 INFO - PID 11841 | 18:24:49 INFO - PID 11841 | Cycle 1(1): loaded http://localhost:56417/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56417/tests/kraken/driver.html?testName=json-parse-financial) 18:24:50 INFO - PID 11841 | RSS: Main: 168079360 18:24:50 INFO - PID 11841 | 18:24:51 INFO - PID 11841 | Cycle 1(1): loaded http://localhost:56417/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56417/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:24:52 INFO - PID 11841 | RSS: Main: 168243200 18:24:52 INFO - PID 11841 | 18:24:53 INFO - PID 11841 | Cycle 1(1): loaded http://localhost:56417/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56417/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:24:54 INFO - PID 11841 | RSS: Main: 168292352 18:24:54 INFO - PID 11841 | 18:24:56 INFO - PID 11841 | Cycle 1(1): loaded http://localhost:56417/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56417/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:24:56 INFO - PID 11841 | RSS: Main: 165007360 18:24:56 INFO - PID 11841 | 18:24:59 INFO - PID 11841 | Cycle 1(1): loaded http://localhost:56417/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56417/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:25:00 INFO - PID 11841 | RSS: Main: 165183488 18:25:00 INFO - PID 11841 | 18:25:02 INFO - PID 11841 | Cycle 1(1): loaded http://localhost:56417/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56417/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:25:03 INFO - PID 11841 | RSS: Main: 165040128 18:25:03 INFO - PID 11841 | 18:25:05 INFO - PID 11841 | Cycle 1(1): loaded http://localhost:56417/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56417/tests/kraken/driver.html?testName=ai-astar) 18:25:05 INFO - PID 11841 | RSS: Main: 167182336 18:25:05 INFO - PID 11841 | 18:25:05 INFO - PID 11841 | __start_tp_report 18:25:05 INFO - PID 11841 | _x_x_mozilla_page_load 18:25:05 INFO - PID 11841 | _x_x_mozilla_page_load_details 18:25:05 INFO - PID 11841 | |i|pagename|runs| 18:25:05 INFO - PID 11841 | |0;ai-astar;96;109;98;106;105;107;107;96;106;110 18:25:05 INFO - PID 11841 | |1;audio-beat-detection;148;116;142;170;111;136;139;115;168;113 18:25:05 INFO - PID 11841 | |2;audio-dft;162;163;164;162;162;164;163;161;164;173 18:25:05 INFO - PID 11841 | |3;audio-fft;73;73;73;166;74;77;74;73;172;73 18:25:05 INFO - PID 11841 | |4;audio-oscillator;78;79;130;81;83;78;129;78;78;124 18:25:05 INFO - PID 11841 | |5;imaging-gaussian-blur;113;114;115;114;113;114;113;114;116;114 18:25:05 INFO - PID 11841 | |6;imaging-darkroom;149;150;152;150;150;149;150;151;149;150 18:25:05 INFO - PID 11841 | |7;imaging-desaturate;95;97;94;95;94;94;93;94;94;93 18:25:05 INFO - PID 11841 | |8;json-parse-financial;45;48;46;51;44;46;49;44;45;45 18:25:05 INFO - PID 11841 | |9;json-stringify-tinderbox;37;37;36;37;38;37;38;37;37;38 18:25:05 INFO - PID 11841 | |10;stanford-crypto-aes;72;72;72;73;73;72;71;71;72;73 18:25:05 INFO - PID 11841 | |11;stanford-crypto-ccm;111;113;121;118;116;126;114;116;113;152 18:25:05 INFO - PID 11841 | |12;stanford-crypto-pbkdf2;164;158;161;162;162;167;158;159;155;160 18:25:05 INFO - PID 11841 | |13;stanford-crypto-sha256-iterative;60;64;62;62;58;58;60;61;60;58 18:25:05 INFO - PID 11841 | __end_tp_report 18:25:05 INFO - PID 11841 | __start_cc_report 18:25:05 INFO - PID 11841 | _x_x_mozilla_cycle_collect,876 18:25:05 INFO - PID 11841 | __end_cc_report 18:25:05 INFO - PID 11841 | __startTimestamp1504747505447__endTimestamp 18:25:05 INFO - PID 11841 | 18:25:05 INFO - PID 11841 | ------- Summary: start ------- 18:25:05 INFO - PID 11841 | Number of tests: 14 18:25:05 INFO - PID 11841 | 18:25:05 INFO - PID 11841 | [#0] ai-astar Cycles:10 Average:104.00 Median:109.50 stddev:5.29 (4.8%) stddev-sans-first:4.76 18:25:05 INFO - PID 11841 | Values: 96.0 109.0 98.0 106.0 105.0 107.0 107.0 96.0 106.0 110.0 18:25:05 INFO - PID 11841 | 18:25:05 INFO - PID 11841 | [#1] audio-beat-detection Cycles:10 Average:135.80 Median:140.50 stddev:22.02 (15.7%) stddev-sans-first:22.91 18:25:05 INFO - PID 11841 | Values: 148.0 116.0 142.0 170.0 111.0 136.0 139.0 115.0 168.0 113.0 18:25:05 INFO - PID 11841 | 18:25:05 INFO - PID 11841 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.50 stddev:3.39 (2.1%) stddev-sans-first:3.54 18:25:05 INFO - PID 11841 | Values: 162.0 163.0 164.0 162.0 162.0 164.0 163.0 161.0 164.0 173.0 18:25:05 INFO - PID 11841 | 18:25:05 INFO - PID 11841 | [#3] audio-fft Cycles:10 Average:92.80 Median:73.00 stddev:40.20 (55.1%) stddev-sans-first:42.00 18:25:05 INFO - PID 11841 | Values: 73.0 73.0 73.0 166.0 74.0 77.0 74.0 73.0 172.0 73.0 18:25:05 INFO - PID 11841 | 18:25:05 INFO - PID 11841 | [#4] audio-oscillator Cycles:10 Average:93.80 Median:78.00 stddev:23.47 (30.1%) stddev-sans-first:24.19 18:25:05 INFO - PID 11841 | Values: 78.0 79.0 130.0 81.0 83.0 78.0 129.0 78.0 78.0 124.0 18:25:05 INFO - PID 11841 | 18:25:05 INFO - PID 11841 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.94 (0.8%) stddev-sans-first:0.93 18:25:05 INFO - PID 11841 | Values: 113.0 114.0 115.0 114.0 113.0 114.0 113.0 114.0 116.0 114.0 18:25:05 INFO - PID 11841 | 18:25:05 INFO - PID 11841 | [#6] imaging-darkroom Cycles:10 Average:150.00 Median:150.00 stddev:0.94 (0.6%) stddev-sans-first:0.93 18:25:05 INFO - PID 11841 | Values: 149.0 150.0 152.0 150.0 150.0 149.0 150.0 151.0 149.0 150.0 18:25:05 INFO - PID 11841 | 18:25:05 INFO - PID 11841 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:1.16 (1.2%) stddev-sans-first:1.20 18:25:05 INFO - PID 11841 | Values: 95.0 97.0 94.0 95.0 94.0 94.0 93.0 94.0 94.0 93.0 18:25:05 INFO - PID 11841 | 18:25:05 INFO - PID 11841 | [#8] json-parse-financial Cycles:10 Average:46.30 Median:46.00 stddev:2.31 (5.0%) stddev-sans-first:2.40 18:25:05 INFO - PID 11841 | Values: 45.0 48.0 46.0 51.0 44.0 46.0 49.0 44.0 45.0 45.0 18:25:05 INFO - PID 11841 | 18:25:05 INFO - PID 11841 | [#9] json-stringify-tinderbox Cycles:10 Average:37.20 Median:37.00 stddev:0.63 (1.7%) stddev-sans-first:0.67 18:25:05 INFO - PID 11841 | Values: 37.0 37.0 36.0 37.0 38.0 37.0 38.0 37.0 37.0 38.0 18:25:05 INFO - PID 11841 | 18:25:05 INFO - PID 11841 | [#10] stanford-crypto-aes Cycles:10 Average:72.10 Median:72.00 stddev:0.74 (1.0%) stddev-sans-first:0.78 18:25:05 INFO - PID 11841 | Values: 72.0 72.0 72.0 73.0 73.0 72.0 71.0 71.0 72.0 73.0 18:25:05 INFO - PID 11841 | 18:25:05 INFO - PID 11841 | [#11] stanford-crypto-ccm Cycles:10 Average:120.00 Median:117.00 stddev:12.07 (10.3%) stddev-sans-first:12.36 18:25:05 INFO - PID 11841 | Values: 111.0 113.0 121.0 118.0 116.0 126.0 114.0 116.0 113.0 152.0 18:25:05 INFO - PID 11841 | 18:25:05 INFO - PID 11841 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.60 Median:161.50 stddev:3.41 (2.1%) stddev-sans-first:3.38 18:25:05 INFO - PID 11841 | Values: 164.0 158.0 161.0 162.0 162.0 167.0 158.0 159.0 155.0 160.0 18:25:05 INFO - PID 11841 | 18:25:05 INFO - PID 11841 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.30 Median:60.50 stddev:2.00 (3.3%) stddev-sans-first:2.12 18:25:05 INFO - PID 11841 | Values: 60.0 64.0 62.0 62.0 58.0 58.0 60.0 61.0 60.0 58.0 18:25:05 INFO - PID 11841 | -------- Summary: end -------- 18:25:05 INFO - PID 11841 | 18:25:05 INFO - PID 11841 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:25:06 INFO - TEST-INFO | 11841: exit 0 18:25:06 INFO - TEST-OK | kraken | took 59837ms 18:25:06 INFO - SUITE-END | took 1166s 18:25:06 INFO - Completed test suite (00:19:27) 18:25:06 INFO - javascript benchmark 18:25:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9137.935630761775, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3833.1183827719624, 3890.5720370759227, 3899.629535194157, 3903.1803321302527, 3936.2324346752393, 6278.215223097113, 6320.051992201172, 6387.457066149372, 6397.584157029795, 6438.806835794928, 6301.810945671626, 6425.453836423898, 6427.2287325521, 6436.581622194566, 6477.0, 5669.177969194464, 5742.655440673562, 5756.510696590794, 5776.566757493184, 5781.913271300913, 5791.884162316772, 5806.361300256968, 5817.62185457946, 5857.824265272048, 5862.179294898718, 54.48699091116059, 5724.427557244284, 5770.9422905770825, 5868.618539794921, 5870.471657550819, 5726.885462290773, 5735.512481439041, 5748.310202775694, 5796.391378905197, 5802.680852553108, 5736.0, 5751.367349591584, 5816.796412125555, 5819.301683797929, 5825.038868586678, 6320.841978950517, 6333.398327158912, 6389.0, 6410.230772307353, 6493.70778314977, 6865.862682746367, 6924.826879328057, 6930.272321406281, 7039.507234493588, 7042.0493233413345, 6882.862342753167, 6967.268436814163, 6982.615956122411, 7013.859722805515, 7065.364117229423, 6452.612843229421, 6465.0, 6471.9968404896845, 6510.93489065108, 6525.0, 7121.750738724223, 7137.357637812622, 7202.603856787875, 7253.56478611285, 7266.309700578437, 6837.931620683829, 6867.416269617139, 6875.278095799969, 6958.304169583002, 6968.512204145661, 6815.625140617214, 6878.174619045646, 6936.375726184668, 7022.6488675566015, 7054.717811287491, 6895.0, 6916.308369163044, 6930.584164950119, 6961.199462061826, 7016.5088443808445, 6917.481188910851, 6920.723171073201, 6955.65221738911, 7013.368796808311, 7051.541649792747, 5056.393232812086, 5076.593872490192, 5145.897082058338, 5147.459516750687, 5160.948390516121, 4504.301833215857, 4558.931616025762, 4564.109998550251, 4572.5198854119835, 4575.084983003413, 6357.300696923335, 6484.675766211671, 6524.543281970216, 6537.705803238866, 6540.018997150465, 6983.685734141975, 6994.300569942965, 7008.719651213894, 7020.543664661781, 7060.117485314336, 6375.71309291083, 6470.870582588322, 6487.0, 6545.934540654628, 6557.639329836905, 5537.833864984057, 5618.381977982419, 5632.662040277514, 5638.069718496402, 5639.069553523705, 7182.96408517954, 7208.171060328024, 7229.385502232264, 7254.202037775841, 7267.091613548307, 6945.47908906834, 6959.0, 6961.37347638715, 7053.0, 7061.364477197077, 7004.264552221944, 7121.394681451928, 7132.714691412493, 7144.24985376528, 7235.493515454078, 6893.138357705287, 6952.756653517103, 6961.164660240804, 6968.581885086911, 6988.580685158907, 6969.0, 6983.266756990442, 7005.684744186422, 7048.753293634698, 7056.1179852518435, 6692.866142677021, 6707.798766037026, 6714.865702686016, 6789.0, 6838.076859624086, 6615.272320044695, 6737.326267373223, 6742.730290788313, 6746.595204287759, 6747.6626168692355, 6739.696713647995, 6743.831404214934, 6745.696443660146, 6754.020667003355, 6758.222804377559, 6682.264950855305, 6723.025161351675, 6829.078074459884, 6838.829029274308, 6842.828929276808, 6398.776042838478, 6421.165248517663, 6443.033544968105, 6452.677366131768, 6460.838479038061], "value": 6310.112901589594, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [882.5454890731272, 938.1228551304536, 957.2724729205804, 966.5360626899088, 981.4651015196717, 41905.0, 42718.35922461165, 43007.78496107523, 43030.78484607572, 43143.78428107859, 39211.803940980324, 39417.0, 39467.80266098673, 39519.20961580767, 39538.60461395385, 7280.089988751392, 7368.484206105575, 7411.0736157980255, 7414.962925185367, 7415.517991330573, 7334.376577990877, 7431.665575049135, 7438.739644112457, 7439.330460258576, 7439.628018599075, 7848.215178482134, 8073.596320183968, 8093.595320233994, 8095.392845536609, 8102.635381407821, 7961.402894782886, 8023.919760802376, 8035.0, 8040.798980025487, 8049.51702897828, 7731.574763388011, 7872.72445464406, 7890.289873911318, 7894.960525197394, 7912.841743165162, 37617.811910940545, 37627.623723762685, 37673.24653506942, 37683.0, 37751.244975100344, 3624.257027309395, 3685.7972811495356, 3687.1519550503535, 3687.797171155585, 3693.242885208526, 32716.0, 32728.181795455064, 32901.17747056319, 32978.17554561155, 33020.33959320824, 5502.376798844351, 5515.117581186991, 5530.5299049580835, 5534.225208470817, 5634.408387119375, 206671.9999999985, 206907.0, 207408.0, 207436.0, 208106.0, 48147.27779083316, 48493.27260091101, 48715.0, 49005.0, 49050.264246036335, 52044.73977630088, 52155.0, 52344.0, 52463.0, 52534.21198682023, 15608.921955390151, 15824.76262856058, 15829.604259893364, 15845.0, 15883.126428046568, 12906.870931290567, 12928.418221180069, 12964.870351296555, 12971.675708107185, 12972.870271297355, 14037.0, 14243.287835608178, 14332.283385830668, 14388.640283992983, 14420.278986050656, 5499.395066542677, 5594.552435805126, 5624.184493248456, 5648.802291919763, 5694.402087780806, 1079.8434227037035, 1084.6691759013577, 1088.2273585754203, 1089.1450211584026, 1095.4960718069776, 23731.406714831923, 24487.755122448903, 24489.265452000487, 24564.87717561401, 24712.629310560354, 1175.8882906124077, 1188.7919614067503, 1189.9762004759857, 1206.90344772418, 1210.1105687319814, 16984.66030679404, 17537.947723136396, 17659.117044148, 17991.370302039366, 18420.88159861633, 286609.0, 288383.0, 289033.0, 289358.0, 290078.0, 58431.12353314704, 61404.385956139864, 61876.0, 63500.047499287546, 63673.68163159154, 1500.482333594908, 1525.6872341170033, 1534.1638806850294, 1541.0, 1561.8750499959976, 30068.24829379283, 30245.546316804826, 30346.241343966576, 30454.23864403319, 31098.378032439676, 40026.0, 40171.39742903917, 40252.1949561013, 40261.0, 40262.79868600638, 176251.0, 177025.1148744248, 178444.0, 178471.0, 178541.0, 36292.27415451729, 36364.81817590895, 36437.45343819898, 36551.26897462089, 36958.260834783694, 43935.56064439315, 44136.558634413246, 44157.33763993607, 44193.77903110464, 44658.55341446544, 32942.34115317728, 33029.834850826555, 33121.66878331282, 33203.0, 33435.83282083574, 30452.23869403194, 30892.53661195039, 31024.0, 31145.532817008218, 31326.530102048942, 38215.235695286494, 38300.42549361706, 38361.616383835804, 38567.80716096402, 38637.42043869288, 34468.31063378769, 35255.47116793199, 35737.28525429529, 35892.82053589715, 35963.46054809232, 26126.0, 26312.736872631027, 26881.827704893345, 27084.0, 27305.863470682518], "value": 18116.813445613356, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.5756661287342, 574.6552068758748, 590.5098768022536, 592.9318128415232, 604.8487878030492, 22588.88705556472, 23058.423539411502, 23417.648735268944, 23513.412164695892, 23640.172593959192, 23392.298231053053, 25986.350341241432, 26133.0, 26251.3437164071, 26319.078832240877, 6798.354156355138, 6960.547564408297, 6967.163940327167, 6968.581885086885, 7029.929700702979, 6249.218847644044, 6548.246951600556, 6549.934500655004, 6774.153230846145, 6836.726530938757, 6474.514411419139, 6492.480601551864, 6493.026046093077, 6505.60966342021, 6528.151340325751, 6516.609003459784, 6521.282658907517, 6525.445337146348, 6532.281449040625, 6538.673066346663, 6069.544784141207, 6075.726592303357, 6081.0, 6139.662318572477, 6139.785107521216, 28770.568441473395, 29590.0, 30019.69980300191, 30074.849625751733, 30257.697423025707, 2189.5292512109813, 2222.1111555377815, 2241.5965126277265, 2242.7757224277607, 2248.213125406111, 20390.0, 21109.8944505278, 21121.68317475239, 21128.471788205265, 21139.682904756442, 2522.571162902311, 2535.32813804342, 2600.5189040027653, 2604.817662763607, 2613.5426300397353, 137656.31171844178, 143249.0, 143310.28344858313, 143491.0, 143711.28144359315, 15438.691226175413, 15742.842571574138, 15892.52322430329, 16144.75782863258, 16263.430779922646, 25991.870040650054, 48448.7577562117, 49785.25322120171, 50178.74910625423, 50202.49797502051, 10923.781524369628, 10974.341539507655, 11025.779484410426, 11808.645740627622, 11887.0, 9579.521023948913, 9609.231261499064, 9679.854802177973, 9746.31775775689, 9747.805043899083, 11819.822702659296, 11936.791693536723, 12100.273983561014, 12212.0, 12239.062624969943, 3630.6913912317223, 4062.7451764270522, 4397.824087036547, 4528.414606825493, 4581.610563102107, 1028.2031425645184, 1056.1286938275953, 1056.6513050693252, 1057.1120258982492, 1058.6136060337922, 21336.466588335417, 21422.250221242495, 21566.24518141889, 22388.88805555962, 22615.773842261697, 1118.4351902289293, 1119.2948442481347, 1124.0501775999267, 1136.7896939066134, 1137.7838210739933, 12083.0, 12109.636710898687, 12136.635900922987, 12218.633440996606, 12331.876681233252, 478635.0, 492453.0, 497601.0, 498725.0, 560569.0, 124671.0, 127197.0, 128277.0, 128280.0, 129181.0, 1236.2458900070949, 1252.461441580111, 1282.3908643394313, 1287.5107459165645, 1288.0532808385829, 19564.510887227934, 19896.910824363233, 23210.071597135924, 24188.395290117183, 24472.87763561171, 61139.38860611515, 61543.0, 61757.38242617696, 61813.0, 63768.362316376246, 84019.15980840358, 85250.1474985267, 85279.14720852712, 86466.1353386458, 88024.5598772002, 16044.598885027968, 16318.673626527641, 16369.754453683443, 16511.752323714914, 16595.50213493597, 25031.874840625682, 25141.371465713502, 25318.240452786446, 25463.490730185662, 25497.61753573661, 19424.320148794723, 19610.90194549075, 19640.607187856447, 19641.0, 20751.169953201705, 16669.83330166683, 17164.313427462763, 17424.47726568205, 17551.473455796346, 17618.11909404499, 20624.0, 20773.27293544719, 20814.687779683012, 21104.155833766476, 21194.894025529775, 15966.12186329763, 16011.919940400223, 16058.0, 16068.43760468378, 16143.75784363212, 19790.802091978894, 20368.08343624511, 20592.176312947315, 20652.0, 20698.896505517376], "value": 13250.968883473866, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1448.7102579484103, 1484.7104814561164, 1488.8511148885113, 1506.141499345373, 1523.0633160606228, 16647.33410663572, 16659.0, 17328.220230089646, 17359.392421265275, 17363.218655160515, 17288.82711172888, 17778.0, 17787.82212177878, 17813.465596032107, 17814.109294535287, 2708.674959004922, 2757.531219692647, 2758.1036163247027, 2759.6826364968083, 2763.5301998660275, 2646.7220941801124, 2701.9594706079424, 2721.18364490653, 2734.753872151506, 2813.22636275025, 2700.729927007303, 2718.796090293226, 2731.4673638640475, 2745.931351716213, 2749.5188342040165, 2630.973690263092, 2645.722199169079, 2649.165512863461, 2651.231142968537, 2653.4825708986755, 2612.596411301588, 2639.920802375932, 2641.418887844671, 2653.9867300663373, 2657.0434643528315, 16524.25640846165, 16803.411880584244, 16864.072476013815, 16940.745888811678, 16950.0, 7529.284717951786, 7767.067951845758, 7797.727079552188, 7800.960995195044, 7810.492317999312, 5146.716930568818, 5156.432792392834, 5177.145770947789, 5223.399309079467, 5313.840584782462, 2143.95712085759, 2149.7312835895514, 2184.7050648162453, 2185.868847869133, 2229.2754854672135, 30665.540016899766, 30885.691143088505, 30938.690613093808, 30983.53524697109, 30996.845015775, 6483.4164925156965, 6513.576617519846, 6537.215534135934, 6600.966995164993, 6655.23464801554, 19581.0, 19617.019149042775, 19619.411417657495, 19628.901855490632, 19653.50866228356, 8075.798105047304, 8320.417570769989, 8320.500769953822, 8322.791930201793, 8328.458650187718, 7170.103737032871, 7268.0914885639295, 7310.086239220098, 7342.48602597813, 7346.77959661211, 5248.291480650139, 5381.596380271495, 5395.568354531628, 5411.323584551931, 5448.727563621803, 1426.12293439536, 1433.8924580656492, 1442.5455981365835, 1503.624093976506, 1528.808898887639, 948.800751842107, 958.2573505533128, 981.4727077774759, 991.1971303244395, 994.22450488619, 8710.041895391501, 9032.412893161923, 9250.213731832735, 9395.57719902606, 9404.059594040542, 1066.2003497376968, 1078.099786678117, 1081.8918108189275, 1084.4577711144427, 1110.1729211737145, 5333.653312534673, 5425.620206585501, 5755.9424405756245, 5801.593888427854, 5890.322612899486, 24520.632190517157, 25498.617520737203, 25549.105781297938, 25689.87155064213, 25702.0, 24052.39869003254, 25165.496690066462, 25240.116595919055, 25263.242102736946, 25330.0, 11994.64016079519, 12478.126531142732, 12729.172603780724, 12739.55411560591, 12764.489420423264, 9071.455712657262, 9376.0, 9492.905070949202, 9571.138597526256, 9777.16894063984, 19897.104630291382, 19914.402567922985, 20214.090365933862, 20673.379798606067, 20950.58098838045, 20843.478913027295, 21191.046402912216, 21597.892010539847, 21731.022104005675, 21803.345899622404, 13852.307384630929, 13855.930720346334, 13897.652558686113, 13959.581212563638, 14142.78785818193, 15550.533483995498, 15678.9216053919, 15689.215539222765, 15697.136657483492, 15701.607459813597, 12069.336186509827, 12121.333326667118, 12256.325902075472, 12309.569165079538, 12397.690057748629, 12101.878981210075, 12390.442430090487, 12401.62795116148, 12536.623901282976, 12614.621561353175, 10892.074173695324, 10914.672559823219, 10950.34297942126, 10951.288166269167, 10954.123670106532, 7799.6100194988885, 7922.286994170552, 7952.284294413531, 8025.638846251816, 8108.148644392254, 7304.452166087458, 7484.0, 7554.169041405551, 7557.508761930457, 7636.350910172698], "value": 7190.90318291897, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.9121740521513, 550.1472717288203, 569.7578529125122, 569.8347479231021, 573.4523530028823, 6258.624482531051, 6294.716737746801, 6322.589031712947, 6324.557280990332, 6347.682615869211, 6205.007198848185, 6224.0, 6248.937510624893, 6250.781222657208, 6302.1177035215, 5105.6936583805, 5106.668066575679, 5111.488851114877, 5118.334616499868, 5139.152039913429, 4853.272009198613, 5092.083424983502, 5127.692338459686, 5134.741988212874, 5138.254953031808, 4948.604111671076, 4955.529224723646, 4967.850964471054, 4980.302757613937, 4988.900221995558, 4969.18008528596, 4973.378327709036, 4986.4514903360605, 4988.052270068712, 4998.125328067574, 4414.933775993362, 4488.768086977371, 4502.234620114556, 4502.504724480337, 4505.481869584974, 6139.969300153515, 6147.44672979434, 6157.353477884847, 6173.876522469571, 6186.443220110166, 5872.412758724094, 5878.265216847894, 5902.852428689274, 5903.232579764646, 5912.379200183962, 6732.576272541881, 6734.158230221223, 6753.966230168818, 6754.108849522142, 6766.763163289311, 5076.832328564414, 5078.248004438463, 5083.525777524514, 5084.46613105626, 5093.363329583802, 6671.2654709775325, 6864.279250678706, 6908.827279318007, 6957.61733104679, 7048.647567621599, 5185.611079169077, 5189.948100519022, 5214.97392513035, 5225.790968361223, 5226.5818734501145, 5257.764425360037, 5281.762320695578, 5281.973590132102, 5292.867678308073, 5293.735313234323, 5785.884282314414, 5830.883382332329, 5838.649681019152, 5855.707214639251, 5877.353491115974, 6581.901271480931, 6637.435817955431, 6676.899846502306, 6693.598384096969, 6703.731850726014, 1809.095452273863, 1827.601884558314, 1836.4307064809952, 1837.4487653703836, 1839.5033340998123, 1216.3127832774453, 1271.5867343113525, 1275.8963496575582, 1300.7268473620645, 1302.8957683385306, 6284.717187726564, 6293.653849038255, 6322.111901180832, 6337.271213810379, 6369.585976911486, 6704.6982885769285, 6742.292059333699, 6773.322667733188, 6786.796396108125, 6795.150606174228, 5989.64062156272, 6138.570300079041, 6189.381061893775, 6205.596636218631, 6276.905846412307, 3536.328097661436, 3558.7153027757718, 3580.013092733558, 3584.426491761306, 3607.981960090235, 6899.862002760017, 6957.199922008933, 6986.231514533397, 6987.755428559976, 7008.369246767714, 6933.341332573397, 6954.895676564855, 7025.262347453444, 7043.859122817515, 7058.188308344606, 6962.408195303355, 7009.7897063088185, 7043.823904402533, 7049.929500704928, 7058.364747172779, 6733.494987875831, 6735.360140786617, 6763.5941843489545, 6773.593584384953, 6789.626570538668, 6580.5064620154635, 6583.210014798064, 6613.14029176204, 6641.169853768279, 6673.766418175534, 6851.280615535297, 6881.552699074544, 6902.446094944702, 6919.238883722887, 6994.790156295319, 5140.614453916046, 5173.1722924331925, 5178.119719647744, 5183.688978661293, 5191.974040129926, 6516.067769503837, 6544.574602650812, 6746.8650626988165, 6794.524383293122, 6821.420179284816, 6480.282725077764, 6490.870182596416, 6503.764469602016, 6514.0, 6590.538662293593, 6492.805215843532, 6496.675166241764, 6499.870002600016, 6503.0, 6634.445738390657, 6464.741410343534, 6477.0, 6518.217813862367, 6591.868162636624, 6599.274079851117, 6539.803805885831, 6580.440662543738, 6646.241809648942, 6647.069410282467, 6706.798796036127, 6422.486201103994, 6430.1319321892815, 6431.774887878902, 6435.165977696334, 6531.804045878631], "value": 5190.473623849343, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [985.216752681618, 999.0359303272343, 1019.23557332001, 1032.0866033560296, 1032.210359075307, 18697.81302186981, 19293.0, 19870.10584523696, 19895.40313790585, 19898.0, 21146.048427820748, 22091.116355345766, 22117.115315387404, 22148.88925555374, 22163.667544986798, 1084.8698156221265, 1086.4241951765537, 1091.0507858163369, 1093.535247519805, 1095.7370231144548, 1091.9945400273027, 1092.268180319184, 1092.3391348234322, 1092.421016861061, 1095.413953534859, 1145.1010956399227, 1150.7813515432042, 1150.9194356395055, 1151.4070253819248, 1156.2773266708307, 1140.657802659203, 1145.032447581792, 1145.37004647444, 1145.484531960621, 1146.8222425524057, 838.9161083891623, 842.5197637346715, 843.6541018182577, 845.1506236232608, 846.3779122345071, 17780.555486112822, 18113.45659630213, 18145.818541814544, 20345.593088138154, 20561.38315850527, 22963.7703622965, 23085.884570577207, 23245.883770581208, 23322.300330990096, 23433.41416464585, 18032.729509057375, 18181.72727409077, 18272.269109235614, 18342.174602142935, 18375.72436413455, 3971.8609848655447, 3988.8603898863403, 3993.6206060424215, 3999.320115580358, 4002.819873105688, 146912.99999999892, 148828.0, 148987.0, 149429.25285373614, 149520.2523987373, 17439.389621363192, 17486.912565437346, 18030.00834954064, 18055.909720451575, 18357.449276521726, 33306.66693333036, 33758.49362259568, 33887.661123388454, 34150.65849341475, 34548.13629659228, 7983.081945576333, 8489.278411334983, 9246.4914429707, 9438.056194380644, 9473.621055157717, 4725.763711814396, 4813.03739252151, 4819.3012013258585, 4820.5420485054565, 4830.2996065571, 5787.479126878601, 5864.765409383662, 5869.0, 5876.206712093898, 5888.882222355614, 1262.501311981762, 1264.462603393554, 1292.5476083370745, 1294.449858810002, 1302.798066299725, 741.1995045351116, 757.9886301705479, 760.2967255288836, 777.40916903154, 787.6534324897027, 12922.741545169043, 13056.151350162208, 13501.392437340342, 14053.0, 14182.929085354508, 729.099562040879, 738.4314078159787, 747.8856503809285, 752.3943225703362, 761.6191904047976, 6228.47058000066, 7220.566765994057, 7278.344948954619, 7314.853702925911, 7336.082989626297, 129871.35064324617, 130717.34641326733, 131460.0, 132060.0, 139060.30469847587, 114258.42870785759, 119193.40403298101, 119730.0, 121487.39256303661, 123464.38267808604, 102901.0, 103064.0, 103441.0, 103753.48123259486, 105728.47135764272, 13124.0, 13277.269750163834, 13286.003549734001, 13754.793678095037, 13898.16611003343, 47936.0, 48484.272735908286, 51179.97640047253, 51909.48090519047, 52248.47751522588, 80837.59581202056, 84627.5768621153, 87155.56422217848, 87186.56406717926, 88078.55960720155, 16695.74956375631, 20159.697604536235, 20702.171913123308, 20811.583768324246, 20825.89587052055, 21597.784022159576, 21726.0, 22941.770582293964, 23713.762862371157, 24016.87991560031, 19285.0, 19859.900700496404, 19917.402477925687, 20307.187712491334, 20763.273285434938, 20865.269715559883, 20933.476663083544, 21210.893945530173, 21700.565988679824, 22032.228871989402, 20606.484837878572, 21381.679274811202, 21457.46356341104, 21591.38623957751, 21731.0, 15422.922885385502, 15556.611084722972, 15860.20698965024, 16114.27485763167, 16175.838241617434, 15164.469243576423, 15352.0, 15621.45324913668, 15779.447719329768, 15817.604559885634], "value": 10296.862433931872, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1444.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 109.0, 98.0, 106.0, 105.0, 107.0, 107.0, 96.0, 106.0, 110.0], "value": 104.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 116.0, 142.0, 170.0, 111.0, 136.0, 139.0, 115.0, 168.0, 113.0], "value": 135.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 164.0, 162.0, 162.0, 164.0, 163.0, 161.0, 164.0, 173.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 166.0, 74.0, 77.0, 74.0, 73.0, 172.0, 73.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 130.0, 81.0, 83.0, 78.0, 129.0, 78.0, 78.0, 124.0], "value": 93.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 115.0, 114.0, 113.0, 114.0, 113.0, 114.0, 116.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 152.0, 150.0, 150.0, 149.0, 150.0, 151.0, 149.0, 150.0], "value": 150.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 94.0, 95.0, 94.0, 94.0, 93.0, 94.0, 94.0, 93.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 48.0, 46.0, 51.0, 44.0, 46.0, 49.0, 44.0, 45.0, 45.0], "value": 46.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 37.0, 36.0, 37.0, 38.0, 37.0, 38.0, 37.0, 37.0, 38.0], "value": 37.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 72.0, 73.0, 73.0, 72.0, 71.0, 71.0, 72.0, 73.0], "value": 72.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 121.0, 118.0, 116.0, 126.0, 114.0, 116.0, 113.0, 152.0], "value": 120.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 158.0, 161.0, 162.0, 162.0, 167.0, 158.0, 159.0, 155.0, 160.0], "value": 160.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 64.0, 62.0, 62.0, 58.0, 58.0, 60.0, 61.0, 60.0, 58.0], "value": 60.3, "unit": "score"}]}]} 18:25:06 INFO - Return code: 0 18:25:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:25:06 INFO - # TBPL SUCCESS # 18:25:06 INFO - Running post-action listener: _package_coverage_data 18:25:06 INFO - Running post-action listener: _resource_record_post_action 18:25:06 INFO - [mozharness: 2017-09-07 01:25:06.745489Z] Finished run-tests step (success) 18:25:06 INFO - Running post-run listener: _resource_record_post_run 18:25:06 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 385830912; Read time: 0; Write time: 334200 18:25:06 INFO - TinderboxPrint: CPU usage
13.1% 18:25:06 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 18:25:06 INFO - TinderboxPrint: I/O write bytes / time
385,830,912 / 334,200 18:25:06 INFO - TinderboxPrint: CPU idle
8,202.5 (86.9%) 18:25:06 INFO - TinderboxPrint: CPU user
1,184.2 (12.5%) 18:25:06 INFO - TinderboxPrint: Swap in / out
0 / 0 18:25:06 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 107180032; Read time: 0; Write time: 114832 18:25:06 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:25:06 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 0; Write bytes: 278650880; Read time: 0; Write time: 219368 18:25:07 INFO - Running post-run listener: _upload_blobber_files 18:25:07 INFO - Blob upload gear active. 18:25:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:25:07 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:25:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:25:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:25:07 INFO - (blobuploader) - INFO - Open directory for files ... 18:25:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 18:25:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:25:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:25:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 18:25:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:25:08 INFO - (blobuploader) - INFO - Done attempting. 18:25:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:25:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:25:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:25:10 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:25:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:25:10 INFO - (blobuploader) - INFO - Done attempting. 18:25:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:25:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:25:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:25:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:25:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:25:16 INFO - (blobuploader) - INFO - Done attempting. 18:25:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 18:25:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:25:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:25:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 18:25:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:25:17 INFO - (blobuploader) - INFO - Done attempting. 18:25:17 INFO - (blobuploader) - INFO - Iteration through files over. 18:25:17 INFO - Return code: 0 18:25:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:25:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:25:17 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b6ff000e2c647bb2f69654b7d5cbfe4635dc71bbd4608157e3c510ba6ad6a32d620d8bb5548f6ce09980a13baa6cefeda7b0efdd08f685a27dcdadc118252d4", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/266aff517a2578779c0a7c267e12612dcf89a22bcde52d0cca23bba5835d0c53e50ca234b22aaaab7b238195e47c485e7ed34f5de764a33c1cc51749449004e7", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/16c7032dd158c7530323cc1082d0bda2eca5d1e306ef6f8a1dd15e6276cf04a7f2cc86e57ac1dc96c06d995e303880558c9ef4a8cc14fbb8912725553cff4d0a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3fd23718f644b0b6b599502b9dfc94dbbe3b6677920c07b391495e6983841c0f6dbfdc4faf5f9201a700026ae3660ef5106ea7247b2da861d58f5842ec9d6ad5"} 18:25:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:25:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:25:17 INFO - Contents: 18:25:17 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b6ff000e2c647bb2f69654b7d5cbfe4635dc71bbd4608157e3c510ba6ad6a32d620d8bb5548f6ce09980a13baa6cefeda7b0efdd08f685a27dcdadc118252d4", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/266aff517a2578779c0a7c267e12612dcf89a22bcde52d0cca23bba5835d0c53e50ca234b22aaaab7b238195e47c485e7ed34f5de764a33c1cc51749449004e7", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/16c7032dd158c7530323cc1082d0bda2eca5d1e306ef6f8a1dd15e6276cf04a7f2cc86e57ac1dc96c06d995e303880558c9ef4a8cc14fbb8912725553cff4d0a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3fd23718f644b0b6b599502b9dfc94dbbe3b6677920c07b391495e6983841c0f6dbfdc4faf5f9201a700026ae3660ef5106ea7247b2da861d58f5842ec9d6ad5"} 18:25:17 INFO - Running post-run listener: copy_logs_to_upload_dir 18:25:17 INFO - Copying logs to upload dir... 18:25:17 INFO - mkdir: /builds/slave/test/build/upload/logs 18:25:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.796856 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-09-06 18:25:17.808217) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-06 18:25:17.811876) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1504746270.959390-84819962 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b6ff000e2c647bb2f69654b7d5cbfe4635dc71bbd4608157e3c510ba6ad6a32d620d8bb5548f6ce09980a13baa6cefeda7b0efdd08f685a27dcdadc118252d4", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/266aff517a2578779c0a7c267e12612dcf89a22bcde52d0cca23bba5835d0c53e50ca234b22aaaab7b238195e47c485e7ed34f5de764a33c1cc51749449004e7", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/16c7032dd158c7530323cc1082d0bda2eca5d1e306ef6f8a1dd15e6276cf04a7f2cc86e57ac1dc96c06d995e303880558c9ef4a8cc14fbb8912725553cff4d0a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3fd23718f644b0b6b599502b9dfc94dbbe3b6677920c07b391495e6983841c0f6dbfdc4faf5f9201a700026ae3660ef5106ea7247b2da861d58f5842ec9d6ad5"} build_url:https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011404 build_url: 'https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b6ff000e2c647bb2f69654b7d5cbfe4635dc71bbd4608157e3c510ba6ad6a32d620d8bb5548f6ce09980a13baa6cefeda7b0efdd08f685a27dcdadc118252d4", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/266aff517a2578779c0a7c267e12612dcf89a22bcde52d0cca23bba5835d0c53e50ca234b22aaaab7b238195e47c485e7ed34f5de764a33c1cc51749449004e7", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/16c7032dd158c7530323cc1082d0bda2eca5d1e306ef6f8a1dd15e6276cf04a7f2cc86e57ac1dc96c06d995e303880558c9ef4a8cc14fbb8912725553cff4d0a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3fd23718f644b0b6b599502b9dfc94dbbe3b6677920c07b391495e6983841c0f6dbfdc4faf5f9201a700026ae3660ef5106ea7247b2da861d58f5842ec9d6ad5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-06 18:25:17.844813) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 18:25:17.845653) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1504746270.959390-84819962 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004499 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 18:25:17.930967) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-06 18:25:17.931755) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-06 18:25:17.932482) ========= ========= Total master_lag: 0.22 =========