builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-014 starttime: 1506594729.49 results: success (0) revision: 82c2eecf82ba820c4593aa4a9749662f7d54d9a7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-28 03:32:09.485948) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-28 03:32:09.486748) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-28 03:32:09.487238) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-28 03:32:09.499883) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 03:32:09.500285) ========= 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=31acecf42b6a79ec49471d4a000001bb-1506594728.591878-1818972610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-28 03:32:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.1M=0s 2017-09-28 03:32:09 (42.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126027 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 03:32:09.641772) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 03:32:09.642176) ========= 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=31acecf42b6a79ec49471d4a000001bb-1506594728.591878-1818972610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018197 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 03:32:09.693209) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-28 03:32:09.693560) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 82c2eecf82ba820c4593aa4a9749662f7d54d9a7 --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 82c2eecf82ba820c4593aa4a9749662f7d54d9a7 --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=31acecf42b6a79ec49471d4a000001bb-1506594728.591878-1818972610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-28 03:32:09,741 truncating revision to first 12 chars 2017-09-28 03:32:09,741 Setting DEBUG logging. 2017-09-28 03:32:09,741 attempt 1/10 2017-09-28 03:32:09,741 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/82c2eecf82ba?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-28 03:32:10,682 unpacking tar archive at: mozilla-central-82c2eecf82ba/testing/mozharness/ program finished with exit code 0 elapsedTime=1.273591 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-28 03:32:10.983799) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-28 03:32:10.984471) ========= script_repo_revision: 82c2eecf82ba820c4593aa4a9749662f7d54d9a7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-28 03:32:10.984872) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-28 03:32:10.985153) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-28 03:32:10.999080) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-09-28 03:32:10.999587) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1506594728.591878-1818972610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:32:11 INFO - MultiFileLogger online at 20170928 03:32:11 in /builds/slave/test 03:32:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:32:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:32:11 INFO - {'append_to_log': False, 03:32:11 INFO - 'base_work_dir': '/builds/slave/test', 03:32:11 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:32:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:32:11 INFO - 'branch': 'Firefox-Non-PGO', 03:32:11 INFO - 'buildbot_json_path': 'buildprops.json', 03:32:11 INFO - 'code_coverage': False, 03:32:11 INFO - 'config_files': ('talos/linux_config.py',), 03:32:11 INFO - 'default_actions': ('clobber', 03:32:11 INFO - 'read-buildbot-config', 03:32:11 INFO - 'download-and-extract', 03:32:11 INFO - 'populate-webroot', 03:32:11 INFO - 'create-virtualenv', 03:32:11 INFO - 'install', 03:32:11 INFO - 'setup-mitmproxy', 03:32:11 INFO - 'run-tests'), 03:32:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:32:11 INFO - 'disable_ccov_upload': False, 03:32:11 INFO - 'disable_stylo': False, 03:32:11 INFO - 'download_minidump_stackwalk': True, 03:32:11 INFO - 'download_symbols': 'ondemand', 03:32:11 INFO - 'enable_stylo': False, 03:32:11 INFO - 'enable_webrender': False, 03:32:11 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:32:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:32:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:32:11 INFO - 'gecko_profile': False, 03:32:11 INFO - 'gecko_profile_interval': 0, 03:32:11 INFO - 'installer_path': 'installer.exe', 03:32:11 INFO - 'log_level': 'info', 03:32:11 INFO - 'log_name': 'talos', 03:32:11 INFO - 'log_to_console': True, 03:32:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:32:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:32:11 INFO - 'opt_config_files': (), 03:32:11 INFO - 'pip_index': False, 03:32:11 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 03:32:11 INFO - 'system_bits': '32', 03:32:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:32:11 INFO - 'title': 'talos-linux64-ix-014', 03:32:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:32:11 INFO - 'use_talos_json': True, 03:32:11 INFO - 'verify': 'False', 03:32:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:32:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:32:11 INFO - 'work_dir': 'build'} 03:32:11 INFO - [mozharness: 2017-09-28 10:32:11.191131Z] Running clobber step. 03:32:11 INFO - Running pre-action listener: _resource_record_pre_action 03:32:11 INFO - Running main action method: clobber 03:32:11 INFO - rmtree: /builds/slave/test/build 03:32:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:32:12 INFO - Running post-action listener: _resource_record_post_action 03:32:12 INFO - [mozharness: 2017-09-28 10:32:12.725945Z] Finished clobber step (success) 03:32:12 INFO - [mozharness: 2017-09-28 10:32:12.726045Z] Running read-buildbot-config step. 03:32:12 INFO - Running pre-action listener: _resource_record_pre_action 03:32:12 INFO - Running main action method: read_buildbot_config 03:32:12 INFO - Using buildbot properties: 03:32:12 INFO - { 03:32:12 INFO - "project": "", 03:32:12 INFO - "product": "firefox", 03:32:12 INFO - "who": "archaeopteryx@coole-files.de", 03:32:12 INFO - "installer_path": "public/build/target.tar.bz2", 03:32:12 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 03:32:12 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:32:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 03:32:12 INFO - "stage_platform": "linux64", 03:32:12 INFO - "basedir": "/builds/slave/test", 03:32:12 INFO - "buildnumber": 51, 03:32:12 INFO - "platform": "ubuntu64_hw", 03:32:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:32:12 INFO - "slavebuilddir": "test", 03:32:12 INFO - "taskId": "bKaXbhJzT1O0eEByK7hU5A", 03:32:12 INFO - "branch": "mozilla-central", 03:32:12 INFO - "script_repo_revision": "production", 03:32:12 INFO - "revision": "82c2eecf82ba820c4593aa4a9749662f7d54d9a7", 03:32:12 INFO - "slavename": "talos-linux64-ix-014", 03:32:12 INFO - "repo_path": "mozilla-central" 03:32:12 INFO - } 03:32:12 INFO - Finding installer, test and symbols from parent task. 03:32:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bKaXbhJzT1O0eEByK7hU5A'}, attempt #1 03:32:13 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bKaXbhJzT1O0eEByK7hU5A'}, attempt #1 03:32:13 INFO - Task dependencies: bHRMUN3XS_OnyBl4OEvKxA 03:32:13 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA'}, attempt #1 03:32:14 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.tar.bz2 03:32:14 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.test_packages.json 03:32:14 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.crashreporter-symbols.zip 03:32:14 INFO - Running post-action listener: _resource_record_post_action 03:32:14 INFO - [mozharness: 2017-09-28 10:32:14.057675Z] Finished read-buildbot-config step (success) 03:32:14 INFO - [mozharness: 2017-09-28 10:32:14.057896Z] Running download-and-extract step. 03:32:14 INFO - Running pre-action listener: _resource_record_pre_action 03:32:14 INFO - Running main action method: download_and_extract 03:32:14 INFO - mkdir: /builds/slave/test/build/tests 03:32:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:32:14 INFO - trying https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.test_packages.json 03:32:14 INFO - Downloading https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:32:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:32:14 INFO - Downloaded 989 bytes. 03:32:14 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:32:14 INFO - Using the following test package requirements: 03:32:14 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:32:14 INFO - u'common': [u'target.common.tests.zip'], 03:32:14 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:32:14 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:32:14 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:32:14 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:32:14 INFO - u'mozbase': [u'target.common.tests.zip'], 03:32:14 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:32:14 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:32:14 INFO - u'web-platform': [u'target.common.tests.zip', 03:32:14 INFO - u'target.web-platform.tests.tar.gz'], 03:32:14 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:32:14 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:32:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.common.tests.zip 03:32:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:32:14 INFO - Fetch https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.common.tests.zip into memory 03:32:15 INFO - Content-Length response header: 55263113 03:32:15 INFO - Bytes received: 55263113 03:32:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.talos.tests.zip 03:32:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:32:26 INFO - Fetch https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.talos.tests.zip into memory 03:32:27 INFO - Content-Length response header: 14521162 03:32:27 INFO - Bytes received: 14521162 03:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:32:27 INFO - trying https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.tar.bz2 03:32:27 INFO - Downloading https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:32:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:32:28 INFO - Downloaded 61661872 bytes. 03:32:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.tar.bz2 03:32:28 INFO - mkdir: /builds/slave/test/properties 03:32:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:32:28 INFO - Writing to file /builds/slave/test/properties/build_url 03:32:28 INFO - Contents: 03:32:28 INFO - build_url:https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.tar.bz2 03:32:28 INFO - Running post-action listener: _resource_record_post_action 03:32:28 INFO - Running post-action listener: find_tests_for_verification 03:32:28 INFO - Running post-action listener: set_extra_try_arguments 03:32:28 INFO - [mozharness: 2017-09-28 10:32:28.636331Z] Finished download-and-extract step (success) 03:32:28 INFO - [mozharness: 2017-09-28 10:32:28.636426Z] Running populate-webroot step. 03:32:28 INFO - Running pre-action listener: _resource_record_pre_action 03:32:28 INFO - Running main action method: populate_webroot 03:32:28 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:32:28 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:32:28 INFO - 'tests': ['tresize', 03:32:28 INFO - 'tcanvasmark']}, 03:32:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:32:28 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:32:28 INFO - 'tests': ['dromaeo_css', 03:32:28 INFO - 'kraken']}, 03:32:28 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:32:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:32:28 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:32:28 INFO - 'talos_options': ['--disable-stylo'], 03:32:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:32:28 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:32:28 INFO - 'tests': ['damp', 'tps']}, 03:32:28 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:32:28 INFO - 'talos_options': ['--disable-stylo'], 03:32:28 INFO - 'tests': ['damp', 'tps']}, 03:32:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:32:28 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:32:28 INFO - 'tests': ['dromaeo_dom']}, 03:32:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:32:28 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:32:28 INFO - 'tests': ['basic_compositor_video', 03:32:28 INFO - 'glvideo']}, 03:32:28 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:32:28 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:32:28 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:32:28 INFO - 'talos_options': ['--disable-stylo'], 03:32:28 INFO - 'tests': ['ts_paint_webext', 03:32:28 INFO - 'tp5o_webext']}, 03:32:28 INFO - 'other-e10s': {'tests': ['a11yr', 03:32:28 INFO - 'ts_paint', 03:32:28 INFO - 'tpaint', 03:32:28 INFO - 'sessionrestore', 03:32:28 INFO - 'sessionrestore_many_windows', 03:32:28 INFO - 'sessionrestore_no_auto_restore', 03:32:28 INFO - 'tabpaint', 03:32:28 INFO - 'cpstartup']}, 03:32:28 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:32:28 INFO - 'tests': ['a11yr', 03:32:28 INFO - 'ts_paint', 03:32:28 INFO - 'tpaint', 03:32:28 INFO - 'sessionrestore', 03:32:28 INFO - 'sessionrestore_many_windows', 03:32:28 INFO - 'sessionrestore_no_auto_restore', 03:32:28 INFO - 'tabpaint', 03:32:28 INFO - 'cpstartup']}, 03:32:28 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 03:32:28 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 03:32:28 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:32:28 INFO - 'tests': ['perf_reftest_singletons']}, 03:32:28 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:32:28 INFO - 'tests': ['perf_reftest']}, 03:32:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:32:28 INFO - 'tsvgr_opacity', 03:32:28 INFO - 'tart', 03:32:28 INFO - 'tscrollx', 03:32:28 INFO - 'tsvg_static']}, 03:32:28 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:32:28 INFO - 'tests': ['tsvgx', 03:32:28 INFO - 'tsvgr_opacity', 03:32:28 INFO - 'tart', 03:32:28 INFO - 'tscrollx', 03:32:28 INFO - 'tsvg_static']}, 03:32:28 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:32:28 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:32:28 INFO - 'talos_options': ['--disable-stylo'], 03:32:28 INFO - 'tests': ['tp5o']}, 03:32:28 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:32:28 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:32:28 INFO - 'talos_options': ['--mitmproxy', 03:32:28 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:32:28 INFO - '--firstNonBlankPaint'], 03:32:28 INFO - 'tests': ['tp6_google', 03:32:28 INFO - 'tp6_youtube', 03:32:28 INFO - 'tp6_amazon', 03:32:28 INFO - 'tp6_facebook']}, 03:32:28 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:32:28 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:32:28 INFO - 'talos_options': ['--disable-stylo', 03:32:28 INFO - '--mitmproxy', 03:32:28 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:32:28 INFO - '--firstNonBlankPaint'], 03:32:28 INFO - 'tests': ['tp6_google', 03:32:28 INFO - 'tp6_youtube', 03:32:28 INFO - 'tp6_amazon', 03:32:28 INFO - 'tp6_facebook']}, 03:32:28 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:32:28 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:32:28 INFO - 'talos_options': ['--stylo-threads=1', 03:32:28 INFO - '--mitmproxy', 03:32:28 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:32:28 INFO - '--firstNonBlankPaint'], 03:32:28 INFO - 'tests': ['tp6_google', 03:32:28 INFO - 'tp6_youtube', 03:32:28 INFO - 'tp6_amazon', 03:32:28 INFO - 'tp6_facebook']}, 03:32:28 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:32:28 INFO - 'talos_options': ['--xperf_path', 03:32:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:32:28 INFO - 'tests': ['tp5n']}, 03:32:28 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:32:28 INFO - 'talos_options': ['--disable-stylo', 03:32:28 INFO - '--xperf_path', 03:32:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:32:28 INFO - 'tests': ['tp5n']}}} 03:32:28 INFO - Running post-action listener: _resource_record_post_action 03:32:28 INFO - [mozharness: 2017-09-28 10:32:28.652054Z] Finished populate-webroot step (success) 03:32:28 INFO - [mozharness: 2017-09-28 10:32:28.652143Z] Running create-virtualenv step. 03:32:28 INFO - Running pre-action listener: _resource_record_pre_action 03:32:28 INFO - Running main action method: create_virtualenv 03:32:28 INFO - Creating virtualenv /builds/slave/test/build/venv 03:32:28 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:32:28 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:32:28 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:32:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:32:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:32:29 INFO - Installing distribute.............................................................................................................................................................................................done. 03:32:29 INFO - Installing pip...............done. 03:32:29 INFO - Return code: 0 03:32:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:32:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:32:29 INFO - Reading from file tmpfile_stdout 03:32:29 INFO - Output received: 03:32:29 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:32:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:32:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:32:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:32:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:29 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 0x28a51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c129c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0fd60>, '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 0x2c10a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c10ef0>, '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': '31acecf42b6a79ec49471d4a000001bb-1506594728.591878-1818972610', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:32:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:32:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:32:29 INFO - Using env: {'DISPLAY': ':0', 03:32:29 INFO - 'HOME': '/home/cltbld', 03:32:29 INFO - 'LANG': 'en_US.UTF-8', 03:32:29 INFO - 'LANGUAGE': 'en_US:en', 03:32:29 INFO - 'LOGNAME': 'cltbld', 03:32:29 INFO - 'MAIL': '/var/mail/cltbld', 03:32:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:29 INFO - 'MOZ_NO_REMOTE': '1', 03:32:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:29 INFO - 'NO_EM_RESTART': '1', 03:32:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:29 INFO - 'PWD': '/builds/slave/test', 03:32:29 INFO - 'SHELL': '/bin/bash', 03:32:29 INFO - 'SHLVL': '1', 03:32:29 INFO - 'TERM': 'linux', 03:32:29 INFO - 'TMOUT': '86400', 03:32:29 INFO - 'USER': 'cltbld', 03:32:29 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1506594728.591878-1818972610', 03:32:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:29 INFO - '_': '/tools/buildbot/bin/python'} 03:32:30 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:32:30 INFO - Downloading/unpacking pip>=1.5 03:32:30 INFO - Running setup.py egg_info for package pip 03:32:30 INFO - warning: no files found matching 'pip/cacert.pem' 03:32:30 INFO - warning: no files found matching '*.html' under directory 'docs' 03:32:30 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:32:30 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:32:30 INFO - Installing collected packages: pip 03:32:30 INFO - Found existing installation: pip 1.1 03:32:30 INFO - Uninstalling pip: 03:32:30 INFO - Successfully uninstalled pip 03:32:30 INFO - Running setup.py install for pip 03:32:30 INFO - warning: no files found matching 'pip/cacert.pem' 03:32:30 INFO - warning: no files found matching '*.html' under directory 'docs' 03:32:30 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:32:30 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:32:30 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:32:30 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:32:30 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:32:30 INFO - Successfully installed pip 03:32:30 INFO - Cleaning up... 03:32:30 INFO - Return code: 0 03:32:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:32:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:32:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x28a51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c129c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0fd60>, '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 0x2c10a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c10ef0>, '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': '31acecf42b6a79ec49471d4a000001bb-1506594728.591878-1818972610', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:32:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:32:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:32:30 INFO - Using env: {'DISPLAY': ':0', 03:32:30 INFO - 'HOME': '/home/cltbld', 03:32:30 INFO - 'LANG': 'en_US.UTF-8', 03:32:30 INFO - 'LANGUAGE': 'en_US:en', 03:32:30 INFO - 'LOGNAME': 'cltbld', 03:32:30 INFO - 'MAIL': '/var/mail/cltbld', 03:32:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:30 INFO - 'MOZ_NO_REMOTE': '1', 03:32:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:30 INFO - 'NO_EM_RESTART': '1', 03:32:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:30 INFO - 'PWD': '/builds/slave/test', 03:32:30 INFO - 'SHELL': '/bin/bash', 03:32:30 INFO - 'SHLVL': '1', 03:32:30 INFO - 'TERM': 'linux', 03:32:30 INFO - 'TMOUT': '86400', 03:32:30 INFO - 'USER': 'cltbld', 03:32:30 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1506594728.591878-1818972610', 03:32:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:30 INFO - '_': '/tools/buildbot/bin/python'} 03:32:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:31 INFO - Downloading/unpacking psutil>=3.1.1 03:32:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:32:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:32:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:32:32 INFO - Installing collected packages: psutil 03:32:32 INFO - Running setup.py install for psutil 03:32:32 INFO - building 'psutil._psutil_linux' extension 03:32:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:32:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:32:32 INFO - building 'psutil._psutil_posix' extension 03:32:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:32:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:32:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:32:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:32:32 INFO - Successfully installed psutil 03:32:32 INFO - Cleaning up... 03:32:32 INFO - Return code: 0 03:32:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:32:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:32 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 0x28a51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c129c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0fd60>, '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 0x2c10a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c10ef0>, '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': '31acecf42b6a79ec49471d4a000001bb-1506594728.591878-1818972610', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:32:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:32:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:32:32 INFO - Using env: {'DISPLAY': ':0', 03:32:32 INFO - 'HOME': '/home/cltbld', 03:32:32 INFO - 'LANG': 'en_US.UTF-8', 03:32:32 INFO - 'LANGUAGE': 'en_US:en', 03:32:32 INFO - 'LOGNAME': 'cltbld', 03:32:32 INFO - 'MAIL': '/var/mail/cltbld', 03:32:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:32 INFO - 'MOZ_NO_REMOTE': '1', 03:32:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:32 INFO - 'NO_EM_RESTART': '1', 03:32:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:32 INFO - 'PWD': '/builds/slave/test', 03:32:32 INFO - 'SHELL': '/bin/bash', 03:32:32 INFO - 'SHLVL': '1', 03:32:32 INFO - 'TERM': 'linux', 03:32:32 INFO - 'TMOUT': '86400', 03:32:32 INFO - 'USER': 'cltbld', 03:32:32 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1506594728.591878-1818972610', 03:32:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:32 INFO - '_': '/tools/buildbot/bin/python'} 03:32:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:32:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:32:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:32:34 INFO - Installing collected packages: mozsystemmonitor 03:32:34 INFO - Running setup.py install for mozsystemmonitor 03:32:34 INFO - Successfully installed mozsystemmonitor 03:32:34 INFO - Cleaning up... 03:32:34 INFO - Return code: 0 03:32:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:32:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:32:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:34 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 0x28a51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c129c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0fd60>, '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 0x2c10a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c10ef0>, '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': '31acecf42b6a79ec49471d4a000001bb-1506594728.591878-1818972610', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:32:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:32:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:32:34 INFO - Using env: {'DISPLAY': ':0', 03:32:34 INFO - 'HOME': '/home/cltbld', 03:32:34 INFO - 'LANG': 'en_US.UTF-8', 03:32:34 INFO - 'LANGUAGE': 'en_US:en', 03:32:34 INFO - 'LOGNAME': 'cltbld', 03:32:34 INFO - 'MAIL': '/var/mail/cltbld', 03:32:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:34 INFO - 'MOZ_NO_REMOTE': '1', 03:32:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:34 INFO - 'NO_EM_RESTART': '1', 03:32:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:34 INFO - 'PWD': '/builds/slave/test', 03:32:34 INFO - 'SHELL': '/bin/bash', 03:32:34 INFO - 'SHLVL': '1', 03:32:34 INFO - 'TERM': 'linux', 03:32:34 INFO - 'TMOUT': '86400', 03:32:34 INFO - 'USER': 'cltbld', 03:32:34 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1506594728.591878-1818972610', 03:32:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:34 INFO - '_': '/tools/buildbot/bin/python'} 03:32:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:34 INFO - Downloading/unpacking jsonschema==2.5.1 03:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:32:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:37 INFO - Downloading functools32-3.2.3-2.tar.gz 03:32:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:32:37 INFO - warning: no files found matching '*.txt' 03:32:37 INFO - no previously-included directories found matching 'build' 03:32:37 INFO - no previously-included directories found matching 'dist' 03:32:37 INFO - no previously-included directories found matching '.git*' 03:32:37 INFO - Installing collected packages: jsonschema, functools32 03:32:37 INFO - Running setup.py install for functools32 03:32:37 INFO - warning: no files found matching '*.txt' 03:32:37 INFO - no previously-included directories found matching 'build' 03:32:37 INFO - no previously-included directories found matching 'dist' 03:32:37 INFO - no previously-included directories found matching '.git*' 03:32:37 INFO - Successfully installed jsonschema functools32 03:32:37 INFO - Cleaning up... 03:32:37 INFO - Return code: 0 03:32:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:32:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:32:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:37 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 0x28a51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c129c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0fd60>, '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 0x2c10a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c10ef0>, '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': '31acecf42b6a79ec49471d4a000001bb-1506594728.591878-1818972610', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:32:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:32:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:32:37 INFO - Using env: {'DISPLAY': ':0', 03:32:37 INFO - 'HOME': '/home/cltbld', 03:32:37 INFO - 'LANG': 'en_US.UTF-8', 03:32:37 INFO - 'LANGUAGE': 'en_US:en', 03:32:37 INFO - 'LOGNAME': 'cltbld', 03:32:37 INFO - 'MAIL': '/var/mail/cltbld', 03:32:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:37 INFO - 'MOZ_NO_REMOTE': '1', 03:32:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:37 INFO - 'NO_EM_RESTART': '1', 03:32:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:37 INFO - 'PWD': '/builds/slave/test', 03:32:37 INFO - 'SHELL': '/bin/bash', 03:32:37 INFO - 'SHLVL': '1', 03:32:37 INFO - 'TERM': 'linux', 03:32:37 INFO - 'TMOUT': '86400', 03:32:37 INFO - 'USER': 'cltbld', 03:32:37 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1506594728.591878-1818972610', 03:32:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:37 INFO - '_': '/tools/buildbot/bin/python'} 03:32:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:32:38 INFO - Cleaning up... 03:32:38 INFO - Return code: 0 03:32:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:32:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:32:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:38 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 0x28a51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c129c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0fd60>, '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 0x2c10a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c10ef0>, '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': '31acecf42b6a79ec49471d4a000001bb-1506594728.591878-1818972610', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:32:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:32:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:32:38 INFO - Using env: {'DISPLAY': ':0', 03:32:38 INFO - 'HOME': '/home/cltbld', 03:32:38 INFO - 'LANG': 'en_US.UTF-8', 03:32:38 INFO - 'LANGUAGE': 'en_US:en', 03:32:38 INFO - 'LOGNAME': 'cltbld', 03:32:38 INFO - 'MAIL': '/var/mail/cltbld', 03:32:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:38 INFO - 'MOZ_NO_REMOTE': '1', 03:32:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:38 INFO - 'NO_EM_RESTART': '1', 03:32:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:38 INFO - 'PWD': '/builds/slave/test', 03:32:38 INFO - 'SHELL': '/bin/bash', 03:32:38 INFO - 'SHLVL': '1', 03:32:38 INFO - 'TERM': 'linux', 03:32:38 INFO - 'TMOUT': '86400', 03:32:38 INFO - 'USER': 'cltbld', 03:32:38 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1506594728.591878-1818972610', 03:32:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:38 INFO - '_': '/tools/buildbot/bin/python'} 03:32:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:38 INFO - Downloading/unpacking blobuploader==1.2.4 03:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:39 INFO - Downloading blobuploader-1.2.4.tar.gz 03:32:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:32:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:32:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:39 INFO - Downloading docopt-0.6.1.tar.gz 03:32:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:32:39 INFO - Installing collected packages: blobuploader, requests, docopt 03:32:39 INFO - Running setup.py install for blobuploader 03:32:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:32:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:32:40 INFO - Running setup.py install for requests 03:32:40 INFO - Running setup.py install for docopt 03:32:40 INFO - Successfully installed blobuploader requests docopt 03:32:40 INFO - Cleaning up... 03:32:40 INFO - Return code: 0 03:32:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:32:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:32:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:40 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 0x28a51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c129c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0fd60>, '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 0x2c10a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c10ef0>, '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': '31acecf42b6a79ec49471d4a000001bb-1506594728.591878-1818972610', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:32:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:32:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:32:40 INFO - Using env: {'DISPLAY': ':0', 03:32:40 INFO - 'HOME': '/home/cltbld', 03:32:40 INFO - 'LANG': 'en_US.UTF-8', 03:32:40 INFO - 'LANGUAGE': 'en_US:en', 03:32:40 INFO - 'LOGNAME': 'cltbld', 03:32:40 INFO - 'MAIL': '/var/mail/cltbld', 03:32:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:40 INFO - 'MOZ_NO_REMOTE': '1', 03:32:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:40 INFO - 'NO_EM_RESTART': '1', 03:32:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:40 INFO - 'PWD': '/builds/slave/test', 03:32:40 INFO - 'SHELL': '/bin/bash', 03:32:40 INFO - 'SHLVL': '1', 03:32:40 INFO - 'TERM': 'linux', 03:32:40 INFO - 'TMOUT': '86400', 03:32:40 INFO - 'USER': 'cltbld', 03:32:40 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1506594728.591878-1818972610', 03:32:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:40 INFO - '_': '/tools/buildbot/bin/python'} 03:32:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:32:40 INFO - Running setup.py (path:/tmp/pip-ypQp5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:32:40 INFO - Running setup.py (path:/tmp/pip-EKc4su-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:32:40 INFO - Running setup.py (path:/tmp/pip-IgxBEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:32:40 INFO - Running setup.py (path:/tmp/pip-VbDbBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:32:41 INFO - Running setup.py (path:/tmp/pip-JxWXN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:32:41 INFO - Running setup.py (path:/tmp/pip-tBZbBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:32:41 INFO - Running setup.py (path:/tmp/pip-O4GxPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:32:41 INFO - Running setup.py (path:/tmp/pip-m8svgF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:32:41 INFO - Running setup.py (path:/tmp/pip-KPbG05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:32:41 INFO - Running setup.py (path:/tmp/pip-GAeb5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:32:41 INFO - Running setup.py (path:/tmp/pip-ePrN9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:32:41 INFO - Running setup.py (path:/tmp/pip-2lMIfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:32:41 INFO - Running setup.py (path:/tmp/pip-VJ1CKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:32:41 INFO - Running setup.py (path:/tmp/pip-pf6Vx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:41 INFO - Running setup.py (path:/tmp/pip-TdSPuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:32:41 INFO - Running setup.py (path:/tmp/pip-w3u3XC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:32:41 INFO - Running setup.py (path:/tmp/pip-qIArHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:32:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:32:41 INFO - Running setup.py install for manifestparser 03:32:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:32:42 INFO - Running setup.py install for mozcrash 03:32:42 INFO - Running setup.py install for mozdebug 03:32:42 INFO - Running setup.py install for mozdevice 03:32:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:32:42 INFO - Running setup.py install for mozfile 03:32:42 INFO - Running setup.py install for mozhttpd 03:32:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:32:42 INFO - Running setup.py install for mozinfo 03:32:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:32:42 INFO - Running setup.py install for mozInstall 03:32:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:32:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:32:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:32:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:32:42 INFO - Running setup.py install for mozleak 03:32:42 INFO - Running setup.py install for mozlog 03:32:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:32:43 INFO - Running setup.py install for moznetwork 03:32:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:32:43 INFO - Running setup.py install for mozprocess 03:32:43 INFO - Running setup.py install for mozprofile 03:32:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:32:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:32:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:32:43 INFO - Running setup.py install for mozrunner 03:32:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:32:43 INFO - Running setup.py install for mozscreenshot 03:32:43 INFO - Running setup.py install for moztest 03:32:43 INFO - Running setup.py install for mozversion 03:32:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:32:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:32:43 INFO - Cleaning up... 03:32:43 INFO - Return code: 0 03:32:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:32: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')]} 03:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32: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')]} 03:32:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:43 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 0x28a51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c129c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0fd60>, '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 0x2c10a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c10ef0>, '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': '31acecf42b6a79ec49471d4a000001bb-1506594728.591878-1818972610', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:32:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:32:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:32:43 INFO - Using env: {'DISPLAY': ':0', 03:32:43 INFO - 'HOME': '/home/cltbld', 03:32:43 INFO - 'LANG': 'en_US.UTF-8', 03:32:43 INFO - 'LANGUAGE': 'en_US:en', 03:32:43 INFO - 'LOGNAME': 'cltbld', 03:32:43 INFO - 'MAIL': '/var/mail/cltbld', 03:32:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:43 INFO - 'MOZ_NO_REMOTE': '1', 03:32:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:43 INFO - 'NO_EM_RESTART': '1', 03:32:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:43 INFO - 'PWD': '/builds/slave/test', 03:32:43 INFO - 'SHELL': '/bin/bash', 03:32:43 INFO - 'SHLVL': '1', 03:32:43 INFO - 'TERM': 'linux', 03:32:43 INFO - 'TMOUT': '86400', 03:32:43 INFO - 'USER': 'cltbld', 03:32:43 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1506594728.591878-1818972610', 03:32:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:43 INFO - '_': '/tools/buildbot/bin/python'} 03:32:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:32:43 INFO - Running setup.py (path:/tmp/pip-OgXd8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:32:44 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:32:44 INFO - Running setup.py (path:/tmp/pip-UFBX5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:32:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:32:44 INFO - Running setup.py (path:/tmp/pip-kKqiIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:32:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:32:44 INFO - Running setup.py (path:/tmp/pip-I4CczT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:32:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:32:44 INFO - Running setup.py (path:/tmp/pip-_mEF8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:32:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:32:44 INFO - Running setup.py (path:/tmp/pip-3AnA9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:32:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:32:44 INFO - Running setup.py (path:/tmp/pip-qYxsrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:32:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:32:44 INFO - Running setup.py (path:/tmp/pip-wStKOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:32:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:32:44 INFO - Running setup.py (path:/tmp/pip-q7L0mw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:32:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:32:44 INFO - Running setup.py (path:/tmp/pip-jym5pU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:32:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:32:44 INFO - Running setup.py (path:/tmp/pip-FjrTYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:32:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:32:44 INFO - Running setup.py (path:/tmp/pip-d1GGpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:32:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:32:44 INFO - Running setup.py (path:/tmp/pip-bXDOWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:32:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:32:44 INFO - Running setup.py (path:/tmp/pip-fpfVXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:32:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:44 INFO - Running setup.py (path:/tmp/pip-Gb1zNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:32:45 INFO - Running setup.py (path:/tmp/pip-ObVPwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:32:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:32:45 INFO - Running setup.py (path:/tmp/pip-OfbEUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:32:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:32:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:32:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:32:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:32:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:32:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:32:45 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:32:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:32: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 03:32: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 03:32: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 03:32: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 03:32:46 INFO - Downloading blessings-1.6.tar.gz 03:32:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:32:46 INFO - Installing collected packages: blessings 03:32:46 INFO - Running setup.py install for blessings 03:32:46 INFO - Successfully installed blessings 03:32:46 INFO - Cleaning up... 03:32:46 INFO - Return code: 0 03:32:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:32:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:32:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:32:46 INFO - Reading from file tmpfile_stdout 03:32:46 INFO - Current package versions: 03:32:46 INFO - argparse == 1.2.1 03:32:46 INFO - blessings == 1.6 03:32:46 INFO - blobuploader == 1.2.4 03:32:46 INFO - docopt == 0.6.1 03:32:46 INFO - functools32 == 3.2.3-2 03:32:46 INFO - jsonschema == 2.5.1 03:32:46 INFO - manifestparser == 1.1 03:32:46 INFO - mozInstall == 1.13 03:32:46 INFO - mozcrash == 1.0 03:32:46 INFO - mozdebug == 0.1 03:32:46 INFO - mozdevice == 0.51 03:32:46 INFO - mozfile == 1.2 03:32:46 INFO - mozhttpd == 0.7 03:32:46 INFO - mozinfo == 0.10 03:32:46 INFO - mozleak == 0.1 03:32:46 INFO - mozlog == 3.5 03:32:46 INFO - moznetwork == 0.27 03:32:46 INFO - mozprocess == 0.25 03:32:46 INFO - mozprofile == 0.28 03:32:46 INFO - mozrunner == 6.13 03:32:46 INFO - mozscreenshot == 0.1 03:32:46 INFO - mozsystemmonitor == 0.3 03:32:46 INFO - moztest == 0.8 03:32:46 INFO - mozversion == 1.4 03:32:46 INFO - psutil == 3.1.1 03:32:46 INFO - requests == 1.2.3 03:32:46 INFO - wsgiref == 0.1.2 03:32:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:32:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:46 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 0x28a51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c129c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0fd60>, '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 0x2c10a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c10ef0>, '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': '31acecf42b6a79ec49471d4a000001bb-1506594728.591878-1818972610', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:32:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:32:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:32:46 INFO - Using env: {'DISPLAY': ':0', 03:32:46 INFO - 'HOME': '/home/cltbld', 03:32:46 INFO - 'LANG': 'en_US.UTF-8', 03:32:46 INFO - 'LANGUAGE': 'en_US:en', 03:32:46 INFO - 'LOGNAME': 'cltbld', 03:32:46 INFO - 'MAIL': '/var/mail/cltbld', 03:32:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:46 INFO - 'MOZ_NO_REMOTE': '1', 03:32:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:46 INFO - 'NO_EM_RESTART': '1', 03:32:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:46 INFO - 'PWD': '/builds/slave/test', 03:32:46 INFO - 'SHELL': '/bin/bash', 03:32:46 INFO - 'SHLVL': '1', 03:32:46 INFO - 'TERM': 'linux', 03:32:46 INFO - 'TMOUT': '86400', 03:32:46 INFO - 'USER': 'cltbld', 03:32:46 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1506594728.591878-1818972610', 03:32:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:46 INFO - '_': '/tools/buildbot/bin/python'} 03:32:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:32:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:32:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:32:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:32:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:32:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:32:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:32:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:32:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:32:46 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:32:48 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:32:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:32:48 INFO - Installing collected packages: simplejson 03:32:48 INFO - Running setup.py install for simplejson 03:32:48 INFO - building 'simplejson._speedups' extension 03:32:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 03:32:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:32:49 INFO - Successfully installed simplejson 03:32:49 INFO - Cleaning up... 03:32:49 INFO - Return code: 0 03:32:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:32:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:32:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c129c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0fd60>, '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 0x2c10a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c10ef0>, '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': '31acecf42b6a79ec49471d4a000001bb-1506594728.591878-1818972610', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:32:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:32:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:32:49 INFO - Using env: {'DISPLAY': ':0', 03:32:49 INFO - 'HOME': '/home/cltbld', 03:32:49 INFO - 'LANG': 'en_US.UTF-8', 03:32:49 INFO - 'LANGUAGE': 'en_US:en', 03:32:49 INFO - 'LOGNAME': 'cltbld', 03:32:49 INFO - 'MAIL': '/var/mail/cltbld', 03:32:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:49 INFO - 'MOZ_NO_REMOTE': '1', 03:32:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:49 INFO - 'NO_EM_RESTART': '1', 03:32:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:49 INFO - 'PWD': '/builds/slave/test', 03:32:49 INFO - 'SHELL': '/bin/bash', 03:32:49 INFO - 'SHLVL': '1', 03:32:49 INFO - 'TERM': 'linux', 03:32:49 INFO - 'TMOUT': '86400', 03:32:49 INFO - 'USER': 'cltbld', 03:32:49 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1506594728.591878-1818972610', 03:32:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:49 INFO - '_': '/tools/buildbot/bin/python'} 03:32:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:32:49 INFO - Cleaning up... 03:32:49 INFO - Return code: 0 03:32:49 INFO - Running post-action listener: _resource_record_post_action 03:32:49 INFO - Running post-action listener: _start_resource_monitoring 03:32:49 INFO - Starting resource monitoring. 03:32:49 INFO - [mozharness: 2017-09-28 10:32:49.486715Z] Finished create-virtualenv step (success) 03:32:49 INFO - [mozharness: 2017-09-28 10:32:49.487225Z] Running install step. 03:32:49 INFO - Running pre-action listener: _resource_record_pre_action 03:32:49 INFO - Running main action method: install 03:32:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:32:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:32:49 INFO - Reading from file tmpfile_stdout 03:32:49 INFO - Detecting whether we're running mozinstall >=1.0... 03:32:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:32:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:32:49 INFO - Reading from file tmpfile_stdout 03:32:49 INFO - Output received: 03:32:49 INFO - Usage: mozinstall [options] installer 03:32:49 INFO - Options: 03:32:49 INFO - -h, --help show this help message and exit 03:32:49 INFO - -d DEST, --destination=DEST 03:32:49 INFO - Directory to install application into. [default: 03:32:49 INFO - "/builds/slave/test"] 03:32:49 INFO - --app=APP Application being installed. [default: firefox] 03:32:49 INFO - mkdir: /builds/slave/test/build/application 03:32:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:32:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:33:07 INFO - Reading from file tmpfile_stdout 03:33:07 INFO - Output received: 03:33:07 INFO - /builds/slave/test/build/application/firefox/firefox 03:33:07 INFO - Running post-action listener: _resource_record_post_action 03:33:07 INFO - [mozharness: 2017-09-28 10:33:07.608937Z] Finished install step (success) 03:33:07 INFO - [mozharness: 2017-09-28 10:33:07.609187Z] Running setup-mitmproxy step. 03:33:07 INFO - Running pre-action listener: _resource_record_pre_action 03:33:07 INFO - Running main action method: setup_mitmproxy 03:33:07 INFO - Skipping: mitmproxy is not required 03:33:07 INFO - Running post-action listener: _resource_record_post_action 03:33:07 INFO - [mozharness: 2017-09-28 10:33:07.610332Z] Finished setup-mitmproxy step (success) 03:33:07 INFO - [mozharness: 2017-09-28 10:33:07.610551Z] Running run-tests step. 03:33:07 INFO - Running pre-action listener: _resource_record_pre_action 03:33:07 INFO - Running pre-action listener: _set_gcov_prefix 03:33:07 INFO - Running main action method: run_tests 03:33:07 WARNING - Try message not found. 03:33:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:33:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:33:07 INFO - Python 2.7.3 03:33:07 INFO - Return code: 0 03:33:07 INFO - grabbing minidump binary from tooltool 03:33:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:07 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 0x2c0fd60>, '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 0x2c10a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c10ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:33:07 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:33:07 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:33:07 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:33:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:33:07 INFO - Return code: 0 03:33:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:33:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:33:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:33:07 INFO - ENV: RUST_BACKTRACE is now full 03:33:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:33:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:33:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 03:33:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 03:33:07 INFO - Using env: {'DISPLAY': ':0', 03:33:07 INFO - 'HOME': '/home/cltbld', 03:33:07 INFO - 'LANG': 'en_US.UTF-8', 03:33:07 INFO - 'LANGUAGE': 'en_US:en', 03:33:07 INFO - 'LOGNAME': 'cltbld', 03:33:07 INFO - 'MAIL': '/var/mail/cltbld', 03:33:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:33:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:33:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:07 INFO - 'MOZ_NO_REMOTE': '1', 03:33:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:33:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:07 INFO - 'NO_EM_RESTART': '1', 03:33:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:07 INFO - 'PWD': '/builds/slave/test', 03:33:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:33:07 INFO - 'RUST_BACKTRACE': 'full', 03:33:07 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:33:07 INFO - 'SHELL': '/bin/bash', 03:33:07 INFO - 'SHLVL': '1', 03:33:07 INFO - 'TERM': 'linux', 03:33:07 INFO - 'TMOUT': '86400', 03:33:07 INFO - 'USER': 'cltbld', 03:33:07 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1506594728.591878-1818972610', 03:33:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:07 INFO - '_': '/tools/buildbot/bin/python'} 03:33:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 03:33:07 INFO - mozversion application_buildid: 20170928094239 03:33:07 INFO - mozversion application_changeset: 82c2eecf82ba820c4593aa4a9749662f7d54d9a7 03:33:07 INFO - mozversion application_display_name: Nightly 03:33:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:33:07 INFO - mozversion application_name: Firefox 03:33:07 INFO - mozversion application_remotingname: firefox 03:33:07 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:33:07 INFO - mozversion application_vendor: Mozilla 03:33:07 INFO - mozversion application_version: 58.0a1 03:33:07 INFO - mozversion platform_buildid: 20170928094239 03:33:07 INFO - mozversion platform_changeset: 82c2eecf82ba820c4593aa4a9749662f7d54d9a7 03:33:07 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:33:07 INFO - mozversion platform_version: 58.0a1 03:33:07 INFO - using testdate: 1506594787 03:33:07 INFO - actual date: 1506594787 03:33:07 INFO - starting webserver on 'localhost:43179' 03:33:07 INFO - SUITE-START | Running 2 tests 03:33:07 INFO - TEST-START | dromaeo_css 03:33:07 INFO - Initialising browser for dromaeo_css test... 03:33:07 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43179/getInfo.html -profile /tmp/tmp42ab0Y/profile 03:33:07 INFO - TEST-INFO | started process 15131 (/builds/slave/test/build/application/firefox/firefox http://localhost:43179/getInfo.html) 03:33:13 INFO - TEST-INFO | 15131: exit 0 03:33:13 INFO - Browser initialized. 03:33:13 INFO - Running cycle 1/1 for dromaeo_css test... 03:33:13 INFO - Using env: {'DISPLAY': ':0', 03:33:13 INFO - 'HOME': '/home/cltbld', 03:33:13 INFO - 'JSGC_DISABLE_POISONING': '1', 03:33:13 INFO - 'LANG': 'en_US.UTF-8', 03:33:13 INFO - 'LANGUAGE': 'en_US:en', 03:33:13 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:33:13 INFO - 'LOGNAME': 'cltbld', 03:33:13 INFO - 'MAIL': '/var/mail/cltbld', 03:33:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:33:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:33:13 INFO - 'MOZ_CRASHREPORTER': '1', 03:33:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:13 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:33:13 INFO - 'MOZ_NO_REMOTE': '1', 03:33:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:33:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:13 INFO - 'NO_EM_RESTART': '1', 03:33:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:13 INFO - 'PWD': '/builds/slave/test', 03:33:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:33:13 INFO - 'RUST_BACKTRACE': 'full', 03:33:13 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:33:13 INFO - 'SHELL': '/bin/bash', 03:33:13 INFO - 'SHLVL': '1', 03:33:13 INFO - 'STYLO_FORCE_DISABLED': '1', 03:33:13 INFO - 'TERM': 'linux', 03:33:13 INFO - 'TMOUT': '86400', 03:33:13 INFO - 'USER': 'cltbld', 03:33:13 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1506594728.591878-1818972610', 03:33:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:13 INFO - '_': '/tools/buildbot/bin/python'} 03:33:13 INFO - TEST-INFO | started process 15369 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp42ab0Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:33:14 INFO - PID 15369 | 03:33:14 INFO - PID 15369 | (/builds/slave/test/build/application/firefox/firefox:15418): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:33:14 INFO - PID 15369 | 03:33:24 INFO - PID 15369 | RSS: Main: 148418560 03:33:24 INFO - PID 15369 | 03:36:22 INFO - PID 15369 | Cycle 1(1): loaded http://localhost:43179/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43179/tests/dromaeo/cssquery-ext.html) 03:36:23 INFO - PID 15369 | RSS: Main: 148705280 03:36:23 INFO - PID 15369 | 03:39:25 INFO - PID 15369 | Cycle 1(1): loaded http://localhost:43179/tests/dromaeo/cssquery-ext.html (next: http://localhost:43179/tests/dromaeo/cssquery-jquery.html) 03:39:26 INFO - PID 15369 | RSS: Main: 150102016 03:39:26 INFO - PID 15369 | 03:42:27 INFO - PID 15369 | Cycle 1(1): loaded http://localhost:43179/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43179/tests/dromaeo/cssquery-mootools.html) 03:42:28 INFO - PID 15369 | RSS: Main: 149970944 03:42:28 INFO - PID 15369 | 03:45:30 INFO - PID 15369 | Cycle 1(1): loaded http://localhost:43179/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43179/tests/dromaeo/cssquery-prototype.html) 03:45:30 INFO - PID 15369 | RSS: Main: 151343104 03:45:30 INFO - PID 15369 | 03:48:34 INFO - PID 15369 | Cycle 1(1): loaded http://localhost:43179/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43179/tests/dromaeo/cssquery-yui.html) 03:48:34 INFO - PID 15369 | RSS: Main: 153862144 03:48:34 INFO - PID 15369 | 03:51:36 INFO - PID 15369 | Cycle 1(1): loaded http://localhost:43179/tests/dromaeo/cssquery-yui.html (next: http://localhost:43179/tests/dromaeo/cssquery-dojo.html) 03:51:36 INFO - PID 15369 | RSS: Main: 154791936 03:51:36 INFO - PID 15369 | 03:51:36 INFO - PID 15369 | __start_tp_report 03:51:36 INFO - PID 15369 | _x_x_mozilla_page_load 03:51:36 INFO - PID 15369 | _x_x_mozilla_page_load_details 03:51:36 INFO - PID 15369 | |i|pagename|runs| 03:51:36 INFO - PID 15369 | |0;dojo.html;3181.9045428637132;3190.872365105396;3203.5515027896085;3216;3227.580414546109;6059.969700151493;6217.782377616784;6272.811815645527;6276.2468503779555;6281.842953926154;6189.783357582485;6192.78325258616;6230.096635987779;6358.459530939876;6363.71363288652;5746.1668058131545;5768.625039372428;5786.884262314762;5817.505512031483;5818;5487.972560137194;5623.690697011662;5753.223314852504;5836.766529338822;5843.561732870052;5704.600677952566;5757.510611598019;5758.971205143989;5766.913496297559;5835.4748072673665;5589.972050139764;5638.520725738317;5685.4883060524335;5712.086066229425;5762.884742305172;5676.971615141939;5716.742746576414;5729.541636669056;5747.3677895431465;5755.251817263771;6212.471939885115;6218.22272215973;6221.066839973995;6223.751049957997;6330.525210609223;6390.233172019341;6534.673266336664;6539.967300163468;6677.666116694146;6763.661816909135;6539;6568.047633093222;6598.670066496656;6611.603303801788;6758.29037951013;6229.6573688447115;6269.059641053833;6291.842703932392;6311.431971122575;6313.621182729051;6785.9660701696175;6824.6928888200155;6893.655317234118;6978.825529361705;6984.755533556403;6511.674416279167;6565.376289252514;6578.506612004119;6595.274519802818;6601;6633.834154146185;6636.900446493307;6701.664916754143;6713.865722685617;6719.328067193242;6429.196350456193;6434.356564343622;6538.738450461929;6538.901916471256;6669.499787515859;6605.30644282353;6611.20665520131;6618.933810661832;6622.238442579069;6651.43462805667;5218.608604354613;5232.084385232645;5249.606279529051;5268.841934741964;5271.947280527223;4590;4609.746463944448;4645.396098507173;4674.135284972223;4683.531646835358;5685.971570142123;5693.886122277531;5696.601237913306;5765.94234057654;5774.220480235114;6550.574212676161;6654.301298363699;6662.7334906604165;6662.833429164213;6754.5947243165565;5696.629719068247;5715.199872017921;5722.799702010493;5729.770809167587;5731.656100633975;5634.887302253932;5731.828045158652;5758.798442054592;5818.389069147764;5823.475887170175;6484.157059582224;6559.967200163968;6565.934340656628;6568.573042752206;6574.572652777554;6661.600303981777;6669.433098186709;6682.331766823376;6754.5947243165565;6781.355771201629;6288.905666414916;6395.7121929514215;6403;6507.446867016167;6507.446867016357;6559.147310849559;6603.339666033358;6605.438537724347;6621;6679.866402672016;6727.764528241684;6739.326067393222;6786.287439818945;6786.355296246848;6813.761518346834;6226.159468471698;6330.746770129143;6347.619142851444;6413.839654008687;6439.645819479973;6433.388828061326;6446.8388290293115;6458.321876202931;6462.838429039311;6505.121808555785;6326.398992095744;6385.393387628168;6425.261094974137;6468.029795530708;6474.158359413246;6491.123698300669;6492.220933488012;6547.508936829661;6552.541322107407;6602.60384376939;6110.358412366638;6261.592996455216;6280.937190628035;6332.335104813928;6350.7459701611415 03:51:36 INFO - PID 15369 | |1;ext.html;880.9559522023898;909.6679711905152;911.2573252798965;913.511271469763;914.3964983111148;39727.80136099319;42964.35553466697;43569.56430435694;43679;43740;39320.21359572814;39366.40950385747;39499.605003950026;39580.40629390562;39689.40465893007;7223.530470519412;7323.670434830418;7371.37343325818;7385.8522829543645;7405.1854296027395;7271.309225623558;7369.631518424084;7374.262573742636;7374.852502949938;7397.371223445986;7320.780376588711;7362.889556656654;7368.078990126234;7407.740729074483;7881.448298619099;8027.879581806277;8055.879161812548;8056.798580035487;8057.395695322874;8058.959705201437;7781.26078022587;7784.649690763873;7945.920540794634;7956.960215198945;7975.8404831903035;39756.801215994026;40025.19949600992;40125;40169.79915100435;40211.39682904759;3534.1164708822794;3588.784672919633;3592.766470179456;3593.1735700788704;3597.316509863144;33001.339973200644;33077;33160.50259246113;33189.834050829835;33290.167745806306;5200.8959820803375;5203.1414816555225;5235.188545775411;5237.319148510707;5244.056069907415;185136;187013;187549;188382;188685;42595;43345.34981975273;48322;48634.51365486371;49570.50429495731;52022;52028.47971520312;52062.47937520652;52141;52144.21783673248;14625.414983400759;14736.410543578351;14808.703825923421;14813.259337033105;14820.777688334683;11781.410929453494;11783.941080294544;11803.468843901874;11814.05487560993;11837.704057398634;13920.58238252854;13943.511977080754;13945.930270348583;14051.367688454044;14138.50515231962;5556.638818476786;5663.5735380095275;5698.230738850285;5701.71491425427;5712.6286791358425;1021.2340744441668;1025.917926565873;1031.2729525684374;1033.560736686905;1033.7467320506523;23131.421714456937;23331.53336933252;23469.530609387715;23488.647670284958;23645.645315320286;1121.5794077221042;1128.7065363005513;1130.5308297056795;1133.393634405589;1135.5855112883903;12326.50693972249;12459.06557008228;12460.875391246153;12498.500059997497;12575.056870734732;221927;223245;223715;223811;224115;56456;56490.15264771032;56741.43258567444;56752.71623641856;56788.43211567831;1425.7291114688176;1471.3305446022034;1475.8229012518352;1479.8964072515037;1492.2986196487634;22825.429364266027;22841.42896427536;22949.196778112684;23041;23049.308520744406;39196;39253.41119883261;39255.2148957025;39280.2143957125;39321;201179;202038;203240;203452;203507;34455.82772086224;36444.81777591095;37348.813255934634;37551.2489750198;37612.62387376091;46621.067578648916;47333;47335.76332118317;47528.762356187995;47635.52364476311;34224.82887585546;34390.31219375548;34423;34563.30873382569;35031.82484087563;33965.15087122842;34619.13452163716;34688.82655586706;35236.64763352334;35245.29509409849;38673.61326386813;39147.80426097851;39156.80421597988;39179.2164156721;39318.2136357277;33438;33666.49500257449;33736.1565960853;34064;34369.484457733655;24382.26853194407;24990.125345612818;25072.874635626704;25157.24528264155;25662.743372566034 03:51:36 INFO - PID 15369 | |2;jquery.html;604.5616927727395;607.2621764556069;610.3194937644527;613.9754409823604;616.1004932798114;22684.54630907383;23210.65184022241;23256.18603348885;23295;23586.174483893068;20597.382078537667;21363.6795448068;21419.250326238584;21453.785462145373;21551.784482155173;6558.311377305374;6703;6704.2625311215725;6706;6733.696983635724;6456.22525296965;6649.035889796;6742.393184613384;6747.25780164184;6748.966255168717;6675.66621668917;6703.899441508382;6705.530612857102;6708.027336036272;6737.35995080469;6683.966580167093;6708.731650733965;6724.495662825308;6740.460763138937;6743.8651226975435;6202.224721909762;6242.687865606701;6259.217597800275;6264.498840092781;6283.7800676976085;28063.29841753952;28720;28974.130776076752;29135.85432072826;29403.705962940312;2105.5683584865064;2142.3572928121503;2150.3656421355736;2151.4943988162768;2151.688005239247;18894.149763260688;19286.13212405431;19373.80626193734;19422.417327480198;19441.31955381555;2413.191580820427;2439.6462512935705;2481.280428675682;2509.034021901581;2518.3829961659326;145497.99999999895;146376;149833;150294.24852875774;150510;14594.927025365017;14868.851311486964;14879.58643928825;15301.234938253043;15563.61090972712;23922.88038559796;23969;23974.760252397602;24027.759722402552;24066.51866962651;9306.86039709405;9638.710838674851;9680.46757428334;9735.1725103367;9762.90237097634;6803.829904252433;7084.574925504383;8665.090165532654;8771;8809.955950220208;8673.73978780625;8888.555572221363;9132.178103970675;9153.496557689392;9261.583228754722;2680.571108622611;2809.9297517562222;2828.2787889088563;2867.1541895140986;2893.7106289370895;970.7621632699893;984.8030393921244;988.6490295944836;992.513668302541;993.1508560180941;19139;19824.70262946057;20065.699014514794;20213.79786202119;20669.689954650694;1040.6097713357492;1041.505284989639;1042.8644276244192;1043.6921108273077;1056.1339701444895;10950.06924411434;11299.94350028261;11354.772904542027;11425.771484570261;11468.59859904916;463413;468280;477297;477974;489909;107160;108354;109734;112778;114935;1152.5562658376584;1152.68877403099;1171.0865524890598;1181.2440038375275;1185.1526158796503;17710.557236069202;17993.730094048336;18030.1886415109;18140.818591813913;18678.972656504022;54512.72743636256;54701;55838.162427562806;56768.7161564206;57517.42482575288;67932;68515.31484685089;69059.65470172618;70160;71664.64167679129;14474.565763026705;14847.554573362817;14943.327550260481;14949.551513454613;14970.625734356729;22645.320640380814;22683.546329073655;22892.542149157256;23072.307830765105;23079.538409232056;18436.539086522946;18573.721394179367;19009.33467328637;19039.04804759784;19040.33358832434;16628.58428539296;16642.417515386904;16938.983660980382;16949.32202711878;17214.31142754326;18811.6237675243;18898.716519251946;18938.431847044612;19071.71392429087;19129.23483060662;14470.638234044232;14588.635284117981;14597.416103355747;14608.342624582132;14627.70744585081;17765.644687106444;17908.641827163643;18010;18193.727094093334;18249.452516424528 03:51:36 INFO - PID 15369 | |3;mootools.html;1299.9935000325;1396.3367400484776;1415.61070705556;1416.5750274917523;1429.3282157386031;15116.395344186232;15781.92109039456;15784.605384865385;15787.579117879388;15809;15502.147381893992;15537.689246215097;15593.688126237468;15635.921820390911;15657.92171039146;2583.4316450380884;2623.8163328567007;2656.880440380178;2660.188642464048;2664.174106027128;2740.849253291068;2752.1881045091645;2759.6274502942147;2767.875445604953;2780.79144064196;2601.7528334808258;2605.0621776160565;2692.1250593557074;2697.3391519077854;2700.66241719785;2639.7492238237337;2643.73562643736;2660.507806055886;2664.027629915077;2671.118530884813;2518.9874050629815;2536.099684611973;2542.9872850635816;2543.2116044026225;2689.367998520346;15518.534443966699;15613.141277229748;15666.216689165496;15709.371625135094;15755.212239387985;8071.919280807234;8238.258556729863;8546.829063418696;8580.270676992463;8589.742307730716;5328.600354973354;5342.54588359986;5411.702356370398;5424.1321388578035;5543.196236545678;1780.9554761131076;1842.824931631493;1977.7033444983367;2041.8264447521979;2042.724232228645;28264.858675706695;28580.14259572237;28626.14121576356;28626.856865715537;28634.427311453863;6683.832904177434;6850.554713943578;7006;7042.6830792614455;7058.858822823618;17909.283628654706;17936.820631793515;17963.37128200533;17998.730019049726;18065.458036258933;7833.921660783433;7956.323712484388;7965.084015338194;7966.721164759206;7972.481788683717;6825.624590647562;7130.821729456701;7296.70813167478;7310.305520975498;7314.305141011595;5287.365516138088;5312;5377.059014672417;5410.567154627621;5414.810481633124;1437.3029080895758;1457.1111621910627;1458.8030615866935;1459.109942934809;1465.2673663168416;860.694453469022;900.7072701372081;902.0933961368783;906.8277027364779;916.3768637326549;7491.438142139361;7502.737404190827;7517.17311095779;7520.1351844537485;7543.660535275926;727.6034561164179;733.3876213361796;734.7244783206297;740.2819265312638;745.0612228591905;4997.175466048061;5134.204198349262;5143.691378517301;5147.6911385317;5216.452272511332;21718.457038573844;22010.88994555017;22423.10307587678;22508.887455562617;22907.19824806124;21938.232161874257;22463.10147594078;22652.207172748876;22682.773172268397;22842.657360139612;10351.689449316533;11539.653810385702;11935.403229838474;11950.46222919988;11970.880291196976;8399.622017009371;8491;8518.48889066658;8556.459837229359;8586.22723954847;18634;19222.61554768925;19222.61554768925;19279;19553.120109595387;19663.213471460982;20100.899495502428;20196.192152313743;20454.590908181457;20964.895175524023;11311.830322545004;11345.092392608736;11346;11399.430028498708;11421.771564568497;14288.142711437347;14420.711585768435;14448.566543003726;14493.92753036228;14547.709045818812;11712.70718232051;11715.062794976551;11728.76542469163;11869.347185904859;12048;11523.884761152281;11635.185537012328;11653.475593598478;11879;11952.64142075739;10214.948925255623;10218.744531386776;10219.182465402899;10272.691819245434;10354.5340459678;7248.693850513752;7266.164391094881;7285.865421083082;7361.815954600964;7443.292887175709;7406.925930740624;7453.627318634155;7462.925370746223;7554.4334174936;7608.695652173851 03:51:36 INFO - PID 15369 | |4;prototype.html;494.35239835815105;517.4334104155948;528.1417696243604;548.5063442901389;553.4769642687659;6107.38926107389;6138.232720909887;6154.753809847612;6250.187475628162;6410.743570257184;6267.843303917404;6281.466075383586;6311.495080393569;6353.174087368647;6357.078223657579;5155.149400348938;5203.161060214;5227.26818245446;5256.290400795901;5268.604854635899;4951.678140920847;5050;5083.898322033557;5084.542391184793;5133.383993920735;4981.455748717891;5035.647504674675;5040.6471546991725;5045.848624541251;5084.923726144092;5014.423341315741;5024.949750502503;5034.244863270502;5036.11867923112;5049.056113396332;4583.679142460029;4620.491745907947;4624;4630.189716799547;4641.2109941310055;6195.907061394083;6208.627482351073;6229.944118440903;6247;6322.683865806737;5713.400092990218;5756.136579513065;5773.278340207474;5774.566907481955;5786.913196302059;6659.600423974577;6666.699998500079;6683.6658167091455;6689.23073846509;6692.598444093322;4955.529224723646;4966.925496117561;5013.197888337849;5025.748712564394;5029.823956161554;6882.070920425778;6919.792406227822;6972.163340399134;6984.860302794017;6996.545224560438;5071.239314102841;5091.439941606421;5111.897762044739;5116.130257856174;5124.461931497213;5186.870328241749;5191.844244672666;5193.195054766517;5205.583553315726;5228.712420816815;5780.942190578125;5804.709764511757;5812.38969908162;5813.79651712188;5831.183634291117;6254.874902501924;6439.678016099177;6621.42443080731;6707;6722.428593569503;1766.6908291049272;1766.7614871992116;1771.866005756317;1774.8136445673276;1779.8220177982098;1239.6714870559128;1241.8385609870659;1252.1422825364655;1255.12768625806;1266.8099785032134;5700.629459085146;5755.740991655385;5784.797532086357;5817.156512305692;5829.446202610745;6777.6272305023695;6798.422134118655;6798.620482830969;6805.863882722318;6820.624865632438;5787.508061814793;5818.156367326714;5820.941790582125;5829.679367634821;5848.812397243512;3555.2000799820353;3603.4054381026835;3605.4411566206754;3608.8707662479264;3612.440071788877;6603.867922641521;6605.801825945229;6654.434373078343;6673.566218195801;6715.832104197337;6926.722931082801;6932.202796678345;6955.643649488403;6976.720931162697;6987.1266091738535;6482.1573195485225;6612.603243805387;6623.628405252606;6658.633775142317;6682.431993280626;6687.1975362956755;6706.780745242409;6720.563163394364;6724.697388617622;6733.360330768569;6650.90023649636;6669.833254168685;6684.4318232950745;6777.728890844311;6794.694238759366;6487.772927947499;6500.187476565429;6520.869582608227;6588.035384077089;6612.23959244693;4989.55094041538;5009.574186194214;5011.924821127613;5057.747112644427;5076.492350764894;6573.5069869759;6666.633335166613;6692.397684208445;6693.364130407604;6753.493487988322;6316.115743795965;6486.156799616019;6537.6791239111335;6538.803835884931;6645.734170633121;6419.807405777834;6486.967565162144;6561.639109848813;6583.210014798255;6600.570962887397;6231.006078054979;6340.619562826245;6357.1735674362035;6408.379265714856;6522.902156467562;6560.540762146604;6564.868702625825;6588.637624930675;6697.966510167418;6724.092247546519;6318.842028949313;6329.208848893888;6353.936460635335;6355.586886852525;6417.422431980957 03:51:36 INFO - PID 15369 | |5;yui.html;891.9241864441523;901.2609660078738;919.576994582492;920.8572671235961;926.101681369072;19576.70634940477;20387.28644497443;20513.58972820543;20514.589708205865;20552.07515661795;18704.15831287592;18753.906230468863;18790.06049697513;18919.337823176193;18921.526961825926;941.6892425499568;969.8399764038925;974.1719538392346;974.9366291191085;975.0541974284932;986.7977064701719;987.0474991633073;988.3773222869582;988.9011098890089;988.9307748457611;981.2493442516445;1015.3755440404135;1021.1371391174446;1023.4268809466722;1034.5344594932274;1007.3099926550336;1015.5531566110961;1016.3292227130058;1019.0726438940566;1019.6788011776304;724.905762250904;741.8887166925005;751.3913729878816;752.9736459223901;757.2238455583016;20358.491037724027;20477;20588.27941022072;20605.793942060536;20624.278150264818;20958.371248862557;21110.788892111188;21483.140674373008;21655.891720541455;21934.341969740773;17372.91313543437;17613;17645.911770441195;17703.20335584902;17845;3672.155404257009;3713.0346110011324;3720.441933709938;3726.3478891194204;3733.2346868891814;99026.50486747592;137387.31306343403;142220;142322;143300;17566.209520571603;18001.459956201335;18052.187651555712;18075.36736214226;18086.728699069525;30948.381032379228;32141;32155.839220803748;32243.677563224068;32253.35493290121;8668.263197628272;8892.466452012899;8896.777580560409;8954.462732236087;8968.730938071869;4189.120284740177;4256.3189889617515;4259.893502662459;4269.957300427018;4285.185814695198;5428.728563571805;5503.3120859892515;5516.641418307797;5525.033119204204;5530.419305972895;1070.1652710885521;1071.121680222226;1072.4048153275007;1075.9408232547128;1085.0993675249524;681.5706105153721;685.7805502239236;705.9541129826545;710.5239489541916;713.0409599089216;11605.30368177912;12197.634070977885;12281.263124212575;12926.612201633967;13179.209247445184;692.6952141057918;698.5773606967813;698.7833771530842;703.8345988692653;710.1265443504518;5657.349404818417;5694.430556944355;5700.315962084576;5783.248177736868;5816.534677225812;120289;124471;125263;126917;129916;106160.46919765507;106768;107767;108715.45642271738;108840.45579772051;90616.54691726499;92122.53938730263;92456;95952;98395;10381.429021403896;10540.998605132807;10789.838152427878;10851.294665846695;10885.401302928098;42745.78627106844;44372.334414983154;44824.77587612041;45529.31706024346;46370.304445432674;55204;55555.722221388634;56956.14565781434;57098.714506427204;57376.42623573711;14651.780223296446;14787.92606037006;14821.851781482479;14856.554303370916;14992.850071499583;18224.72662910084;18305.450836474927;18398.448046558624;18525.629487410446;18609.06954652235;16136.515904522883;16314.26585803618;16354.264058117174;16444.917775411046;16452.588685282964;15179.544613661608;15191.848081519043;15301.08193508393;15488.84511154874;15592.064476131469;16384.098874562012;16516.83483165153;16652.750208746635;16653.41713040038;16675.49973500797;11220.943895280472;11448.198626096093;11496.367699776592;11690.88309116932;11705.473253703774;12483.625491235278;12503.624891253277;12577.685557861127;12582.24506529611;12685.873141268838 03:51:36 INFO - PID 15369 | __end_tp_report 03:51:36 INFO - PID 15369 | __start_cc_report 03:51:36 INFO - PID 15369 | _x_x_mozilla_cycle_collect,286 03:51:36 INFO - PID 15369 | __end_cc_report 03:51:36 INFO - PID 15369 | __startTimestamp1506595896618__endTimestamp 03:51:36 INFO - PID 15369 | 03:51:36 INFO - PID 15369 | ------- Summary: start ------- 03:51:36 INFO - PID 15369 | Number of tests: 6 03:51:36 INFO - PID 15369 | 03:51:36 INFO - PID 15369 | [#0] dojo.html Cycles:165 Average:6127.48 Median:6350.75 stddev:717.32 (11.3%) stddev-sans-first:681.28 03:51:36 INFO - PID 15369 | Values: 3181.9 3190.9 3203.6 3216.0 3227.6 6060.0 6217.8 6272.8 6276.2 6281.8 6189.8 6192.8 6230.1 6358.5 6363.7 5746.2 5768.6 5786.9 5817.5 5818.0 5488.0 5623.7 5753.2 5836.8 5843.6 5704.6 5757.5 5759.0 5766.9 5835.5 5590.0 5638.5 5685.5 5712.1 5762.9 5677.0 5716.7 5729.5 5747.4 5755.3 6212.5 6218.2 6221.1 6223.8 6330.5 6390.2 6534.7 6540.0 6677.7 6763.7 6539.0 6568.0 6598.7 6611.6 6758.3 6229.7 6269.1 6291.8 6311.4 6313.6 6786.0 6824.7 6893.7 6978.8 6984.8 6511.7 6565.4 6578.5 6595.3 6601.0 6633.8 6636.9 6701.7 6713.9 6719.3 6429.2 6434.4 6538.7 6538.9 6669.5 6605.3 6611.2 6618.9 6622.2 6651.4 5218.6 5232.1 5249.6 5268.8 5271.9 4590.0 4609.7 4645.4 4674.1 4683.5 5686.0 5693.9 5696.6 5765.9 5774.2 6550.6 6654.3 6662.7 6662.8 6754.6 5696.6 5715.2 5722.8 5729.8 5731.7 5634.9 5731.8 5758.8 5818.4 5823.5 6484.2 6560.0 6565.9 6568.6 6574.6 6661.6 6669.4 6682.3 6754.6 6781.4 6288.9 6395.7 6403.0 6507.4 6507.4 6559.1 6603.3 6605.4 6621.0 6679.9 6727.8 6739.3 6786.3 6786.4 6813.8 6226.2 6330.7 6347.6 6413.8 6439.6 6433.4 6446.8 6458.3 6462.8 6505.1 6326.4 6385.4 6425.3 6468.0 6474.2 6491.1 6492.2 6547.5 6552.5 6602.6 6110.4 6261.6 6280.9 6332.3 6350.7 03:51:36 INFO - PID 15369 | 03:51:36 INFO - PID 15369 | [#1] ext.html Cycles:180 Average:38084.98 Median:20021.07 stddev:53120.65 (265.3%) stddev-sans-first:53196.21 03:51:36 INFO - PID 15369 | Values: 881.0 909.7 911.3 913.5 914.4 39727.8 42964.4 43569.6 43679.0 43740.0 39320.2 39366.4 39499.6 39580.4 39689.4 7223.5 7323.7 7371.4 7385.9 7405.2 7271.3 7369.6 7374.3 7374.9 7397.4 7320.8 7362.9 7368.1 7407.7 7881.4 8027.9 8055.9 8056.8 8057.4 8059.0 7781.3 7784.6 7945.9 7957.0 7975.8 39756.8 40025.2 40125.0 40169.8 40211.4 3534.1 3588.8 3592.8 3593.2 3597.3 33001.3 33077.0 33160.5 33189.8 33290.2 5200.9 5203.1 5235.2 5237.3 5244.1 185136.0 187013.0 187549.0 188382.0 188685.0 42595.0 43345.3 48322.0 48634.5 49570.5 52022.0 52028.5 52062.5 52141.0 52144.2 14625.4 14736.4 14808.7 14813.3 14820.8 11781.4 11783.9 11803.5 11814.1 11837.7 13920.6 13943.5 13945.9 14051.4 14138.5 5556.6 5663.6 5698.2 5701.7 5712.6 1021.2 1025.9 1031.3 1033.6 1033.7 23131.4 23331.5 23469.5 23488.6 23645.6 1121.6 1128.7 1130.5 1133.4 1135.6 12326.5 12459.1 12460.9 12498.5 12575.1 221927.0 223245.0 223715.0 223811.0 224115.0 56456.0 56490.2 56741.4 56752.7 56788.4 1425.7 1471.3 1475.8 1479.9 1492.3 22825.4 22841.4 22949.2 23041.0 23049.3 39196.0 39253.4 39255.2 39280.2 39321.0 201179.0 202038.0 203240.0 203452.0 203507.0 34455.8 36444.8 37348.8 37551.2 37612.6 46621.1 47333.0 47335.8 47528.8 47635.5 34224.8 34390.3 34423.0 34563.3 35031.8 33965.2 34619.1 34688.8 35236.6 35245.3 38673.6 39147.8 39156.8 39179.2 39318.2 33438.0 33666.5 33736.2 34064.0 34369.5 24382.3 24990.1 25072.9 25157.2 25662.7 03:51:36 INFO - PID 15369 | 03:51:36 INFO - PID 15369 | [#2] jquery.html Cycles:180 Average:34354.88 Median:23145.10 stddev:80576.60 (348.1%) stddev-sans-first:80762.79 03:51:36 INFO - PID 15369 | Values: 604.6 607.3 610.3 614.0 616.1 22684.5 23210.7 23256.2 23295.0 23586.2 20597.4 21363.7 21419.3 21453.8 21551.8 6558.3 6703.0 6704.3 6706.0 6733.7 6456.2 6649.0 6742.4 6747.3 6749.0 6675.7 6703.9 6705.5 6708.0 6737.4 6684.0 6708.7 6724.5 6740.5 6743.9 6202.2 6242.7 6259.2 6264.5 6283.8 28063.3 28720.0 28974.1 29135.9 29403.7 2105.6 2142.4 2150.4 2151.5 2151.7 18894.1 19286.1 19373.8 19422.4 19441.3 2413.2 2439.6 2481.3 2509.0 2518.4 145498.0 146376.0 149833.0 150294.2 150510.0 14594.9 14868.9 14879.6 15301.2 15563.6 23922.9 23969.0 23974.8 24027.8 24066.5 9306.9 9638.7 9680.5 9735.2 9762.9 6803.8 7084.6 8665.1 8771.0 8810.0 8673.7 8888.6 9132.2 9153.5 9261.6 2680.6 2809.9 2828.3 2867.2 2893.7 970.8 984.8 988.6 992.5 993.2 19139.0 19824.7 20065.7 20213.8 20669.7 1040.6 1041.5 1042.9 1043.7 1056.1 10950.1 11299.9 11354.8 11425.8 11468.6 463413.0 468280.0 477297.0 477974.0 489909.0 107160.0 108354.0 109734.0 112778.0 114935.0 1152.6 1152.7 1171.1 1181.2 1185.2 17710.6 17993.7 18030.2 18140.8 18679.0 54512.7 54701.0 55838.2 56768.7 57517.4 67932.0 68515.3 69059.7 70160.0 71664.6 14474.6 14847.6 14943.3 14949.6 14970.6 22645.3 22683.5 22892.5 23072.3 23079.5 18436.5 18573.7 19009.3 19039.0 19040.3 16628.6 16642.4 16939.0 16949.3 17214.3 18811.6 18898.7 18938.4 19071.7 19129.2 14470.6 14588.6 14597.4 14608.3 14627.7 17765.6 17908.6 18010.0 18193.7 18249.5 03:51:36 INFO - PID 15369 | 03:51:36 INFO - PID 15369 | [#3] mootools.html Cycles:180 Average:9604.01 Median:2603.41 stddev:7070.43 (271.6%) stddev-sans-first:7062.73 03:51:36 INFO - PID 15369 | Values: 1300.0 1396.3 1415.6 1416.6 1429.3 15116.4 15781.9 15784.6 15787.6 15809.0 15502.1 15537.7 15593.7 15635.9 15657.9 2583.4 2623.8 2656.9 2660.2 2664.2 2740.8 2752.2 2759.6 2767.9 2780.8 2601.8 2605.1 2692.1 2697.3 2700.7 2639.7 2643.7 2660.5 2664.0 2671.1 2519.0 2536.1 2543.0 2543.2 2689.4 15518.5 15613.1 15666.2 15709.4 15755.2 8071.9 8238.3 8546.8 8580.3 8589.7 5328.6 5342.5 5411.7 5424.1 5543.2 1781.0 1842.8 1977.7 2041.8 2042.7 28264.9 28580.1 28626.1 28626.9 28634.4 6683.8 6850.6 7006.0 7042.7 7058.9 17909.3 17936.8 17963.4 17998.7 18065.5 7833.9 7956.3 7965.1 7966.7 7972.5 6825.6 7130.8 7296.7 7310.3 7314.3 5287.4 5312.0 5377.1 5410.6 5414.8 1437.3 1457.1 1458.8 1459.1 1465.3 860.7 900.7 902.1 906.8 916.4 7491.4 7502.7 7517.2 7520.1 7543.7 727.6 733.4 734.7 740.3 745.1 4997.2 5134.2 5143.7 5147.7 5216.5 21718.5 22010.9 22423.1 22508.9 22907.2 21938.2 22463.1 22652.2 22682.8 22842.7 10351.7 11539.7 11935.4 11950.5 11970.9 8399.6 8491.0 8518.5 8556.5 8586.2 18634.0 19222.6 19222.6 19279.0 19553.1 19663.2 20100.9 20196.2 20454.6 20964.9 11311.8 11345.1 11346.0 11399.4 11421.8 14288.1 14420.7 14448.6 14493.9 14547.7 11712.7 11715.1 11728.8 11869.3 12048.0 11523.9 11635.2 11653.5 11879.0 11952.6 10214.9 10218.7 10219.2 10272.7 10354.5 7248.7 7266.2 7285.9 7361.8 7443.3 7406.9 7453.6 7462.9 7554.4 7608.7 03:51:36 INFO - PID 15369 | 03:51:36 INFO - PID 15369 | [#4] prototype.html Cycles:180 Average:5572.83 Median:6230.48 stddev:1547.11 (24.8%) stddev-sans-first:1503.76 03:51:36 INFO - PID 15369 | Values: 494.4 517.4 528.1 548.5 553.5 6107.4 6138.2 6154.8 6250.2 6410.7 6267.8 6281.5 6311.5 6353.2 6357.1 5155.1 5203.2 5227.3 5256.3 5268.6 4951.7 5050.0 5083.9 5084.5 5133.4 4981.5 5035.6 5040.6 5045.8 5084.9 5014.4 5024.9 5034.2 5036.1 5049.1 4583.7 4620.5 4624.0 4630.2 4641.2 6195.9 6208.6 6229.9 6247.0 6322.7 5713.4 5756.1 5773.3 5774.6 5786.9 6659.6 6666.7 6683.7 6689.2 6692.6 4955.5 4966.9 5013.2 5025.7 5029.8 6882.1 6919.8 6972.2 6984.9 6996.5 5071.2 5091.4 5111.9 5116.1 5124.5 5186.9 5191.8 5193.2 5205.6 5228.7 5780.9 5804.7 5812.4 5813.8 5831.2 6254.9 6439.7 6621.4 6707.0 6722.4 1766.7 1766.8 1771.9 1774.8 1779.8 1239.7 1241.8 1252.1 1255.1 1266.8 5700.6 5755.7 5784.8 5817.2 5829.4 6777.6 6798.4 6798.6 6805.9 6820.6 5787.5 5818.2 5820.9 5829.7 5848.8 3555.2 3603.4 3605.4 3608.9 3612.4 6603.9 6605.8 6654.4 6673.6 6715.8 6926.7 6932.2 6955.6 6976.7 6987.1 6482.2 6612.6 6623.6 6658.6 6682.4 6687.2 6706.8 6720.6 6724.7 6733.4 6650.9 6669.8 6684.4 6777.7 6794.7 6487.8 6500.2 6520.9 6588.0 6612.2 4989.6 5009.6 5011.9 5057.7 5076.5 6573.5 6666.6 6692.4 6693.4 6753.5 6316.1 6486.2 6537.7 6538.8 6645.7 6419.8 6487.0 6561.6 6583.2 6600.6 6231.0 6340.6 6357.2 6408.4 6522.9 6560.5 6564.9 6588.6 6698.0 6724.1 6318.8 6329.2 6353.9 6355.6 6417.4 03:51:36 INFO - PID 15369 | 03:51:36 INFO - PID 15369 | [#5] yui.html Cycles:180 Average:24292.08 Median:20432.14 stddev:34822.55 (170.4%) stddev-sans-first:34875.91 03:51:36 INFO - PID 15369 | Values: 891.9 901.3 919.6 920.9 926.1 19576.7 20387.3 20513.6 20514.6 20552.1 18704.2 18753.9 18790.1 18919.3 18921.5 941.7 969.8 974.2 974.9 975.1 986.8 987.0 988.4 988.9 988.9 981.2 1015.4 1021.1 1023.4 1034.5 1007.3 1015.6 1016.3 1019.1 1019.7 724.9 741.9 751.4 753.0 757.2 20358.5 20477.0 20588.3 20605.8 20624.3 20958.4 21110.8 21483.1 21655.9 21934.3 17372.9 17613.0 17645.9 17703.2 17845.0 3672.2 3713.0 3720.4 3726.3 3733.2 99026.5 137387.3 142220.0 142322.0 143300.0 17566.2 18001.5 18052.2 18075.4 18086.7 30948.4 32141.0 32155.8 32243.7 32253.4 8668.3 8892.5 8896.8 8954.5 8968.7 4189.1 4256.3 4259.9 4270.0 4285.2 5428.7 5503.3 5516.6 5525.0 5530.4 1070.2 1071.1 1072.4 1075.9 1085.1 681.6 685.8 706.0 710.5 713.0 11605.3 12197.6 12281.3 12926.6 13179.2 692.7 698.6 698.8 703.8 710.1 5657.3 5694.4 5700.3 5783.2 5816.5 120289.0 124471.0 125263.0 126917.0 129916.0 106160.5 106768.0 107767.0 108715.5 108840.5 90616.5 92122.5 92456.0 95952.0 98395.0 10381.4 10541.0 10789.8 10851.3 10885.4 42745.8 44372.3 44824.8 45529.3 46370.3 55204.0 55555.7 56956.1 57098.7 57376.4 14651.8 14787.9 14821.9 14856.6 14992.9 18224.7 18305.5 18398.4 18525.6 18609.1 16136.5 16314.3 16354.3 16444.9 16452.6 15179.5 15191.8 15301.1 15488.8 15592.1 16384.1 16516.8 16652.8 16653.4 16675.5 11220.9 11448.2 11496.4 11690.9 11705.5 12483.6 12503.6 12577.7 12582.2 12685.9 03:51:36 INFO - PID 15369 | -------- Summary: end -------- 03:51:36 INFO - PID 15369 | 03:51:37 INFO - TEST-INFO | 15369: exit 0 03:51:37 INFO - TEST-OK | dromaeo_css | took 1109183ms 03:51:37 INFO - TEST-START | kraken 03:51:37 INFO - Initialising browser for kraken test... 03:51:37 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43179/getInfo.html -profile /tmp/tmpEC5HAh/profile 03:51:37 INFO - TEST-INFO | started process 15723 (/builds/slave/test/build/application/firefox/firefox http://localhost:43179/getInfo.html) 03:51:42 INFO - TEST-INFO | 15723: exit 0 03:51:42 INFO - Browser initialized. 03:51:42 INFO - Running cycle 1/1 for kraken test... 03:51:42 INFO - Using env: {'DISPLAY': ':0', 03:51:42 INFO - 'HOME': '/home/cltbld', 03:51:42 INFO - 'JSGC_DISABLE_POISONING': '1', 03:51:42 INFO - 'LANG': 'en_US.UTF-8', 03:51:42 INFO - 'LANGUAGE': 'en_US:en', 03:51:42 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:51:42 INFO - 'LOGNAME': 'cltbld', 03:51:42 INFO - 'MAIL': '/var/mail/cltbld', 03:51:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:51:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:51:42 INFO - 'MOZ_CRASHREPORTER': '1', 03:51:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:42 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:51:42 INFO - 'MOZ_NO_REMOTE': '1', 03:51:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:51:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:42 INFO - 'NO_EM_RESTART': '1', 03:51:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:42 INFO - 'PWD': '/builds/slave/test', 03:51:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:51:42 INFO - 'RUST_BACKTRACE': 'full', 03:51:42 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:51:42 INFO - 'SHELL': '/bin/bash', 03:51:42 INFO - 'SHLVL': '1', 03:51:42 INFO - 'STYLO_FORCE_DISABLED': '1', 03:51:42 INFO - 'TERM': 'linux', 03:51:42 INFO - 'TMOUT': '86400', 03:51:42 INFO - 'USER': 'cltbld', 03:51:42 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1506594728.591878-1818972610', 03:51:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:42 INFO - '_': '/tools/buildbot/bin/python'} 03:51:42 INFO - TEST-INFO | started process 15958 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEC5HAh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:51:43 INFO - PID 15958 | 03:51:43 INFO - PID 15958 | (/builds/slave/test/build/application/firefox/firefox:16007): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:51:43 INFO - PID 15958 | 03:51:53 INFO - PID 15958 | RSS: Main: 151248896 03:51:53 INFO - PID 15958 | 03:51:56 INFO - PID 15958 | Cycle 1(1): loaded http://localhost:43179/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43179/tests/kraken/driver.html?testName=audio-beat-detection) 03:51:57 INFO - PID 15958 | RSS: Main: 156913664 03:51:57 INFO - PID 15958 | 03:51:59 INFO - PID 15958 | Cycle 1(1): loaded http://localhost:43179/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43179/tests/kraken/driver.html?testName=audio-dft) 03:52:00 INFO - PID 15958 | RSS: Main: 157831168 03:52:00 INFO - PID 15958 | 03:52:03 INFO - PID 15958 | Cycle 1(1): loaded http://localhost:43179/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43179/tests/kraken/driver.html?testName=audio-fft) 03:52:03 INFO - PID 15958 | RSS: Main: 154857472 03:52:03 INFO - PID 15958 | 03:52:06 INFO - PID 15958 | Cycle 1(1): loaded http://localhost:43179/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43179/tests/kraken/driver.html?testName=audio-oscillator) 03:52:06 INFO - PID 15958 | RSS: Main: 155271168 03:52:06 INFO - PID 15958 | 03:52:08 INFO - PID 15958 | Cycle 1(1): loaded http://localhost:43179/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43179/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:52:09 INFO - PID 15958 | RSS: Main: 155234304 03:52:09 INFO - PID 15958 | 03:52:12 INFO - PID 15958 | Cycle 1(1): loaded http://localhost:43179/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43179/tests/kraken/driver.html?testName=imaging-darkroom) 03:52:13 INFO - PID 15958 | RSS: Main: 158113792 03:52:13 INFO - PID 15958 | 03:52:16 INFO - PID 15958 | Cycle 1(1): loaded http://localhost:43179/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43179/tests/kraken/driver.html?testName=imaging-desaturate) 03:52:17 INFO - PID 15958 | RSS: Main: 157724672 03:52:17 INFO - PID 15958 | 03:52:20 INFO - PID 15958 | Cycle 1(1): loaded http://localhost:43179/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43179/tests/kraken/driver.html?testName=json-parse-financial) 03:52:21 INFO - PID 15958 | RSS: Main: 157782016 03:52:21 INFO - PID 15958 | 03:52:22 INFO - PID 15958 | Cycle 1(1): loaded http://localhost:43179/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43179/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:52:23 INFO - PID 15958 | RSS: Main: 157827072 03:52:23 INFO - PID 15958 | 03:52:24 INFO - PID 15958 | Cycle 1(1): loaded http://localhost:43179/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43179/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:52:25 INFO - PID 15958 | RSS: Main: 157859840 03:52:25 INFO - PID 15958 | 03:52:27 INFO - PID 15958 | Cycle 1(1): loaded http://localhost:43179/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43179/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:52:28 INFO - PID 15958 | RSS: Main: 154931200 03:52:28 INFO - PID 15958 | 03:52:30 INFO - PID 15958 | Cycle 1(1): loaded http://localhost:43179/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43179/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:52:31 INFO - PID 15958 | RSS: Main: 155275264 03:52:31 INFO - PID 15958 | 03:52:34 INFO - PID 15958 | Cycle 1(1): loaded http://localhost:43179/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43179/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:52:34 INFO - PID 15958 | RSS: Main: 155639808 03:52:34 INFO - PID 15958 | 03:52:36 INFO - PID 15958 | Cycle 1(1): loaded http://localhost:43179/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43179/tests/kraken/driver.html?testName=ai-astar) 03:52:36 INFO - PID 15958 | RSS: Main: 156889088 03:52:36 INFO - PID 15958 | 03:52:36 INFO - PID 15958 | __start_tp_report 03:52:36 INFO - PID 15958 | _x_x_mozilla_page_load 03:52:36 INFO - PID 15958 | _x_x_mozilla_page_load_details 03:52:36 INFO - PID 15958 | |i|pagename|runs| 03:52:36 INFO - PID 15958 | |0;ai-astar;110;106;107;108;107;108;108;108;108;110 03:52:36 INFO - PID 15958 | |1;audio-beat-detection;119;131;120;115;119;118;117;120;121;117 03:52:36 INFO - PID 15958 | |2;audio-dft;162;162;164;163;162;163;163;171;163;163 03:52:36 INFO - PID 15958 | |3;audio-fft;74;74;74;75;74;74;82;74;74;74 03:52:36 INFO - PID 15958 | |4;audio-oscillator;82;79;80;80;86;79;78;78;81;81 03:52:36 INFO - PID 15958 | |5;imaging-gaussian-blur;110;114;114;113;114;110;114;111;114;111 03:52:36 INFO - PID 15958 | |6;imaging-darkroom;148;148;149;149;148;148;147;148;148;149 03:52:36 INFO - PID 15958 | |7;imaging-desaturate;98;94;94;93;94;95;95;98;94;94 03:52:36 INFO - PID 15958 | |8;json-parse-financial;51;51;51;51;52;54;52;51;52;65 03:52:36 INFO - PID 15958 | |9;json-stringify-tinderbox;37;37;37;37;36;36;38;37;37;38 03:52:36 INFO - PID 15958 | |10;stanford-crypto-aes;71;73;75;71;71;75;72;75;74;73 03:52:36 INFO - PID 15958 | |11;stanford-crypto-ccm;110;109;107;111;111;113;112;116;110;114 03:52:36 INFO - PID 15958 | |12;stanford-crypto-pbkdf2;173;169;166;159;161;165;162;166;161;163 03:52:36 INFO - PID 15958 | |13;stanford-crypto-sha256-iterative;62;66;61;66;63;64;63;66;75;71 03:52:36 INFO - PID 15958 | __end_tp_report 03:52:36 INFO - PID 15958 | __start_cc_report 03:52:36 INFO - PID 15958 | _x_x_mozilla_cycle_collect,745 03:52:36 INFO - PID 15958 | __end_cc_report 03:52:36 INFO - PID 15958 | __startTimestamp1506595956889__endTimestamp 03:52:36 INFO - PID 15958 | 03:52:36 INFO - PID 15958 | ------- Summary: start ------- 03:52:36 INFO - PID 15958 | Number of tests: 14 03:52:36 INFO - PID 15958 | 03:52:36 INFO - PID 15958 | [#0] ai-astar Cycles:10 Average:108.00 Median:108.00 stddev:1.25 (1.2%) stddev-sans-first:1.09 03:52:36 INFO - PID 15958 | Values: 110.0 106.0 107.0 108.0 107.0 108.0 108.0 108.0 108.0 110.0 03:52:36 INFO - PID 15958 | 03:52:36 INFO - PID 15958 | [#1] audio-beat-detection Cycles:10 Average:119.70 Median:119.50 stddev:4.35 (3.6%) stddev-sans-first:4.60 03:52:36 INFO - PID 15958 | Values: 119.0 131.0 120.0 115.0 119.0 118.0 117.0 120.0 121.0 117.0 03:52:36 INFO - PID 15958 | 03:52:36 INFO - PID 15958 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.00 stddev:2.67 (1.6%) stddev-sans-first:2.77 03:52:36 INFO - PID 15958 | Values: 162.0 162.0 164.0 163.0 162.0 163.0 163.0 171.0 163.0 163.0 03:52:36 INFO - PID 15958 | 03:52:36 INFO - PID 15958 | [#3] audio-fft Cycles:10 Average:74.90 Median:74.00 stddev:2.51 (3.4%) stddev-sans-first:2.65 03:52:36 INFO - PID 15958 | Values: 74.0 74.0 74.0 75.0 74.0 74.0 82.0 74.0 74.0 74.0 03:52:36 INFO - PID 15958 | 03:52:36 INFO - PID 15958 | [#4] audio-oscillator Cycles:10 Average:80.40 Median:80.50 stddev:2.37 (2.9%) stddev-sans-first:2.44 03:52:36 INFO - PID 15958 | Values: 82.0 79.0 80.0 80.0 86.0 79.0 78.0 78.0 81.0 81.0 03:52:36 INFO - PID 15958 | 03:52:36 INFO - PID 15958 | [#5] imaging-gaussian-blur Cycles:10 Average:112.50 Median:114.00 stddev:1.78 (1.6%) stddev-sans-first:1.64 03:52:36 INFO - PID 15958 | Values: 110.0 114.0 114.0 113.0 114.0 110.0 114.0 111.0 114.0 111.0 03:52:36 INFO - PID 15958 | 03:52:36 INFO - PID 15958 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 03:52:36 INFO - PID 15958 | Values: 148.0 148.0 149.0 149.0 148.0 148.0 147.0 148.0 148.0 149.0 03:52:36 INFO - PID 15958 | 03:52:36 INFO - PID 15958 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:94.50 stddev:1.73 (1.8%) stddev-sans-first:1.42 03:52:36 INFO - PID 15958 | Values: 98.0 94.0 94.0 93.0 94.0 95.0 95.0 98.0 94.0 94.0 03:52:36 INFO - PID 15958 | 03:52:36 INFO - PID 15958 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:52.00 stddev:4.32 (8.3%) stddev-sans-first:4.52 03:52:36 INFO - PID 15958 | Values: 51.0 51.0 51.0 51.0 52.0 54.0 52.0 51.0 52.0 65.0 03:52:36 INFO - PID 15958 | 03:52:36 INFO - PID 15958 | [#9] json-stringify-tinderbox Cycles:10 Average:37.00 Median:37.00 stddev:0.67 (1.8%) stddev-sans-first:0.71 03:52:36 INFO - PID 15958 | Values: 37.0 37.0 37.0 37.0 36.0 36.0 38.0 37.0 37.0 38.0 03:52:36 INFO - PID 15958 | 03:52:36 INFO - PID 15958 | [#10] stanford-crypto-aes Cycles:10 Average:73.00 Median:73.50 stddev:1.70 (2.3%) stddev-sans-first:1.64 03:52:36 INFO - PID 15958 | Values: 71.0 73.0 75.0 71.0 71.0 75.0 72.0 75.0 74.0 73.0 03:52:36 INFO - PID 15958 | 03:52:36 INFO - PID 15958 | [#11] stanford-crypto-ccm Cycles:10 Average:111.30 Median:111.50 stddev:2.58 (2.3%) stddev-sans-first:2.70 03:52:36 INFO - PID 15958 | Values: 110.0 109.0 107.0 111.0 111.0 113.0 112.0 116.0 110.0 114.0 03:52:36 INFO - PID 15958 | 03:52:36 INFO - PID 15958 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.50 Median:165.50 stddev:4.22 (2.6%) stddev-sans-first:3.17 03:52:36 INFO - PID 15958 | Values: 173.0 169.0 166.0 159.0 161.0 165.0 162.0 166.0 161.0 163.0 03:52:36 INFO - PID 15958 | 03:52:36 INFO - PID 15958 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:66.00 stddev:4.32 (6.5%) stddev-sans-first:4.37 03:52:36 INFO - PID 15958 | Values: 62.0 66.0 61.0 66.0 63.0 64.0 63.0 66.0 75.0 71.0 03:52:36 INFO - PID 15958 | -------- Summary: end -------- 03:52:36 INFO - PID 15958 | 03:52:37 INFO - PID 15958 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:52:37 INFO - TEST-INFO | 15958: exit 0 03:52:37 INFO - TEST-OK | kraken | took 60396ms 03:52:37 INFO - SUITE-END | took 1169s 03:52:38 INFO - Completed test suite (00:19:30) 03:52:38 INFO - javascript benchmark 03:52:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8559.929160982585, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3181.9045428637132, 3190.872365105396, 3203.5515027896085, 3216.0, 3227.580414546109, 6059.969700151493, 6217.782377616784, 6272.811815645527, 6276.2468503779555, 6281.842953926154, 6189.783357582485, 6192.78325258616, 6230.096635987779, 6358.459530939876, 6363.71363288652, 5746.1668058131545, 5768.625039372428, 5786.884262314762, 5817.505512031483, 5818.0, 5487.972560137194, 5623.690697011662, 5753.223314852504, 5836.766529338822, 5843.561732870052, 5704.600677952566, 5757.510611598019, 5758.971205143989, 5766.913496297559, 5835.4748072673665, 5589.972050139764, 5638.520725738317, 5685.4883060524335, 5712.086066229425, 5762.884742305172, 5676.971615141939, 5716.742746576414, 5729.541636669056, 5747.3677895431465, 5755.251817263771, 6212.471939885115, 6218.22272215973, 6221.066839973995, 6223.751049957997, 6330.525210609223, 6390.233172019341, 6534.673266336664, 6539.967300163468, 6677.666116694146, 6763.661816909135, 6539.0, 6568.047633093222, 6598.670066496656, 6611.603303801788, 6758.29037951013, 6229.6573688447115, 6269.059641053833, 6291.842703932392, 6311.431971122575, 6313.621182729051, 6785.9660701696175, 6824.6928888200155, 6893.655317234118, 6978.825529361705, 6984.755533556403, 6511.674416279167, 6565.376289252514, 6578.506612004119, 6595.274519802818, 6601.0, 6633.834154146185, 6636.900446493307, 6701.664916754143, 6713.865722685617, 6719.328067193242, 6429.196350456193, 6434.356564343622, 6538.738450461929, 6538.901916471256, 6669.499787515859, 6605.30644282353, 6611.20665520131, 6618.933810661832, 6622.238442579069, 6651.43462805667, 5218.608604354613, 5232.084385232645, 5249.606279529051, 5268.841934741964, 5271.947280527223, 4590.0, 4609.746463944448, 4645.396098507173, 4674.135284972223, 4683.531646835358, 5685.971570142123, 5693.886122277531, 5696.601237913306, 5765.94234057654, 5774.220480235114, 6550.574212676161, 6654.301298363699, 6662.7334906604165, 6662.833429164213, 6754.5947243165565, 5696.629719068247, 5715.199872017921, 5722.799702010493, 5729.770809167587, 5731.656100633975, 5634.887302253932, 5731.828045158652, 5758.798442054592, 5818.389069147764, 5823.475887170175, 6484.157059582224, 6559.967200163968, 6565.934340656628, 6568.573042752206, 6574.572652777554, 6661.600303981777, 6669.433098186709, 6682.331766823376, 6754.5947243165565, 6781.355771201629, 6288.905666414916, 6395.7121929514215, 6403.0, 6507.446867016167, 6507.446867016357, 6559.147310849559, 6603.339666033358, 6605.438537724347, 6621.0, 6679.866402672016, 6727.764528241684, 6739.326067393222, 6786.287439818945, 6786.355296246848, 6813.761518346834, 6226.159468471698, 6330.746770129143, 6347.619142851444, 6413.839654008687, 6439.645819479973, 6433.388828061326, 6446.8388290293115, 6458.321876202931, 6462.838429039311, 6505.121808555785, 6326.398992095744, 6385.393387628168, 6425.261094974137, 6468.029795530708, 6474.158359413246, 6491.123698300669, 6492.220933488012, 6547.508936829661, 6552.541322107407, 6602.60384376939, 6110.358412366638, 6261.592996455216, 6280.937190628035, 6332.335104813928, 6350.7459701611415], "value": 6074.720362826639, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [880.9559522023898, 909.6679711905152, 911.2573252798965, 913.511271469763, 914.3964983111148, 39727.80136099319, 42964.35553466697, 43569.56430435694, 43679.0, 43740.0, 39320.21359572814, 39366.40950385747, 39499.605003950026, 39580.40629390562, 39689.40465893007, 7223.530470519412, 7323.670434830418, 7371.37343325818, 7385.8522829543645, 7405.1854296027395, 7271.309225623558, 7369.631518424084, 7374.262573742636, 7374.852502949938, 7397.371223445986, 7320.780376588711, 7362.889556656654, 7368.078990126234, 7407.740729074483, 7881.448298619099, 8027.879581806277, 8055.879161812548, 8056.798580035487, 8057.395695322874, 8058.959705201437, 7781.26078022587, 7784.649690763873, 7945.920540794634, 7956.960215198945, 7975.8404831903035, 39756.801215994026, 40025.19949600992, 40125.0, 40169.79915100435, 40211.39682904759, 3534.1164708822794, 3588.784672919633, 3592.766470179456, 3593.1735700788704, 3597.316509863144, 33001.339973200644, 33077.0, 33160.50259246113, 33189.834050829835, 33290.167745806306, 5200.8959820803375, 5203.1414816555225, 5235.188545775411, 5237.319148510707, 5244.056069907415, 185136.0, 187013.0, 187549.0, 188382.0, 188685.0, 42595.0, 43345.34981975273, 48322.0, 48634.51365486371, 49570.50429495731, 52022.0, 52028.47971520312, 52062.47937520652, 52141.0, 52144.21783673248, 14625.414983400759, 14736.410543578351, 14808.703825923421, 14813.259337033105, 14820.777688334683, 11781.410929453494, 11783.941080294544, 11803.468843901874, 11814.05487560993, 11837.704057398634, 13920.58238252854, 13943.511977080754, 13945.930270348583, 14051.367688454044, 14138.50515231962, 5556.638818476786, 5663.5735380095275, 5698.230738850285, 5701.71491425427, 5712.6286791358425, 1021.2340744441668, 1025.917926565873, 1031.2729525684374, 1033.560736686905, 1033.7467320506523, 23131.421714456937, 23331.53336933252, 23469.530609387715, 23488.647670284958, 23645.645315320286, 1121.5794077221042, 1128.7065363005513, 1130.5308297056795, 1133.393634405589, 1135.5855112883903, 12326.50693972249, 12459.06557008228, 12460.875391246153, 12498.500059997497, 12575.056870734732, 221927.0, 223245.0, 223715.0, 223811.0, 224115.0, 56456.0, 56490.15264771032, 56741.43258567444, 56752.71623641856, 56788.43211567831, 1425.7291114688176, 1471.3305446022034, 1475.8229012518352, 1479.8964072515037, 1492.2986196487634, 22825.429364266027, 22841.42896427536, 22949.196778112684, 23041.0, 23049.308520744406, 39196.0, 39253.41119883261, 39255.2148957025, 39280.2143957125, 39321.0, 201179.0, 202038.0, 203240.0, 203452.0, 203507.0, 34455.82772086224, 36444.81777591095, 37348.813255934634, 37551.2489750198, 37612.62387376091, 46621.067578648916, 47333.0, 47335.76332118317, 47528.762356187995, 47635.52364476311, 34224.82887585546, 34390.31219375548, 34423.0, 34563.30873382569, 35031.82484087563, 33965.15087122842, 34619.13452163716, 34688.82655586706, 35236.64763352334, 35245.29509409849, 38673.61326386813, 39147.80426097851, 39156.80421597988, 39179.2164156721, 39318.2136357277, 33438.0, 33666.49500257449, 33736.1565960853, 34064.0, 34369.484457733655, 24382.26853194407, 24990.125345612818, 25072.874635626704, 25157.24528264155, 25662.743372566034], "value": 17430.67950951446, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.5616927727395, 607.2621764556069, 610.3194937644527, 613.9754409823604, 616.1004932798114, 22684.54630907383, 23210.65184022241, 23256.18603348885, 23295.0, 23586.174483893068, 20597.382078537667, 21363.6795448068, 21419.250326238584, 21453.785462145373, 21551.784482155173, 6558.311377305374, 6703.0, 6704.2625311215725, 6706.0, 6733.696983635724, 6456.22525296965, 6649.035889796, 6742.393184613384, 6747.25780164184, 6748.966255168717, 6675.66621668917, 6703.899441508382, 6705.530612857102, 6708.027336036272, 6737.35995080469, 6683.966580167093, 6708.731650733965, 6724.495662825308, 6740.460763138937, 6743.8651226975435, 6202.224721909762, 6242.687865606701, 6259.217597800275, 6264.498840092781, 6283.7800676976085, 28063.29841753952, 28720.0, 28974.130776076752, 29135.85432072826, 29403.705962940312, 2105.5683584865064, 2142.3572928121503, 2150.3656421355736, 2151.4943988162768, 2151.688005239247, 18894.149763260688, 19286.13212405431, 19373.80626193734, 19422.417327480198, 19441.31955381555, 2413.191580820427, 2439.6462512935705, 2481.280428675682, 2509.034021901581, 2518.3829961659326, 145497.99999999895, 146376.0, 149833.0, 150294.24852875774, 150510.0, 14594.927025365017, 14868.851311486964, 14879.58643928825, 15301.234938253043, 15563.61090972712, 23922.88038559796, 23969.0, 23974.760252397602, 24027.759722402552, 24066.51866962651, 9306.86039709405, 9638.710838674851, 9680.46757428334, 9735.1725103367, 9762.90237097634, 6803.829904252433, 7084.574925504383, 8665.090165532654, 8771.0, 8809.955950220208, 8673.73978780625, 8888.555572221363, 9132.178103970675, 9153.496557689392, 9261.583228754722, 2680.571108622611, 2809.9297517562222, 2828.2787889088563, 2867.1541895140986, 2893.7106289370895, 970.7621632699893, 984.8030393921244, 988.6490295944836, 992.513668302541, 993.1508560180941, 19139.0, 19824.70262946057, 20065.699014514794, 20213.79786202119, 20669.689954650694, 1040.6097713357492, 1041.505284989639, 1042.8644276244192, 1043.6921108273077, 1056.1339701444895, 10950.06924411434, 11299.94350028261, 11354.772904542027, 11425.771484570261, 11468.59859904916, 463413.0, 468280.0, 477297.0, 477974.0, 489909.0, 107160.0, 108354.0, 109734.0, 112778.0, 114935.0, 1152.5562658376584, 1152.68877403099, 1171.0865524890598, 1181.2440038375275, 1185.1526158796503, 17710.557236069202, 17993.730094048336, 18030.1886415109, 18140.818591813913, 18678.972656504022, 54512.72743636256, 54701.0, 55838.162427562806, 56768.7161564206, 57517.42482575288, 67932.0, 68515.31484685089, 69059.65470172618, 70160.0, 71664.64167679129, 14474.565763026705, 14847.554573362817, 14943.327550260481, 14949.551513454613, 14970.625734356729, 22645.320640380814, 22683.546329073655, 22892.542149157256, 23072.307830765105, 23079.538409232056, 18436.539086522946, 18573.721394179367, 19009.33467328637, 19039.04804759784, 19040.33358832434, 16628.58428539296, 16642.417515386904, 16938.983660980382, 16949.32202711878, 17214.31142754326, 18811.6237675243, 18898.716519251946, 18938.431847044612, 19071.71392429087, 19129.23483060662, 14470.638234044232, 14588.635284117981, 14597.416103355747, 14608.342624582132, 14627.70744585081, 17765.644687106444, 17908.641827163643, 18010.0, 18193.727094093334, 18249.452516424528], "value": 11963.638445997462, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1299.9935000325, 1396.3367400484776, 1415.61070705556, 1416.5750274917523, 1429.3282157386031, 15116.395344186232, 15781.92109039456, 15784.605384865385, 15787.579117879388, 15809.0, 15502.147381893992, 15537.689246215097, 15593.688126237468, 15635.921820390911, 15657.92171039146, 2583.4316450380884, 2623.8163328567007, 2656.880440380178, 2660.188642464048, 2664.174106027128, 2740.849253291068, 2752.1881045091645, 2759.6274502942147, 2767.875445604953, 2780.79144064196, 2601.7528334808258, 2605.0621776160565, 2692.1250593557074, 2697.3391519077854, 2700.66241719785, 2639.7492238237337, 2643.73562643736, 2660.507806055886, 2664.027629915077, 2671.118530884813, 2518.9874050629815, 2536.099684611973, 2542.9872850635816, 2543.2116044026225, 2689.367998520346, 15518.534443966699, 15613.141277229748, 15666.216689165496, 15709.371625135094, 15755.212239387985, 8071.919280807234, 8238.258556729863, 8546.829063418696, 8580.270676992463, 8589.742307730716, 5328.600354973354, 5342.54588359986, 5411.702356370398, 5424.1321388578035, 5543.196236545678, 1780.9554761131076, 1842.824931631493, 1977.7033444983367, 2041.8264447521979, 2042.724232228645, 28264.858675706695, 28580.14259572237, 28626.14121576356, 28626.856865715537, 28634.427311453863, 6683.832904177434, 6850.554713943578, 7006.0, 7042.6830792614455, 7058.858822823618, 17909.283628654706, 17936.820631793515, 17963.37128200533, 17998.730019049726, 18065.458036258933, 7833.921660783433, 7956.323712484388, 7965.084015338194, 7966.721164759206, 7972.481788683717, 6825.624590647562, 7130.821729456701, 7296.70813167478, 7310.305520975498, 7314.305141011595, 5287.365516138088, 5312.0, 5377.059014672417, 5410.567154627621, 5414.810481633124, 1437.3029080895758, 1457.1111621910627, 1458.8030615866935, 1459.109942934809, 1465.2673663168416, 860.694453469022, 900.7072701372081, 902.0933961368783, 906.8277027364779, 916.3768637326549, 7491.438142139361, 7502.737404190827, 7517.17311095779, 7520.1351844537485, 7543.660535275926, 727.6034561164179, 733.3876213361796, 734.7244783206297, 740.2819265312638, 745.0612228591905, 4997.175466048061, 5134.204198349262, 5143.691378517301, 5147.6911385317, 5216.452272511332, 21718.457038573844, 22010.88994555017, 22423.10307587678, 22508.887455562617, 22907.19824806124, 21938.232161874257, 22463.10147594078, 22652.207172748876, 22682.773172268397, 22842.657360139612, 10351.689449316533, 11539.653810385702, 11935.403229838474, 11950.46222919988, 11970.880291196976, 8399.622017009371, 8491.0, 8518.48889066658, 8556.459837229359, 8586.22723954847, 18634.0, 19222.61554768925, 19222.61554768925, 19279.0, 19553.120109595387, 19663.213471460982, 20100.899495502428, 20196.192152313743, 20454.590908181457, 20964.895175524023, 11311.830322545004, 11345.092392608736, 11346.0, 11399.430028498708, 11421.771564568497, 14288.142711437347, 14420.711585768435, 14448.566543003726, 14493.92753036228, 14547.709045818812, 11712.70718232051, 11715.062794976551, 11728.76542469163, 11869.347185904859, 12048.0, 11523.884761152281, 11635.185537012328, 11653.475593598478, 11879.0, 11952.64142075739, 10214.948925255623, 10218.744531386776, 10219.182465402899, 10272.691819245434, 10354.5340459678, 7248.693850513752, 7266.164391094881, 7285.865421083082, 7361.815954600964, 7443.292887175709, 7406.925930740624, 7453.627318634155, 7462.925370746223, 7554.4334174936, 7608.695652173851], "value": 6720.996576738986, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [494.35239835815105, 517.4334104155948, 528.1417696243604, 548.5063442901389, 553.4769642687659, 6107.38926107389, 6138.232720909887, 6154.753809847612, 6250.187475628162, 6410.743570257184, 6267.843303917404, 6281.466075383586, 6311.495080393569, 6353.174087368647, 6357.078223657579, 5155.149400348938, 5203.161060214, 5227.26818245446, 5256.290400795901, 5268.604854635899, 4951.678140920847, 5050.0, 5083.898322033557, 5084.542391184793, 5133.383993920735, 4981.455748717891, 5035.647504674675, 5040.6471546991725, 5045.848624541251, 5084.923726144092, 5014.423341315741, 5024.949750502503, 5034.244863270502, 5036.11867923112, 5049.056113396332, 4583.679142460029, 4620.491745907947, 4624.0, 4630.189716799547, 4641.2109941310055, 6195.907061394083, 6208.627482351073, 6229.944118440903, 6247.0, 6322.683865806737, 5713.400092990218, 5756.136579513065, 5773.278340207474, 5774.566907481955, 5786.913196302059, 6659.600423974577, 6666.699998500079, 6683.6658167091455, 6689.23073846509, 6692.598444093322, 4955.529224723646, 4966.925496117561, 5013.197888337849, 5025.748712564394, 5029.823956161554, 6882.070920425778, 6919.792406227822, 6972.163340399134, 6984.860302794017, 6996.545224560438, 5071.239314102841, 5091.439941606421, 5111.897762044739, 5116.130257856174, 5124.461931497213, 5186.870328241749, 5191.844244672666, 5193.195054766517, 5205.583553315726, 5228.712420816815, 5780.942190578125, 5804.709764511757, 5812.38969908162, 5813.79651712188, 5831.183634291117, 6254.874902501924, 6439.678016099177, 6621.42443080731, 6707.0, 6722.428593569503, 1766.6908291049272, 1766.7614871992116, 1771.866005756317, 1774.8136445673276, 1779.8220177982098, 1239.6714870559128, 1241.8385609870659, 1252.1422825364655, 1255.12768625806, 1266.8099785032134, 5700.629459085146, 5755.740991655385, 5784.797532086357, 5817.156512305692, 5829.446202610745, 6777.6272305023695, 6798.422134118655, 6798.620482830969, 6805.863882722318, 6820.624865632438, 5787.508061814793, 5818.156367326714, 5820.941790582125, 5829.679367634821, 5848.812397243512, 3555.2000799820353, 3603.4054381026835, 3605.4411566206754, 3608.8707662479264, 3612.440071788877, 6603.867922641521, 6605.801825945229, 6654.434373078343, 6673.566218195801, 6715.832104197337, 6926.722931082801, 6932.202796678345, 6955.643649488403, 6976.720931162697, 6987.1266091738535, 6482.1573195485225, 6612.603243805387, 6623.628405252606, 6658.633775142317, 6682.431993280626, 6687.1975362956755, 6706.780745242409, 6720.563163394364, 6724.697388617622, 6733.360330768569, 6650.90023649636, 6669.833254168685, 6684.4318232950745, 6777.728890844311, 6794.694238759366, 6487.772927947499, 6500.187476565429, 6520.869582608227, 6588.035384077089, 6612.23959244693, 4989.55094041538, 5009.574186194214, 5011.924821127613, 5057.747112644427, 5076.492350764894, 6573.5069869759, 6666.633335166613, 6692.397684208445, 6693.364130407604, 6753.493487988322, 6316.115743795965, 6486.156799616019, 6537.6791239111335, 6538.803835884931, 6645.734170633121, 6419.807405777834, 6486.967565162144, 6561.639109848813, 6583.210014798255, 6600.570962887397, 6231.006078054979, 6340.619562826245, 6357.1735674362035, 6408.379265714856, 6522.902156467562, 6560.540762146604, 6564.868702625825, 6588.637624930675, 6697.966510167418, 6724.092247546519, 6318.842028949313, 6329.208848893888, 6353.936460635335, 6355.586886852525, 6417.422431980957], "value": 5119.644329322273, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [891.9241864441523, 901.2609660078738, 919.576994582492, 920.8572671235961, 926.101681369072, 19576.70634940477, 20387.28644497443, 20513.58972820543, 20514.589708205865, 20552.07515661795, 18704.15831287592, 18753.906230468863, 18790.06049697513, 18919.337823176193, 18921.526961825926, 941.6892425499568, 969.8399764038925, 974.1719538392346, 974.9366291191085, 975.0541974284932, 986.7977064701719, 987.0474991633073, 988.3773222869582, 988.9011098890089, 988.9307748457611, 981.2493442516445, 1015.3755440404135, 1021.1371391174446, 1023.4268809466722, 1034.5344594932274, 1007.3099926550336, 1015.5531566110961, 1016.3292227130058, 1019.0726438940566, 1019.6788011776304, 724.905762250904, 741.8887166925005, 751.3913729878816, 752.9736459223901, 757.2238455583016, 20358.491037724027, 20477.0, 20588.27941022072, 20605.793942060536, 20624.278150264818, 20958.371248862557, 21110.788892111188, 21483.140674373008, 21655.891720541455, 21934.341969740773, 17372.91313543437, 17613.0, 17645.911770441195, 17703.20335584902, 17845.0, 3672.155404257009, 3713.0346110011324, 3720.441933709938, 3726.3478891194204, 3733.2346868891814, 99026.50486747592, 137387.31306343403, 142220.0, 142322.0, 143300.0, 17566.209520571603, 18001.459956201335, 18052.187651555712, 18075.36736214226, 18086.728699069525, 30948.381032379228, 32141.0, 32155.839220803748, 32243.677563224068, 32253.35493290121, 8668.263197628272, 8892.466452012899, 8896.777580560409, 8954.462732236087, 8968.730938071869, 4189.120284740177, 4256.3189889617515, 4259.893502662459, 4269.957300427018, 4285.185814695198, 5428.728563571805, 5503.3120859892515, 5516.641418307797, 5525.033119204204, 5530.419305972895, 1070.1652710885521, 1071.121680222226, 1072.4048153275007, 1075.9408232547128, 1085.0993675249524, 681.5706105153721, 685.7805502239236, 705.9541129826545, 710.5239489541916, 713.0409599089216, 11605.30368177912, 12197.634070977885, 12281.263124212575, 12926.612201633967, 13179.209247445184, 692.6952141057918, 698.5773606967813, 698.7833771530842, 703.8345988692653, 710.1265443504518, 5657.349404818417, 5694.430556944355, 5700.315962084576, 5783.248177736868, 5816.534677225812, 120289.0, 124471.0, 125263.0, 126917.0, 129916.0, 106160.46919765507, 106768.0, 107767.0, 108715.45642271738, 108840.45579772051, 90616.54691726499, 92122.53938730263, 92456.0, 95952.0, 98395.0, 10381.429021403896, 10540.998605132807, 10789.838152427878, 10851.294665846695, 10885.401302928098, 42745.78627106844, 44372.334414983154, 44824.77587612041, 45529.31706024346, 46370.304445432674, 55204.0, 55555.722221388634, 56956.14565781434, 57098.714506427204, 57376.42623573711, 14651.780223296446, 14787.92606037006, 14821.851781482479, 14856.554303370916, 14992.850071499583, 18224.72662910084, 18305.450836474927, 18398.448046558624, 18525.629487410446, 18609.06954652235, 16136.515904522883, 16314.26585803618, 16354.264058117174, 16444.917775411046, 16452.588685282964, 15179.544613661608, 15191.848081519043, 15301.08193508393, 15488.84511154874, 15592.064476131469, 16384.098874562012, 16516.83483165153, 16652.750208746635, 16653.41713040038, 16675.49973500797, 11220.943895280472, 11448.198626096093, 11496.367699776592, 11690.88309116932, 11705.473253703774, 12483.625491235278, 12503.624891253277, 12577.685557861127, 12582.24506529611, 12685.873141268838], "value": 9024.389073209439, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1406.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 106.0, 107.0, 108.0, 107.0, 108.0, 108.0, 108.0, 108.0, 110.0], "value": 108.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 131.0, 120.0, 115.0, 119.0, 118.0, 117.0, 120.0, 121.0, 117.0], "value": 119.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 164.0, 163.0, 162.0, 163.0, 163.0, 171.0, 163.0, 163.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 75.0, 74.0, 74.0, 82.0, 74.0, 74.0, 74.0], "value": 74.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 79.0, 80.0, 80.0, 86.0, 79.0, 78.0, 78.0, 81.0, 81.0], "value": 80.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 114.0, 114.0, 113.0, 114.0, 110.0, 114.0, 111.0, 114.0, 111.0], "value": 112.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 149.0, 149.0, 148.0, 148.0, 147.0, 148.0, 148.0, 149.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 94.0, 94.0, 93.0, 94.0, 95.0, 95.0, 98.0, 94.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 51.0, 51.0, 52.0, 54.0, 52.0, 51.0, 52.0, 65.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 37.0, 37.0, 37.0, 36.0, 36.0, 38.0, 37.0, 37.0, 38.0], "value": 37.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 73.0, 75.0, 71.0, 71.0, 75.0, 72.0, 75.0, 74.0, 73.0], "value": 73.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 109.0, 107.0, 111.0, 111.0, 113.0, 112.0, 116.0, 110.0, 114.0], "value": 111.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 169.0, 166.0, 159.0, 161.0, 165.0, 162.0, 166.0, 161.0, 163.0], "value": 164.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 66.0, 61.0, 66.0, 63.0, 64.0, 63.0, 66.0, 75.0, 71.0], "value": 65.7, "unit": "score"}]}]} 03:52:38 INFO - Return code: 0 03:52:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:52:38 INFO - # TBPL SUCCESS # 03:52:38 INFO - Running post-action listener: _package_coverage_data 03:52:38 INFO - Running post-action listener: _resource_record_post_action 03:52:38 INFO - [mozharness: 2017-09-28 10:52:38.194759Z] Finished run-tests step (success) 03:52:38 INFO - Running post-run listener: _resource_record_post_run 03:52:38 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 341069824; Read time: 8; Write time: 220656 03:52:38 INFO - TinderboxPrint: CPU usage
13.1% 03:52:38 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 03:52:38 INFO - TinderboxPrint: I/O write bytes / time
341,069,824 / 220,656 03:52:38 INFO - TinderboxPrint: CPU idle
8,229.3 (86.9%) 03:52:38 INFO - TinderboxPrint: CPU user
1,194.9 (12.6%) 03:52:38 INFO - TinderboxPrint: Swap in / out
0 / 0 03:52:38 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 6250496; Read time: 0; Write time: 664 03:52:38 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:52:38 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 333697024; Read time: 0; Write time: 219972 03:52:38 INFO - Running post-run listener: _upload_blobber_files 03:52:38 INFO - Blob upload gear active. 03:52:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:52:38 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:52:38 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'] 03:52:38 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 03:52:39 INFO - (blobuploader) - INFO - Open directory for files ... 03:52:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:52:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:52:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:52:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:52:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:52:43 INFO - (blobuploader) - INFO - Done attempting. 03:52:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 03:52:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:52:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:52:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 03:52:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:52:44 INFO - (blobuploader) - INFO - Done attempting. 03:52:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:52:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:52:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:52:45 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:52:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:52:45 INFO - (blobuploader) - INFO - Done attempting. 03:52:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 03:52:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:52:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:52:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 03:52:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:52:46 INFO - (blobuploader) - INFO - Done attempting. 03:52:46 INFO - (blobuploader) - INFO - Iteration through files over. 03:52:46 INFO - Return code: 0 03:52:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:52:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:52:46 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/37f52d01d3638bb95a5cf29367f3b67001a30c39259bd1e33ae580106a285b28a8bf5c0095783b1116fece40e901ae538861456d05391a4cf55acaa5f544b570", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/981f7fbf6a24e9b060a31b36266303ef0f7a6be1958241abf7d11d38b208f7d67802d589f7c54e23779ec81d88df53cc41d3571a97867e7af39dd3109a79ec7d", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7eea5a2b86f603296794995fb9dafdc550d5fc1b6c251a9b1be4fea3fa4fef1ea290a6549f3a7ad66848e914043a1c44d96a4dd0671b9fcdaf86085e9c827223", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a2170ab71908cae5bf81135e5baa0770b0decada6ada0ce640631ffe6607961146dde8e388bc757e6879dcc74088463884e1a0100b99275861b84f7bc5a7cb19"} 03:52:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:52:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:52:46 INFO - Contents: 03:52:46 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/37f52d01d3638bb95a5cf29367f3b67001a30c39259bd1e33ae580106a285b28a8bf5c0095783b1116fece40e901ae538861456d05391a4cf55acaa5f544b570", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/981f7fbf6a24e9b060a31b36266303ef0f7a6be1958241abf7d11d38b208f7d67802d589f7c54e23779ec81d88df53cc41d3571a97867e7af39dd3109a79ec7d", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7eea5a2b86f603296794995fb9dafdc550d5fc1b6c251a9b1be4fea3fa4fef1ea290a6549f3a7ad66848e914043a1c44d96a4dd0671b9fcdaf86085e9c827223", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a2170ab71908cae5bf81135e5baa0770b0decada6ada0ce640631ffe6607961146dde8e388bc757e6879dcc74088463884e1a0100b99275861b84f7bc5a7cb19"} 03:52:46 INFO - Running post-run listener: copy_logs_to_upload_dir 03:52:46 INFO - Copying logs to upload dir... 03:52:46 INFO - mkdir: /builds/slave/test/build/upload/logs 03:52:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.349001 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-09-28 03:52:46.392140) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-28 03:52:46.396118) ========= 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=31acecf42b6a79ec49471d4a000001bb-1506594728.591878-1818972610 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/37f52d01d3638bb95a5cf29367f3b67001a30c39259bd1e33ae580106a285b28a8bf5c0095783b1116fece40e901ae538861456d05391a4cf55acaa5f544b570", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/981f7fbf6a24e9b060a31b36266303ef0f7a6be1958241abf7d11d38b208f7d67802d589f7c54e23779ec81d88df53cc41d3571a97867e7af39dd3109a79ec7d", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7eea5a2b86f603296794995fb9dafdc550d5fc1b6c251a9b1be4fea3fa4fef1ea290a6549f3a7ad66848e914043a1c44d96a4dd0671b9fcdaf86085e9c827223", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a2170ab71908cae5bf81135e5baa0770b0decada6ada0ce640631ffe6607961146dde8e388bc757e6879dcc74088463884e1a0100b99275861b84f7bc5a7cb19"} build_url:https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011262 build_url: 'https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/37f52d01d3638bb95a5cf29367f3b67001a30c39259bd1e33ae580106a285b28a8bf5c0095783b1116fece40e901ae538861456d05391a4cf55acaa5f544b570", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/981f7fbf6a24e9b060a31b36266303ef0f7a6be1958241abf7d11d38b208f7d67802d589f7c54e23779ec81d88df53cc41d3571a97867e7af39dd3109a79ec7d", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7eea5a2b86f603296794995fb9dafdc550d5fc1b6c251a9b1be4fea3fa4fef1ea290a6549f3a7ad66848e914043a1c44d96a4dd0671b9fcdaf86085e9c827223", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a2170ab71908cae5bf81135e5baa0770b0decada6ada0ce640631ffe6607961146dde8e388bc757e6879dcc74088463884e1a0100b99275861b84f7bc5a7cb19"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-28 03:52:46.429513) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 03:52:46.429889) ========= 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=31acecf42b6a79ec49471d4a000001bb-1506594728.591878-1818972610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004509 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 03:52:46.511820) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-28 03:52:46.512135) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-28 03:52:46.512488) ========= ========= Total master_lag: 0.21 =========