builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-064 starttime: 1504893802.66 results: success (0) revision: 6d0288c291650ab619dc4ff92cb0b60e3b6e7b3b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-08 11:03:22.658097) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-08 11:03:22.658795) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-08 11:03:22.659114) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-08 11:03:22.686406) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 11:03:22.686807) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1504891611.93820-649172738 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-08 11:03:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2017-09-08 11:03:22 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.092337 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 11:03:22.806920) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 11:03:22.807482) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1504891611.93820-649172738 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023949 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 11:03:22.867732) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 11:03:22.868090) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6d0288c291650ab619dc4ff92cb0b60e3b6e7b3b --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 6d0288c291650ab619dc4ff92cb0b60e3b6e7b3b --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=a12cd81e0ef515edd9e0d800000001bb-1504891611.93820-649172738 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-08 11:03:22,931 truncating revision to first 12 chars 2017-09-08 11:03:22,931 Setting DEBUG logging. 2017-09-08 11:03:22,931 attempt 1/10 2017-09-08 11:03:22,931 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6d0288c29165?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-08 11:03:23,353 unpacking tar archive at: mozilla-central-6d0288c29165/testing/mozharness/ program finished with exit code 0 elapsedTime=0.695492 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 11:03:23.591226) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-08 11:03:23.591525) ========= script_repo_revision: 6d0288c291650ab619dc4ff92cb0b60e3b6e7b3b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-08 11:03:23.591902) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-08 11:03:23.592206) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-08 11:03:23.627470) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-08 11:03:23.627780) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1504891611.93820-649172738 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:03:23 INFO - MultiFileLogger online at 20170908 11:03:23 in /builds/slave/test 11:03:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 11:03:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:03:23 INFO - {'append_to_log': False, 11:03:23 INFO - 'base_work_dir': '/builds/slave/test', 11:03:23 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 11:03:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:03:23 INFO - 'branch': 'Firefox-Non-PGO', 11:03:23 INFO - 'buildbot_json_path': 'buildprops.json', 11:03:23 INFO - 'code_coverage': False, 11:03:23 INFO - 'config_files': ('talos/linux_config.py',), 11:03:23 INFO - 'default_actions': ('clobber', 11:03:23 INFO - 'read-buildbot-config', 11:03:23 INFO - 'download-and-extract', 11:03:23 INFO - 'populate-webroot', 11:03:23 INFO - 'create-virtualenv', 11:03:23 INFO - 'install', 11:03:23 INFO - 'setup-mitmproxy', 11:03:23 INFO - 'run-tests'), 11:03:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:03:23 INFO - 'disable_ccov_upload': False, 11:03:23 INFO - 'disable_stylo': False, 11:03:23 INFO - 'download_minidump_stackwalk': True, 11:03:23 INFO - 'download_symbols': 'ondemand', 11:03:23 INFO - 'enable_stylo': False, 11:03:23 INFO - 'enable_webrender': False, 11:03:23 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:03:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:03:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:03:23 INFO - 'gecko_profile': False, 11:03:23 INFO - 'gecko_profile_interval': 0, 11:03:23 INFO - 'installer_path': 'installer.exe', 11:03:23 INFO - 'log_level': 'info', 11:03:23 INFO - 'log_name': 'talos', 11:03:23 INFO - 'log_to_console': True, 11:03:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:03:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:03:23 INFO - 'opt_config_files': (), 11:03:23 INFO - 'pip_index': False, 11:03:23 INFO - 'suite': 'dromaeojs-e10s', 11:03:23 INFO - 'system_bits': '32', 11:03:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:03:23 INFO - 'title': 'talos-linux64-ix-064', 11:03:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:03:23 INFO - 'use_talos_json': True, 11:03:23 INFO - 'verify': 'False', 11:03:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:03:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:03:23 INFO - 'work_dir': 'build'} 11:03:23 INFO - [mozharness: 2017-09-08 18:03:23.824782Z] Running clobber step. 11:03:23 INFO - Running pre-action listener: _resource_record_pre_action 11:03:23 INFO - Running main action method: clobber 11:03:23 INFO - rmtree: /builds/slave/test/build 11:03:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:03:24 INFO - Running post-action listener: _resource_record_post_action 11:03:24 INFO - [mozharness: 2017-09-08 18:03:24.826767Z] Finished clobber step (success) 11:03:24 INFO - [mozharness: 2017-09-08 18:03:24.826863Z] Running read-buildbot-config step. 11:03:24 INFO - Running pre-action listener: _resource_record_pre_action 11:03:24 INFO - Running main action method: read_buildbot_config 11:03:24 INFO - Using buildbot properties: 11:03:24 INFO - { 11:03:24 INFO - "project": "", 11:03:24 INFO - "product": "firefox", 11:03:24 INFO - "who": "ffxbld@noreply.mozilla.org", 11:03:24 INFO - "installer_path": "public/build/target.tar.bz2", 11:03:24 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 11:03:24 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:03:24 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 11:03:24 INFO - "stage_platform": "linux64", 11:03:24 INFO - "basedir": "/builds/slave/test", 11:03:24 INFO - "buildnumber": 1125, 11:03:24 INFO - "platform": "ubuntu64_hw", 11:03:24 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:03:24 INFO - "slavebuilddir": "test", 11:03:24 INFO - "taskId": "KRM0Yza3SjakV4XDagTgnQ", 11:03:24 INFO - "branch": "mozilla-central", 11:03:24 INFO - "script_repo_revision": "production", 11:03:24 INFO - "revision": "6d0288c291650ab619dc4ff92cb0b60e3b6e7b3b", 11:03:24 INFO - "slavename": "talos-linux64-ix-064", 11:03:24 INFO - "repo_path": "mozilla-central" 11:03:24 INFO - } 11:03:24 INFO - Finding installer, test and symbols from parent task. 11:03:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KRM0Yza3SjakV4XDagTgnQ'}, attempt #1 11:03:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KRM0Yza3SjakV4XDagTgnQ'}, attempt #1 11:03:25 INFO - Task dependencies: RlzMfz8tRFW8DsiiCEg_WA 11:03:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA'}, attempt #1 11:03:26 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.tar.bz2 11:03:26 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.test_packages.json 11:03:26 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.crashreporter-symbols.zip 11:03:26 INFO - Running post-action listener: _resource_record_post_action 11:03:26 INFO - [mozharness: 2017-09-08 18:03:26.189751Z] Finished read-buildbot-config step (success) 11:03:26 INFO - [mozharness: 2017-09-08 18:03:26.189967Z] Running download-and-extract step. 11:03:26 INFO - Running pre-action listener: _resource_record_pre_action 11:03:26 INFO - Running main action method: download_and_extract 11:03:26 INFO - mkdir: /builds/slave/test/build/tests 11:03:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:26 INFO - trying https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.test_packages.json 11:03:26 INFO - Downloading https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:03:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:03:26 INFO - Downloaded 989 bytes. 11:03:26 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:03:26 INFO - Using the following test package requirements: 11:03:26 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:03:26 INFO - u'common': [u'target.common.tests.zip'], 11:03:26 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:03:26 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:03:26 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:03:26 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:03:26 INFO - u'mozbase': [u'target.common.tests.zip'], 11:03:26 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:03:26 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:03:26 INFO - u'web-platform': [u'target.common.tests.zip', 11:03:26 INFO - u'target.web-platform.tests.tar.gz'], 11:03:26 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:03:26 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:03:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.common.tests.zip 11:03:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:03:26 INFO - Fetch https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.common.tests.zip into memory 11:03:27 INFO - Content-Length response header: 55023640 11:03:27 INFO - Bytes received: 55023640 11:03:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.talos.tests.zip 11:03:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:03:38 INFO - Fetch https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.talos.tests.zip into memory 11:03:39 INFO - Content-Length response header: 14496665 11:03:39 INFO - Bytes received: 14496665 11:03: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')]} 11:03:39 INFO - trying https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.tar.bz2 11:03:39 INFO - Downloading https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:03:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:03:41 INFO - Downloaded 62833296 bytes. 11:03:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.tar.bz2 11:03:41 INFO - mkdir: /builds/slave/test/properties 11:03:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:03:41 INFO - Writing to file /builds/slave/test/properties/build_url 11:03:41 INFO - Contents: 11:03:41 INFO - build_url:https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.tar.bz2 11:03:41 INFO - Running post-action listener: _resource_record_post_action 11:03:41 INFO - Running post-action listener: find_tests_for_verification 11:03:41 INFO - Running post-action listener: set_extra_try_arguments 11:03:41 INFO - [mozharness: 2017-09-08 18:03:41.170768Z] Finished download-and-extract step (success) 11:03:41 INFO - [mozharness: 2017-09-08 18:03:41.170880Z] Running populate-webroot step. 11:03:41 INFO - Running pre-action listener: _resource_record_pre_action 11:03:41 INFO - Running main action method: populate_webroot 11:03:41 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:03:41 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:03:41 INFO - 'tests': ['tresize', 11:03:41 INFO - 'tcanvasmark']}, 11:03:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:03:41 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:03:41 INFO - 'tests': ['dromaeo_css', 11:03:41 INFO - 'kraken']}, 11:03:41 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:03:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:03:41 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:03:41 INFO - 'talos_options': ['--disable-stylo'], 11:03:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:03:41 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:03:41 INFO - 'tests': ['damp', 'tps']}, 11:03:41 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:03:41 INFO - 'talos_options': ['--disable-stylo'], 11:03:41 INFO - 'tests': ['damp', 'tps']}, 11:03:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:03:41 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:03:41 INFO - 'tests': ['dromaeo_dom']}, 11:03:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:03:41 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:03:41 INFO - 'tests': ['basic_compositor_video', 11:03:41 INFO - 'glvideo']}, 11:03:41 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:03:41 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:03:41 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:03:41 INFO - 'talos_options': ['--disable-stylo'], 11:03:41 INFO - 'tests': ['ts_paint_webext', 11:03:41 INFO - 'tp5o_webext']}, 11:03:41 INFO - 'other-e10s': {'tests': ['a11yr', 11:03:41 INFO - 'ts_paint', 11:03:41 INFO - 'tpaint', 11:03:41 INFO - 'sessionrestore', 11:03:41 INFO - 'sessionrestore_many_windows', 11:03:41 INFO - 'sessionrestore_no_auto_restore', 11:03:41 INFO - 'tabpaint']}, 11:03:41 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:03:41 INFO - 'tests': ['a11yr', 11:03:41 INFO - 'ts_paint', 11:03:41 INFO - 'tpaint', 11:03:41 INFO - 'sessionrestore', 11:03:41 INFO - 'sessionrestore_many_windows', 11:03:41 INFO - 'sessionrestore_no_auto_restore', 11:03:41 INFO - 'tabpaint']}, 11:03:41 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:03:41 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:03:41 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:03:41 INFO - 'tests': ['bloom_basic_singleton']}, 11:03:41 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:03:41 INFO - 'tests': ['bloom_basic']}, 11:03:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:03:41 INFO - 'tsvgr_opacity', 11:03:41 INFO - 'tart', 11:03:41 INFO - 'tscrollx', 11:03:41 INFO - 'tsvg_static']}, 11:03:41 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:03:41 INFO - 'tests': ['tsvgx', 11:03:41 INFO - 'tsvgr_opacity', 11:03:41 INFO - 'tart', 11:03:41 INFO - 'tscrollx', 11:03:41 INFO - 'tsvg_static']}, 11:03:41 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:03:41 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:03:41 INFO - 'talos_options': ['--disable-stylo'], 11:03:41 INFO - 'tests': ['tp5o']}, 11:03:41 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:03:41 INFO - 'talos_options': ['--mitmproxy', 11:03:41 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:03:41 INFO - '--firstNonBlankPaint'], 11:03:41 INFO - 'tests': ['tp6_google', 11:03:41 INFO - 'tp6_youtube', 11:03:41 INFO - 'tp6_amazon', 11:03:41 INFO - 'tp6_facebook']}, 11:03:41 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:03:41 INFO - 'talos_options': ['--disable-stylo', 11:03:41 INFO - '--mitmproxy', 11:03:41 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:03:41 INFO - '--firstNonBlankPaint'], 11:03:41 INFO - 'tests': ['tp6_google', 11:03:41 INFO - 'tp6_youtube', 11:03:41 INFO - 'tp6_amazon', 11:03:41 INFO - 'tp6_facebook']}, 11:03:41 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:03:41 INFO - 'talos_options': ['--stylo-threads=1', 11:03:41 INFO - '--mitmproxy', 11:03:41 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:03:41 INFO - '--firstNonBlankPaint'], 11:03:41 INFO - 'tests': ['tp6_google', 11:03:41 INFO - 'tp6_youtube', 11:03:41 INFO - 'tp6_amazon', 11:03:41 INFO - 'tp6_facebook']}, 11:03:41 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:03:41 INFO - 'talos_options': ['--xperf_path', 11:03:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:03:41 INFO - 'tests': ['tp5n']}, 11:03:41 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:03:41 INFO - 'talos_options': ['--disable-stylo', 11:03:41 INFO - '--xperf_path', 11:03:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:03:41 INFO - 'tests': ['tp5n']}}} 11:03:41 INFO - Running post-action listener: _resource_record_post_action 11:03:41 INFO - [mozharness: 2017-09-08 18:03:41.187941Z] Finished populate-webroot step (success) 11:03:41 INFO - [mozharness: 2017-09-08 18:03:41.188049Z] Running create-virtualenv step. 11:03:41 INFO - Running pre-action listener: _resource_record_pre_action 11:03:41 INFO - Running main action method: create_virtualenv 11:03:41 INFO - Creating virtualenv /builds/slave/test/build/venv 11:03:41 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:03:41 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:03:41 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:03:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:03:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:03:42 INFO - Installing distribute.............................................................................................................................................................................................done. 11:03:42 INFO - Installing pip...............done. 11:03:42 INFO - Return code: 0 11:03:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:03:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:03:42 INFO - Reading from file tmpfile_stdout 11:03:42 INFO - Output received: 11:03:42 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:03:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:42 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 0xa501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc19a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc0090>, '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 0xdc0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdbaf90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1504891611.93820-649172738', '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 11:03:42 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 11:03:42 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 11:03:42 INFO - Using env: {'DISPLAY': ':0', 11:03:42 INFO - 'HOME': '/home/cltbld', 11:03:42 INFO - 'LANG': 'en_US.UTF-8', 11:03:42 INFO - 'LANGUAGE': 'en_US:en', 11:03:42 INFO - 'LOGNAME': 'cltbld', 11:03:42 INFO - 'MAIL': '/var/mail/cltbld', 11:03:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:42 INFO - 'MOZ_NO_REMOTE': '1', 11:03:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:42 INFO - 'NO_EM_RESTART': '1', 11:03:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:42 INFO - 'PWD': '/builds/slave/test', 11:03:42 INFO - 'SHELL': '/bin/bash', 11:03:42 INFO - 'SHLVL': '1', 11:03:42 INFO - 'TERM': 'linux', 11:03:42 INFO - 'TMOUT': '86400', 11:03:42 INFO - 'USER': 'cltbld', 11:03:42 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1504891611.93820-649172738', 11:03:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:42 INFO - '_': '/tools/buildbot/bin/python'} 11:03:43 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:03:43 INFO - Downloading/unpacking pip>=1.5 11:03:43 INFO - Running setup.py egg_info for package pip 11:03:43 INFO - warning: no files found matching 'pip/cacert.pem' 11:03:43 INFO - warning: no files found matching '*.html' under directory 'docs' 11:03:43 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:03:43 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:03:43 INFO - Installing collected packages: pip 11:03:43 INFO - Found existing installation: pip 1.1 11:03:43 INFO - Uninstalling pip: 11:03:43 INFO - Successfully uninstalled pip 11:03:43 INFO - Running setup.py install for pip 11:03:43 INFO - warning: no files found matching 'pip/cacert.pem' 11:03:43 INFO - warning: no files found matching '*.html' under directory 'docs' 11:03:43 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:03:43 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:03:43 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:03:43 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:03:43 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:03:43 INFO - Successfully installed pip 11:03:43 INFO - Cleaning up... 11:03:43 INFO - Return code: 0 11:03:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:03:43 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')]} 11:03:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:43 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')]} 11:03:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:43 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 0xa501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc19a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc0090>, '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 0xdc0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdbaf90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1504891611.93820-649172738', '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 11:03:43 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 11:03:43 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 11:03:43 INFO - Using env: {'DISPLAY': ':0', 11:03:43 INFO - 'HOME': '/home/cltbld', 11:03:43 INFO - 'LANG': 'en_US.UTF-8', 11:03:43 INFO - 'LANGUAGE': 'en_US:en', 11:03:43 INFO - 'LOGNAME': 'cltbld', 11:03:43 INFO - 'MAIL': '/var/mail/cltbld', 11:03:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:43 INFO - 'MOZ_NO_REMOTE': '1', 11:03:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:43 INFO - 'NO_EM_RESTART': '1', 11:03:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:43 INFO - 'PWD': '/builds/slave/test', 11:03:43 INFO - 'SHELL': '/bin/bash', 11:03:43 INFO - 'SHLVL': '1', 11:03:43 INFO - 'TERM': 'linux', 11:03:43 INFO - 'TMOUT': '86400', 11:03:43 INFO - 'USER': 'cltbld', 11:03:43 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1504891611.93820-649172738', 11:03:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:43 INFO - '_': '/tools/buildbot/bin/python'} 11:03:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:43 INFO - Downloading/unpacking psutil>=3.1.1 11:03:43 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 11:03:43 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 11:03:43 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 11:03:43 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 11:03:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:03:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:03:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:03:45 INFO - Installing collected packages: psutil 11:03:45 INFO - Running setup.py install for psutil 11:03:45 INFO - building 'psutil._psutil_linux' extension 11:03:45 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 11:03:45 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 11:03:45 INFO - building 'psutil._psutil_posix' extension 11:03:45 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 11:03:45 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 11:03:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:03:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:03:45 INFO - Successfully installed psutil 11:03:45 INFO - Cleaning up... 11:03:45 INFO - Return code: 0 11:03:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:03:45 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')]} 11:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:45 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')]} 11:03:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:45 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 0xa501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc19a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc0090>, '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 0xdc0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdbaf90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1504891611.93820-649172738', '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 11:03:45 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 11:03:45 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 11:03:45 INFO - Using env: {'DISPLAY': ':0', 11:03:45 INFO - 'HOME': '/home/cltbld', 11:03:45 INFO - 'LANG': 'en_US.UTF-8', 11:03:45 INFO - 'LANGUAGE': 'en_US:en', 11:03:45 INFO - 'LOGNAME': 'cltbld', 11:03:45 INFO - 'MAIL': '/var/mail/cltbld', 11:03:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:45 INFO - 'MOZ_NO_REMOTE': '1', 11:03:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:45 INFO - 'NO_EM_RESTART': '1', 11:03:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:45 INFO - 'PWD': '/builds/slave/test', 11:03:45 INFO - 'SHELL': '/bin/bash', 11:03:45 INFO - 'SHLVL': '1', 11:03:45 INFO - 'TERM': 'linux', 11:03:45 INFO - 'TMOUT': '86400', 11:03:45 INFO - 'USER': 'cltbld', 11:03:45 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1504891611.93820-649172738', 11:03:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:45 INFO - '_': '/tools/buildbot/bin/python'} 11:03:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:03:45 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 11:03:45 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 11:03:45 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 11:03:45 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 11:03:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:03:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:03:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:03:47 INFO - Installing collected packages: mozsystemmonitor 11:03:47 INFO - Running setup.py install for mozsystemmonitor 11:03:47 INFO - Successfully installed mozsystemmonitor 11:03:47 INFO - Cleaning up... 11:03:48 INFO - Return code: 0 11:03:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:03:48 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')]} 11:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:48 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')]} 11:03:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xa501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc19a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc0090>, '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 0xdc0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdbaf90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1504891611.93820-649172738', '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 11:03:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:03:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:03:48 INFO - Using env: {'DISPLAY': ':0', 11:03:48 INFO - 'HOME': '/home/cltbld', 11:03:48 INFO - 'LANG': 'en_US.UTF-8', 11:03:48 INFO - 'LANGUAGE': 'en_US:en', 11:03:48 INFO - 'LOGNAME': 'cltbld', 11:03:48 INFO - 'MAIL': '/var/mail/cltbld', 11:03:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:48 INFO - 'MOZ_NO_REMOTE': '1', 11:03:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:48 INFO - 'NO_EM_RESTART': '1', 11:03:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:48 INFO - 'PWD': '/builds/slave/test', 11:03:48 INFO - 'SHELL': '/bin/bash', 11:03:48 INFO - 'SHLVL': '1', 11:03:48 INFO - 'TERM': 'linux', 11:03:48 INFO - 'TMOUT': '86400', 11:03:48 INFO - 'USER': 'cltbld', 11:03:48 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1504891611.93820-649172738', 11:03:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:48 INFO - '_': '/tools/buildbot/bin/python'} 11:03:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:48 INFO - Downloading/unpacking jsonschema==2.5.1 11:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:03:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:50 INFO - Downloading functools32-3.2.3-2.tar.gz 11:03:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:03:50 INFO - warning: no files found matching '*.txt' 11:03:50 INFO - no previously-included directories found matching 'build' 11:03:50 INFO - no previously-included directories found matching 'dist' 11:03:50 INFO - no previously-included directories found matching '.git*' 11:03:50 INFO - Installing collected packages: jsonschema, functools32 11:03:50 INFO - Running setup.py install for functools32 11:03:50 INFO - warning: no files found matching '*.txt' 11:03:50 INFO - no previously-included directories found matching 'build' 11:03:50 INFO - no previously-included directories found matching 'dist' 11:03:50 INFO - no previously-included directories found matching '.git*' 11:03:50 INFO - Successfully installed jsonschema functools32 11:03:50 INFO - Cleaning up... 11:03:50 INFO - Return code: 0 11:03:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:03:50 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')]} 11:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:50 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')]} 11:03:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:50 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 0xa501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc19a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc0090>, '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 0xdc0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdbaf90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1504891611.93820-649172738', '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 11:03:50 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 11:03:50 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 11:03:50 INFO - Using env: {'DISPLAY': ':0', 11:03:50 INFO - 'HOME': '/home/cltbld', 11:03:50 INFO - 'LANG': 'en_US.UTF-8', 11:03:50 INFO - 'LANGUAGE': 'en_US:en', 11:03:50 INFO - 'LOGNAME': 'cltbld', 11:03:50 INFO - 'MAIL': '/var/mail/cltbld', 11:03:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:51 INFO - 'MOZ_NO_REMOTE': '1', 11:03:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:51 INFO - 'NO_EM_RESTART': '1', 11:03:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:51 INFO - 'PWD': '/builds/slave/test', 11:03:51 INFO - 'SHELL': '/bin/bash', 11:03:51 INFO - 'SHLVL': '1', 11:03:51 INFO - 'TERM': 'linux', 11:03:51 INFO - 'TMOUT': '86400', 11:03:51 INFO - 'USER': 'cltbld', 11:03:51 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1504891611.93820-649172738', 11:03:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:51 INFO - '_': '/tools/buildbot/bin/python'} 11:03:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:03:51 INFO - Cleaning up... 11:03:51 INFO - Return code: 0 11:03:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:03:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xa501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc19a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc0090>, '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 0xdc0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdbaf90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1504891611.93820-649172738', '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 11:03:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:03:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:03:51 INFO - Using env: {'DISPLAY': ':0', 11:03:51 INFO - 'HOME': '/home/cltbld', 11:03:51 INFO - 'LANG': 'en_US.UTF-8', 11:03:51 INFO - 'LANGUAGE': 'en_US:en', 11:03:51 INFO - 'LOGNAME': 'cltbld', 11:03:51 INFO - 'MAIL': '/var/mail/cltbld', 11:03:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:51 INFO - 'MOZ_NO_REMOTE': '1', 11:03:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:51 INFO - 'NO_EM_RESTART': '1', 11:03:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:51 INFO - 'PWD': '/builds/slave/test', 11:03:51 INFO - 'SHELL': '/bin/bash', 11:03:51 INFO - 'SHLVL': '1', 11:03:51 INFO - 'TERM': 'linux', 11:03:51 INFO - 'TMOUT': '86400', 11:03:51 INFO - 'USER': 'cltbld', 11:03:51 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1504891611.93820-649172738', 11:03:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:51 INFO - '_': '/tools/buildbot/bin/python'} 11:03:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:51 INFO - Downloading/unpacking blobuploader==1.2.4 11:03:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:52 INFO - Downloading blobuploader-1.2.4.tar.gz 11:03:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:03:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:03:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:53 INFO - Downloading docopt-0.6.1.tar.gz 11:03:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:03:53 INFO - Installing collected packages: blobuploader, requests, docopt 11:03:53 INFO - Running setup.py install for blobuploader 11:03:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:03:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:03:53 INFO - Running setup.py install for requests 11:03:53 INFO - Running setup.py install for docopt 11:03:53 INFO - Successfully installed blobuploader requests docopt 11:03:53 INFO - Cleaning up... 11:03:53 INFO - Return code: 0 11:03:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:03:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xa501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc19a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc0090>, '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 0xdc0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdbaf90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1504891611.93820-649172738', '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 11:03:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:03:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:03:53 INFO - Using env: {'DISPLAY': ':0', 11:03:53 INFO - 'HOME': '/home/cltbld', 11:03:53 INFO - 'LANG': 'en_US.UTF-8', 11:03:53 INFO - 'LANGUAGE': 'en_US:en', 11:03:53 INFO - 'LOGNAME': 'cltbld', 11:03:53 INFO - 'MAIL': '/var/mail/cltbld', 11:03:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:53 INFO - 'MOZ_NO_REMOTE': '1', 11:03:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:53 INFO - 'NO_EM_RESTART': '1', 11:03:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:53 INFO - 'PWD': '/builds/slave/test', 11:03:53 INFO - 'SHELL': '/bin/bash', 11:03:53 INFO - 'SHLVL': '1', 11:03:53 INFO - 'TERM': 'linux', 11:03:53 INFO - 'TMOUT': '86400', 11:03:53 INFO - 'USER': 'cltbld', 11:03:53 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1504891611.93820-649172738', 11:03:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:53 INFO - '_': '/tools/buildbot/bin/python'} 11:03:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:03:53 INFO - Running setup.py (path:/tmp/pip-WZh6yK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:03:53 INFO - Running setup.py (path:/tmp/pip-kVZrxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:03:54 INFO - Running setup.py (path:/tmp/pip-TbV0Uj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:03:54 INFO - Running setup.py (path:/tmp/pip-ZnIEpZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:03:54 INFO - Running setup.py (path:/tmp/pip-Q9pA3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:03:54 INFO - Running setup.py (path:/tmp/pip-fxExgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:03:54 INFO - Running setup.py (path:/tmp/pip-OQUb0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:03:54 INFO - Running setup.py (path:/tmp/pip-3MZX8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:03:54 INFO - Running setup.py (path:/tmp/pip-TF1YY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:03:54 INFO - Running setup.py (path:/tmp/pip-hGQjaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:03:54 INFO - Running setup.py (path:/tmp/pip-0QnQV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:03:54 INFO - Running setup.py (path:/tmp/pip-a7Sn57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:03:54 INFO - Running setup.py (path:/tmp/pip-QvEmLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:03:54 INFO - Running setup.py (path:/tmp/pip-46e6NJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:54 INFO - Running setup.py (path:/tmp/pip-wiM1Hx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:03:54 INFO - Running setup.py (path:/tmp/pip-5jR2Al-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:03:55 INFO - Running setup.py (path:/tmp/pip-zQBpjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:03:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:03:55 INFO - Running setup.py install for manifestparser 11:03:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:03:55 INFO - Running setup.py install for mozcrash 11:03:55 INFO - Running setup.py install for mozdebug 11:03:55 INFO - Running setup.py install for mozdevice 11:03:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:03:55 INFO - Running setup.py install for mozfile 11:03:55 INFO - Running setup.py install for mozhttpd 11:03:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:03:55 INFO - Running setup.py install for mozinfo 11:03:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:03:55 INFO - Running setup.py install for mozInstall 11:03:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:03:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:03:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:03:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:03:55 INFO - Running setup.py install for mozleak 11:03:55 INFO - Running setup.py install for mozlog 11:03:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:03:56 INFO - Running setup.py install for moznetwork 11:03:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:03:56 INFO - Running setup.py install for mozprocess 11:03:56 INFO - Running setup.py install for mozprofile 11:03:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:03:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:03:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:03:56 INFO - Running setup.py install for mozrunner 11:03:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:03:56 INFO - Running setup.py install for mozscreenshot 11:03:56 INFO - Running setup.py install for moztest 11:03:56 INFO - Running setup.py install for mozversion 11:03:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:03:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:03:56 INFO - Cleaning up... 11:03:56 INFO - Return code: 0 11:03:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:03:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:56 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 0xa501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc19a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc0090>, '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 0xdc0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdbaf90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1504891611.93820-649172738', '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 11:03:56 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 11:03:56 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 11:03:56 INFO - Using env: {'DISPLAY': ':0', 11:03:56 INFO - 'HOME': '/home/cltbld', 11:03:56 INFO - 'LANG': 'en_US.UTF-8', 11:03:56 INFO - 'LANGUAGE': 'en_US:en', 11:03:56 INFO - 'LOGNAME': 'cltbld', 11:03:56 INFO - 'MAIL': '/var/mail/cltbld', 11:03:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:56 INFO - 'MOZ_NO_REMOTE': '1', 11:03:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:56 INFO - 'NO_EM_RESTART': '1', 11:03:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:56 INFO - 'PWD': '/builds/slave/test', 11:03:56 INFO - 'SHELL': '/bin/bash', 11:03:56 INFO - 'SHLVL': '1', 11:03:56 INFO - 'TERM': 'linux', 11:03:56 INFO - 'TMOUT': '86400', 11:03:56 INFO - 'USER': 'cltbld', 11:03:56 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1504891611.93820-649172738', 11:03:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:56 INFO - '_': '/tools/buildbot/bin/python'} 11:03:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:03:57 INFO - Running setup.py (path:/tmp/pip-VXtJ7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:03:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:03:57 INFO - Running setup.py (path:/tmp/pip-O92TNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:03:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:03:57 INFO - Running setup.py (path:/tmp/pip-3AhDW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:03:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:03:57 INFO - Running setup.py (path:/tmp/pip-sDYDtP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:03:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:03:57 INFO - Running setup.py (path:/tmp/pip-LSipyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:03:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:03:57 INFO - Running setup.py (path:/tmp/pip-uT87P2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:03:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:03:57 INFO - Running setup.py (path:/tmp/pip-P3r_6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:03:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:03:57 INFO - Running setup.py (path:/tmp/pip-Fvv5il-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:03:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:03:57 INFO - Running setup.py (path:/tmp/pip-jlgnm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:03:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:03:57 INFO - Running setup.py (path:/tmp/pip-yko2Rd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:03:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:03:57 INFO - Running setup.py (path:/tmp/pip-AIsDZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:03:57 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)) 11:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:03:57 INFO - Running setup.py (path:/tmp/pip-USlyXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:03:57 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)) 11:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:03:57 INFO - Running setup.py (path:/tmp/pip-O4axjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:03:58 INFO - Running setup.py (path:/tmp/pip-9_kIUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:58 INFO - Running setup.py (path:/tmp/pip-wJK3uy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:03:58 INFO - Running setup.py (path:/tmp/pip-Oxex3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:03:58 INFO - Running setup.py (path:/tmp/pip-d3HzWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:03:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:59 INFO - Downloading blessings-1.6.tar.gz 11:03:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:03:59 INFO - Installing collected packages: blessings 11:03:59 INFO - Running setup.py install for blessings 11:03:59 INFO - Successfully installed blessings 11:03:59 INFO - Cleaning up... 11:03:59 INFO - Return code: 0 11:03:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:03:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:03:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:03:59 INFO - Reading from file tmpfile_stdout 11:03:59 INFO - Current package versions: 11:03:59 INFO - argparse == 1.2.1 11:03:59 INFO - blessings == 1.6 11:03:59 INFO - blobuploader == 1.2.4 11:03:59 INFO - docopt == 0.6.1 11:03:59 INFO - functools32 == 3.2.3-2 11:03:59 INFO - jsonschema == 2.5.1 11:03:59 INFO - manifestparser == 1.1 11:03:59 INFO - mozInstall == 1.13 11:03:59 INFO - mozcrash == 1.0 11:03:59 INFO - mozdebug == 0.1 11:03:59 INFO - mozdevice == 0.51 11:03:59 INFO - mozfile == 1.2 11:03:59 INFO - mozhttpd == 0.7 11:03:59 INFO - mozinfo == 0.10 11:03:59 INFO - mozleak == 0.1 11:03:59 INFO - mozlog == 3.5 11:03:59 INFO - moznetwork == 0.27 11:03:59 INFO - mozprocess == 0.25 11:03:59 INFO - mozprofile == 0.28 11:03:59 INFO - mozrunner == 6.13 11:03:59 INFO - mozscreenshot == 0.1 11:03:59 INFO - mozsystemmonitor == 0.3 11:03:59 INFO - moztest == 0.8 11:03:59 INFO - mozversion == 1.4 11:03:59 INFO - psutil == 3.1.1 11:03:59 INFO - requests == 1.2.3 11:03:59 INFO - wsgiref == 0.1.2 11:03:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:03:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xa501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc19a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc0090>, '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 0xdc0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdbaf90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1504891611.93820-649172738', '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 11:03:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:03:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:03:59 INFO - Using env: {'DISPLAY': ':0', 11:03:59 INFO - 'HOME': '/home/cltbld', 11:03:59 INFO - 'LANG': 'en_US.UTF-8', 11:03:59 INFO - 'LANGUAGE': 'en_US:en', 11:03:59 INFO - 'LOGNAME': 'cltbld', 11:03:59 INFO - 'MAIL': '/var/mail/cltbld', 11:03:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:59 INFO - 'MOZ_NO_REMOTE': '1', 11:03:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:59 INFO - 'NO_EM_RESTART': '1', 11:03:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:59 INFO - 'PWD': '/builds/slave/test', 11:03:59 INFO - 'SHELL': '/bin/bash', 11:03:59 INFO - 'SHLVL': '1', 11:03:59 INFO - 'TERM': 'linux', 11:03:59 INFO - 'TMOUT': '86400', 11:03:59 INFO - 'USER': 'cltbld', 11:03:59 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1504891611.93820-649172738', 11:03:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:59 INFO - '_': '/tools/buildbot/bin/python'} 11:04:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:04:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:04:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:04:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:04:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:04:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:04:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:04:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:04:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:04:00 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:04:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:04:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:04:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:04:01 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:04:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:04:01 INFO - Installing collected packages: simplejson 11:04:01 INFO - Running setup.py install for simplejson 11:04:01 INFO - building 'simplejson._speedups' extension 11:04:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 11:04:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 11:04:02 INFO - Successfully installed simplejson 11:04:02 INFO - Cleaning up... 11:04:02 INFO - Return code: 0 11:04:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:04: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')]} 11:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04: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')]} 11:04:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xa501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc19a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc0090>, '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 0xdc0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdbaf90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1504891611.93820-649172738', '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 11:04:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:04:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:04:02 INFO - Using env: {'DISPLAY': ':0', 11:04:02 INFO - 'HOME': '/home/cltbld', 11:04:02 INFO - 'LANG': 'en_US.UTF-8', 11:04:02 INFO - 'LANGUAGE': 'en_US:en', 11:04:02 INFO - 'LOGNAME': 'cltbld', 11:04:02 INFO - 'MAIL': '/var/mail/cltbld', 11:04:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:02 INFO - 'MOZ_NO_REMOTE': '1', 11:04:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:02 INFO - 'NO_EM_RESTART': '1', 11:04:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:02 INFO - 'PWD': '/builds/slave/test', 11:04:02 INFO - 'SHELL': '/bin/bash', 11:04:02 INFO - 'SHLVL': '1', 11:04:02 INFO - 'TERM': 'linux', 11:04:02 INFO - 'TMOUT': '86400', 11:04:02 INFO - 'USER': 'cltbld', 11:04:02 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1504891611.93820-649172738', 11:04:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:02 INFO - '_': '/tools/buildbot/bin/python'} 11:04:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:04:02 INFO - Cleaning up... 11:04:02 INFO - Return code: 0 11:04:02 INFO - Running post-action listener: _resource_record_post_action 11:04:02 INFO - Running post-action listener: _start_resource_monitoring 11:04:02 INFO - Starting resource monitoring. 11:04:02 INFO - [mozharness: 2017-09-08 18:04:02.556723Z] Finished create-virtualenv step (success) 11:04:02 INFO - [mozharness: 2017-09-08 18:04:02.557243Z] Running install step. 11:04:02 INFO - Running pre-action listener: _resource_record_pre_action 11:04:02 INFO - Running main action method: install 11:04:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:04:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:04:02 INFO - Reading from file tmpfile_stdout 11:04:02 INFO - Detecting whether we're running mozinstall >=1.0... 11:04:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:04:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:04:02 INFO - Reading from file tmpfile_stdout 11:04:02 INFO - Output received: 11:04:02 INFO - Usage: mozinstall [options] installer 11:04:02 INFO - Options: 11:04:02 INFO - -h, --help show this help message and exit 11:04:02 INFO - -d DEST, --destination=DEST 11:04:02 INFO - Directory to install application into. [default: 11:04:02 INFO - "/builds/slave/test"] 11:04:02 INFO - --app=APP Application being installed. [default: firefox] 11:04:02 INFO - mkdir: /builds/slave/test/build/application 11:04:02 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'] 11:04:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:04:19 INFO - Reading from file tmpfile_stdout 11:04:19 INFO - Output received: 11:04:19 INFO - /builds/slave/test/build/application/firefox/firefox 11:04:19 INFO - Running post-action listener: _resource_record_post_action 11:04:19 INFO - [mozharness: 2017-09-08 18:04:19.465856Z] Finished install step (success) 11:04:19 INFO - [mozharness: 2017-09-08 18:04:19.466106Z] Running setup-mitmproxy step. 11:04:19 INFO - Running pre-action listener: _resource_record_pre_action 11:04:19 INFO - Running main action method: setup_mitmproxy 11:04:19 INFO - Skipping: mitmproxy is not required 11:04:19 INFO - Running post-action listener: _resource_record_post_action 11:04:19 INFO - [mozharness: 2017-09-08 18:04:19.467229Z] Finished setup-mitmproxy step (success) 11:04:19 INFO - [mozharness: 2017-09-08 18:04:19.467449Z] Running run-tests step. 11:04:19 INFO - Running pre-action listener: _resource_record_pre_action 11:04:19 INFO - Running pre-action listener: _set_gcov_prefix 11:04:19 INFO - Running main action method: run_tests 11:04:19 WARNING - Try message not found. 11:04:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:04:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:04:19 INFO - Python 2.7.3 11:04:19 INFO - Return code: 0 11:04:19 INFO - grabbing minidump binary from tooltool 11:04: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')]} 11:04:19 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc0090>, '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 0xdc0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdbaf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:04:19 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:04:19 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:04:19 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:04:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:04:19 INFO - Return code: 0 11:04:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:04:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:04:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:04:19 INFO - ENV: RUST_BACKTRACE is now full 11:04:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:04:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:04:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:04:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:04:19 INFO - Using env: {'DISPLAY': ':0', 11:04:19 INFO - 'HOME': '/home/cltbld', 11:04:19 INFO - 'LANG': 'en_US.UTF-8', 11:04:19 INFO - 'LANGUAGE': 'en_US:en', 11:04:19 INFO - 'LOGNAME': 'cltbld', 11:04:19 INFO - 'MAIL': '/var/mail/cltbld', 11:04:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:04:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:04:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:19 INFO - 'MOZ_NO_REMOTE': '1', 11:04:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:04:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:19 INFO - 'NO_EM_RESTART': '1', 11:04:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:19 INFO - 'PWD': '/builds/slave/test', 11:04:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:04:19 INFO - 'RUST_BACKTRACE': 'full', 11:04:19 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:04:19 INFO - 'SHELL': '/bin/bash', 11:04:19 INFO - 'SHLVL': '1', 11:04:19 INFO - 'TERM': 'linux', 11:04:19 INFO - 'TMOUT': '86400', 11:04:19 INFO - 'USER': 'cltbld', 11:04:19 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1504891611.93820-649172738', 11:04:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:19 INFO - '_': '/tools/buildbot/bin/python'} 11:04:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:04:19 INFO - mozversion application_buildid: 20170908171740 11:04:19 INFO - mozversion application_changeset: 6d0288c291650ab619dc4ff92cb0b60e3b6e7b3b 11:04:19 INFO - mozversion application_display_name: Nightly 11:04:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:04:19 INFO - mozversion application_name: Firefox 11:04:19 INFO - mozversion application_remotingname: firefox 11:04:19 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:04:19 INFO - mozversion application_vendor: Mozilla 11:04:19 INFO - mozversion application_version: 57.0a1 11:04:19 INFO - mozversion platform_buildid: 20170908171740 11:04:19 INFO - mozversion platform_changeset: 6d0288c291650ab619dc4ff92cb0b60e3b6e7b3b 11:04:19 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:04:19 INFO - mozversion platform_version: 57.0a1 11:04:19 INFO - using testdate: 1504893859 11:04:19 INFO - actual date: 1504893859 11:04:19 INFO - starting webserver on 'localhost:53614' 11:04:19 INFO - SUITE-START | Running 2 tests 11:04:19 INFO - TEST-START | dromaeo_css 11:04:19 INFO - Initialising browser for dromaeo_css test... 11:04:19 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53614/getInfo.html -profile /tmp/tmpqqc6g0/profile 11:04:19 INFO - TEST-INFO | started process 9456 (/builds/slave/test/build/application/firefox/firefox http://localhost:53614/getInfo.html) 11:04:26 INFO - TEST-INFO | 9456: exit 0 11:04:26 INFO - Browser initialized. 11:04:26 INFO - Running cycle 1/1 for dromaeo_css test... 11:04:26 INFO - Using env: {'DISPLAY': ':0', 11:04:26 INFO - 'HOME': '/home/cltbld', 11:04:26 INFO - 'JSGC_DISABLE_POISONING': '1', 11:04:26 INFO - 'LANG': 'en_US.UTF-8', 11:04:26 INFO - 'LANGUAGE': 'en_US:en', 11:04:26 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:04:26 INFO - 'LOGNAME': 'cltbld', 11:04:26 INFO - 'MAIL': '/var/mail/cltbld', 11:04:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:04:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:04:26 INFO - 'MOZ_CRASHREPORTER': '1', 11:04:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:26 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:04:26 INFO - 'MOZ_NO_REMOTE': '1', 11:04:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:04:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:26 INFO - 'NO_EM_RESTART': '1', 11:04:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:26 INFO - 'PWD': '/builds/slave/test', 11:04:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:04:26 INFO - 'RUST_BACKTRACE': 'full', 11:04:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:04:26 INFO - 'SHELL': '/bin/bash', 11:04:26 INFO - 'SHLVL': '1', 11:04:26 INFO - 'TERM': 'linux', 11:04:26 INFO - 'TMOUT': '86400', 11:04:26 INFO - 'USER': 'cltbld', 11:04:26 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1504891611.93820-649172738', 11:04:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:26 INFO - '_': '/tools/buildbot/bin/python'} 11:04:26 INFO - TEST-INFO | started process 9652 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqqc6g0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:04:27 INFO - PID 9652 | 11:04:27 INFO - PID 9652 | (/builds/slave/test/build/application/firefox/firefox:9703): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:04:27 INFO - PID 9652 | 11:04:37 INFO - PID 9652 | RSS: Main: 170475520 11:04:37 INFO - PID 9652 | 11:07:34 INFO - PID 9652 | Cycle 1(1): loaded http://localhost:53614/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53614/tests/dromaeo/cssquery-ext.html) 11:07:35 INFO - PID 9652 | RSS: Main: 173903872 11:07:35 INFO - PID 9652 | 11:10:36 INFO - PID 9652 | Cycle 1(1): loaded http://localhost:53614/tests/dromaeo/cssquery-ext.html (next: http://localhost:53614/tests/dromaeo/cssquery-jquery.html) 11:10:37 INFO - PID 9652 | RSS: Main: 171163648 11:10:37 INFO - PID 9652 | 11:13:39 INFO - PID 9652 | Cycle 1(1): loaded http://localhost:53614/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53614/tests/dromaeo/cssquery-mootools.html) 11:13:39 INFO - PID 9652 | RSS: Main: 172986368 11:13:39 INFO - PID 9652 | 11:16:41 INFO - PID 9652 | Cycle 1(1): loaded http://localhost:53614/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53614/tests/dromaeo/cssquery-prototype.html) 11:16:42 INFO - PID 9652 | RSS: Main: 171085824 11:16:42 INFO - PID 9652 | 11:19:45 INFO - PID 9652 | Cycle 1(1): loaded http://localhost:53614/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53614/tests/dromaeo/cssquery-yui.html) 11:19:45 INFO - PID 9652 | RSS: Main: 172703744 11:19:45 INFO - PID 9652 | 11:22:47 INFO - PID 9652 | Cycle 1(1): loaded http://localhost:53614/tests/dromaeo/cssquery-yui.html (next: http://localhost:53614/tests/dromaeo/cssquery-dojo.html) 11:22:47 INFO - PID 9652 | RSS: Main: 175775744 11:22:47 INFO - PID 9652 | 11:22:47 INFO - PID 9652 | __start_tp_report 11:22:47 INFO - PID 9652 | _x_x_mozilla_page_load 11:22:47 INFO - PID 9652 | _x_x_mozilla_page_load_details 11:22:47 INFO - PID 9652 | |i|pagename|runs| 11:22:47 INFO - PID 9652 | |0;dojo.html;3078.0458058002023;3102.1158969693643;3104.674009229031;3105.285784269618;3118.2672072063046;6099.207103076594;6234.719437625301;6289.213848268966;6298.874022519552;6327.272363678178;6239.906401403971;6284.277308109568;6293.874122517547;6298.244210694712;6315.810525684236;5771.2497375341145;5806.622569532967;5882.6764527950945;5896.587238893279;5949;5818.563607729416;5885.705714714269;5898.262717160355;5909.852253693649;5932.584719069667;306.8623462092225;5724.398938111501;5748.2527271454655;5749.482546570787;5896.498797602209;5793.768249270024;5853.531717462635;5870.677112758796;5888;5888.735006924699;5768.97115514424;5772.797952071657;5854.677992710399;5855.8536036599;5860.296764388258;6266.749330026793;6268.1851359323455;6277.843053923689;6287.622742635456;6371.2991570927625;6670.433013193884;6734.629595372253;6782.932170678279;6809.421199198025;6822.351876571718;6477.74089036438;6580.078788969548;6752.561083529555;6851.794446166623;6857.55425897315;6189.566730328879;6238.1266622672865;6253.46845518127;6258.718357673915;6339.36606339367;6915.4121899638085;6920.031195632565;6929.064576282138;7010.228874823765;7030.718771249195;6407.903881441782;6438.066480360321;6581.539292249497;6654.401103900672;6655.633940133339;6637.601743895381;6707.53047286695;6715.899261511081;6718.328167183243;6773.491988100912;6695.296993815677;6750.898736518956;6777.796666100025;6791.524593278423;6798.320167983162;6733.562318449285;6738.764143254963;6745.224299205556;6836.6923488443135;6838.555493892881;5155.61332900034;5268.868278293074;5331.173668081454;5338.092524270884;5339.359276886798;4601.976990115028;4646.09401166776;4698.929516057262;4702.741349225757;4723.220668589713;5729.169270455761;5750.223719797774;5773.6824474654295;5782.045962416154;5809.390014048464;6763.188417389944;6796.082528858541;6796.286389928986;6874.690638921261;6877.140357455318;5649.6327738696855;5739.971300143473;5754.223179870663;5764.221830052973;5818.127280907813;5818.883622327529;5858.2677165354335;5891.469767720926;5892.764289428461;5901.321348044944;6515.641639709766;6521.5108866834225;6589.341065893373;6603.867922641521;6611.933880661228;6585.045168450548;6672.5329226953645;6753.054572359972;6827.1807383112355;6829.043933849166;6530.314316996647;6565.146530950946;6577.704003319958;6580.012998050331;6593.736250549924;6666.766663166766;6679.1984961802955;6697.3637504437;6714.865702686016;6756.29058948823;6698.765543206159;6784.219814721173;6800.795976120724;6874.759383421556;6906.171259448898;6318.368163183645;6423.164988551458;6493.480521558358;6530.151080359713;6627.469802415699;6543.051257567721;6597.670116494252;6610.338966103352;6634.303398143125;6635.402813746786;6358.237011558643;6469.191351081115;6470.547061705635;6530.444912182517;6569.178852643419;6520.315366886598;6621.205455345389;6623.105880706043;6641.867162656623;6676.232233293234;6235.96882015587;6253.09330147117;6278.309385967448;6338.841528961629;6353.983362661952 11:22:47 INFO - PID 9652 | |1;ext.html;832.6378025558882;861.414238317944;886.0563499872632;888.7467071884514;889.7820034091649;41614.58385416145;41697.37453938186;42467;42642.78678606606;42685.57314426859;43155.35266970998;43556;43641.12717745643;43710;43717.34423983643;7915.12933577306;8033.277005069543;8066.757997260062;8068.47554908929;8072.919270807305;7965.72119975801;7985.640646170937;8057.516549007049;8061.798455038613;8078.636461359223;8088.959555202216;8099.311558517533;8122.106568277485;8129.187081291882;8130.471519351253;8042.115367309591;8068.878966815502;8080.757577272691;8082.717104901359;8084.919150808505;7792.532448053135;7886.487378320448;7890.802729931797;7893.565853878034;7898;38799.41800872989;39170.804145979375;39176;39216.60783392158;39276.803615981735;3514.0687717754818;3550.786952782841;3551.129973156593;3552.662497062775;3554.680078792895;32996.010119696206;33098.3380332392;33116;33170.33659326824;33231.33537329264;5117.232415137722;5216.243644671539;5263.973525162595;5267;5289.074411977888;193080;193397.9999999986;193535;193830;194155;48627.513724863005;48755;48839.51160488421;48849;48852.267215991786;50771.74614126905;54777;55270.44729552653;55430;55666.72166639141;16242.918785405996;16297;16393.344266229455;16412.75380869288;16436.260368283456;13288.800667989988;13338.866611333957;13587.45650173982;13623;13737.107088039245;15147.772783408258;15173.696526069416;15239.695206095816;15287.61780955485;15318.080915145127;5758.424157584292;5984.222051133324;6058.697065146725;6073.665948372882;6152.0156774915795;994.4132961552574;1004.7588578741049;1006.3810756384771;1016.1413605503337;1026.2559644257854;22867.771322286895;22905.427364316027;22915;23433.41416464602;23609.05563777464;1074.3768614203743;1089.4334945828284;1092.317301686446;1103.089950790585;1111.6193051882299;12413.93793031029;12422.088137483366;12462.563810266598;12543.811842822364;12554.81167782484;213224;214801;228909;229710;230201;45904.540954590695;46945.76527117411;52776.73611631994;54809.72595136999;55068.724656376464;1420.609332433589;1427.3933578229212;1435.2895316818242;1447.1244896837472;1449.8042764226905;26312;26501.204963851116;26616.600750988364;26782;26924.192274231806;37942.2411551773;37985.62014379821;38006.2398752029;38010.23979520449;38035.809820950715;200426;201091;201368;201522;201848;34583;34620.65379346275;34743.47884781781;34834.65165348314;34839.30321393507;42180.57819421889;42510;42548.78725606476;43222.351664724425;43224.56775432331;31029.379412411174;31395;31434;31452;31461.52807707932;31177.688223118384;31345.52981705322;31488.370232595676;31616.367672646877;32198.19504512406;35459.82270088633;35557.82221088878;35657.46513802243;35658.82170589131;35768.82115589405;30301.24246893757;30506.694933050385;30694.232644184074;31151.84424077865;31175.53236701406;22884.542309154058;22935.426614334774;23185.652215216447;23402;23562.52874942457 11:22:47 INFO - PID 9652 | |2;jquery.html;557.1253132581845;560.7420586530196;569.7550851389714;576.3170642788299;596.9910451343229;22416.88791556042;23485.178018769348;23544.293671189847;23576.410589735264;23584.76415235845;22776.77223227767;23391.76608233917;23496.530069398603;24715.62926556103;25096;6478.4817214622835;6623.701933412984;6688.230853451842;6690.996350547408;6697.196336439634;6299.275583307909;6574.80275591733;6673.8331541711605;6680.83297917551;6685.097511835913;6495.285518592951;6574.704138313788;6579.868402631944;6582.341765823403;6586.37429444202;6543.985682219263;6550.737970481175;6573.441257493118;6575.473962083046;6577.802665920006;5801.941980580183;6019.729112189962;6021.819345419601;6033.42682445167;6052.727627256784;27293;27810;27828.30429239265;27831.582526262122;27844.443111137665;1997.9300724474574;2029.5839352932614;2032.2582257475915;2033.298512013353;2033.5424529480897;18725;19415.708764368545;19710.80289197104;19722.408327750192;19827.90086049575;2185.115028413495;2247.71903512061;2256.2892688802976;2270.137347807839;2345.917892873741;111474.44262778715;118438.40780796041;135060;138950;144079.27960360236;13954.441822326993;14065.367058482392;14207.715845683235;14304.499342522962;14646.487372941896;22110.668339974913;22178.667319990214;22219;22231.333060008226;22280.554388912456;9069.909300907038;9284.860727089099;9421.528923553795;9477.24182065447;9545.665901693408;8384.790380240544;8475.533845638425;8529.061803201643;8533;8646.78383040429;8696.652133914573;8740.606672699743;8800.735977920673;8910.643574257087;9068.81862362749;2622.2002289301563;2631.8552479613422;2636.1564299424;2645.6031595260865;2693.232428757834;947.6067432015636;960.644561512231;962.4754508792724;964.0118878149952;964.6527250189926;18731.438056858315;18751.156197971122;18892.527686807938;18947.24211031571;19023.239070437303;991.6563057057728;1017.8473229015559;1019.3832731197518;1021.8416145497459;1027.445179603006;10405.739856503496;10418.21863360251;10471.84292235617;10492.632757853438;10771.299865508718;480140;482461;483386;485035;496351;110706;111570.44214779037;111760;111770;112386;1046.931949423285;1083.6586475260267;1137.0846468592863;1160.5763896177834;1189.7501524679915;19769.40691779249;19963.301284454974;20026.098825553177;20050.398488045383;20413.89793051025;55440.722796387374;56206.71896640491;56269.43730562642;56479.435205647416;57731.99999999832;68543.31456685369;68736.6563167181;69204.30795691979;69322.30677693158;69492.65253673699;13332.133411328232;13610.727785444433;14012;14022.22877741734;14135.081219720685;22334.10663573504;22538.436539086655;22613;22647.20734774275;22789.77210227943;17340.47978560645;17730.91134544319;18108;18311.084445777924;18313.908430457763;14750.409983600535;15237.238138093273;15342.232888355315;15469.5359139226;15632.4528641497;16586;16927.661446771242;17097.658046839242;17114.743278851078;17156.39952601653;13900.51348202808;13923.094998825043;13933.58199254024;13935.163890166217;13953.023288369717;17944.19251133676;17993.730094048336;18019.2792288307;18121.728174077136;18145.364912228008 11:22:47 INFO - PID 9652 | |3;mootools.html;1336.9064165508414;1386.6325423762698;1388.2225953466059;1392.4708610727928;1401.131298594871;12659.620211393662;13236.404361803718;13264.801027984588;15174.924125379384;15693.686126277467;15336.769948450754;15612.921935390306;15616.76574851378;15625.687486250268;15665.13841738704;2781.3324802047514;2845.2460098073925;2850.3586692994013;2850.78619103567;2852.3011862093817;2756;2928.868200930963;2928.8974885878997;2931.2378781516854;2932.545455454408;2789.4700006998705;2852;2855.543113101904;2895.073576455535;2898.9710102899016;2805.424887897976;2820.083472871315;2821.139552436506;2821.210061182872;2831.603575499432;2692.434588736368;2701.864906754674;2708.377073273158;2712.51174788538;2713.9728602713917;14825.18461484618;15122.260939991931;15134.394624215018;15198.316075776505;15231.390744370212;7945.245201705829;8203.548804815733;8206.548639824807;8233.135520770293;8235.670573177065;5222.4255331913455;5408.4591540845995;5460.754266058037;5513.365962914276;5540.141278101901;1927.4988502989183;1927.7493925789558;1936.4868309897888;1967.3114409956545;1969.803019698033;23897.283081507583;26035.869820650965;26132;26137.607935880977;26167.345816354555;6893.655317234118;6985.301469853076;7132;7175.138983322035;7219.747308844166;17431.302747890197;17504.64990700179;17515.56211094733;17518.824811751972;17537;7552;7858.685652573833;8044.678212871419;8046.476978996347;8048.718294859652;7433.219511951167;7456.701731930771;7457.254274572608;7463.776086717407;7481.177070522238;5235.73821308933;5236.188390799432;5268.28878101459;5308.389535203424;5368.489993450616;1505.224809223251;1506.2694593122546;1515.8029456170627;1521.5435369389138;1544.1121355220794;894.7449976756593;916.3402350307767;918.3387960668308;930.3208657679796;933.4819175357605;7784;7840.882386764203;7849.803754906173;7908.644111015018;7946.721864734706;718.4396170986639;722.4509372876547;728.4318231779115;734.720806093681;737.8930055141974;5168.638195326366;5264.763085661154;5319.0957537218765;5336.092864213093;5345.732713364394;21249.150033998776;22127.114915403203;22135;22224.888875555844;22226.333210003726;21282.467938301666;21646.458838529164;21738.34784956454;21834.454138646663;21865.12539498434;11117.27737697047;11366.659000230007;11429.542818287342;11561.30632162073;11586.246893952035;8347.248747612744;8485.193906579112;8500.659973600987;8504.319654427507;8623.87064194025;18246.543836404195;18371;18513.722294165327;18627.627447451247;18908.43274701761;18750.718739219195;18807.811921880606;18831.435056948314;18832.717509237646;18940.242390304233;10897.128229741444;11133;11135.10919126484;11192.048675862643;11204.495797689287;13905.791413128609;14038.859611403755;14172.716545669235;14195.43218271299;14283.928580357031;11422.543098275975;11472.655820325404;11560.47977841016;11711.1802173847;11827.763444730885;10314.535845886803;10383.480825958823;10494.108000820015;10676.46617669098;10726.141908647445;10161.187105031431;10208.693739187836;10303.278770485995;10345.637902673672;10392.792144156923;6720.966395167993;6845.863082738417;6864.7940561783225;6879.8968015480805;6886.48351373659;6895.6552172392185;6974.267701891431;6977.058097157022;7036.296370362923;7053.753118640823 11:22:47 INFO - PID 9652 | |4;prototype.html;496.5059765533295;508.2757071173577;526.0898645343555;528.036333691014;531.9468053194681;6192.349803270648;6209.2548894132715;6262;6345.50996951677;6401.199850018747;6092.299385570661;6113.266408031042;6141.232345956755;6154.246039878635;6168.105624684418;4923.335349727795;4993.126202914494;5035.622328325372;5037.798488060492;5067.138586440314;5002.274670172823;5010.323606313155;5071.137906555894;5141.871453213662;5153.948460515385;4975.2835271831345;4998.075356059123;5038.622103342245;5074.264231686422;5102.540771330579;4925.507449255046;4988.802687355027;5017;5044.218146187347;5080.110980578384;4542.454905411339;4546.29532422475;4562.520935301812;4571.405717256735;4579.816807327703;6241.313455519889;6260.87478250437;6311.211098612674;6314.778982735628;6319.936800631981;5680.4319568042865;5721.828345149652;5723.570732195102;5736.196932429463;5745.597808153431;6596;6612.239592446882;6613.966930165367;6617.636030018347;6617.702203400859;4872.220444728861;4884.804607815683;4896.2410826321975;4906.828261010884;4909.975450122726;6863.553868998499;6898.551014389869;6905.240423553405;6931.1682598088555;6934.861302773917;5022.372203474566;5026.59787217029;5047.570956468668;5063.113955057924;5070.239464080418;5090.847274581768;5137.255098010767;5137.922931156036;5137.9743101285;5148.6910785353;5668.489835914705;5745.454181852718;5746.2529871116485;5747.712614369265;5750.852986576991;6272.937270627235;6273.278572964076;6491.967540162269;6648.96675516629;6661.666916654148;1728.4728157911957;1741.4601473543241;1751.3082332478855;1769.5576105973507;1771.3977247735575;1181.6293100003954;1204.5422739358987;1205.15036898986;1222.1261797814605;1233.586748439265;5552.750126244328;5684.976704193202;5696.857578560569;5753.223314852441;5754;6700.363465470772;6727.899081513781;6739.663016849138;6757.189137303555;6820.590764554143;5653.745581448845;5662.943370566324;5673.489385955284;5694.060480020833;5739.891496568058;3457.913552161216;3567.9117869050187;3568.8572457101427;3572.7141828653644;3595.1551385424405;6419.602572238032;6463.644499552475;6501.642409667419;6517.804465866032;6549.672516374162;6862.862742745217;6882.518223724292;6914.308569143045;6947.89578156328;6951.756688515979;6466.482681385478;6477.963525835844;6490.188726409199;6541.378569035934;6545.214574251025;6660.966695166493;6719.664016799238;6745.436734041033;6766.391024807791;6779.423748981392;6644.90032649501;6690.531662783558;6691.832704182434;6724.159480064992;6793.150856142982;6388.616682999035;6468.2561505427475;6524.858149823856;6532.41208291256;6536.150300460909;4953.23224900141;4976.8553232757395;4976.925346119883;4990.1516742154645;5059.848204553869;6482;6696.229933557704;6775.593464392152;6788.694508747019;6864.622445765531;6305.337939516468;6526.9347306528225;6532.216134063943;6561;6577.2436169841085;6469.159009328757;6507.316731743288;6511.934880651323;6551.50863685216;6584.604923704593;6244.937550624436;6377.840553986188;6392.954254638471;6444.387783160592;6484.740610375532;6515.185601799775;6579.144711187515;6587.769428069994;6617.470602351704;6661.500387471056;6305.274893387319;6318.115463835159;6350.650714210763;6350.745970161327;6367.267764207176 11:22:47 INFO - PID 9652 | |5;yui.html;884.5709830732097;896.7220161749857;916.4638686368478;919.9356045076843;943.9716808495743;17274;17397.82602173978;17446.738298925527;17566.385176518823;17577.209025593846;16837.83162168378;16968.4061057863;17015.744763828552;17139.657206855856;18641.533961650966;940.0505489455647;962.9085236902519;968.2350942755215;968.602872822143;969.3263182088451;948.2035090523958;980.3676628574565;985.9654912078079;988.8714467119264;990.0643891522515;1034.5654824973528;1041.161864698917;1050.4432650695144;1050.5220124843179;1051.363924825481;1034.4724190662741;1036.2331874412919;1044.5508431374544;1050.6532844161484;1051.64244156987;721.1418412089597;733.7248531800575;751.7782254235013;752.0824593995317;775.275117764886;20483.07826147827;20668.689969650466;20682;20692.896535517375;20696.482587935272;20693.0688119035;20759.5848083039;20802.895985519976;20981.5803683927;21062.2628208012;17633.55916102095;17769.46691599254;17804;18087.638247235114;18312.90843545787;3748.381517049711;3756.267527832074;3781.9810900945595;3787.4129509926006;3789.3936970084656;137725;141067.29466352705;141256.2937185318;142463;143891.2805435966;15384.615384615474;15619.062856228435;15678.529644110695;15715.21423928799;15759.054456732632;30104.24739381489;30129.849350753106;30411.543826842615;30624.69375306263;30846.69153308483;8527.530985795716;8662.177093176138;8663.176998185163;8695.565221739014;8711.60797764102;4057.594240575978;4101.651359634405;4165.562615925345;4166.7708276044505;4178.707490475637;5164.715940623227;5273.235380869829;5299.12564426873;5301.708406037705;5309.256704061358;981.3130808433982;985.2462865907586;1003.9247056470793;1006.1397505133152;1009.8889122196553;657.7763560389395;666.8799616069057;671.2850813883199;680.8059702984725;685.372883811307;10719;10883.78232435347;11057.668269951915;11577.768444631229;11949.88050119505;670.51722759613;672.052406107396;678.2776343194482;684.260998122027;687;5073.720945347967;5092.821751238689;5098;5122.92315615266;5131.435542090367;115274;117463.41268293603;117651.41174294073;119823.40088299503;123707.38146309211;105829;107853;108424.45787771011;110833;111440;94421.5278923601;95138;99218.50390748144;100162.99837001682;100779.49610252048;9557.378770379903;9776.364536305402;9781;9817.950910245403;9967.651132210338;43357.78321108374;44609;44686.3297050551;45505.31742023806;45879;58691;58905.70547147408;59448;59652;59951.400485996324;14552;14909.478168264059;15061.397544098114;15145.091294522364;15191.620209494851;14037.578872633838;14061.507847225297;14108.224047677066;14167.433302667778;14233.430662773788;13647.931760341531;13722.65693357674;13758.036937414285;13856.099353541988;13864.098833575785;14515.201663908587;14527.85472145265;14558.4904528341;14611.561653150422;14842.109473431628;14641.48754793577;14716.926415367854;14748.188849613374;14837.480688176294;14890;10073.798524029331;10371.429571373646;10401.739956501147;10414;10773.353598783784;11573.942130289295;11681.88318116808;11887.940560297144;12052.397380130784;12139 11:22:47 INFO - PID 9652 | __end_tp_report 11:22:47 INFO - PID 9652 | __start_cc_report 11:22:47 INFO - PID 9652 | _x_x_mozilla_cycle_collect,354 11:22:47 INFO - PID 9652 | __end_cc_report 11:22:47 INFO - PID 9652 | __startTimestamp1504894967737__endTimestamp 11:22:47 INFO - PID 9652 | 11:22:47 INFO - PID 9652 | ------- Summary: start ------- 11:22:47 INFO - PID 9652 | Number of tests: 6 11:22:47 INFO - PID 9652 | 11:22:47 INFO - PID 9652 | [#0] dojo.html Cycles:165 Average:6168.50 Median:6407.90 stddev:876.27 (13.7%) stddev-sans-first:844.76 11:22:47 INFO - PID 9652 | Values: 3078.0 3102.1 3104.7 3105.3 3118.3 6099.2 6234.7 6289.2 6298.9 6327.3 6239.9 6284.3 6293.9 6298.2 6315.8 5771.2 5806.6 5882.7 5896.6 5949.0 5818.6 5885.7 5898.3 5909.9 5932.6 306.9 5724.4 5748.3 5749.5 5896.5 5793.8 5853.5 5870.7 5888.0 5888.7 5769.0 5772.8 5854.7 5855.9 5860.3 6266.7 6268.2 6277.8 6287.6 6371.3 6670.4 6734.6 6782.9 6809.4 6822.4 6477.7 6580.1 6752.6 6851.8 6857.6 6189.6 6238.1 6253.5 6258.7 6339.4 6915.4 6920.0 6929.1 7010.2 7030.7 6407.9 6438.1 6581.5 6654.4 6655.6 6637.6 6707.5 6715.9 6718.3 6773.5 6695.3 6750.9 6777.8 6791.5 6798.3 6733.6 6738.8 6745.2 6836.7 6838.6 5155.6 5268.9 5331.2 5338.1 5339.4 4602.0 4646.1 4698.9 4702.7 4723.2 5729.2 5750.2 5773.7 5782.0 5809.4 6763.2 6796.1 6796.3 6874.7 6877.1 5649.6 5740.0 5754.2 5764.2 5818.1 5818.9 5858.3 5891.5 5892.8 5901.3 6515.6 6521.5 6589.3 6603.9 6611.9 6585.0 6672.5 6753.1 6827.2 6829.0 6530.3 6565.1 6577.7 6580.0 6593.7 6666.8 6679.2 6697.4 6714.9 6756.3 6698.8 6784.2 6800.8 6874.8 6906.2 6318.4 6423.2 6493.5 6530.2 6627.5 6543.1 6597.7 6610.3 6634.3 6635.4 6358.2 6469.2 6470.5 6530.4 6569.2 6520.3 6621.2 6623.1 6641.9 6676.2 6236.0 6253.1 6278.3 6338.8 6354.0 11:22:47 INFO - PID 9652 | 11:22:47 INFO - PID 9652 | [#1] ext.html Cycles:180 Average:37920.64 Median:19505.30 stddev:53413.99 (273.8%) stddev-sans-first:53491.23 11:22:47 INFO - PID 9652 | Values: 832.6 861.4 886.1 888.7 889.8 41614.6 41697.4 42467.0 42642.8 42685.6 43155.4 43556.0 43641.1 43710.0 43717.3 7915.1 8033.3 8066.8 8068.5 8072.9 7965.7 7985.6 8057.5 8061.8 8078.6 8089.0 8099.3 8122.1 8129.2 8130.5 8042.1 8068.9 8080.8 8082.7 8084.9 7792.5 7886.5 7890.8 7893.6 7898.0 38799.4 39170.8 39176.0 39216.6 39276.8 3514.1 3550.8 3551.1 3552.7 3554.7 32996.0 33098.3 33116.0 33170.3 33231.3 5117.2 5216.2 5264.0 5267.0 5289.1 193080.0 193398.0 193535.0 193830.0 194155.0 48627.5 48755.0 48839.5 48849.0 48852.3 50771.7 54777.0 55270.4 55430.0 55666.7 16242.9 16297.0 16393.3 16412.8 16436.3 13288.8 13338.9 13587.5 13623.0 13737.1 15147.8 15173.7 15239.7 15287.6 15318.1 5758.4 5984.2 6058.7 6073.7 6152.0 994.4 1004.8 1006.4 1016.1 1026.3 22867.8 22905.4 22915.0 23433.4 23609.1 1074.4 1089.4 1092.3 1103.1 1111.6 12413.9 12422.1 12462.6 12543.8 12554.8 213224.0 214801.0 228909.0 229710.0 230201.0 45904.5 46945.8 52776.7 54809.7 55068.7 1420.6 1427.4 1435.3 1447.1 1449.8 26312.0 26501.2 26616.6 26782.0 26924.2 37942.2 37985.6 38006.2 38010.2 38035.8 200426.0 201091.0 201368.0 201522.0 201848.0 34583.0 34620.7 34743.5 34834.7 34839.3 42180.6 42510.0 42548.8 43222.4 43224.6 31029.4 31395.0 31434.0 31452.0 31461.5 31177.7 31345.5 31488.4 31616.4 32198.2 35459.8 35557.8 35657.5 35658.8 35768.8 30301.2 30506.7 30694.2 31151.8 31175.5 22884.5 22935.4 23185.7 23402.0 23562.5 11:22:47 INFO - PID 9652 | 11:22:47 INFO - PID 9652 | [#2] jquery.html Cycles:180 Average:33909.47 Median:22630.10 stddev:81544.76 (360.3%) stddev-sans-first:81735.06 11:22:47 INFO - PID 9652 | Values: 557.1 560.7 569.8 576.3 597.0 22416.9 23485.2 23544.3 23576.4 23584.8 22776.8 23391.8 23496.5 24715.6 25096.0 6478.5 6623.7 6688.2 6691.0 6697.2 6299.3 6574.8 6673.8 6680.8 6685.1 6495.3 6574.7 6579.9 6582.3 6586.4 6544.0 6550.7 6573.4 6575.5 6577.8 5801.9 6019.7 6021.8 6033.4 6052.7 27293.0 27810.0 27828.3 27831.6 27844.4 1997.9 2029.6 2032.3 2033.3 2033.5 18725.0 19415.7 19710.8 19722.4 19827.9 2185.1 2247.7 2256.3 2270.1 2345.9 111474.4 118438.4 135060.0 138950.0 144079.3 13954.4 14065.4 14207.7 14304.5 14646.5 22110.7 22178.7 22219.0 22231.3 22280.6 9069.9 9284.9 9421.5 9477.2 9545.7 8384.8 8475.5 8529.1 8533.0 8646.8 8696.7 8740.6 8800.7 8910.6 9068.8 2622.2 2631.9 2636.2 2645.6 2693.2 947.6 960.6 962.5 964.0 964.7 18731.4 18751.2 18892.5 18947.2 19023.2 991.7 1017.8 1019.4 1021.8 1027.4 10405.7 10418.2 10471.8 10492.6 10771.3 480140.0 482461.0 483386.0 485035.0 496351.0 110706.0 111570.4 111760.0 111770.0 112386.0 1046.9 1083.7 1137.1 1160.6 1189.8 19769.4 19963.3 20026.1 20050.4 20413.9 55440.7 56206.7 56269.4 56479.4 57732.0 68543.3 68736.7 69204.3 69322.3 69492.7 13332.1 13610.7 14012.0 14022.2 14135.1 22334.1 22538.4 22613.0 22647.2 22789.8 17340.5 17730.9 18108.0 18311.1 18313.9 14750.4 15237.2 15342.2 15469.5 15632.5 16586.0 16927.7 17097.7 17114.7 17156.4 13900.5 13923.1 13933.6 13935.2 13953.0 17944.2 17993.7 18019.3 18121.7 18145.4 11:22:47 INFO - PID 9652 | 11:22:47 INFO - PID 9652 | [#3] mootools.html Cycles:180 Average:9314.95 Median:2697.15 stddev:6613.79 (245.2%) stddev-sans-first:6605.18 11:22:47 INFO - PID 9652 | Values: 1336.9 1386.6 1388.2 1392.5 1401.1 12659.6 13236.4 13264.8 15174.9 15693.7 15336.8 15612.9 15616.8 15625.7 15665.1 2781.3 2845.2 2850.4 2850.8 2852.3 2756.0 2928.9 2928.9 2931.2 2932.5 2789.5 2852.0 2855.5 2895.1 2899.0 2805.4 2820.1 2821.1 2821.2 2831.6 2692.4 2701.9 2708.4 2712.5 2714.0 14825.2 15122.3 15134.4 15198.3 15231.4 7945.2 8203.5 8206.5 8233.1 8235.7 5222.4 5408.5 5460.8 5513.4 5540.1 1927.5 1927.7 1936.5 1967.3 1969.8 23897.3 26035.9 26132.0 26137.6 26167.3 6893.7 6985.3 7132.0 7175.1 7219.7 17431.3 17504.6 17515.6 17518.8 17537.0 7552.0 7858.7 8044.7 8046.5 8048.7 7433.2 7456.7 7457.3 7463.8 7481.2 5235.7 5236.2 5268.3 5308.4 5368.5 1505.2 1506.3 1515.8 1521.5 1544.1 894.7 916.3 918.3 930.3 933.5 7784.0 7840.9 7849.8 7908.6 7946.7 718.4 722.5 728.4 734.7 737.9 5168.6 5264.8 5319.1 5336.1 5345.7 21249.2 22127.1 22135.0 22224.9 22226.3 21282.5 21646.5 21738.3 21834.5 21865.1 11117.3 11366.7 11429.5 11561.3 11586.2 8347.2 8485.2 8500.7 8504.3 8623.9 18246.5 18371.0 18513.7 18627.6 18908.4 18750.7 18807.8 18831.4 18832.7 18940.2 10897.1 11133.0 11135.1 11192.0 11204.5 13905.8 14038.9 14172.7 14195.4 14283.9 11422.5 11472.7 11560.5 11711.2 11827.8 10314.5 10383.5 10494.1 10676.5 10726.1 10161.2 10208.7 10303.3 10345.6 10392.8 6721.0 6845.9 6864.8 6879.9 6886.5 6895.7 6974.3 6977.1 7036.3 7053.8 11:22:47 INFO - PID 9652 | 11:22:47 INFO - PID 9652 | [#4] prototype.html Cycles:180 Average:5526.85 Median:6200.80 stddev:1546.11 (24.9%) stddev-sans-first:1503.64 11:22:47 INFO - PID 9652 | Values: 496.5 508.3 526.1 528.0 531.9 6192.3 6209.3 6262.0 6345.5 6401.2 6092.3 6113.3 6141.2 6154.2 6168.1 4923.3 4993.1 5035.6 5037.8 5067.1 5002.3 5010.3 5071.1 5141.9 5153.9 4975.3 4998.1 5038.6 5074.3 5102.5 4925.5 4988.8 5017.0 5044.2 5080.1 4542.5 4546.3 4562.5 4571.4 4579.8 6241.3 6260.9 6311.2 6314.8 6319.9 5680.4 5721.8 5723.6 5736.2 5745.6 6596.0 6612.2 6614.0 6617.6 6617.7 4872.2 4884.8 4896.2 4906.8 4910.0 6863.6 6898.6 6905.2 6931.2 6934.9 5022.4 5026.6 5047.6 5063.1 5070.2 5090.8 5137.3 5137.9 5138.0 5148.7 5668.5 5745.5 5746.3 5747.7 5750.9 6272.9 6273.3 6492.0 6649.0 6661.7 1728.5 1741.5 1751.3 1769.6 1771.4 1181.6 1204.5 1205.2 1222.1 1233.6 5552.8 5685.0 5696.9 5753.2 5754.0 6700.4 6727.9 6739.7 6757.2 6820.6 5653.7 5662.9 5673.5 5694.1 5739.9 3457.9 3567.9 3568.9 3572.7 3595.2 6419.6 6463.6 6501.6 6517.8 6549.7 6862.9 6882.5 6914.3 6947.9 6951.8 6466.5 6478.0 6490.2 6541.4 6545.2 6661.0 6719.7 6745.4 6766.4 6779.4 6644.9 6690.5 6691.8 6724.2 6793.2 6388.6 6468.3 6524.9 6532.4 6536.2 4953.2 4976.9 4976.9 4990.2 5059.8 6482.0 6696.2 6775.6 6788.7 6864.6 6305.3 6526.9 6532.2 6561.0 6577.2 6469.2 6507.3 6511.9 6551.5 6584.6 6244.9 6377.8 6393.0 6444.4 6484.7 6515.2 6579.1 6587.8 6617.5 6661.5 6305.3 6318.1 6350.7 6350.7 6367.3 11:22:47 INFO - PID 9652 | 11:22:47 INFO - PID 9652 | [#5] yui.html Cycles:180 Average:23938.26 Median:20575.88 stddev:35485.77 (172.5%) stddev-sans-first:35543.10 11:22:47 INFO - PID 9652 | Values: 884.6 896.7 916.5 919.9 944.0 17274.0 17397.8 17446.7 17566.4 17577.2 16837.8 16968.4 17015.7 17139.7 18641.5 940.1 962.9 968.2 968.6 969.3 948.2 980.4 986.0 988.9 990.1 1034.6 1041.2 1050.4 1050.5 1051.4 1034.5 1036.2 1044.6 1050.7 1051.6 721.1 733.7 751.8 752.1 775.3 20483.1 20668.7 20682.0 20692.9 20696.5 20693.1 20759.6 20802.9 20981.6 21062.3 17633.6 17769.5 17804.0 18087.6 18312.9 3748.4 3756.3 3782.0 3787.4 3789.4 137725.0 141067.3 141256.3 142463.0 143891.3 15384.6 15619.1 15678.5 15715.2 15759.1 30104.2 30129.8 30411.5 30624.7 30846.7 8527.5 8662.2 8663.2 8695.6 8711.6 4057.6 4101.7 4165.6 4166.8 4178.7 5164.7 5273.2 5299.1 5301.7 5309.3 981.3 985.2 1003.9 1006.1 1009.9 657.8 666.9 671.3 680.8 685.4 10719.0 10883.8 11057.7 11577.8 11949.9 670.5 672.1 678.3 684.3 687.0 5073.7 5092.8 5098.0 5122.9 5131.4 115274.0 117463.4 117651.4 119823.4 123707.4 105829.0 107853.0 108424.5 110833.0 111440.0 94421.5 95138.0 99218.5 100163.0 100779.5 9557.4 9776.4 9781.0 9818.0 9967.7 43357.8 44609.0 44686.3 45505.3 45879.0 58691.0 58905.7 59448.0 59652.0 59951.4 14552.0 14909.5 15061.4 15145.1 15191.6 14037.6 14061.5 14108.2 14167.4 14233.4 13647.9 13722.7 13758.0 13856.1 13864.1 14515.2 14527.9 14558.5 14611.6 14842.1 14641.5 14716.9 14748.2 14837.5 14890.0 10073.8 10371.4 10401.7 10414.0 10773.4 11573.9 11681.9 11887.9 12052.4 12139.0 11:22:47 INFO - PID 9652 | -------- Summary: end -------- 11:22:47 INFO - PID 9652 | 11:22:48 INFO - TEST-INFO | 9652: exit 0 11:22:48 INFO - TEST-OK | dromaeo_css | took 1108569ms 11:22:48 INFO - TEST-START | kraken 11:22:48 INFO - Initialising browser for kraken test... 11:22:48 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53614/getInfo.html -profile /tmp/tmpZ2x8xX/profile 11:22:48 INFO - TEST-INFO | started process 10034 (/builds/slave/test/build/application/firefox/firefox http://localhost:53614/getInfo.html) 11:22:54 INFO - TEST-INFO | 10034: exit 0 11:22:54 INFO - Browser initialized. 11:22:54 INFO - Running cycle 1/1 for kraken test... 11:22:54 INFO - Using env: {'DISPLAY': ':0', 11:22:54 INFO - 'HOME': '/home/cltbld', 11:22:54 INFO - 'JSGC_DISABLE_POISONING': '1', 11:22:54 INFO - 'LANG': 'en_US.UTF-8', 11:22:54 INFO - 'LANGUAGE': 'en_US:en', 11:22:54 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:22:54 INFO - 'LOGNAME': 'cltbld', 11:22:54 INFO - 'MAIL': '/var/mail/cltbld', 11:22:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:22:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:22:54 INFO - 'MOZ_CRASHREPORTER': '1', 11:22:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:54 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:22:54 INFO - 'MOZ_NO_REMOTE': '1', 11:22:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:22:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:54 INFO - 'NO_EM_RESTART': '1', 11:22:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:54 INFO - 'PWD': '/builds/slave/test', 11:22:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:22:54 INFO - 'RUST_BACKTRACE': 'full', 11:22:54 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:22:54 INFO - 'SHELL': '/bin/bash', 11:22:54 INFO - 'SHLVL': '1', 11:22:54 INFO - 'TERM': 'linux', 11:22:54 INFO - 'TMOUT': '86400', 11:22:54 INFO - 'USER': 'cltbld', 11:22:54 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1504891611.93820-649172738', 11:22:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:54 INFO - '_': '/tools/buildbot/bin/python'} 11:22:54 INFO - TEST-INFO | started process 10235 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ2x8xX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:22:55 INFO - PID 10235 | 11:22:55 INFO - PID 10235 | (/builds/slave/test/build/application/firefox/firefox:10286): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:22:55 INFO - PID 10235 | 11:23:06 INFO - PID 10235 | RSS: Main: 167116800 11:23:06 INFO - PID 10235 | 11:23:08 INFO - PID 10235 | Cycle 1(1): loaded http://localhost:53614/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53614/tests/kraken/driver.html?testName=audio-beat-detection) 11:23:09 INFO - PID 10235 | RSS: Main: 173400064 11:23:09 INFO - PID 10235 | 11:23:12 INFO - PID 10235 | Cycle 1(1): loaded http://localhost:53614/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53614/tests/kraken/driver.html?testName=audio-dft) 11:23:13 INFO - PID 10235 | RSS: Main: 173981696 11:23:13 INFO - PID 10235 | 11:23:16 INFO - PID 10235 | Cycle 1(1): loaded http://localhost:53614/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53614/tests/kraken/driver.html?testName=audio-fft) 11:23:16 INFO - PID 10235 | RSS: Main: 168640512 11:23:16 INFO - PID 10235 | 11:23:18 INFO - PID 10235 | Cycle 1(1): loaded http://localhost:53614/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53614/tests/kraken/driver.html?testName=audio-oscillator) 11:23:19 INFO - PID 10235 | RSS: Main: 169385984 11:23:19 INFO - PID 10235 | 11:23:21 INFO - PID 10235 | Cycle 1(1): loaded http://localhost:53614/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53614/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:23:22 INFO - PID 10235 | RSS: Main: 169656320 11:23:22 INFO - PID 10235 | 11:23:25 INFO - PID 10235 | Cycle 1(1): loaded http://localhost:53614/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53614/tests/kraken/driver.html?testName=imaging-darkroom) 11:23:25 INFO - PID 10235 | RSS: Main: 172789760 11:23:25 INFO - PID 10235 | 11:23:29 INFO - PID 10235 | Cycle 1(1): loaded http://localhost:53614/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53614/tests/kraken/driver.html?testName=imaging-desaturate) 11:23:30 INFO - PID 10235 | RSS: Main: 171945984 11:23:30 INFO - PID 10235 | 11:23:33 INFO - PID 10235 | Cycle 1(1): loaded http://localhost:53614/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53614/tests/kraken/driver.html?testName=json-parse-financial) 11:23:33 INFO - PID 10235 | RSS: Main: 172322816 11:23:33 INFO - PID 10235 | 11:23:35 INFO - PID 10235 | Cycle 1(1): loaded http://localhost:53614/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53614/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:23:35 INFO - PID 10235 | RSS: Main: 172326912 11:23:35 INFO - PID 10235 | 11:23:37 INFO - PID 10235 | Cycle 1(1): loaded http://localhost:53614/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53614/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:23:38 INFO - PID 10235 | RSS: Main: 172044288 11:23:38 INFO - PID 10235 | 11:23:40 INFO - PID 10235 | Cycle 1(1): loaded http://localhost:53614/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53614/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:23:41 INFO - PID 10235 | RSS: Main: 171995136 11:23:41 INFO - PID 10235 | 11:23:43 INFO - PID 10235 | Cycle 1(1): loaded http://localhost:53614/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53614/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:23:44 INFO - PID 10235 | RSS: Main: 173236224 11:23:44 INFO - PID 10235 | 11:23:47 INFO - PID 10235 | Cycle 1(1): loaded http://localhost:53614/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53614/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:23:47 INFO - PID 10235 | RSS: Main: 172908544 11:23:47 INFO - PID 10235 | 11:23:49 INFO - PID 10235 | Cycle 1(1): loaded http://localhost:53614/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53614/tests/kraken/driver.html?testName=ai-astar) 11:23:49 INFO - PID 10235 | RSS: Main: 174342144 11:23:49 INFO - PID 10235 | 11:23:49 INFO - PID 10235 | __start_tp_report 11:23:49 INFO - PID 10235 | _x_x_mozilla_page_load 11:23:49 INFO - PID 10235 | _x_x_mozilla_page_load_details 11:23:49 INFO - PID 10235 | |i|pagename|runs| 11:23:49 INFO - PID 10235 | |0;ai-astar;109;108;107;108;110;109;107;108;108;110 11:23:49 INFO - PID 10235 | |1;audio-beat-detection;118;120;116;117;116;118;117;117;123;142 11:23:49 INFO - PID 10235 | |2;audio-dft;167;164;163;163;162;162;165;170;168;164 11:23:49 INFO - PID 10235 | |3;audio-fft;76;75;74;74;73;74;73;75;78;76 11:23:49 INFO - PID 10235 | |4;audio-oscillator;79;79;79;79;79;79;83;80;79;79 11:23:49 INFO - PID 10235 | |5;imaging-gaussian-blur;113;114;111;114;113;110;115;114;114;119 11:23:49 INFO - PID 10235 | |6;imaging-darkroom;150;149;148;148;150;148;147;148;149;149 11:23:49 INFO - PID 10235 | |7;imaging-desaturate;95;94;94;94;94;94;94;94;95;95 11:23:49 INFO - PID 10235 | |8;json-parse-financial;52;51;51;52;55;52;54;52;51;53 11:23:49 INFO - PID 10235 | |9;json-stringify-tinderbox;38;48;38;38;37;37;38;38;38;38 11:23:49 INFO - PID 10235 | |10;stanford-crypto-aes;74;75;76;75;75;77;77;75;75;77 11:23:49 INFO - PID 10235 | |11;stanford-crypto-ccm;119;130;122;128;120;124;128;123;122;123 11:23:49 INFO - PID 10235 | |12;stanford-crypto-pbkdf2;169;171;171;178;172;166;167;165;167;167 11:23:49 INFO - PID 10235 | |13;stanford-crypto-sha256-iterative;67;66;64;65;65;66;66;62;63;64 11:23:49 INFO - PID 10235 | __end_tp_report 11:23:49 INFO - PID 10235 | __start_cc_report 11:23:49 INFO - PID 10235 | _x_x_mozilla_cycle_collect,936 11:23:49 INFO - PID 10235 | __end_cc_report 11:23:49 INFO - PID 10235 | __startTimestamp1504895029946__endTimestamp 11:23:49 INFO - PID 10235 | 11:23:49 INFO - PID 10235 | ------- Summary: start ------- 11:23:49 INFO - PID 10235 | Number of tests: 14 11:23:49 INFO - PID 10235 | 11:23:49 INFO - PID 10235 | [#0] ai-astar Cycles:10 Average:108.40 Median:108.50 stddev:1.07 (1.0%) stddev-sans-first:1.12 11:23:49 INFO - PID 10235 | Values: 109.0 108.0 107.0 108.0 110.0 109.0 107.0 108.0 108.0 110.0 11:23:49 INFO - PID 10235 | 11:23:49 INFO - PID 10235 | [#1] audio-beat-detection Cycles:10 Average:120.40 Median:118.00 stddev:7.88 (6.7%) stddev-sans-first:8.31 11:23:49 INFO - PID 10235 | Values: 118.0 120.0 116.0 117.0 116.0 118.0 117.0 117.0 123.0 142.0 11:23:49 INFO - PID 10235 | 11:23:49 INFO - PID 10235 | [#2] audio-dft Cycles:10 Average:164.80 Median:164.50 stddev:2.70 (1.6%) stddev-sans-first:2.74 11:23:49 INFO - PID 10235 | Values: 167.0 164.0 163.0 163.0 162.0 162.0 165.0 170.0 168.0 164.0 11:23:49 INFO - PID 10235 | 11:23:49 INFO - PID 10235 | [#3] audio-fft Cycles:10 Average:74.80 Median:75.00 stddev:1.55 (2.1%) stddev-sans-first:1.58 11:23:49 INFO - PID 10235 | Values: 76.0 75.0 74.0 74.0 73.0 74.0 73.0 75.0 78.0 76.0 11:23:49 INFO - PID 10235 | 11:23:49 INFO - PID 10235 | [#4] audio-oscillator Cycles:10 Average:79.50 Median:79.00 stddev:1.27 (1.6%) stddev-sans-first:1.33 11:23:49 INFO - PID 10235 | Values: 79.0 79.0 79.0 79.0 79.0 79.0 83.0 80.0 79.0 79.0 11:23:49 INFO - PID 10235 | 11:23:49 INFO - PID 10235 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:2.41 (2.1%) stddev-sans-first:2.54 11:23:49 INFO - PID 10235 | Values: 113.0 114.0 111.0 114.0 113.0 110.0 115.0 114.0 114.0 119.0 11:23:49 INFO - PID 10235 | 11:23:49 INFO - PID 10235 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:149.00 stddev:0.97 (0.6%) stddev-sans-first:0.88 11:23:49 INFO - PID 10235 | Values: 150.0 149.0 148.0 148.0 150.0 148.0 147.0 148.0 149.0 149.0 11:23:49 INFO - PID 10235 | 11:23:49 INFO - PID 10235 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 11:23:49 INFO - PID 10235 | Values: 95.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 95.0 95.0 11:23:49 INFO - PID 10235 | 11:23:49 INFO - PID 10235 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:52.00 stddev:1.34 (2.6%) stddev-sans-first:1.41 11:23:49 INFO - PID 10235 | Values: 52.0 51.0 51.0 52.0 55.0 52.0 54.0 52.0 51.0 53.0 11:23:49 INFO - PID 10235 | 11:23:49 INFO - PID 10235 | [#9] json-stringify-tinderbox Cycles:10 Average:38.80 Median:38.00 stddev:3.26 (8.6%) stddev-sans-first:3.44 11:23:49 INFO - PID 10235 | Values: 38.0 48.0 38.0 38.0 37.0 37.0 38.0 38.0 38.0 38.0 11:23:49 INFO - PID 10235 | 11:23:49 INFO - PID 10235 | [#10] stanford-crypto-aes Cycles:10 Average:75.60 Median:75.50 stddev:1.07 (1.4%) stddev-sans-first:0.97 11:23:49 INFO - PID 10235 | Values: 74.0 75.0 76.0 75.0 75.0 77.0 77.0 75.0 75.0 77.0 11:23:49 INFO - PID 10235 | 11:23:49 INFO - PID 10235 | [#11] stanford-crypto-ccm Cycles:10 Average:123.90 Median:123.50 stddev:3.63 (2.9%) stddev-sans-first:3.40 11:23:49 INFO - PID 10235 | Values: 119.0 130.0 122.0 128.0 120.0 124.0 128.0 123.0 122.0 123.0 11:23:49 INFO - PID 10235 | 11:23:49 INFO - PID 10235 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.30 Median:170.00 stddev:3.86 (2.3%) stddev-sans-first:4.09 11:23:49 INFO - PID 10235 | Values: 169.0 171.0 171.0 178.0 172.0 166.0 167.0 165.0 167.0 167.0 11:23:49 INFO - PID 10235 | 11:23:49 INFO - PID 10235 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:65.50 stddev:1.55 (2.4%) stddev-sans-first:1.42 11:23:49 INFO - PID 10235 | Values: 67.0 66.0 64.0 65.0 65.0 66.0 66.0 62.0 63.0 64.0 11:23:49 INFO - PID 10235 | -------- Summary: end -------- 11:23:49 INFO - PID 10235 | 11:23:50 INFO - PID 10235 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:23:50 INFO - TEST-INFO | 10235: exit 0 11:23:50 INFO - TEST-OK | kraken | took 62290ms 11:23:50 INFO - SUITE-END | took 1170s 11:23:51 INFO - Completed test suite (00:19:31) 11:23:51 INFO - javascript benchmark 11:23:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8443.142640516799, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3078.0458058002023, 3102.1158969693643, 3104.674009229031, 3105.285784269618, 3118.2672072063046, 6099.207103076594, 6234.719437625301, 6289.213848268966, 6298.874022519552, 6327.272363678178, 6239.906401403971, 6284.277308109568, 6293.874122517547, 6298.244210694712, 6315.810525684236, 5771.2497375341145, 5806.622569532967, 5882.6764527950945, 5896.587238893279, 5949.0, 5818.563607729416, 5885.705714714269, 5898.262717160355, 5909.852253693649, 5932.584719069667, 306.8623462092225, 5724.398938111501, 5748.2527271454655, 5749.482546570787, 5896.498797602209, 5793.768249270024, 5853.531717462635, 5870.677112758796, 5888.0, 5888.735006924699, 5768.97115514424, 5772.797952071657, 5854.677992710399, 5855.8536036599, 5860.296764388258, 6266.749330026793, 6268.1851359323455, 6277.843053923689, 6287.622742635456, 6371.2991570927625, 6670.433013193884, 6734.629595372253, 6782.932170678279, 6809.421199198025, 6822.351876571718, 6477.74089036438, 6580.078788969548, 6752.561083529555, 6851.794446166623, 6857.55425897315, 6189.566730328879, 6238.1266622672865, 6253.46845518127, 6258.718357673915, 6339.36606339367, 6915.4121899638085, 6920.031195632565, 6929.064576282138, 7010.228874823765, 7030.718771249195, 6407.903881441782, 6438.066480360321, 6581.539292249497, 6654.401103900672, 6655.633940133339, 6637.601743895381, 6707.53047286695, 6715.899261511081, 6718.328167183243, 6773.491988100912, 6695.296993815677, 6750.898736518956, 6777.796666100025, 6791.524593278423, 6798.320167983162, 6733.562318449285, 6738.764143254963, 6745.224299205556, 6836.6923488443135, 6838.555493892881, 5155.61332900034, 5268.868278293074, 5331.173668081454, 5338.092524270884, 5339.359276886798, 4601.976990115028, 4646.09401166776, 4698.929516057262, 4702.741349225757, 4723.220668589713, 5729.169270455761, 5750.223719797774, 5773.6824474654295, 5782.045962416154, 5809.390014048464, 6763.188417389944, 6796.082528858541, 6796.286389928986, 6874.690638921261, 6877.140357455318, 5649.6327738696855, 5739.971300143473, 5754.223179870663, 5764.221830052973, 5818.127280907813, 5818.883622327529, 5858.2677165354335, 5891.469767720926, 5892.764289428461, 5901.321348044944, 6515.641639709766, 6521.5108866834225, 6589.341065893373, 6603.867922641521, 6611.933880661228, 6585.045168450548, 6672.5329226953645, 6753.054572359972, 6827.1807383112355, 6829.043933849166, 6530.314316996647, 6565.146530950946, 6577.704003319958, 6580.012998050331, 6593.736250549924, 6666.766663166766, 6679.1984961802955, 6697.3637504437, 6714.865702686016, 6756.29058948823, 6698.765543206159, 6784.219814721173, 6800.795976120724, 6874.759383421556, 6906.171259448898, 6318.368163183645, 6423.164988551458, 6493.480521558358, 6530.151080359713, 6627.469802415699, 6543.051257567721, 6597.670116494252, 6610.338966103352, 6634.303398143125, 6635.402813746786, 6358.237011558643, 6469.191351081115, 6470.547061705635, 6530.444912182517, 6569.178852643419, 6520.315366886598, 6621.205455345389, 6623.105880706043, 6641.867162656623, 6676.232233293234, 6235.96882015587, 6253.09330147117, 6278.309385967448, 6338.841528961629, 6353.983362661952], "value": 6104.830143055419, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [832.6378025558882, 861.414238317944, 886.0563499872632, 888.7467071884514, 889.7820034091649, 41614.58385416145, 41697.37453938186, 42467.0, 42642.78678606606, 42685.57314426859, 43155.35266970998, 43556.0, 43641.12717745643, 43710.0, 43717.34423983643, 7915.12933577306, 8033.277005069543, 8066.757997260062, 8068.47554908929, 8072.919270807305, 7965.72119975801, 7985.640646170937, 8057.516549007049, 8061.798455038613, 8078.636461359223, 8088.959555202216, 8099.311558517533, 8122.106568277485, 8129.187081291882, 8130.471519351253, 8042.115367309591, 8068.878966815502, 8080.757577272691, 8082.717104901359, 8084.919150808505, 7792.532448053135, 7886.487378320448, 7890.802729931797, 7893.565853878034, 7898.0, 38799.41800872989, 39170.804145979375, 39176.0, 39216.60783392158, 39276.803615981735, 3514.0687717754818, 3550.786952782841, 3551.129973156593, 3552.662497062775, 3554.680078792895, 32996.010119696206, 33098.3380332392, 33116.0, 33170.33659326824, 33231.33537329264, 5117.232415137722, 5216.243644671539, 5263.973525162595, 5267.0, 5289.074411977888, 193080.0, 193397.9999999986, 193535.0, 193830.0, 194155.0, 48627.513724863005, 48755.0, 48839.51160488421, 48849.0, 48852.267215991786, 50771.74614126905, 54777.0, 55270.44729552653, 55430.0, 55666.72166639141, 16242.918785405996, 16297.0, 16393.344266229455, 16412.75380869288, 16436.260368283456, 13288.800667989988, 13338.866611333957, 13587.45650173982, 13623.0, 13737.107088039245, 15147.772783408258, 15173.696526069416, 15239.695206095816, 15287.61780955485, 15318.080915145127, 5758.424157584292, 5984.222051133324, 6058.697065146725, 6073.665948372882, 6152.0156774915795, 994.4132961552574, 1004.7588578741049, 1006.3810756384771, 1016.1413605503337, 1026.2559644257854, 22867.771322286895, 22905.427364316027, 22915.0, 23433.41416464602, 23609.05563777464, 1074.3768614203743, 1089.4334945828284, 1092.317301686446, 1103.089950790585, 1111.6193051882299, 12413.93793031029, 12422.088137483366, 12462.563810266598, 12543.811842822364, 12554.81167782484, 213224.0, 214801.0, 228909.0, 229710.0, 230201.0, 45904.540954590695, 46945.76527117411, 52776.73611631994, 54809.72595136999, 55068.724656376464, 1420.609332433589, 1427.3933578229212, 1435.2895316818242, 1447.1244896837472, 1449.8042764226905, 26312.0, 26501.204963851116, 26616.600750988364, 26782.0, 26924.192274231806, 37942.2411551773, 37985.62014379821, 38006.2398752029, 38010.23979520449, 38035.809820950715, 200426.0, 201091.0, 201368.0, 201522.0, 201848.0, 34583.0, 34620.65379346275, 34743.47884781781, 34834.65165348314, 34839.30321393507, 42180.57819421889, 42510.0, 42548.78725606476, 43222.351664724425, 43224.56775432331, 31029.379412411174, 31395.0, 31434.0, 31452.0, 31461.52807707932, 31177.688223118384, 31345.52981705322, 31488.370232595676, 31616.367672646877, 32198.19504512406, 35459.82270088633, 35557.82221088878, 35657.46513802243, 35658.82170589131, 35768.82115589405, 30301.24246893757, 30506.694933050385, 30694.232644184074, 31151.84424077865, 31175.53236701406, 22884.542309154058, 22935.426614334774, 23185.652215216447, 23402.0, 23562.52874942457], "value": 17472.796376683327, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.1253132581845, 560.7420586530196, 569.7550851389714, 576.3170642788299, 596.9910451343229, 22416.88791556042, 23485.178018769348, 23544.293671189847, 23576.410589735264, 23584.76415235845, 22776.77223227767, 23391.76608233917, 23496.530069398603, 24715.62926556103, 25096.0, 6478.4817214622835, 6623.701933412984, 6688.230853451842, 6690.996350547408, 6697.196336439634, 6299.275583307909, 6574.80275591733, 6673.8331541711605, 6680.83297917551, 6685.097511835913, 6495.285518592951, 6574.704138313788, 6579.868402631944, 6582.341765823403, 6586.37429444202, 6543.985682219263, 6550.737970481175, 6573.441257493118, 6575.473962083046, 6577.802665920006, 5801.941980580183, 6019.729112189962, 6021.819345419601, 6033.42682445167, 6052.727627256784, 27293.0, 27810.0, 27828.30429239265, 27831.582526262122, 27844.443111137665, 1997.9300724474574, 2029.5839352932614, 2032.2582257475915, 2033.298512013353, 2033.5424529480897, 18725.0, 19415.708764368545, 19710.80289197104, 19722.408327750192, 19827.90086049575, 2185.115028413495, 2247.71903512061, 2256.2892688802976, 2270.137347807839, 2345.917892873741, 111474.44262778715, 118438.40780796041, 135060.0, 138950.0, 144079.27960360236, 13954.441822326993, 14065.367058482392, 14207.715845683235, 14304.499342522962, 14646.487372941896, 22110.668339974913, 22178.667319990214, 22219.0, 22231.333060008226, 22280.554388912456, 9069.909300907038, 9284.860727089099, 9421.528923553795, 9477.24182065447, 9545.665901693408, 8384.790380240544, 8475.533845638425, 8529.061803201643, 8533.0, 8646.78383040429, 8696.652133914573, 8740.606672699743, 8800.735977920673, 8910.643574257087, 9068.81862362749, 2622.2002289301563, 2631.8552479613422, 2636.1564299424, 2645.6031595260865, 2693.232428757834, 947.6067432015636, 960.644561512231, 962.4754508792724, 964.0118878149952, 964.6527250189926, 18731.438056858315, 18751.156197971122, 18892.527686807938, 18947.24211031571, 19023.239070437303, 991.6563057057728, 1017.8473229015559, 1019.3832731197518, 1021.8416145497459, 1027.445179603006, 10405.739856503496, 10418.21863360251, 10471.84292235617, 10492.632757853438, 10771.299865508718, 480140.0, 482461.0, 483386.0, 485035.0, 496351.0, 110706.0, 111570.44214779037, 111760.0, 111770.0, 112386.0, 1046.931949423285, 1083.6586475260267, 1137.0846468592863, 1160.5763896177834, 1189.7501524679915, 19769.40691779249, 19963.301284454974, 20026.098825553177, 20050.398488045383, 20413.89793051025, 55440.722796387374, 56206.71896640491, 56269.43730562642, 56479.435205647416, 57731.99999999832, 68543.31456685369, 68736.6563167181, 69204.30795691979, 69322.30677693158, 69492.65253673699, 13332.133411328232, 13610.727785444433, 14012.0, 14022.22877741734, 14135.081219720685, 22334.10663573504, 22538.436539086655, 22613.0, 22647.20734774275, 22789.77210227943, 17340.47978560645, 17730.91134544319, 18108.0, 18311.084445777924, 18313.908430457763, 14750.409983600535, 15237.238138093273, 15342.232888355315, 15469.5359139226, 15632.4528641497, 16586.0, 16927.661446771242, 17097.658046839242, 17114.743278851078, 17156.39952601653, 13900.51348202808, 13923.094998825043, 13933.58199254024, 13935.163890166217, 13953.023288369717, 17944.19251133676, 17993.730094048336, 18019.2792288307, 18121.728174077136, 18145.364912228008], "value": 11629.772011742225, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1336.9064165508414, 1386.6325423762698, 1388.2225953466059, 1392.4708610727928, 1401.131298594871, 12659.620211393662, 13236.404361803718, 13264.801027984588, 15174.924125379384, 15693.686126277467, 15336.769948450754, 15612.921935390306, 15616.76574851378, 15625.687486250268, 15665.13841738704, 2781.3324802047514, 2845.2460098073925, 2850.3586692994013, 2850.78619103567, 2852.3011862093817, 2756.0, 2928.868200930963, 2928.8974885878997, 2931.2378781516854, 2932.545455454408, 2789.4700006998705, 2852.0, 2855.543113101904, 2895.073576455535, 2898.9710102899016, 2805.424887897976, 2820.083472871315, 2821.139552436506, 2821.210061182872, 2831.603575499432, 2692.434588736368, 2701.864906754674, 2708.377073273158, 2712.51174788538, 2713.9728602713917, 14825.18461484618, 15122.260939991931, 15134.394624215018, 15198.316075776505, 15231.390744370212, 7945.245201705829, 8203.548804815733, 8206.548639824807, 8233.135520770293, 8235.670573177065, 5222.4255331913455, 5408.4591540845995, 5460.754266058037, 5513.365962914276, 5540.141278101901, 1927.4988502989183, 1927.7493925789558, 1936.4868309897888, 1967.3114409956545, 1969.803019698033, 23897.283081507583, 26035.869820650965, 26132.0, 26137.607935880977, 26167.345816354555, 6893.655317234118, 6985.301469853076, 7132.0, 7175.138983322035, 7219.747308844166, 17431.302747890197, 17504.64990700179, 17515.56211094733, 17518.824811751972, 17537.0, 7552.0, 7858.685652573833, 8044.678212871419, 8046.476978996347, 8048.718294859652, 7433.219511951167, 7456.701731930771, 7457.254274572608, 7463.776086717407, 7481.177070522238, 5235.73821308933, 5236.188390799432, 5268.28878101459, 5308.389535203424, 5368.489993450616, 1505.224809223251, 1506.2694593122546, 1515.8029456170627, 1521.5435369389138, 1544.1121355220794, 894.7449976756593, 916.3402350307767, 918.3387960668308, 930.3208657679796, 933.4819175357605, 7784.0, 7840.882386764203, 7849.803754906173, 7908.644111015018, 7946.721864734706, 718.4396170986639, 722.4509372876547, 728.4318231779115, 734.720806093681, 737.8930055141974, 5168.638195326366, 5264.763085661154, 5319.0957537218765, 5336.092864213093, 5345.732713364394, 21249.150033998776, 22127.114915403203, 22135.0, 22224.888875555844, 22226.333210003726, 21282.467938301666, 21646.458838529164, 21738.34784956454, 21834.454138646663, 21865.12539498434, 11117.27737697047, 11366.659000230007, 11429.542818287342, 11561.30632162073, 11586.246893952035, 8347.248747612744, 8485.193906579112, 8500.659973600987, 8504.319654427507, 8623.87064194025, 18246.543836404195, 18371.0, 18513.722294165327, 18627.627447451247, 18908.43274701761, 18750.718739219195, 18807.811921880606, 18831.435056948314, 18832.717509237646, 18940.242390304233, 10897.128229741444, 11133.0, 11135.10919126484, 11192.048675862643, 11204.495797689287, 13905.791413128609, 14038.859611403755, 14172.716545669235, 14195.43218271299, 14283.928580357031, 11422.543098275975, 11472.655820325404, 11560.47977841016, 11711.1802173847, 11827.763444730885, 10314.535845886803, 10383.480825958823, 10494.108000820015, 10676.46617669098, 10726.141908647445, 10161.187105031431, 10208.693739187836, 10303.278770485995, 10345.637902673672, 10392.792144156923, 6720.966395167993, 6845.863082738417, 6864.7940561783225, 6879.8968015480805, 6886.48351373659, 6895.6552172392185, 6974.267701891431, 6977.058097157022, 7036.296370362923, 7053.753118640823], "value": 6662.702083440152, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.5059765533295, 508.2757071173577, 526.0898645343555, 528.036333691014, 531.9468053194681, 6192.349803270648, 6209.2548894132715, 6262.0, 6345.50996951677, 6401.199850018747, 6092.299385570661, 6113.266408031042, 6141.232345956755, 6154.246039878635, 6168.105624684418, 4923.335349727795, 4993.126202914494, 5035.622328325372, 5037.798488060492, 5067.138586440314, 5002.274670172823, 5010.323606313155, 5071.137906555894, 5141.871453213662, 5153.948460515385, 4975.2835271831345, 4998.075356059123, 5038.622103342245, 5074.264231686422, 5102.540771330579, 4925.507449255046, 4988.802687355027, 5017.0, 5044.218146187347, 5080.110980578384, 4542.454905411339, 4546.29532422475, 4562.520935301812, 4571.405717256735, 4579.816807327703, 6241.313455519889, 6260.87478250437, 6311.211098612674, 6314.778982735628, 6319.936800631981, 5680.4319568042865, 5721.828345149652, 5723.570732195102, 5736.196932429463, 5745.597808153431, 6596.0, 6612.239592446882, 6613.966930165367, 6617.636030018347, 6617.702203400859, 4872.220444728861, 4884.804607815683, 4896.2410826321975, 4906.828261010884, 4909.975450122726, 6863.553868998499, 6898.551014389869, 6905.240423553405, 6931.1682598088555, 6934.861302773917, 5022.372203474566, 5026.59787217029, 5047.570956468668, 5063.113955057924, 5070.239464080418, 5090.847274581768, 5137.255098010767, 5137.922931156036, 5137.9743101285, 5148.6910785353, 5668.489835914705, 5745.454181852718, 5746.2529871116485, 5747.712614369265, 5750.852986576991, 6272.937270627235, 6273.278572964076, 6491.967540162269, 6648.96675516629, 6661.666916654148, 1728.4728157911957, 1741.4601473543241, 1751.3082332478855, 1769.5576105973507, 1771.3977247735575, 1181.6293100003954, 1204.5422739358987, 1205.15036898986, 1222.1261797814605, 1233.586748439265, 5552.750126244328, 5684.976704193202, 5696.857578560569, 5753.223314852441, 5754.0, 6700.363465470772, 6727.899081513781, 6739.663016849138, 6757.189137303555, 6820.590764554143, 5653.745581448845, 5662.943370566324, 5673.489385955284, 5694.060480020833, 5739.891496568058, 3457.913552161216, 3567.9117869050187, 3568.8572457101427, 3572.7141828653644, 3595.1551385424405, 6419.602572238032, 6463.644499552475, 6501.642409667419, 6517.804465866032, 6549.672516374162, 6862.862742745217, 6882.518223724292, 6914.308569143045, 6947.89578156328, 6951.756688515979, 6466.482681385478, 6477.963525835844, 6490.188726409199, 6541.378569035934, 6545.214574251025, 6660.966695166493, 6719.664016799238, 6745.436734041033, 6766.391024807791, 6779.423748981392, 6644.90032649501, 6690.531662783558, 6691.832704182434, 6724.159480064992, 6793.150856142982, 6388.616682999035, 6468.2561505427475, 6524.858149823856, 6532.41208291256, 6536.150300460909, 4953.23224900141, 4976.8553232757395, 4976.925346119883, 4990.1516742154645, 5059.848204553869, 6482.0, 6696.229933557704, 6775.593464392152, 6788.694508747019, 6864.622445765531, 6305.337939516468, 6526.9347306528225, 6532.216134063943, 6561.0, 6577.2436169841085, 6469.159009328757, 6507.316731743288, 6511.934880651323, 6551.50863685216, 6584.604923704593, 6244.937550624436, 6377.840553986188, 6392.954254638471, 6444.387783160592, 6484.740610375532, 6515.185601799775, 6579.144711187515, 6587.769428069994, 6617.470602351704, 6661.500387471056, 6305.274893387319, 6318.115463835159, 6350.650714210763, 6350.745970161327, 6367.267764207176], "value": 5070.905639865042, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [884.5709830732097, 896.7220161749857, 916.4638686368478, 919.9356045076843, 943.9716808495743, 17274.0, 17397.82602173978, 17446.738298925527, 17566.385176518823, 17577.209025593846, 16837.83162168378, 16968.4061057863, 17015.744763828552, 17139.657206855856, 18641.533961650966, 940.0505489455647, 962.9085236902519, 968.2350942755215, 968.602872822143, 969.3263182088451, 948.2035090523958, 980.3676628574565, 985.9654912078079, 988.8714467119264, 990.0643891522515, 1034.5654824973528, 1041.161864698917, 1050.4432650695144, 1050.5220124843179, 1051.363924825481, 1034.4724190662741, 1036.2331874412919, 1044.5508431374544, 1050.6532844161484, 1051.64244156987, 721.1418412089597, 733.7248531800575, 751.7782254235013, 752.0824593995317, 775.275117764886, 20483.07826147827, 20668.689969650466, 20682.0, 20692.896535517375, 20696.482587935272, 20693.0688119035, 20759.5848083039, 20802.895985519976, 20981.5803683927, 21062.2628208012, 17633.55916102095, 17769.46691599254, 17804.0, 18087.638247235114, 18312.90843545787, 3748.381517049711, 3756.267527832074, 3781.9810900945595, 3787.4129509926006, 3789.3936970084656, 137725.0, 141067.29466352705, 141256.2937185318, 142463.0, 143891.2805435966, 15384.615384615474, 15619.062856228435, 15678.529644110695, 15715.21423928799, 15759.054456732632, 30104.24739381489, 30129.849350753106, 30411.543826842615, 30624.69375306263, 30846.69153308483, 8527.530985795716, 8662.177093176138, 8663.176998185163, 8695.565221739014, 8711.60797764102, 4057.594240575978, 4101.651359634405, 4165.562615925345, 4166.7708276044505, 4178.707490475637, 5164.715940623227, 5273.235380869829, 5299.12564426873, 5301.708406037705, 5309.256704061358, 981.3130808433982, 985.2462865907586, 1003.9247056470793, 1006.1397505133152, 1009.8889122196553, 657.7763560389395, 666.8799616069057, 671.2850813883199, 680.8059702984725, 685.372883811307, 10719.0, 10883.78232435347, 11057.668269951915, 11577.768444631229, 11949.88050119505, 670.51722759613, 672.052406107396, 678.2776343194482, 684.260998122027, 687.0, 5073.720945347967, 5092.821751238689, 5098.0, 5122.92315615266, 5131.435542090367, 115274.0, 117463.41268293603, 117651.41174294073, 119823.40088299503, 123707.38146309211, 105829.0, 107853.0, 108424.45787771011, 110833.0, 111440.0, 94421.5278923601, 95138.0, 99218.50390748144, 100162.99837001682, 100779.49610252048, 9557.378770379903, 9776.364536305402, 9781.0, 9817.950910245403, 9967.651132210338, 43357.78321108374, 44609.0, 44686.3297050551, 45505.31742023806, 45879.0, 58691.0, 58905.70547147408, 59448.0, 59652.0, 59951.400485996324, 14552.0, 14909.478168264059, 15061.397544098114, 15145.091294522364, 15191.620209494851, 14037.578872633838, 14061.507847225297, 14108.224047677066, 14167.433302667778, 14233.430662773788, 13647.931760341531, 13722.65693357674, 13758.036937414285, 13856.099353541988, 13864.098833575785, 14515.201663908587, 14527.85472145265, 14558.4904528341, 14611.561653150422, 14842.109473431628, 14641.48754793577, 14716.926415367854, 14748.188849613374, 14837.480688176294, 14890.0, 10073.798524029331, 10371.429571373646, 10401.739956501147, 10414.0, 10773.353598783784, 11573.942130289295, 11681.88318116808, 11887.940560297144, 12052.397380130784, 12139.0], "value": 8642.827589403045, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1429.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 108.0, 107.0, 108.0, 110.0, 109.0, 107.0, 108.0, 108.0, 110.0], "value": 108.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 120.0, 116.0, 117.0, 116.0, 118.0, 117.0, 117.0, 123.0, 142.0], "value": 120.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 164.0, 163.0, 163.0, 162.0, 162.0, 165.0, 170.0, 168.0, 164.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 74.0, 73.0, 74.0, 73.0, 75.0, 78.0, 76.0], "value": 74.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 79.0, 79.0, 79.0, 83.0, 80.0, 79.0, 79.0], "value": 79.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 111.0, 114.0, 113.0, 110.0, 115.0, 114.0, 114.0, 119.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 148.0, 148.0, 150.0, 148.0, 147.0, 148.0, 149.0, 149.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 51.0, 52.0, 55.0, 52.0, 54.0, 52.0, 51.0, 53.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 48.0, 38.0, 38.0, 37.0, 37.0, 38.0, 38.0, 38.0, 38.0], "value": 38.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 75.0, 75.0, 77.0, 77.0, 75.0, 75.0, 77.0], "value": 75.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 130.0, 122.0, 128.0, 120.0, 124.0, 128.0, 123.0, 122.0, 123.0], "value": 123.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 171.0, 171.0, 178.0, 172.0, 166.0, 167.0, 165.0, 167.0, 167.0], "value": 169.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 64.0, 65.0, 65.0, 66.0, 66.0, 62.0, 63.0, 64.0], "value": 64.8, "unit": "score"}]}]} 11:23:51 INFO - Return code: 0 11:23:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:23:51 INFO - # TBPL SUCCESS # 11:23:51 INFO - Running post-action listener: _package_coverage_data 11:23:51 INFO - Running post-action listener: _resource_record_post_action 11:23:51 INFO - [mozharness: 2017-09-08 18:23:51.245371Z] Finished run-tests step (success) 11:23:51 INFO - Running post-run listener: _resource_record_post_run 11:23:51 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 8192; Write bytes: 296857600; Read time: 176; Write time: 182928 11:23:51 INFO - TinderboxPrint: CPU usage
13.1% 11:23:51 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 176 11:23:51 INFO - TinderboxPrint: I/O write bytes / time
296,857,600 / 182,928 11:23:51 INFO - TinderboxPrint: CPU idle
8,228.3 (86.9%) 11:23:51 INFO - TinderboxPrint: CPU user
1,191.0 (12.6%) 11:23:51 INFO - TinderboxPrint: Swap in / out
0 / 0 11:23:51 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 12357632; Read time: 0; Write time: 2528 11:23:51 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:23:51 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 8192; Write bytes: 284073984; Read time: 176; Write time: 180384 11:23:51 INFO - Running post-run listener: _upload_blobber_files 11:23:51 INFO - Blob upload gear active. 11:23:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:23:51 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:23:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:23:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:23:52 INFO - (blobuploader) - INFO - Open directory for files ... 11:23:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:23:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:23:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:23:53 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:23:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:23:53 INFO - (blobuploader) - INFO - Done attempting. 11:23:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:23:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:23:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:23:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:23:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:23:54 INFO - (blobuploader) - INFO - Done attempting. 11:23:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:23:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:23:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:24:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:24:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:24:01 INFO - (blobuploader) - INFO - Done attempting. 11:24:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:24:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:24:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:24:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:24:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:24:02 INFO - (blobuploader) - INFO - Done attempting. 11:24:02 INFO - (blobuploader) - INFO - Iteration through files over. 11:24:02 INFO - Return code: 0 11:24:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:24:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:24:02 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/56a2b10dc0ca1598b1ee79e52adb3dda9e211ced4b9bc7397540e83415ddd477b9e819ce75a39dca238621076c8c67f48b588e2066b2a18bdcfd0ac5cc29dc20", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e7782dfa4ab1153a2d0aeda811c0259a258fc8a6661265c7b490e41c612c808ab09beb547cedb357e2fe1b617f8cc35e6e6f70f206070289d5264dce9115991b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3bca66f6a22ddf21ce4f1e1c4733bd52ed41cf2625dc2d6ef3df317e5cd0207b7cb6287d6cde1825a205fad16f7b449f15748c9f57c253e6deaf43bc8d47b5f6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c06c9f0b6fa620707b30426c1fbc4981da720f6cf0ce6f38957b0f36a8894cd4a6b32290151402e5a054fc06304d10d9f9c096178a9ea06fb0e35781a720d9d7"} 11:24:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:24:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:24:02 INFO - Contents: 11:24:02 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/56a2b10dc0ca1598b1ee79e52adb3dda9e211ced4b9bc7397540e83415ddd477b9e819ce75a39dca238621076c8c67f48b588e2066b2a18bdcfd0ac5cc29dc20", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e7782dfa4ab1153a2d0aeda811c0259a258fc8a6661265c7b490e41c612c808ab09beb547cedb357e2fe1b617f8cc35e6e6f70f206070289d5264dce9115991b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3bca66f6a22ddf21ce4f1e1c4733bd52ed41cf2625dc2d6ef3df317e5cd0207b7cb6287d6cde1825a205fad16f7b449f15748c9f57c253e6deaf43bc8d47b5f6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c06c9f0b6fa620707b30426c1fbc4981da720f6cf0ce6f38957b0f36a8894cd4a6b32290151402e5a054fc06304d10d9f9c096178a9ea06fb0e35781a720d9d7"} 11:24:02 INFO - Running post-run listener: copy_logs_to_upload_dir 11:24:02 INFO - Copying logs to upload dir... 11:24:02 INFO - mkdir: /builds/slave/test/build/upload/logs 11:24:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.550153 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-08 11:24:02.210869) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-08 11:24:02.214494) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1504891611.93820-649172738 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/56a2b10dc0ca1598b1ee79e52adb3dda9e211ced4b9bc7397540e83415ddd477b9e819ce75a39dca238621076c8c67f48b588e2066b2a18bdcfd0ac5cc29dc20", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e7782dfa4ab1153a2d0aeda811c0259a258fc8a6661265c7b490e41c612c808ab09beb547cedb357e2fe1b617f8cc35e6e6f70f206070289d5264dce9115991b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3bca66f6a22ddf21ce4f1e1c4733bd52ed41cf2625dc2d6ef3df317e5cd0207b7cb6287d6cde1825a205fad16f7b449f15748c9f57c253e6deaf43bc8d47b5f6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c06c9f0b6fa620707b30426c1fbc4981da720f6cf0ce6f38957b0f36a8894cd4a6b32290151402e5a054fc06304d10d9f9c096178a9ea06fb0e35781a720d9d7"} build_url:https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011552 build_url: 'https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/56a2b10dc0ca1598b1ee79e52adb3dda9e211ced4b9bc7397540e83415ddd477b9e819ce75a39dca238621076c8c67f48b588e2066b2a18bdcfd0ac5cc29dc20", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e7782dfa4ab1153a2d0aeda811c0259a258fc8a6661265c7b490e41c612c808ab09beb547cedb357e2fe1b617f8cc35e6e6f70f206070289d5264dce9115991b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3bca66f6a22ddf21ce4f1e1c4733bd52ed41cf2625dc2d6ef3df317e5cd0207b7cb6287d6cde1825a205fad16f7b449f15748c9f57c253e6deaf43bc8d47b5f6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c06c9f0b6fa620707b30426c1fbc4981da720f6cf0ce6f38957b0f36a8894cd4a6b32290151402e5a054fc06304d10d9f9c096178a9ea06fb0e35781a720d9d7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-08 11:24:02.243223) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 11:24:02.243605) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1504891611.93820-649172738 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004548 ========= master_lag: 0.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 11:24:02.334824) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-08 11:24:02.335147) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-08 11:24:02.335487) ========= ========= Total master_lag: 0.23 =========