builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-023 starttime: 1507184965.12 results: success (0) revision: 3a3dd3b7cfc609f10c603073cd07949a5b7b9472 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-04 23:29:25.121475) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-04 23:29:25.121958) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-04 23:29:25.122246) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-04 23:29:25.167313) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 23:29:25.167693) ========= 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=6d15e502d8e29d5d2676d664000001c3-1507177148.389834-1262642936 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-04 23:29:24-- 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% 26.4M=0s 2017-10-04 23:29:24 (26.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.339715 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 23:29:25.530973) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 23:29:25.531250) ========= 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=6d15e502d8e29d5d2676d664000001c3-1507177148.389834-1262642936 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022165 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 23:29:25.583824) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-04 23:29:25.587173) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 3a3dd3b7cfc609f10c603073cd07949a5b7b9472 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 3a3dd3b7cfc609f10c603073cd07949a5b7b9472 --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=6d15e502d8e29d5d2676d664000001c3-1507177148.389834-1262642936 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-04 23:29:24,947 truncating revision to first 12 chars 2017-10-04 23:29:24,947 Setting DEBUG logging. 2017-10-04 23:29:24,947 attempt 1/10 2017-10-04 23:29:24,947 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/3a3dd3b7cfc6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-04 23:29:26,069 unpacking tar archive at: mozilla-beta-3a3dd3b7cfc6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.428959 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-04 23:29:27.033585) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-04 23:29:27.036921) ========= script_repo_revision: 3a3dd3b7cfc609f10c603073cd07949a5b7b9472 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-04 23:29:27.037291) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-04 23:29:27.037552) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-04 23:29:27.051925) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2017-10-04 23:29:27.052236) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-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=6d15e502d8e29d5d2676d664000001c3-1507177148.389834-1262642936 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:29:26 INFO - MultiFileLogger online at 20171004 23:29:26 in /builds/slave/test 23:29:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 23:29:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:29:26 INFO - {'append_to_log': False, 23:29:26 INFO - 'base_work_dir': '/builds/slave/test', 23:29:26 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 23:29:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:29:26 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 23:29:26 INFO - 'buildbot_json_path': 'buildprops.json', 23:29:26 INFO - 'code_coverage': False, 23:29:26 INFO - 'config_files': ('talos/linux_config.py',), 23:29:26 INFO - 'default_actions': ('clobber', 23:29:26 INFO - 'read-buildbot-config', 23:29:26 INFO - 'download-and-extract', 23:29:26 INFO - 'populate-webroot', 23:29:26 INFO - 'create-virtualenv', 23:29:26 INFO - 'install', 23:29:26 INFO - 'setup-mitmproxy', 23:29:26 INFO - 'run-tests'), 23:29:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:29:26 INFO - 'disable_ccov_upload': False, 23:29:26 INFO - 'disable_stylo': False, 23:29:26 INFO - 'download_minidump_stackwalk': True, 23:29:26 INFO - 'download_symbols': 'ondemand', 23:29:26 INFO - 'enable_stylo': False, 23:29:26 INFO - 'enable_webrender': False, 23:29:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 23:29:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:29:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:29:26 INFO - 'gecko_profile': False, 23:29:26 INFO - 'gecko_profile_interval': 0, 23:29:26 INFO - 'installer_path': 'installer.exe', 23:29:26 INFO - 'log_level': 'info', 23:29:26 INFO - 'log_name': 'talos', 23:29:26 INFO - 'log_to_console': True, 23:29:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:29:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:29:26 INFO - 'opt_config_files': (), 23:29:26 INFO - 'pip_index': False, 23:29:26 INFO - 'suite': 'dromaeojs-e10s', 23:29:26 INFO - 'system_bits': '32', 23:29:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:29:26 INFO - 'title': 'talos-linux64-ix-023', 23:29:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:29:26 INFO - 'use_talos_json': True, 23:29:26 INFO - 'verify': 'False', 23:29:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:29:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:29:26 INFO - 'work_dir': 'build'} 23:29:26 INFO - [mozharness: 2017-10-05 06:29:26.552300Z] Running clobber step. 23:29:26 INFO - Running pre-action listener: _resource_record_pre_action 23:29:26 INFO - Running main action method: clobber 23:29:26 INFO - rmtree: /builds/slave/test/build 23:29:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:29:28 INFO - Running post-action listener: _resource_record_post_action 23:29:28 INFO - [mozharness: 2017-10-05 06:29:28.079943Z] Finished clobber step (success) 23:29:28 INFO - [mozharness: 2017-10-05 06:29:28.080040Z] Running read-buildbot-config step. 23:29:28 INFO - Running pre-action listener: _resource_record_pre_action 23:29:28 INFO - Running main action method: read_buildbot_config 23:29:28 INFO - Using buildbot properties: 23:29:28 INFO - { 23:29:28 INFO - "project": "", 23:29:28 INFO - "product": "firefox", 23:29:28 INFO - "who": "bholley@mozilla.com", 23:29:28 INFO - "installer_path": "public/build/target.tar.bz2", 23:29:28 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 23:29:28 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 23:29:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 23:29:28 INFO - "stage_platform": "linux64", 23:29:28 INFO - "basedir": "/builds/slave/test", 23:29:28 INFO - "buildnumber": 158, 23:29:28 INFO - "platform": "ubuntu64_hw", 23:29:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:29:28 INFO - "slavebuilddir": "test", 23:29:28 INFO - "taskId": "YDCZR2WOR-Shq2QVj6zlEQ", 23:29:28 INFO - "branch": "mozilla-beta", 23:29:28 INFO - "script_repo_revision": "production", 23:29:28 INFO - "revision": "3a3dd3b7cfc609f10c603073cd07949a5b7b9472", 23:29:28 INFO - "slavename": "talos-linux64-ix-023", 23:29:28 INFO - "repo_path": "releases/mozilla-beta" 23:29:28 INFO - } 23:29:28 INFO - Finding installer, test and symbols from parent task. 23:29:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YDCZR2WOR-Shq2QVj6zlEQ'}, attempt #1 23:29:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YDCZR2WOR-Shq2QVj6zlEQ'}, attempt #1 23:29:28 INFO - Task dependencies: VzvV0R-ATLmcfM0_Ua3a-w 23:29:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VzvV0R-ATLmcfM0_Ua3a-w'}, attempt #1 23:29:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/VzvV0R-ATLmcfM0_Ua3a-w/artifacts/public/build/target.tar.bz2 23:29:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/VzvV0R-ATLmcfM0_Ua3a-w/artifacts/public/build/target.test_packages.json 23:29:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/VzvV0R-ATLmcfM0_Ua3a-w/artifacts/public/build/target.crashreporter-symbols.zip 23:29:29 INFO - Running post-action listener: _resource_record_post_action 23:29:29 INFO - [mozharness: 2017-10-05 06:29:29.396696Z] Finished read-buildbot-config step (success) 23:29:29 INFO - [mozharness: 2017-10-05 06:29:29.396913Z] Running download-and-extract step. 23:29:29 INFO - Running pre-action listener: _resource_record_pre_action 23:29:29 INFO - Running main action method: download_and_extract 23:29:29 INFO - mkdir: /builds/slave/test/build/tests 23:29: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')]} 23:29:29 INFO - trying https://queue.taskcluster.net/v1/task/VzvV0R-ATLmcfM0_Ua3a-w/artifacts/public/build/target.test_packages.json 23:29:29 INFO - Downloading https://queue.taskcluster.net/v1/task/VzvV0R-ATLmcfM0_Ua3a-w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 23:29:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VzvV0R-ATLmcfM0_Ua3a-w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 23:29:30 INFO - Downloaded 989 bytes. 23:29:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 23:29:30 INFO - Using the following test package requirements: 23:29:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 23:29:30 INFO - u'common': [u'target.common.tests.zip'], 23:29:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 23:29:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 23:29:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 23:29:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 23:29:30 INFO - u'mozbase': [u'target.common.tests.zip'], 23:29:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 23:29:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 23:29:30 INFO - u'web-platform': [u'target.common.tests.zip', 23:29:30 INFO - u'target.web-platform.tests.tar.gz'], 23:29:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 23:29:30 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 23:29:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VzvV0R-ATLmcfM0_Ua3a-w/artifacts/public/build/target.common.tests.zip 23:29:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VzvV0R-ATLmcfM0_Ua3a-w/artifacts/public/build/target.common.tests.zip'}, attempt #1 23:29:30 INFO - Fetch https://queue.taskcluster.net/v1/task/VzvV0R-ATLmcfM0_Ua3a-w/artifacts/public/build/target.common.tests.zip into memory 23:29:31 INFO - Content-Length response header: 55176965 23:29:31 INFO - Bytes received: 55176965 23:29:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VzvV0R-ATLmcfM0_Ua3a-w/artifacts/public/build/target.talos.tests.zip 23:29:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VzvV0R-ATLmcfM0_Ua3a-w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 23:29:41 INFO - Fetch https://queue.taskcluster.net/v1/task/VzvV0R-ATLmcfM0_Ua3a-w/artifacts/public/build/target.talos.tests.zip into memory 23:29:42 INFO - Content-Length response header: 14509224 23:29:42 INFO - Bytes received: 14509224 23:29:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:29:42 INFO - trying https://queue.taskcluster.net/v1/task/VzvV0R-ATLmcfM0_Ua3a-w/artifacts/public/build/target.tar.bz2 23:29:42 INFO - Downloading https://queue.taskcluster.net/v1/task/VzvV0R-ATLmcfM0_Ua3a-w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 23:29:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VzvV0R-ATLmcfM0_Ua3a-w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 23:29:44 INFO - Downloaded 55272037 bytes. 23:29:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VzvV0R-ATLmcfM0_Ua3a-w/artifacts/public/build/target.tar.bz2 23:29:44 INFO - mkdir: /builds/slave/test/properties 23:29:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:29:44 INFO - Writing to file /builds/slave/test/properties/build_url 23:29:44 INFO - Contents: 23:29:44 INFO - build_url:https://queue.taskcluster.net/v1/task/VzvV0R-ATLmcfM0_Ua3a-w/artifacts/public/build/target.tar.bz2 23:29:44 INFO - Running post-action listener: _resource_record_post_action 23:29:44 INFO - Running post-action listener: find_tests_for_verification 23:29:44 INFO - Running post-action listener: set_extra_try_arguments 23:29:44 INFO - [mozharness: 2017-10-05 06:29:44.082174Z] Finished download-and-extract step (success) 23:29:44 INFO - [mozharness: 2017-10-05 06:29:44.082296Z] Running populate-webroot step. 23:29:44 INFO - Running pre-action listener: _resource_record_pre_action 23:29:44 INFO - Running main action method: populate_webroot 23:29:44 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:29:44 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 23:29:44 INFO - 'tests': ['tresize', 23:29:44 INFO - 'tcanvasmark']}, 23:29:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:29:44 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 23:29:44 INFO - 'tests': ['dromaeo_css', 23:29:44 INFO - 'kraken']}, 23:29:44 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 23:29:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:29:44 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 23:29:44 INFO - 'talos_options': ['--disable-stylo'], 23:29:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:29:44 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 23:29:44 INFO - 'tests': ['damp', 'tps']}, 23:29:44 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 23:29:44 INFO - 'talos_options': ['--disable-stylo'], 23:29:44 INFO - 'tests': ['damp', 'tps']}, 23:29:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:29:44 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 23:29:44 INFO - 'tests': ['dromaeo_dom']}, 23:29:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 23:29:44 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 23:29:44 INFO - 'tests': ['basic_compositor_video', 23:29:44 INFO - 'glvideo']}, 23:29:44 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 23:29:44 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 23:29:44 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 23:29:44 INFO - 'talos_options': ['--disable-stylo'], 23:29:44 INFO - 'tests': ['ts_paint_webext', 23:29:44 INFO - 'tp5o_webext']}, 23:29:44 INFO - 'other-e10s': {'tests': ['a11yr', 23:29:44 INFO - 'ts_paint', 23:29:44 INFO - 'tpaint', 23:29:44 INFO - 'sessionrestore', 23:29:44 INFO - 'sessionrestore_many_windows', 23:29:44 INFO - 'sessionrestore_no_auto_restore', 23:29:44 INFO - 'tabpaint']}, 23:29:44 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 23:29:44 INFO - 'tests': ['a11yr', 23:29:44 INFO - 'ts_paint', 23:29:44 INFO - 'tpaint', 23:29:44 INFO - 'sessionrestore', 23:29:44 INFO - 'sessionrestore_many_windows', 23:29:44 INFO - 'sessionrestore_no_auto_restore', 23:29:44 INFO - 'tabpaint']}, 23:29:44 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 23:29:44 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 23:29:44 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 23:29:44 INFO - 'tests': ['perf_reftest_singletons']}, 23:29:44 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 23:29:44 INFO - 'tests': ['bloom_basic']}, 23:29:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:29:44 INFO - 'tsvgr_opacity', 23:29:44 INFO - 'tart', 23:29:44 INFO - 'tscrollx', 23:29:44 INFO - 'tsvg_static']}, 23:29:44 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 23:29:44 INFO - 'tests': ['tsvgx', 23:29:44 INFO - 'tsvgr_opacity', 23:29:44 INFO - 'tart', 23:29:44 INFO - 'tscrollx', 23:29:44 INFO - 'tsvg_static']}, 23:29:44 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 23:29:44 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 23:29:44 INFO - 'talos_options': ['--disable-stylo'], 23:29:44 INFO - 'tests': ['tp5o']}, 23:29:44 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 23:29:44 INFO - 'talos_options': ['--mitmproxy', 23:29:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 23:29:44 INFO - '--firstNonBlankPaint'], 23:29:44 INFO - 'tests': ['tp6_google', 23:29:44 INFO - 'tp6_youtube', 23:29:44 INFO - 'tp6_amazon', 23:29:44 INFO - 'tp6_facebook']}, 23:29:44 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 23:29:44 INFO - 'talos_options': ['--disable-stylo', 23:29:44 INFO - '--mitmproxy', 23:29:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 23:29:44 INFO - '--firstNonBlankPaint'], 23:29:44 INFO - 'tests': ['tp6_google', 23:29:44 INFO - 'tp6_youtube', 23:29:44 INFO - 'tp6_amazon', 23:29:44 INFO - 'tp6_facebook']}, 23:29:44 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 23:29:44 INFO - 'talos_options': ['--stylo-threads=1', 23:29:44 INFO - '--mitmproxy', 23:29:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 23:29:44 INFO - '--firstNonBlankPaint'], 23:29:44 INFO - 'tests': ['tp6_google', 23:29:44 INFO - 'tp6_youtube', 23:29:44 INFO - 'tp6_amazon', 23:29:44 INFO - 'tp6_facebook']}, 23:29:44 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 23:29:44 INFO - 'talos_options': ['--xperf_path', 23:29:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:29:44 INFO - 'tests': ['tp5n']}, 23:29:44 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 23:29:44 INFO - 'talos_options': ['--disable-stylo', 23:29:44 INFO - '--xperf_path', 23:29:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:29:44 INFO - 'tests': ['tp5n']}}} 23:29:44 INFO - Running post-action listener: _resource_record_post_action 23:29:44 INFO - [mozharness: 2017-10-05 06:29:44.098911Z] Finished populate-webroot step (success) 23:29:44 INFO - [mozharness: 2017-10-05 06:29:44.099000Z] Running create-virtualenv step. 23:29:44 INFO - Running pre-action listener: _resource_record_pre_action 23:29:44 INFO - Running main action method: create_virtualenv 23:29:44 INFO - Creating virtualenv /builds/slave/test/build/venv 23:29:44 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 23:29:44 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 23:29:44 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 23:29:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:29:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:29:44 INFO - Installing distribute.............................................................................................................................................................................................done. 23:29:44 INFO - Installing pip...............done. 23:29:44 INFO - Return code: 0 23:29:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 23:29:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 23:29:45 INFO - Reading from file tmpfile_stdout 23:29:45 INFO - Output received: 23:29:45 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 23:29:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:29:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:29:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1379a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137d090>, '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 0x137dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1377f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1507177148.389834-1262642936', '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 23:29:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:29:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:29:45 INFO - Using env: {'DISPLAY': ':0', 23:29:45 INFO - 'HOME': '/home/cltbld', 23:29:45 INFO - 'LANG': 'en_US.UTF-8', 23:29:45 INFO - 'LANGUAGE': 'en_US:en', 23:29:45 INFO - 'LOGNAME': 'cltbld', 23:29:45 INFO - 'MAIL': '/var/mail/cltbld', 23:29:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:45 INFO - 'MOZ_NO_REMOTE': '1', 23:29:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:29:45 INFO - 'NO_EM_RESTART': '1', 23:29:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:29:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:29:45 INFO - 'PWD': '/builds/slave/test', 23:29:45 INFO - 'SHELL': '/bin/bash', 23:29:45 INFO - 'SHLVL': '1', 23:29:45 INFO - 'TERM': 'linux', 23:29:45 INFO - 'TMOUT': '86400', 23:29:45 INFO - 'USER': 'cltbld', 23:29:45 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1507177148.389834-1262642936', 23:29:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:45 INFO - '_': '/tools/buildbot/bin/python'} 23:29:46 INFO - Ignoring indexes: http://pypi.python.org/simple/ 23:29:46 INFO - Downloading/unpacking pip>=1.5 23:29:46 INFO - Running setup.py egg_info for package pip 23:29:46 INFO - warning: no files found matching 'pip/cacert.pem' 23:29:46 INFO - warning: no files found matching '*.html' under directory 'docs' 23:29:46 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 23:29:46 INFO - no previously-included directories found matching 'docs/_build/_sources' 23:29:46 INFO - Installing collected packages: pip 23:29:46 INFO - Found existing installation: pip 1.1 23:29:46 INFO - Uninstalling pip: 23:29:46 INFO - Successfully uninstalled pip 23:29:46 INFO - Running setup.py install for pip 23:29:46 INFO - warning: no files found matching 'pip/cacert.pem' 23:29:46 INFO - warning: no files found matching '*.html' under directory 'docs' 23:29:46 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 23:29:46 INFO - no previously-included directories found matching 'docs/_build/_sources' 23:29:46 INFO - Installing pip script to /builds/slave/test/build/venv/bin 23:29:46 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 23:29:46 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 23:29:46 INFO - Successfully installed pip 23:29:46 INFO - Cleaning up... 23:29:46 INFO - Return code: 0 23:29:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:29: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')]} 23:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29: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')]} 23:29:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1379a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137d090>, '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 0x137dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1377f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1507177148.389834-1262642936', '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 23:29:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:29:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:29:46 INFO - Using env: {'DISPLAY': ':0', 23:29:46 INFO - 'HOME': '/home/cltbld', 23:29:46 INFO - 'LANG': 'en_US.UTF-8', 23:29:46 INFO - 'LANGUAGE': 'en_US:en', 23:29:46 INFO - 'LOGNAME': 'cltbld', 23:29:46 INFO - 'MAIL': '/var/mail/cltbld', 23:29:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:46 INFO - 'MOZ_NO_REMOTE': '1', 23:29:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:29:46 INFO - 'NO_EM_RESTART': '1', 23:29:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:29:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:29:46 INFO - 'PWD': '/builds/slave/test', 23:29:46 INFO - 'SHELL': '/bin/bash', 23:29:46 INFO - 'SHLVL': '1', 23:29:46 INFO - 'TERM': 'linux', 23:29:46 INFO - 'TMOUT': '86400', 23:29:46 INFO - 'USER': 'cltbld', 23:29:46 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1507177148.389834-1262642936', 23:29:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:46 INFO - '_': '/tools/buildbot/bin/python'} 23:29:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:46 INFO - Downloading/unpacking psutil>=3.1.1 23:29: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 23:29: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 23:29: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 23:29: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 23:29:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:29:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:29:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:29:47 INFO - Installing collected packages: psutil 23:29:47 INFO - Running setup.py install for psutil 23:29:47 INFO - building 'psutil._psutil_linux' extension 23:29:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 23:29:48 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 23:29:48 INFO - building 'psutil._psutil_posix' extension 23:29:48 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 23:29:48 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 23:29:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:29:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:29:48 INFO - Successfully installed psutil 23:29:48 INFO - Cleaning up... 23:29:48 INFO - Return code: 0 23:29:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:29:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:29:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1379a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137d090>, '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 0x137dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1377f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1507177148.389834-1262642936', '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 23:29:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:29:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:29:48 INFO - Using env: {'DISPLAY': ':0', 23:29:48 INFO - 'HOME': '/home/cltbld', 23:29:48 INFO - 'LANG': 'en_US.UTF-8', 23:29:48 INFO - 'LANGUAGE': 'en_US:en', 23:29:48 INFO - 'LOGNAME': 'cltbld', 23:29:48 INFO - 'MAIL': '/var/mail/cltbld', 23:29:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:48 INFO - 'MOZ_NO_REMOTE': '1', 23:29:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:29:48 INFO - 'NO_EM_RESTART': '1', 23:29:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:29:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:29:48 INFO - 'PWD': '/builds/slave/test', 23:29:48 INFO - 'SHELL': '/bin/bash', 23:29:48 INFO - 'SHLVL': '1', 23:29:48 INFO - 'TERM': 'linux', 23:29:48 INFO - 'TMOUT': '86400', 23:29:48 INFO - 'USER': 'cltbld', 23:29:48 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1507177148.389834-1262642936', 23:29:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:48 INFO - '_': '/tools/buildbot/bin/python'} 23:29:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:29:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:29:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:29:49 INFO - Installing collected packages: mozsystemmonitor 23:29:49 INFO - Running setup.py install for mozsystemmonitor 23:29:49 INFO - Successfully installed mozsystemmonitor 23:29:49 INFO - Cleaning up... 23:29:50 INFO - Return code: 0 23:29:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:29:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:29:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:29:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1379a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137d090>, '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 0x137dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1377f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1507177148.389834-1262642936', '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 23:29:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 23:29:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 23:29:50 INFO - Using env: {'DISPLAY': ':0', 23:29:50 INFO - 'HOME': '/home/cltbld', 23:29:50 INFO - 'LANG': 'en_US.UTF-8', 23:29:50 INFO - 'LANGUAGE': 'en_US:en', 23:29:50 INFO - 'LOGNAME': 'cltbld', 23:29:50 INFO - 'MAIL': '/var/mail/cltbld', 23:29:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:50 INFO - 'MOZ_NO_REMOTE': '1', 23:29:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:29:50 INFO - 'NO_EM_RESTART': '1', 23:29:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:29:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:29:50 INFO - 'PWD': '/builds/slave/test', 23:29:50 INFO - 'SHELL': '/bin/bash', 23:29:50 INFO - 'SHLVL': '1', 23:29:50 INFO - 'TERM': 'linux', 23:29:50 INFO - 'TMOUT': '86400', 23:29:50 INFO - 'USER': 'cltbld', 23:29:50 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1507177148.389834-1262642936', 23:29:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:50 INFO - '_': '/tools/buildbot/bin/python'} 23:29:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:50 INFO - Downloading/unpacking jsonschema==2.5.1 23:29:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:29:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:52 INFO - Downloading functools32-3.2.3-2.tar.gz 23:29:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:29:52 INFO - warning: no files found matching '*.txt' 23:29:52 INFO - no previously-included directories found matching 'build' 23:29:52 INFO - no previously-included directories found matching 'dist' 23:29:52 INFO - no previously-included directories found matching '.git*' 23:29:52 INFO - Installing collected packages: jsonschema, functools32 23:29:52 INFO - Running setup.py install for functools32 23:29:53 INFO - warning: no files found matching '*.txt' 23:29:53 INFO - no previously-included directories found matching 'build' 23:29:53 INFO - no previously-included directories found matching 'dist' 23:29:53 INFO - no previously-included directories found matching '.git*' 23:29:53 INFO - Successfully installed jsonschema functools32 23:29:53 INFO - Cleaning up... 23:29:53 INFO - Return code: 0 23:29:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:29:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:29:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:29:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:53 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 0x100e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1379a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137d090>, '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 0x137dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1377f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1507177148.389834-1262642936', '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 23:29:53 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 23:29:53 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 23:29:53 INFO - Using env: {'DISPLAY': ':0', 23:29:53 INFO - 'HOME': '/home/cltbld', 23:29:53 INFO - 'LANG': 'en_US.UTF-8', 23:29:53 INFO - 'LANGUAGE': 'en_US:en', 23:29:53 INFO - 'LOGNAME': 'cltbld', 23:29:53 INFO - 'MAIL': '/var/mail/cltbld', 23:29:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:53 INFO - 'MOZ_NO_REMOTE': '1', 23:29:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:29:53 INFO - 'NO_EM_RESTART': '1', 23:29:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:29:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:29:53 INFO - 'PWD': '/builds/slave/test', 23:29:53 INFO - 'SHELL': '/bin/bash', 23:29:53 INFO - 'SHLVL': '1', 23:29:53 INFO - 'TERM': 'linux', 23:29:53 INFO - 'TMOUT': '86400', 23:29:53 INFO - 'USER': 'cltbld', 23:29:53 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1507177148.389834-1262642936', 23:29:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:53 INFO - '_': '/tools/buildbot/bin/python'} 23:29:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:29:53 INFO - Cleaning up... 23:29:53 INFO - Return code: 0 23:29:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:29:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:29:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:29:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:53 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 0x100e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1379a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137d090>, '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 0x137dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1377f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1507177148.389834-1262642936', '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 23:29:53 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 23:29:53 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 23:29:53 INFO - Using env: {'DISPLAY': ':0', 23:29:53 INFO - 'HOME': '/home/cltbld', 23:29:53 INFO - 'LANG': 'en_US.UTF-8', 23:29:53 INFO - 'LANGUAGE': 'en_US:en', 23:29:53 INFO - 'LOGNAME': 'cltbld', 23:29:53 INFO - 'MAIL': '/var/mail/cltbld', 23:29:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:53 INFO - 'MOZ_NO_REMOTE': '1', 23:29:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:29:53 INFO - 'NO_EM_RESTART': '1', 23:29:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:29:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:29:53 INFO - 'PWD': '/builds/slave/test', 23:29:53 INFO - 'SHELL': '/bin/bash', 23:29:53 INFO - 'SHLVL': '1', 23:29:53 INFO - 'TERM': 'linux', 23:29:53 INFO - 'TMOUT': '86400', 23:29:53 INFO - 'USER': 'cltbld', 23:29:53 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1507177148.389834-1262642936', 23:29:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:53 INFO - '_': '/tools/buildbot/bin/python'} 23:29:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:53 INFO - Downloading/unpacking blobuploader==1.2.4 23:29:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:54 INFO - Downloading blobuploader-1.2.4.tar.gz 23:29:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:29:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:29:54 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 23:29:54 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 23:29:54 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 23:29:54 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 23:29:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:29:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:29:55 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 23:29:55 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 23:29:55 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 23:29:55 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 23:29:55 INFO - Downloading docopt-0.6.1.tar.gz 23:29:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:29:55 INFO - Installing collected packages: blobuploader, requests, docopt 23:29:55 INFO - Running setup.py install for blobuploader 23:29:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:29:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:29:55 INFO - Running setup.py install for requests 23:29:55 INFO - Running setup.py install for docopt 23:29:55 INFO - Successfully installed blobuploader requests docopt 23:29:55 INFO - Cleaning up... 23:29:55 INFO - Return code: 0 23:29:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:29:55 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')]} 23:29:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29:55 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')]} 23:29:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:55 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 0x100e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1379a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137d090>, '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 0x137dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1377f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1507177148.389834-1262642936', '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 23:29:55 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 23:29:55 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 23:29:55 INFO - Using env: {'DISPLAY': ':0', 23:29:55 INFO - 'HOME': '/home/cltbld', 23:29:55 INFO - 'LANG': 'en_US.UTF-8', 23:29:55 INFO - 'LANGUAGE': 'en_US:en', 23:29:55 INFO - 'LOGNAME': 'cltbld', 23:29:55 INFO - 'MAIL': '/var/mail/cltbld', 23:29:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:55 INFO - 'MOZ_NO_REMOTE': '1', 23:29:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:29:55 INFO - 'NO_EM_RESTART': '1', 23:29:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:29:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:29:55 INFO - 'PWD': '/builds/slave/test', 23:29:55 INFO - 'SHELL': '/bin/bash', 23:29:55 INFO - 'SHLVL': '1', 23:29:55 INFO - 'TERM': 'linux', 23:29:55 INFO - 'TMOUT': '86400', 23:29:55 INFO - 'USER': 'cltbld', 23:29:55 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1507177148.389834-1262642936', 23:29:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:55 INFO - '_': '/tools/buildbot/bin/python'} 23:29:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:29:56 INFO - Running setup.py (path:/tmp/pip-ZT5akU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:29:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:29:56 INFO - Running setup.py (path:/tmp/pip-gz1Ulj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:29:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:29:56 INFO - Running setup.py (path:/tmp/pip-baqfjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:29:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:29:56 INFO - Running setup.py (path:/tmp/pip-30SBYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:29:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:29:56 INFO - Running setup.py (path:/tmp/pip-dqByeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:29:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:29:56 INFO - Running setup.py (path:/tmp/pip-gFODqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:29:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:29:56 INFO - Running setup.py (path:/tmp/pip-NAdnvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:29:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:29:56 INFO - Running setup.py (path:/tmp/pip-eXun2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:29:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:29:56 INFO - Running setup.py (path:/tmp/pip-a31WBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:29:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:29:56 INFO - Running setup.py (path:/tmp/pip-3doOJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:29:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:29:56 INFO - Running setup.py (path:/tmp/pip-shL3zP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:29:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:29:56 INFO - Running setup.py (path:/tmp/pip-SVSpTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:29:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:29:56 INFO - Running setup.py (path:/tmp/pip-vm7JsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:29:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:29:56 INFO - Running setup.py (path:/tmp/pip-eRYCe_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:29:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:29:57 INFO - Running setup.py (path:/tmp/pip-rNV0SH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:29:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:29:57 INFO - Running setup.py (path:/tmp/pip-gybMmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:29:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:29:57 INFO - Running setup.py (path:/tmp/pip-fafjf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:29:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:29:57 INFO - Running setup.py install for manifestparser 23:29:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:29:57 INFO - Running setup.py install for mozcrash 23:29:57 INFO - Running setup.py install for mozdebug 23:29:57 INFO - Running setup.py install for mozdevice 23:29:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:29:57 INFO - Running setup.py install for mozfile 23:29:57 INFO - Running setup.py install for mozhttpd 23:29:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:29:57 INFO - Running setup.py install for mozinfo 23:29:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:29:57 INFO - Running setup.py install for mozInstall 23:29:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:29:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:29:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:29:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:29:58 INFO - Running setup.py install for mozleak 23:29:58 INFO - Running setup.py install for mozlog 23:29:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:29:58 INFO - Running setup.py install for moznetwork 23:29:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:29:58 INFO - Running setup.py install for mozprocess 23:29:58 INFO - Running setup.py install for mozprofile 23:29:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:29:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:29:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:29:58 INFO - Running setup.py install for mozrunner 23:29:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:29:58 INFO - Running setup.py install for mozscreenshot 23:29:58 INFO - Running setup.py install for moztest 23:29:58 INFO - Running setup.py install for mozversion 23:29:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:29:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:29:58 INFO - Cleaning up... 23:29:58 INFO - Return code: 0 23:29:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:29:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:29:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:29:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:59 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 0x100e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1379a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137d090>, '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 0x137dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1377f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1507177148.389834-1262642936', '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 23:29:59 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 23:29:59 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 23:29:59 INFO - Using env: {'DISPLAY': ':0', 23:29:59 INFO - 'HOME': '/home/cltbld', 23:29:59 INFO - 'LANG': 'en_US.UTF-8', 23:29:59 INFO - 'LANGUAGE': 'en_US:en', 23:29:59 INFO - 'LOGNAME': 'cltbld', 23:29:59 INFO - 'MAIL': '/var/mail/cltbld', 23:29:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:59 INFO - 'MOZ_NO_REMOTE': '1', 23:29:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:29:59 INFO - 'NO_EM_RESTART': '1', 23:29:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:29:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:29:59 INFO - 'PWD': '/builds/slave/test', 23:29:59 INFO - 'SHELL': '/bin/bash', 23:29:59 INFO - 'SHLVL': '1', 23:29:59 INFO - 'TERM': 'linux', 23:29:59 INFO - 'TMOUT': '86400', 23:29:59 INFO - 'USER': 'cltbld', 23:29:59 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1507177148.389834-1262642936', 23:29:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:59 INFO - '_': '/tools/buildbot/bin/python'} 23:29:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:29:59 INFO - Running setup.py (path:/tmp/pip-MJzTwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:29:59 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)) 23:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:29:59 INFO - Running setup.py (path:/tmp/pip-eKDJLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:29:59 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)) 23:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:29:59 INFO - Running setup.py (path:/tmp/pip-ZbUIqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:29:59 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)) 23:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:29:59 INFO - Running setup.py (path:/tmp/pip-8fSSEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:29:59 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)) 23:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:29:59 INFO - Running setup.py (path:/tmp/pip-cR4zXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:29:59 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)) 23:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:29:59 INFO - Running setup.py (path:/tmp/pip-OTj0hB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:29:59 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)) 23:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:29:59 INFO - Running setup.py (path:/tmp/pip-GZ7aGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:29:59 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)) 23:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:29:59 INFO - Running setup.py (path:/tmp/pip-dJyFm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:29:59 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)) 23:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:29:59 INFO - Running setup.py (path:/tmp/pip-oXcvw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:29:59 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)) 23:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:29:59 INFO - Running setup.py (path:/tmp/pip-bFWHGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:29:59 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)) 23:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:29:59 INFO - Running setup.py (path:/tmp/pip-7lGGfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:29:59 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)) 23:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:30:00 INFO - Running setup.py (path:/tmp/pip-tfXN3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:30:00 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)) 23:30:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:30:00 INFO - Running setup.py (path:/tmp/pip-zMiQGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:30:00 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)) 23:30:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:30:00 INFO - Running setup.py (path:/tmp/pip-34Yzy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:30:00 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)) 23:30:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:30:00 INFO - Running setup.py (path:/tmp/pip-E0KD_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:30:00 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)) 23:30:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:30:00 INFO - Running setup.py (path:/tmp/pip-3YSpPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:30:00 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)) 23:30:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:30:00 INFO - Running setup.py (path:/tmp/pip-h7jTLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:30:00 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)) 23:30:00 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)) 23:30:00 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)) 23:30:00 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)) 23:30:00 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)) 23:30:00 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)) 23:30:00 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)) 23:30:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:30:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:30:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:30:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:30:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:30:01 INFO - Downloading blessings-1.6.tar.gz 23:30:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:30:01 INFO - Installing collected packages: blessings 23:30:01 INFO - Running setup.py install for blessings 23:30:01 INFO - Successfully installed blessings 23:30:01 INFO - Cleaning up... 23:30:01 INFO - Return code: 0 23:30:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:30:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:30:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:30:02 INFO - Reading from file tmpfile_stdout 23:30:02 INFO - Current package versions: 23:30:02 INFO - argparse == 1.2.1 23:30:02 INFO - blessings == 1.6 23:30:02 INFO - blobuploader == 1.2.4 23:30:02 INFO - docopt == 0.6.1 23:30:02 INFO - functools32 == 3.2.3-2 23:30:02 INFO - jsonschema == 2.5.1 23:30:02 INFO - manifestparser == 1.1 23:30:02 INFO - mozInstall == 1.13 23:30:02 INFO - mozcrash == 1.0 23:30:02 INFO - mozdebug == 0.1 23:30:02 INFO - mozdevice == 0.51 23:30:02 INFO - mozfile == 1.2 23:30:02 INFO - mozhttpd == 0.7 23:30:02 INFO - mozinfo == 0.10 23:30:02 INFO - mozleak == 0.1 23:30:02 INFO - mozlog == 3.5 23:30:02 INFO - moznetwork == 0.27 23:30:02 INFO - mozprocess == 0.25 23:30:02 INFO - mozprofile == 0.28 23:30:02 INFO - mozrunner == 6.13 23:30:02 INFO - mozscreenshot == 0.1 23:30:02 INFO - mozsystemmonitor == 0.3 23:30:02 INFO - moztest == 0.8 23:30:02 INFO - mozversion == 1.4 23:30:02 INFO - psutil == 3.1.1 23:30:02 INFO - requests == 1.2.3 23:30:02 INFO - wsgiref == 0.1.2 23:30:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:30:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:30:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:30:02 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 0x100e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1379a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137d090>, '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 0x137dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1377f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1507177148.389834-1262642936', '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 23:30:02 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 23:30:02 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 23:30:02 INFO - Using env: {'DISPLAY': ':0', 23:30:02 INFO - 'HOME': '/home/cltbld', 23:30:02 INFO - 'LANG': 'en_US.UTF-8', 23:30:02 INFO - 'LANGUAGE': 'en_US:en', 23:30:02 INFO - 'LOGNAME': 'cltbld', 23:30:02 INFO - 'MAIL': '/var/mail/cltbld', 23:30:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:02 INFO - 'MOZ_NO_REMOTE': '1', 23:30:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:30:02 INFO - 'NO_EM_RESTART': '1', 23:30:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:30:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:30:02 INFO - 'PWD': '/builds/slave/test', 23:30:02 INFO - 'SHELL': '/bin/bash', 23:30:02 INFO - 'SHLVL': '1', 23:30:02 INFO - 'TERM': 'linux', 23:30:02 INFO - 'TMOUT': '86400', 23:30:02 INFO - 'USER': 'cltbld', 23:30:02 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1507177148.389834-1262642936', 23:30:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:02 INFO - '_': '/tools/buildbot/bin/python'} 23:30:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:30:02 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)) 23:30:02 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)) 23:30:02 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)) 23:30:02 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)) 23:30:02 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)) 23:30:02 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)) 23:30:02 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)) 23:30:02 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)) 23:30:02 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)) 23:30:02 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 23:30:02 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 23:30:02 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 23:30:02 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 23:30:02 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 23:30:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 23:30:03 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)) 23:30:03 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)) 23:30:03 INFO - Installing collected packages: simplejson 23:30:03 INFO - Running setup.py install for simplejson 23:30:03 INFO - building 'simplejson._speedups' extension 23:30:03 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 23:30:04 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 23:30:04 INFO - Successfully installed simplejson 23:30:04 INFO - Cleaning up... 23:30:04 INFO - Return code: 0 23:30:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:30:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:30:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:30:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1379a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137d090>, '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 0x137dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1377f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1507177148.389834-1262642936', '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 23:30:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:30:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:30:04 INFO - Using env: {'DISPLAY': ':0', 23:30:04 INFO - 'HOME': '/home/cltbld', 23:30:04 INFO - 'LANG': 'en_US.UTF-8', 23:30:04 INFO - 'LANGUAGE': 'en_US:en', 23:30:04 INFO - 'LOGNAME': 'cltbld', 23:30:04 INFO - 'MAIL': '/var/mail/cltbld', 23:30:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:04 INFO - 'MOZ_NO_REMOTE': '1', 23:30:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:30:04 INFO - 'NO_EM_RESTART': '1', 23:30:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:30:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:30:04 INFO - 'PWD': '/builds/slave/test', 23:30:04 INFO - 'SHELL': '/bin/bash', 23:30:04 INFO - 'SHLVL': '1', 23:30:04 INFO - 'TERM': 'linux', 23:30:04 INFO - 'TMOUT': '86400', 23:30:04 INFO - 'USER': 'cltbld', 23:30:04 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1507177148.389834-1262642936', 23:30:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:04 INFO - '_': '/tools/buildbot/bin/python'} 23:30:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:30:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:30:04 INFO - Cleaning up... 23:30:04 INFO - Return code: 0 23:30:04 INFO - Running post-action listener: _resource_record_post_action 23:30:04 INFO - Running post-action listener: _start_resource_monitoring 23:30:04 INFO - Starting resource monitoring. 23:30:04 INFO - [mozharness: 2017-10-05 06:30:04.779671Z] Finished create-virtualenv step (success) 23:30:04 INFO - [mozharness: 2017-10-05 06:30:04.780180Z] Running install step. 23:30:04 INFO - Running pre-action listener: _resource_record_pre_action 23:30:04 INFO - Running main action method: install 23:30:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:30:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:30:05 INFO - Reading from file tmpfile_stdout 23:30:05 INFO - Detecting whether we're running mozinstall >=1.0... 23:30:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:30:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:30:05 INFO - Reading from file tmpfile_stdout 23:30:05 INFO - Output received: 23:30:05 INFO - Usage: mozinstall [options] installer 23:30:05 INFO - Options: 23:30:05 INFO - -h, --help show this help message and exit 23:30:05 INFO - -d DEST, --destination=DEST 23:30:05 INFO - Directory to install application into. [default: 23:30:05 INFO - "/builds/slave/test"] 23:30:05 INFO - --app=APP Application being installed. [default: firefox] 23:30:05 INFO - mkdir: /builds/slave/test/build/application 23:30:05 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'] 23:30:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 23:30:20 INFO - Reading from file tmpfile_stdout 23:30:20 INFO - Output received: 23:30:20 INFO - /builds/slave/test/build/application/firefox/firefox 23:30:20 INFO - Running post-action listener: _resource_record_post_action 23:30:20 INFO - [mozharness: 2017-10-05 06:30:20.056123Z] Finished install step (success) 23:30:20 INFO - [mozharness: 2017-10-05 06:30:20.056371Z] Running setup-mitmproxy step. 23:30:20 INFO - Running pre-action listener: _resource_record_pre_action 23:30:20 INFO - Running main action method: setup_mitmproxy 23:30:20 INFO - Skipping: mitmproxy is not required 23:30:20 INFO - Running post-action listener: _resource_record_post_action 23:30:20 INFO - [mozharness: 2017-10-05 06:30:20.057535Z] Finished setup-mitmproxy step (success) 23:30:20 INFO - [mozharness: 2017-10-05 06:30:20.057755Z] Running run-tests step. 23:30:20 INFO - Running pre-action listener: _resource_record_pre_action 23:30:20 INFO - Running pre-action listener: _set_gcov_prefix 23:30:20 INFO - Running main action method: run_tests 23:30:20 WARNING - Try message not found. 23:30:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:30:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:30:20 INFO - Python 2.7.3 23:30:20 INFO - Return code: 0 23:30:20 INFO - grabbing minidump binary from tooltool 23:30:20 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')]} 23:30:20 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 0x137d090>, '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 0x137dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1377f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:30:20 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 23:30:20 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 23:30:20 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 23:30:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:30:20 INFO - Return code: 0 23:30:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:30:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:30:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:30:20 INFO - ENV: RUST_BACKTRACE is now full 23:30:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:30:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:30:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VzvV0R-ATLmcfM0_Ua3a-w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 23:30:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VzvV0R-ATLmcfM0_Ua3a-w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 23:30:20 INFO - Using env: {'DISPLAY': ':0', 23:30:20 INFO - 'HOME': '/home/cltbld', 23:30:20 INFO - 'LANG': 'en_US.UTF-8', 23:30:20 INFO - 'LANGUAGE': 'en_US:en', 23:30:20 INFO - 'LOGNAME': 'cltbld', 23:30:20 INFO - 'MAIL': '/var/mail/cltbld', 23:30:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:30:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:30:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:20 INFO - 'MOZ_NO_REMOTE': '1', 23:30:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:30:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:30:20 INFO - 'NO_EM_RESTART': '1', 23:30:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:30:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:30:20 INFO - 'PWD': '/builds/slave/test', 23:30:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:30:20 INFO - 'RUST_BACKTRACE': 'full', 23:30:20 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 23:30:20 INFO - 'SHELL': '/bin/bash', 23:30:20 INFO - 'SHLVL': '1', 23:30:20 INFO - 'TERM': 'linux', 23:30:20 INFO - 'TMOUT': '86400', 23:30:20 INFO - 'USER': 'cltbld', 23:30:20 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1507177148.389834-1262642936', 23:30:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:20 INFO - '_': '/tools/buildbot/bin/python'} 23:30:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VzvV0R-ATLmcfM0_Ua3a-w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 23:30:20 INFO - mozversion application_buildid: 20171005051325 23:30:20 INFO - mozversion application_changeset: 3a3dd3b7cfc609f10c603073cd07949a5b7b9472 23:30:20 INFO - mozversion application_display_name: Firefox 23:30:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:30:20 INFO - mozversion application_name: Firefox 23:30:20 INFO - mozversion application_remotingname: firefox 23:30:20 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 23:30:20 INFO - mozversion application_vendor: Mozilla 23:30:20 INFO - mozversion application_version: 57.0 23:30:20 INFO - mozversion platform_buildid: 20171005051325 23:30:20 INFO - mozversion platform_changeset: 3a3dd3b7cfc609f10c603073cd07949a5b7b9472 23:30:20 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 23:30:20 INFO - mozversion platform_version: 57.0 23:30:20 INFO - using testdate: 1507185020 23:30:20 INFO - actual date: 1507185020 23:30:20 INFO - starting webserver on 'localhost:51987' 23:30:20 INFO - SUITE-START | Running 2 tests 23:30:20 INFO - TEST-START | dromaeo_css 23:30:20 INFO - Initialising browser for dromaeo_css test... 23:30:20 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51987/getInfo.html -profile /tmp/tmpuCpE17/profile 23:30:20 INFO - TEST-INFO | started process 389 (/builds/slave/test/build/application/firefox/firefox http://localhost:51987/getInfo.html) 23:30:25 INFO - TEST-INFO | 389: exit 0 23:30:25 INFO - Browser initialized. 23:30:25 INFO - Running cycle 1/1 for dromaeo_css test... 23:30:25 INFO - Using env: {'DISPLAY': ':0', 23:30:25 INFO - 'HOME': '/home/cltbld', 23:30:25 INFO - 'JSGC_DISABLE_POISONING': '1', 23:30:25 INFO - 'LANG': 'en_US.UTF-8', 23:30:25 INFO - 'LANGUAGE': 'en_US:en', 23:30:25 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 23:30:25 INFO - 'LOGNAME': 'cltbld', 23:30:25 INFO - 'MAIL': '/var/mail/cltbld', 23:30:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:30:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:30:25 INFO - 'MOZ_CRASHREPORTER': '1', 23:30:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:25 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 23:30:25 INFO - 'MOZ_NO_REMOTE': '1', 23:30:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:30:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:30:25 INFO - 'NO_EM_RESTART': '1', 23:30:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:30:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:30:25 INFO - 'PWD': '/builds/slave/test', 23:30:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:30:25 INFO - 'RUST_BACKTRACE': 'full', 23:30:25 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 23:30:25 INFO - 'SHELL': '/bin/bash', 23:30:25 INFO - 'SHLVL': '1', 23:30:25 INFO - 'TERM': 'linux', 23:30:25 INFO - 'TMOUT': '86400', 23:30:25 INFO - 'USER': 'cltbld', 23:30:25 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1507177148.389834-1262642936', 23:30:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:25 INFO - '_': '/tools/buildbot/bin/python'} 23:30:25 INFO - TEST-INFO | started process 622 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuCpE17/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 23:30:25 INFO - PID 622 | 23:30:25 INFO - PID 622 | (/builds/slave/test/build/application/firefox/firefox:671): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 23:30:25 INFO - PID 622 | 23:30:36 INFO - PID 622 | RSS: Main: 143548416 23:30:36 INFO - PID 622 | 23:33:33 INFO - PID 622 | Cycle 1(1): loaded http://localhost:51987/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51987/tests/dromaeo/cssquery-ext.html) 23:33:34 INFO - PID 622 | RSS: Main: 146673664 23:33:34 INFO - PID 622 | 23:36:35 INFO - PID 622 | Cycle 1(1): loaded http://localhost:51987/tests/dromaeo/cssquery-ext.html (next: http://localhost:51987/tests/dromaeo/cssquery-jquery.html) 23:36:36 INFO - PID 622 | RSS: Main: 145481728 23:36:36 INFO - PID 622 | 23:39:38 INFO - PID 622 | Cycle 1(1): loaded http://localhost:51987/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51987/tests/dromaeo/cssquery-mootools.html) 23:39:38 INFO - PID 622 | RSS: Main: 146489344 23:39:38 INFO - PID 622 | 23:42:40 INFO - PID 622 | Cycle 1(1): loaded http://localhost:51987/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51987/tests/dromaeo/cssquery-prototype.html) 23:42:40 INFO - PID 622 | RSS: Main: 146366464 23:42:40 INFO - PID 622 | 23:45:43 INFO - PID 622 | Cycle 1(1): loaded http://localhost:51987/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51987/tests/dromaeo/cssquery-yui.html) 23:45:44 INFO - PID 622 | RSS: Main: 147378176 23:45:44 INFO - PID 622 | 23:48:45 INFO - PID 622 | Cycle 1(1): loaded http://localhost:51987/tests/dromaeo/cssquery-yui.html (next: http://localhost:51987/tests/dromaeo/cssquery-dojo.html) 23:48:45 INFO - PID 622 | RSS: Main: 150020096 23:48:45 INFO - PID 622 | 23:48:45 INFO - PID 622 | __start_tp_report 23:48:45 INFO - PID 622 | _x_x_mozilla_page_load 23:48:45 INFO - PID 622 | _x_x_mozilla_page_load_details 23:48:45 INFO - PID 622 | |i|pagename|runs| 23:48:45 INFO - PID 622 | |0;dojo.html;3969.86105486308;3970.4242884781706;3973.1060511384944;3980.2835489611866;3981.422693709414;6409.935900641004;6429.517786166033;6446;6484.773032943848;6493;6364.8727025459575;6456.322086180942;6463.159789227406;6514.283428822838;6518.934810651892;5790.102534107199;5792.044312688412;5891.646501209942;5901.822945311647;5933;5841.5326773858205;5844.298684157907;5849.707514624273;5880.470757631812;5988.401159884021;5884.411558844125;5892.9705351473185;5900.822975310747;5920.555958303123;5920.703964801764;5934.554908381867;5953.315368732608;6002.339742628307;6007.189029481052;6014.458698717114;5843.824685259449;5853.268341457318;5903.940960590382;5983.910241346383;6005.519558435315;6335.3981371769605;6368.522360822957;6383.234011918553;6393.360663933569;6472.773452929125;7051.612161331124;7080.044194033791;7089.397401220903;7102.715891364339;7115.217326094125;7005.054317667152;7081.044059052014;7161.462890283249;7164.856702865965;7180.8922866157045;6379.138816259792;6469.77355792545;6485.416312531895;6527.836804079889;6595.175603049619;7211.639418029183;7218.386437152901;7219.927800722031;7229.566226026455;7237.855242895218;6881.10545629075;6914.204866440323;6917.239103698589;6940.618265995317;6943.201531823804;7099.07711997437;7174.892376614355;7179.856402871913;7193.064901562763;7194.568325900463;6966.756163534252;6988.056612357368;6988.091548098715;7021.648917554204;7074.646267686698;6880.724771009103;6985.545939513915;6995.335443132894;7055.329743674342;7058.976448414951;5162.251473536317;5165.560927321219;5177.844664660066;5185.948140518622;5200.63595548308;4659.627229821606;4723.338732577442;4744.857654270378;4764.499727528629;4770.976145119322;6570.671466426659;6611;6620.5034622402545;6653.500987425866;6720.428763555153;7087.716491340392;7096.467764917548;7122.145342558926;7122.928770712227;7138.214796372395;6528.869422611521;6538.476921846241;6608.140941677551;6620.5034622402545;6622.701978410983;5821.85690857718;5829.242198514166;5863.296404431496;5885.941140588625;5890.6171098879295;7268.38218751412;7335.193128755833;7393.889091663629;7439.739609113763;7450.403967682572;7033.542819716702;7043.542169758949;7125.643717814192;7132.0015197872335;7151.106111736033;7288.3076107769675;7331.083614548182;7338.743143989935;7351.963240183765;7421.666025028994;6896.034555162181;6898.403699836014;6922.342377474132;6938.236793952762;6938.930610693828;7043.190033146254;7091.1490621125795;7149.678264478215;7150.749723759852;7163.892541611985;6799.11611490503;6801.1158549388265;6882.965585172042;6893.310668933267;6894.586324820527;6711.295313992156;6715.1941766988275;6728.024436456784;6785.491088168308;6806.727730890709;6593.044008618627;6741.764038258638;6769.763058292936;6801.489888258499;6829.52193346461;6751;6867.278935711878;6920.342567456084;6963.7562685305775;6964.338387853146;6548.377904099293;6573.934260657332;6589.80230593083;6605.768798092044;6671.733130674913 23:48:45 INFO - PID 622 | |1;ext.html;981.5386768218939;985.4678473624248;1009.2380252909053;1021.4688362051734;1046.5761366646507;44670.32994505085;44903.55096449039;45413.772931135296;45423.77288113563;45480.54519454809;42082;42403.78798106013;42865.571344286625;42887.785561072225;42905.35641965365;8032.999999999985;8127.390445716565;8155.225253600898;8177;8190.221928916773;7983.880241796378;8002.719904803333;8055.879161812578;8076.71731489398;8082.313003394718;8700.521471319074;8852.513111778882;8862.158094980967;8864.246539044158;8869.246114080312;8701.651933922636;8741.868871966926;8781.912180878173;8799.692010779656;8811;8581.871271930926;8661.523616201106;8668.869966950439;8672.56637168139;8681.609327580274;41145.79427102875;41365;41453.792731036454;41458.37812432786;41505;3807.638274363931;3820.9044773880596;3841.4045822897497;3842.1547259602844;3844.058205739612;33506.83246583776;33530.497042544135;33579.496307555404;33626.83186584051;33630.83184584086;5398.568114550866;5518.558515318765;5555.388907220203;5601.131824567198;5620.606557540974;236876;237608;238758.8062059696;239179;239180;52221.7388913053;52259.47740522622;52352.73823630858;52394.21408678873;52517.47482525202;55863.720681396335;55887.44112558904;55934.44065559374;55936.72031639897;56092.71953640206;17170.570735731457;17472.737908931376;17527.29890804379;17528.12359382026;17538.210780514906;14368.281585920871;14402.495912643008;14405.207713575644;14411.85588144126;14415.927920360331;15443.459478918185;15744;15775.368985240691;15863.920680396755;15917.761233581505;5919;5968.761249550056;6071.423214794588;6099.207103076572;6117.938820611826;1109.1348747976592;1122.6688127002553;1122.8484154639182;1125.5104029747085;1129.5877004893318;26071.739282607312;26311.605325920125;26397.20808375752;26704.59943100855;26784.866075669495;1215.398377802993;1216.051479845704;1233.2970206982113;1239.5041983206609;1240.8697086805937;13587.59237222885;13602.455901764017;13999.16005039701;14159.150450972975;14186.290685465685;281156;296198;301015;302712;302834;60340.698296509116;60490.39509604935;60527.394726052175;60819.695901521096;60934;1506.088816266143;1515.2499512741263;1540.7688846673088;1549.7752825840416;1581.7627355896707;30847.383052339275;30966.380672385974;31053.689463105078;31104;31112.377752444372;42491;42527.787361063;42576.787116064224;42668.14663706771;42725.1454970905;255634;257183;257392;258074;259916;38671.80664096661;38847;38850.22299553936;39058.80470597629;39190.608093918694;48033.27950080681;48361.274580880614;48895.5110448891;49180.508194917595;49291.50708492869;35367;35733.82133089422;35949.46075808813;36095;36900.26199476049;35359.64640353563;35574.64425355713;35608.109797255274;35811.64188358083;35942.460863087595;41186.588134118276;41516.58483415127;41768.791156044026;41808.3728744063;41989;33482;34153.65846341604;34193.14517136992;34442.655573443946;34836.303273934886;25921.351966200997;25940.48119037571;26259.4748105033;26451.735482644926;26536.958775217317 23:48:45 INFO - PID 622 | |2;jquery.html;619.6777675608681;627.6140173793118;630.8422894276431;648.6918713611035;660.1253339325393;23483;24615.384615384624;24872;24901.875490622544;26024.089156879512;27065.188044358652;27970.881164753384;27991.440171196617;28002.159935201926;28011.159665210027;7051.365377116059;7073.540219885691;7107.680154393065;7219.8917016244795;7222.313880181375;6607.9008814867575;6927.618980956046;6937.445004399636;6943.6875340609795;6949.374556289933;6834.726610935557;6866.588004719732;6892.931070689304;6894.034835123087;6926.549774264682;6830.8975365369315;6859.451243900501;6877.484188685844;6886.414654754352;6889.621070841102;6402.93597064028;6466.773662921775;6500.4799616030605;6503.739850405978;6511.804645860631;31794.36411271785;32913;33179.17052073693;33349;33369.49945750816;2229.788170123852;2233.050953344822;2233.955320893573;2235.7205349331334;2249.403907964391;20939.26712565068;21138.78861211399;21393.57212855734;21782.237621683165;21810.781892181032;2592.40374713815;2614.045873256267;2618.5024845279336;2624.6325514427995;2626.4090579619624;145466;151658;162572;167676;169024.1548792248;17258.568535786453;17491.737623935653;18060.9096954517;18096.638067238844;18616.348427804962;28436.289092772848;28559.857200713865;28601.141965741062;28635.713642863306;28810.567841482396;11276.210665253517;11282.94358528202;11287.040601548797;11333.320000799979;11381.374024428736;10113.69658910234;10139.746506337253;10246.795064098676;10307.433091180057;10335.379877207391;10403.47982600867;10529.210309226839;10558.630447934285;10770.78458430827;10793.136549076055;2932.310906936868;2992.371601963612;2999.4954213232195;3066.2794243352796;3101.255698632312;1049.4228174503992;1050.805600963809;1061.877884043345;1067.9946600266949;1074.1621535202555;22673.659895101588;22890.42773930665;22955.770442295696;23074.307770766904;23299.53400931972;1127.4306475229957;1133.2690414682484;1141.5490881101919;1142.4230763464398;1143.988560114405;12496;12595.622131336075;12759.043071769654;12791.872081279254;12850.614481565568;566060;566903;571070;609010;609821;132332;132810;133994;134377;134838;1171.9531218751154;1227.1777908801125;1228.993855030737;1255.5668294438588;1274.6813296675832;23580.764192358543;24024.519509610058;24112.638310425005;24269.150579729623;24347.26958191257;63223;64350.35649643443;64558;64810.35189648043;66256;79029.60485197537;79032.60483697544;79164.60417697874;82038;83241.58379208065;17022.2339994703;17413.390531331344;17499.737503937708;17500.387486437914;17504.387346443324;26090;26415.60376594391;26561.734382655926;26802.195934122006;26823.463530728885;21292.254771083557;21536;21650.6752398711;21678.566428671653;21759;18892.527686807938;18911.716324255423;18977;19043.714344285123;19192.904035479733;21911;21996.340109796733;22247.332580022627;22354.66468003014;22438.551228975004;16791.160441978096;16849.66300674004;16918.66162676715;16994.830051699326;17021.48935531936;20942.267020654202;21096.68354974646;21217.575648486636;21397.144114235256;21453.785462145177 23:48:45 INFO - PID 622 | |3;mootools.html;1420.1408148070418;1476.5127507922386;1487.2786698451257;1508.683176532928;1513.8032055832741;17496;18184;18199.636007279845;18206.180721867513;18206.81793182068;17634.559136021573;17672.20475078621;17723.379681711143;17796.64406711865;17814.64370712585;2917.9416411671755;2932.9413411731807;2999.5350720638226;3005;3008.1877892968887;3023.4708925937985;3052;3054.9541756873664;3061.8622162002653;3066.3254084101463;3010.834404107773;3043.923901902459;3057.113437103237;3143.245621050954;3145.543896135059;2838.6451693538306;2847.729465700755;2853.243890369054;2871.6984716604666;2879.539273716206;3023.2744141406124;3036.726694597497;3058.235441139715;3066.708662677042;3072.6466456357357;16920.576985575335;17178;17228.655426891517;17243.3964811231;17271.481855544353;8640.179182977607;8968.955155224246;8970.461772293684;9003.369764116514;9010.098990101003;5870.6477611343025;5873.794417195378;6009.57932944694;6041.184440100574;6131.754729810802;1946.6009468059015;1970.6846904495212;1975.9308424205228;2025.402506260642;2049.405672355015;32739.18152046194;32819.67180328214;32934.176645584055;32982.340353193045;33055.00834974954;7475.401967842559;7571.659275332623;7584;7656.234376562299;7752.26353496417;20334.694979575317;20457;20545;20566;20601.072951717208;8532.616032278562;8847.071057538995;8848.203661670352;8863.556822158866;8867.379283450096;7838.3337416320255;7954.721584744506;7979;7988;8087.272145506932;5924.407559244041;5993.9700301498215;5997.550183736237;6105.114758360013;6319.0837328587095;1517.8102737157856;1558;1574.7874037004858;1582.7151112799577;1610.1788088075166;915.7527467583849;926.5598840550684;946.9526523673788;950.8336041192902;969.96120155193;9046.366754327266;9059.229965452878;9087.636494540277;9111.453312801254;9248.16766491019;843.0599881132493;847.894013248344;848.8217474330336;861.4917198852708;916.5966974531185;5542.91685624716;5950.8809823803285;5986.311574168939;6043.063325184604;6044.24446944132;26651.733482665313;26675.466490670467;26997.460050798873;27213.591796123073;27668.723312766615;26641.86679066592;26706.332341691224;27043.1887043389;27663.723362766515;27696.584551231746;13233;13348.125889294703;13368.6657833553;13459;13483.662908427368;9425.575849086945;9479.857802132836;9493.240540756584;9501.762455938657;9511.57197926081;22349.441263968532;22504.32487025392;22650.43373915665;23276.06895724152;23428.297151085495;23818.642720359556;24002;24079.398015049763;24129.276121716375;24235.63646545268;12321.815172772236;12443.502259909503;12649.430775614936;12651.93674031624;12655.81016284738;15601.375944962074;16252.918735406247;16263.75604365959;16283.430079947146;16334.346626134822;12819.743605127658;13413.66465838362;13527.594172174851;13708.451661933412;13744.793828092786;12649.430775615303;12735.80896286538;12786.232826030468;12886.742265154831;13331.066825322134;11437;11439;11520.769584608428;11598.362090084789;11624.07007439386;8330.75317359639;8387.748367548984;8412.443697915905;8426.536540490331;8480.872786908078;8075.192480751878;8147;8164.8367032657825;8188.959055204686;8207.097219305751 23:48:45 INFO - PID 622 | |4;prototype.html;562.2915126940056;569.7494895164101;577.3043482603463;593.7803012885232;601.1163589523402;6337.904931426032;6390;6432.356764323566;6470.320616335282;6483.902741458882;6317.36826317368;6329.1772069631;6400.967995160029;6422.165118534584;6423.100765892767;5044.016416798726;5105;5117.106670531908;5190.221466779975;5204.141316682742;5101.336826212587;5124.180131179012;5146.9485305146845;5161.200013997836;5164.147915593922;5086.516780905808;5091.694498330094;5099.5068378160895;5117.104506711311;5121.871953201181;5050.318207042057;5050.646454748169;5120.206368012964;5142.30578871855;5149.6910185389;4657.650676199265;4687.20317546018;4689.412599361492;4718.811247550094;4725.314829349725;6159.907601385983;6166.136740856284;6252.155958945529;6269.153664255313;6371.139896114011;5926.2295901532525;5929.436703513159;5959.672218028007;5968.552358573124;5989.520838332966;6715.589726157513;6762.628055456948;6769.255381908036;6772.153480814898;6850.691718872663;4945.579625731817;5169.586433085344;5172.301739265189;5175.560077393426;5223.921641175385;6896.7586134485555;6896.965515172442;7015.89476157858;7087.291270872923;7110.857782844366;5276.709780962084;5348.4594817462175;5349.786008559692;5353.839384818461;5373.570114390839;5365.785368585213;5427.755750991215;5449.809256675997;5472.7263636818;5490.5882058844945;5950.256217972754;5976.85057873548;6019.367966363468;6056.212692350055;6061.484773794277;6818.420434263143;6823.215330236987;6851.109355783816;6851.910167398892;6903.1371078615175;1831.7985021647607;1854.8145185481344;1861.088066847262;1875.2405275863298;1885.8585606079598;1291.922484650924;1320.7584870222151;1346.8518462969066;1347.5351003903638;1356.7354365898555;6289.55973081889;6313.40022697843;6436.935630643728;6444.291127975919;6484.383983521558;6696.59820410777;6810.6254156020905;6820.727170913207;6840.726370945106;6849.1780986281965;6365.713542890581;6448.387403196689;6448.388402696915;6458.160439142881;6503.902441463382;3591.4612808078996;3596.3166998270244;3631.618680038558;3657.4148136298063;3664.04734768962;7182.856342873113;7233.598265535039;7261.600611966287;7274.781756547312;7295.70817167318;6916.273791251947;6991.580505169706;7059.329363710542;7082;7139.821929381697;7050.435965122778;7249.275072492708;7269.818254543678;7283.271672832674;7323.707051717872;6886.24251332343;6903.861922761617;6924.238333783179;6962.895556566555;6995.755148569776;6826.863462730618;6839.443489385591;6850.177978642595;6924.861502770017;6972.442204623517;7152.213256541881;7164.498485105993;7181.511555277952;7222;7261.419086473175;5359.437259087739;5384.784608615611;5385.2460655507475;5386.192071189196;5398.703071330958;6741.561798483083;6856.348646878539;6964.398188416591;7012.333828286304;7042.366187043191;6710.564442801347;6723.848368522222;6729.024291477806;6789.367688286743;6794.912813949942;6727.629980351127;6770.35681610266;6780.1524809398825;6790.151231096113;6806.693698783468;6669.53313268086;6693.899591506229;6697.397234248941;6720.227173875067;6740.865182696417;6659.900101498384;6773;6777.220619628806;6798.742232686969;6819.318068193339;6364.931397295804;6458.12714312844;6555.344465553407;6600.768973085919;6614.8346291343105 23:48:45 INFO - PID 622 | |5;yui.html;997.8503224516321;998.730342807442;1017.2065788684823;1034.5137785240934;1038.94805259737;17493.650126997454;17760.289588416446;17817.37639182629;17847.10764461775;17856.553586160353;18014.81985180148;18290;18309.084545772726;18338.63322733548;18340.81659183408;1045.6706137566662;1047.240750455921;1053.6575612925792;1054.8628678271853;1055.8996895294954;1084.1922767538194;1085.592902661502;1086.7554800169978;1087.40736298717;1091.5851976249055;1054.4464156317956;1126.881677423871;1132.6885106595669;1137.6700756780524;1147.0364893489468;1112.7607564373698;1117.1956191542076;1117.9608713695063;1117.9776404471907;1133.8129208680557;819.778659761867;820.1470470710454;826;826.4380221449472;828.2752591482453;19140.904295478573;20040.599188016156;20120.597588048302;20400.28598999028;20416.693749593767;18264.726029109574;18798.90600547002;18899.62200755977;18905.90547047256;18910.810891891044;18873.96193209373;19105;19179.424617261506;19250.326238581583;19258.903705481524;3917.7453465524936;3920.882373528799;3921.4313924481075;3927.7054220933546;3932.6853851691794;154779;167060.16469917572;167846;168963.99999999878;170981;16626.83373166277;17101.48695539136;17237;17286.827131728773;17291.221895014754;34501.654983449844;34819.30361392758;35303.823480882435;35364.64635353665;35371.82314088465;8378.287845533197;8468.534230617252;8480.872786908201;8484.19400156984;8528.317734581218;4226.260404429274;4241.63946064588;4276.444062271947;4320.330348795942;4331.263685173465;5885.823425297248;5925.200097986803;5975.581709280395;5979.4917432018765;6000.669963151981;1251.2367455851922;1278.2330601639128;1279.4242590833976;1280.0655521469193;1288.1047671868148;734.5262305812721;736.5985537881867;740.326303064209;749.7825630567183;754.0687251244708;11950.223235489666;12285.877141228651;12444.253344799341;13095.738085238241;13195.20828750278;715.0811207598211;717.3794667612477;720.4740539406263;727.2291371146601;728.2535401213798;6069.696515174223;6131.448169664752;6146.754129834757;6310.148130002391;6338.176037115146;148090;148856;149038;149044;150240;131325.34337328444;132698;135671.32164339116;138472.3076384632;138849;120259;120615.39692301658;121776.39111804562;122073;123289.5342093171;11715.707107322045;11868.643940681794;11922.821157682814;11987.400629968291;12061.396930153633;57082.7145864268;57653.71173144107;57847.710761447604;58319.12521312269;58708.41291587029;70716.64641676759;70890;71467.64266178636;71747.28252717406;72618.63690681513;13742.875553846252;14009.859901401263;14241.21673307978;14244.928775356057;14282.500112496013;17061.744073838654;17127.57181070483;17378.39175628847;17394;17444.389446369318;15609.68780624404;15640.687186255984;15703.528894133195;15855.841441585899;15872.920635397211;16526.173691315627;16558.83441165573;16615.916920415322;16730.916345418194;16745.33018679239;16755.07847068374;16813;16852.57868553296;16875.831241687425;16927.15364231808;12790;12846.42191101384;13209.471621135048;13259;13264.137831041338;12884.613461596167;12945.223286602833;13008.414621341873;13081.542146024844;13166.868331316564 23:48:45 INFO - PID 622 | __end_tp_report 23:48:45 INFO - PID 622 | __start_cc_report 23:48:45 INFO - PID 622 | _x_x_mozilla_cycle_collect,248 23:48:45 INFO - PID 622 | __end_cc_report 23:48:45 INFO - PID 622 | __startTimestamp1507186125885__endTimestamp 23:48:45 INFO - PID 622 | 23:48:45 INFO - PID 622 | ------- Summary: start ------- 23:48:45 INFO - PID 622 | Number of tests: 6 23:48:45 INFO - PID 622 | 23:48:45 INFO - PID 622 | [#0] dojo.html Cycles:165 Average:6504.37 Median:6720.43 stddev:762.94 (11.4%) stddev-sans-first:738.91 23:48:45 INFO - PID 622 | Values: 3969.9 3970.4 3973.1 3980.3 3981.4 6409.9 6429.5 6446.0 6484.8 6493.0 6364.9 6456.3 6463.2 6514.3 6518.9 5790.1 5792.0 5891.6 5901.8 5933.0 5841.5 5844.3 5849.7 5880.5 5988.4 5884.4 5893.0 5900.8 5920.6 5920.7 5934.6 5953.3 6002.3 6007.2 6014.5 5843.8 5853.3 5903.9 5983.9 6005.5 6335.4 6368.5 6383.2 6393.4 6472.8 7051.6 7080.0 7089.4 7102.7 7115.2 7005.1 7081.0 7161.5 7164.9 7180.9 6379.1 6469.8 6485.4 6527.8 6595.2 7211.6 7218.4 7219.9 7229.6 7237.9 6881.1 6914.2 6917.2 6940.6 6943.2 7099.1 7174.9 7179.9 7193.1 7194.6 6966.8 6988.1 6988.1 7021.6 7074.6 6880.7 6985.5 6995.3 7055.3 7059.0 5162.3 5165.6 5177.8 5185.9 5200.6 4659.6 4723.3 4744.9 4764.5 4771.0 6570.7 6611.0 6620.5 6653.5 6720.4 7087.7 7096.5 7122.1 7122.9 7138.2 6528.9 6538.5 6608.1 6620.5 6622.7 5821.9 5829.2 5863.3 5885.9 5890.6 7268.4 7335.2 7393.9 7439.7 7450.4 7033.5 7043.5 7125.6 7132.0 7151.1 7288.3 7331.1 7338.7 7352.0 7421.7 6896.0 6898.4 6922.3 6938.2 6938.9 7043.2 7091.1 7149.7 7150.7 7163.9 6799.1 6801.1 6883.0 6893.3 6894.6 6711.3 6715.2 6728.0 6785.5 6806.7 6593.0 6741.8 6769.8 6801.5 6829.5 6751.0 6867.3 6920.3 6963.8 6964.3 6548.4 6573.9 6589.8 6605.8 6671.7 23:48:45 INFO - PID 622 | 23:48:45 INFO - PID 622 | [#1] ext.html Cycles:180 Average:44726.97 Median:3841.78 stddev:69008.03 (1796.3%) stddev-sans-first:69123.44 23:48:45 INFO - PID 622 | Values: 981.5 985.5 1009.2 1021.5 1046.6 44670.3 44903.6 45413.8 45423.8 45480.5 42082.0 42403.8 42865.6 42887.8 42905.4 8033.0 8127.4 8155.2 8177.0 8190.2 7983.9 8002.7 8055.9 8076.7 8082.3 8700.5 8852.5 8862.2 8864.2 8869.2 8701.7 8741.9 8781.9 8799.7 8811.0 8581.9 8661.5 8668.9 8672.6 8681.6 41145.8 41365.0 41453.8 41458.4 41505.0 3807.6 3820.9 3841.4 3842.2 3844.1 33506.8 33530.5 33579.5 33626.8 33630.8 5398.6 5518.6 5555.4 5601.1 5620.6 236876.0 237608.0 238758.8 239179.0 239180.0 52221.7 52259.5 52352.7 52394.2 52517.5 55863.7 55887.4 55934.4 55936.7 56092.7 17170.6 17472.7 17527.3 17528.1 17538.2 14368.3 14402.5 14405.2 14411.9 14415.9 15443.5 15744.0 15775.4 15863.9 15917.8 5919.0 5968.8 6071.4 6099.2 6117.9 1109.1 1122.7 1122.8 1125.5 1129.6 26071.7 26311.6 26397.2 26704.6 26784.9 1215.4 1216.1 1233.3 1239.5 1240.9 13587.6 13602.5 13999.2 14159.2 14186.3 281156.0 296198.0 301015.0 302712.0 302834.0 60340.7 60490.4 60527.4 60819.7 60934.0 1506.1 1515.2 1540.8 1549.8 1581.8 30847.4 30966.4 31053.7 31104.0 31112.4 42491.0 42527.8 42576.8 42668.1 42725.1 255634.0 257183.0 257392.0 258074.0 259916.0 38671.8 38847.0 38850.2 39058.8 39190.6 48033.3 48361.3 48895.5 49180.5 49291.5 35367.0 35733.8 35949.5 36095.0 36900.3 35359.6 35574.6 35608.1 35811.6 35942.5 41186.6 41516.6 41768.8 41808.4 41989.0 33482.0 34153.7 34193.1 34442.7 34836.3 25921.4 25940.5 26259.5 26451.7 26537.0 23:48:45 INFO - PID 622 | 23:48:45 INFO - PID 622 | [#2] jquery.html Cycles:180 Average:40528.01 Median:22782.04 stddev:98310.04 (431.5%) stddev-sans-first:98540.16 23:48:45 INFO - PID 622 | Values: 619.7 627.6 630.8 648.7 660.1 23483.0 24615.4 24872.0 24901.9 26024.1 27065.2 27970.9 27991.4 28002.2 28011.2 7051.4 7073.5 7107.7 7219.9 7222.3 6607.9 6927.6 6937.4 6943.7 6949.4 6834.7 6866.6 6892.9 6894.0 6926.5 6830.9 6859.5 6877.5 6886.4 6889.6 6402.9 6466.8 6500.5 6503.7 6511.8 31794.4 32913.0 33179.2 33349.0 33369.5 2229.8 2233.1 2234.0 2235.7 2249.4 20939.3 21138.8 21393.6 21782.2 21810.8 2592.4 2614.0 2618.5 2624.6 2626.4 145466.0 151658.0 162572.0 167676.0 169024.2 17258.6 17491.7 18060.9 18096.6 18616.3 28436.3 28559.9 28601.1 28635.7 28810.6 11276.2 11282.9 11287.0 11333.3 11381.4 10113.7 10139.7 10246.8 10307.4 10335.4 10403.5 10529.2 10558.6 10770.8 10793.1 2932.3 2992.4 2999.5 3066.3 3101.3 1049.4 1050.8 1061.9 1068.0 1074.2 22673.7 22890.4 22955.8 23074.3 23299.5 1127.4 1133.3 1141.5 1142.4 1144.0 12496.0 12595.6 12759.0 12791.9 12850.6 566060.0 566903.0 571070.0 609010.0 609821.0 132332.0 132810.0 133994.0 134377.0 134838.0 1172.0 1227.2 1229.0 1255.6 1274.7 23580.8 24024.5 24112.6 24269.2 24347.3 63223.0 64350.4 64558.0 64810.4 66256.0 79029.6 79032.6 79164.6 82038.0 83241.6 17022.2 17413.4 17499.7 17500.4 17504.4 26090.0 26415.6 26561.7 26802.2 26823.5 21292.3 21536.0 21650.7 21678.6 21759.0 18892.5 18911.7 18977.0 19043.7 19192.9 21911.0 21996.3 22247.3 22354.7 22438.6 16791.2 16849.7 16918.7 16994.8 17021.5 20942.3 21096.7 21217.6 21397.1 21453.8 23:48:45 INFO - PID 622 | 23:48:45 INFO - PID 622 | [#3] mootools.html Cycles:180 Average:10989.96 Median:2925.44 stddev:8336.07 (285.0%) stddev-sans-first:8328.45 23:48:45 INFO - PID 622 | Values: 1420.1 1476.5 1487.3 1508.7 1513.8 17496.0 18184.0 18199.6 18206.2 18206.8 17634.6 17672.2 17723.4 17796.6 17814.6 2917.9 2932.9 2999.5 3005.0 3008.2 3023.5 3052.0 3055.0 3061.9 3066.3 3010.8 3043.9 3057.1 3143.2 3145.5 2838.6 2847.7 2853.2 2871.7 2879.5 3023.3 3036.7 3058.2 3066.7 3072.6 16920.6 17178.0 17228.7 17243.4 17271.5 8640.2 8969.0 8970.5 9003.4 9010.1 5870.6 5873.8 6009.6 6041.2 6131.8 1946.6 1970.7 1975.9 2025.4 2049.4 32739.2 32819.7 32934.2 32982.3 33055.0 7475.4 7571.7 7584.0 7656.2 7752.3 20334.7 20457.0 20545.0 20566.0 20601.1 8532.6 8847.1 8848.2 8863.6 8867.4 7838.3 7954.7 7979.0 7988.0 8087.3 5924.4 5994.0 5997.6 6105.1 6319.1 1517.8 1558.0 1574.8 1582.7 1610.2 915.8 926.6 947.0 950.8 970.0 9046.4 9059.2 9087.6 9111.5 9248.2 843.1 847.9 848.8 861.5 916.6 5542.9 5950.9 5986.3 6043.1 6044.2 26651.7 26675.5 26997.5 27213.6 27668.7 26641.9 26706.3 27043.2 27663.7 27696.6 13233.0 13348.1 13368.7 13459.0 13483.7 9425.6 9479.9 9493.2 9501.8 9511.6 22349.4 22504.3 22650.4 23276.1 23428.3 23818.6 24002.0 24079.4 24129.3 24235.6 12321.8 12443.5 12649.4 12651.9 12655.8 15601.4 16252.9 16263.8 16283.4 16334.3 12819.7 13413.7 13527.6 13708.5 13744.8 12649.4 12735.8 12786.2 12886.7 13331.1 11437.0 11439.0 11520.8 11598.4 11624.1 8330.8 8387.7 8412.4 8426.5 8480.9 8075.2 8147.0 8164.8 8189.0 8207.1 23:48:45 INFO - PID 622 | 23:48:45 INFO - PID 622 | [#4] prototype.html Cycles:180 Average:5781.45 Median:6427.73 stddev:1614.24 (25.1%) stddev-sans-first:1570.51 23:48:45 INFO - PID 622 | Values: 562.3 569.7 577.3 593.8 601.1 6337.9 6390.0 6432.4 6470.3 6483.9 6317.4 6329.2 6401.0 6422.2 6423.1 5044.0 5105.0 5117.1 5190.2 5204.1 5101.3 5124.2 5146.9 5161.2 5164.1 5086.5 5091.7 5099.5 5117.1 5121.9 5050.3 5050.6 5120.2 5142.3 5149.7 4657.7 4687.2 4689.4 4718.8 4725.3 6159.9 6166.1 6252.2 6269.2 6371.1 5926.2 5929.4 5959.7 5968.6 5989.5 6715.6 6762.6 6769.3 6772.2 6850.7 4945.6 5169.6 5172.3 5175.6 5223.9 6896.8 6897.0 7015.9 7087.3 7110.9 5276.7 5348.5 5349.8 5353.8 5373.6 5365.8 5427.8 5449.8 5472.7 5490.6 5950.3 5976.9 6019.4 6056.2 6061.5 6818.4 6823.2 6851.1 6851.9 6903.1 1831.8 1854.8 1861.1 1875.2 1885.9 1291.9 1320.8 1346.9 1347.5 1356.7 6289.6 6313.4 6436.9 6444.3 6484.4 6696.6 6810.6 6820.7 6840.7 6849.2 6365.7 6448.4 6448.4 6458.2 6503.9 3591.5 3596.3 3631.6 3657.4 3664.0 7182.9 7233.6 7261.6 7274.8 7295.7 6916.3 6991.6 7059.3 7082.0 7139.8 7050.4 7249.3 7269.8 7283.3 7323.7 6886.2 6903.9 6924.2 6962.9 6995.8 6826.9 6839.4 6850.2 6924.9 6972.4 7152.2 7164.5 7181.5 7222.0 7261.4 5359.4 5384.8 5385.2 5386.2 5398.7 6741.6 6856.3 6964.4 7012.3 7042.4 6710.6 6723.8 6729.0 6789.4 6794.9 6727.6 6770.4 6780.2 6790.2 6806.7 6669.5 6693.9 6697.4 6720.2 6740.9 6659.9 6773.0 6777.2 6798.7 6819.3 6364.9 6458.1 6555.3 6600.8 6614.8 23:48:45 INFO - PID 622 | 23:48:45 INFO - PID 622 | [#5] yui.html Cycles:180 Average:28235.74 Median:17114.53 stddev:43616.04 (254.8%) stddev-sans-first:43690.44 23:48:45 INFO - PID 622 | Values: 997.9 998.7 1017.2 1034.5 1038.9 17493.7 17760.3 17817.4 17847.1 17856.6 18014.8 18290.0 18309.1 18338.6 18340.8 1045.7 1047.2 1053.7 1054.9 1055.9 1084.2 1085.6 1086.8 1087.4 1091.6 1054.4 1126.9 1132.7 1137.7 1147.0 1112.8 1117.2 1118.0 1118.0 1133.8 819.8 820.1 826.0 826.4 828.3 19140.9 20040.6 20120.6 20400.3 20416.7 18264.7 18798.9 18899.6 18905.9 18910.8 18874.0 19105.0 19179.4 19250.3 19258.9 3917.7 3920.9 3921.4 3927.7 3932.7 154779.0 167060.2 167846.0 168964.0 170981.0 16626.8 17101.5 17237.0 17286.8 17291.2 34501.7 34819.3 35303.8 35364.6 35371.8 8378.3 8468.5 8480.9 8484.2 8528.3 4226.3 4241.6 4276.4 4320.3 4331.3 5885.8 5925.2 5975.6 5979.5 6000.7 1251.2 1278.2 1279.4 1280.1 1288.1 734.5 736.6 740.3 749.8 754.1 11950.2 12285.9 12444.3 13095.7 13195.2 715.1 717.4 720.5 727.2 728.3 6069.7 6131.4 6146.8 6310.1 6338.2 148090.0 148856.0 149038.0 149044.0 150240.0 131325.3 132698.0 135671.3 138472.3 138849.0 120259.0 120615.4 121776.4 122073.0 123289.5 11715.7 11868.6 11922.8 11987.4 12061.4 57082.7 57653.7 57847.7 58319.1 58708.4 70716.6 70890.0 71467.6 71747.3 72618.6 13742.9 14009.9 14241.2 14244.9 14282.5 17061.7 17127.6 17378.4 17394.0 17444.4 15609.7 15640.7 15703.5 15855.8 15872.9 16526.2 16558.8 16615.9 16730.9 16745.3 16755.1 16813.0 16852.6 16875.8 16927.2 12790.0 12846.4 13209.5 13259.0 13264.1 12884.6 12945.2 13008.4 13081.5 13166.9 23:48:45 INFO - PID 622 | -------- Summary: end -------- 23:48:45 INFO - PID 622 | 23:48:46 INFO - TEST-INFO | 622: exit 0 23:48:46 INFO - TEST-OK | dromaeo_css | took 1106051ms 23:48:46 INFO - TEST-START | kraken 23:48:46 INFO - Initialising browser for kraken test... 23:48:46 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51987/getInfo.html -profile /tmp/tmpjmOZdr/profile 23:48:46 INFO - TEST-INFO | started process 996 (/builds/slave/test/build/application/firefox/firefox http://localhost:51987/getInfo.html) 23:48:50 INFO - TEST-INFO | 996: exit 0 23:48:51 INFO - Browser initialized. 23:48:51 INFO - Running cycle 1/1 for kraken test... 23:48:51 INFO - Using env: {'DISPLAY': ':0', 23:48:51 INFO - 'HOME': '/home/cltbld', 23:48:51 INFO - 'JSGC_DISABLE_POISONING': '1', 23:48:51 INFO - 'LANG': 'en_US.UTF-8', 23:48:51 INFO - 'LANGUAGE': 'en_US:en', 23:48:51 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 23:48:51 INFO - 'LOGNAME': 'cltbld', 23:48:51 INFO - 'MAIL': '/var/mail/cltbld', 23:48:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:48:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:48:51 INFO - 'MOZ_CRASHREPORTER': '1', 23:48:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:48:51 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 23:48:51 INFO - 'MOZ_NO_REMOTE': '1', 23:48:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:48:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:48:51 INFO - 'NO_EM_RESTART': '1', 23:48:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:48:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:48:51 INFO - 'PWD': '/builds/slave/test', 23:48:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:48:51 INFO - 'RUST_BACKTRACE': 'full', 23:48:51 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 23:48:51 INFO - 'SHELL': '/bin/bash', 23:48:51 INFO - 'SHLVL': '1', 23:48:51 INFO - 'TERM': 'linux', 23:48:51 INFO - 'TMOUT': '86400', 23:48:51 INFO - 'USER': 'cltbld', 23:48:51 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1507177148.389834-1262642936', 23:48:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:48:51 INFO - '_': '/tools/buildbot/bin/python'} 23:48:51 INFO - TEST-INFO | started process 1244 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjmOZdr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 23:48:51 INFO - PID 1244 | 23:48:51 INFO - PID 1244 | (/builds/slave/test/build/application/firefox/firefox:1362): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 23:48:51 INFO - PID 1244 | 23:49:02 INFO - PID 1244 | RSS: Main: 143781888 23:49:02 INFO - PID 1244 | 23:49:04 INFO - PID 1244 | Cycle 1(1): loaded http://localhost:51987/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51987/tests/kraken/driver.html?testName=audio-beat-detection) 23:49:05 INFO - PID 1244 | RSS: Main: 149409792 23:49:05 INFO - PID 1244 | 23:49:08 INFO - PID 1244 | Cycle 1(1): loaded http://localhost:51987/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51987/tests/kraken/driver.html?testName=audio-dft) 23:49:08 INFO - PID 1244 | RSS: Main: 149876736 23:49:08 INFO - PID 1244 | 23:49:11 INFO - PID 1244 | Cycle 1(1): loaded http://localhost:51987/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51987/tests/kraken/driver.html?testName=audio-fft) 23:49:12 INFO - PID 1244 | RSS: Main: 151142400 23:49:12 INFO - PID 1244 | 23:49:14 INFO - PID 1244 | Cycle 1(1): loaded http://localhost:51987/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51987/tests/kraken/driver.html?testName=audio-oscillator) 23:49:14 INFO - PID 1244 | RSS: Main: 151244800 23:49:14 INFO - PID 1244 | 23:49:16 INFO - PID 1244 | Cycle 1(1): loaded http://localhost:51987/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51987/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:49:17 INFO - PID 1244 | RSS: Main: 151158784 23:49:17 INFO - PID 1244 | 23:49:20 INFO - PID 1244 | Cycle 1(1): loaded http://localhost:51987/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51987/tests/kraken/driver.html?testName=imaging-darkroom) 23:49:21 INFO - PID 1244 | RSS: Main: 150970368 23:49:21 INFO - PID 1244 | 23:49:24 INFO - PID 1244 | Cycle 1(1): loaded http://localhost:51987/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51987/tests/kraken/driver.html?testName=imaging-desaturate) 23:49:25 INFO - PID 1244 | RSS: Main: 152539136 23:49:25 INFO - PID 1244 | 23:49:28 INFO - PID 1244 | Cycle 1(1): loaded http://localhost:51987/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51987/tests/kraken/driver.html?testName=json-parse-financial) 23:49:28 INFO - PID 1244 | RSS: Main: 153866240 23:49:28 INFO - PID 1244 | 23:49:30 INFO - PID 1244 | Cycle 1(1): loaded http://localhost:51987/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51987/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:49:30 INFO - PID 1244 | RSS: Main: 153624576 23:49:30 INFO - PID 1244 | 23:49:32 INFO - PID 1244 | Cycle 1(1): loaded http://localhost:51987/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51987/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:49:33 INFO - PID 1244 | RSS: Main: 153624576 23:49:33 INFO - PID 1244 | 23:49:34 INFO - PID 1244 | Cycle 1(1): loaded http://localhost:51987/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51987/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:49:35 INFO - PID 1244 | RSS: Main: 150360064 23:49:35 INFO - PID 1244 | 23:49:37 INFO - PID 1244 | Cycle 1(1): loaded http://localhost:51987/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51987/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:49:38 INFO - PID 1244 | RSS: Main: 150401024 23:49:38 INFO - PID 1244 | 23:49:41 INFO - PID 1244 | Cycle 1(1): loaded http://localhost:51987/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51987/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:49:41 INFO - PID 1244 | RSS: Main: 151236608 23:49:41 INFO - PID 1244 | 23:49:43 INFO - PID 1244 | Cycle 1(1): loaded http://localhost:51987/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51987/tests/kraken/driver.html?testName=ai-astar) 23:49:43 INFO - PID 1244 | RSS: Main: 152403968 23:49:43 INFO - PID 1244 | 23:49:43 INFO - PID 1244 | __start_tp_report 23:49:43 INFO - PID 1244 | _x_x_mozilla_page_load 23:49:43 INFO - PID 1244 | _x_x_mozilla_page_load_details 23:49:43 INFO - PID 1244 | |i|pagename|runs| 23:49:43 INFO - PID 1244 | |0;ai-astar;105;104;105;108;105;106;105;107;105;105 23:49:43 INFO - PID 1244 | |1;audio-beat-detection;110;111;110;115;113;111;111;112;111;137 23:49:43 INFO - PID 1244 | |2;audio-dft;163;161;161;162;161;161;162;165;171;163 23:49:43 INFO - PID 1244 | |3;audio-fft;75;74;72;72;74;73;72;75;73;73 23:49:43 INFO - PID 1244 | |4;audio-oscillator;78;77;79;78;78;76;76;77;76;78 23:49:43 INFO - PID 1244 | |5;imaging-gaussian-blur;114;115;115;113;114;114;114;114;114;113 23:49:43 INFO - PID 1244 | |6;imaging-darkroom;149;148;149;149;149;149;149;149;148;149 23:49:43 INFO - PID 1244 | |7;imaging-desaturate;94;98;97;94;94;94;96;94;94;95 23:49:43 INFO - PID 1244 | |8;json-parse-financial;46;47;45;45;45;46;44;46;45;46 23:49:43 INFO - PID 1244 | |9;json-stringify-tinderbox;44;44;46;45;45;45;46;45;45;45 23:49:43 INFO - PID 1244 | |10;stanford-crypto-aes;73;70;68;69;70;69;69;68;70;69 23:49:43 INFO - PID 1244 | |11;stanford-crypto-ccm;101;101;100;107;99;102;104;107;105;107 23:49:43 INFO - PID 1244 | |12;stanford-crypto-pbkdf2;147;145;149;152;150;149;147;154;144;152 23:49:43 INFO - PID 1244 | |13;stanford-crypto-sha256-iterative;58;58;60;62;61;58;57;59;57;58 23:49:43 INFO - PID 1244 | __end_tp_report 23:49:43 INFO - PID 1244 | __start_cc_report 23:49:43 INFO - PID 1244 | _x_x_mozilla_cycle_collect,681 23:49:43 INFO - PID 1244 | __end_cc_report 23:49:43 INFO - PID 1244 | __startTimestamp1507186183768__endTimestamp 23:49:43 INFO - PID 1244 | 23:49:43 INFO - PID 1244 | ------- Summary: start ------- 23:49:43 INFO - PID 1244 | Number of tests: 14 23:49:43 INFO - PID 1244 | 23:49:43 INFO - PID 1244 | [#0] ai-astar Cycles:10 Average:105.50 Median:105.00 stddev:1.18 (1.1%) stddev-sans-first:1.24 23:49:43 INFO - PID 1244 | Values: 105.0 104.0 105.0 108.0 105.0 106.0 105.0 107.0 105.0 105.0 23:49:43 INFO - PID 1244 | 23:49:43 INFO - PID 1244 | [#1] audio-beat-detection Cycles:10 Average:114.10 Median:111.50 stddev:8.18 (7.3%) stddev-sans-first:8.55 23:49:43 INFO - PID 1244 | Values: 110.0 111.0 110.0 115.0 113.0 111.0 111.0 112.0 111.0 137.0 23:49:43 INFO - PID 1244 | 23:49:43 INFO - PID 1244 | [#2] audio-dft Cycles:10 Average:163.00 Median:162.50 stddev:3.09 (1.9%) stddev-sans-first:3.28 23:49:43 INFO - PID 1244 | Values: 163.0 161.0 161.0 162.0 161.0 161.0 162.0 165.0 171.0 163.0 23:49:43 INFO - PID 1244 | 23:49:43 INFO - PID 1244 | [#3] audio-fft Cycles:10 Average:73.30 Median:73.50 stddev:1.16 (1.6%) stddev-sans-first:1.05 23:49:43 INFO - PID 1244 | Values: 75.0 74.0 72.0 72.0 74.0 73.0 72.0 75.0 73.0 73.0 23:49:43 INFO - PID 1244 | 23:49:43 INFO - PID 1244 | [#4] audio-oscillator Cycles:10 Average:77.30 Median:78.00 stddev:1.06 (1.4%) stddev-sans-first:1.09 23:49:43 INFO - PID 1244 | Values: 78.0 77.0 79.0 78.0 78.0 76.0 76.0 77.0 76.0 78.0 23:49:43 INFO - PID 1244 | 23:49:43 INFO - PID 1244 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 23:49:43 INFO - PID 1244 | Values: 114.0 115.0 115.0 113.0 114.0 114.0 114.0 114.0 114.0 113.0 23:49:43 INFO - PID 1244 | 23:49:43 INFO - PID 1244 | [#6] imaging-darkroom Cycles:10 Average:148.80 Median:149.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 23:49:43 INFO - PID 1244 | Values: 149.0 148.0 149.0 149.0 149.0 149.0 149.0 149.0 148.0 149.0 23:49:43 INFO - PID 1244 | 23:49:43 INFO - PID 1244 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:94.50 stddev:1.49 (1.6%) stddev-sans-first:1.54 23:49:43 INFO - PID 1244 | Values: 94.0 98.0 97.0 94.0 94.0 94.0 96.0 94.0 94.0 95.0 23:49:43 INFO - PID 1244 | 23:49:43 INFO - PID 1244 | [#8] json-parse-financial Cycles:10 Average:45.50 Median:46.00 stddev:0.85 (1.8%) stddev-sans-first:0.88 23:49:43 INFO - PID 1244 | Values: 46.0 47.0 45.0 45.0 45.0 46.0 44.0 46.0 45.0 46.0 23:49:43 INFO - PID 1244 | 23:49:43 INFO - PID 1244 | [#9] json-stringify-tinderbox Cycles:10 Average:45.00 Median:45.00 stddev:0.67 (1.5%) stddev-sans-first:0.60 23:49:43 INFO - PID 1244 | Values: 44.0 44.0 46.0 45.0 45.0 45.0 46.0 45.0 45.0 45.0 23:49:43 INFO - PID 1244 | 23:49:43 INFO - PID 1244 | [#10] stanford-crypto-aes Cycles:10 Average:69.50 Median:69.50 stddev:1.43 (2.1%) stddev-sans-first:0.78 23:49:43 INFO - PID 1244 | Values: 73.0 70.0 68.0 69.0 70.0 69.0 69.0 68.0 70.0 69.0 23:49:43 INFO - PID 1244 | 23:49:43 INFO - PID 1244 | [#11] stanford-crypto-ccm Cycles:10 Average:103.30 Median:106.00 stddev:3.09 (2.9%) stddev-sans-first:3.17 23:49:43 INFO - PID 1244 | Values: 101.0 101.0 100.0 107.0 99.0 102.0 104.0 107.0 105.0 107.0 23:49:43 INFO - PID 1244 | 23:49:43 INFO - PID 1244 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.90 Median:149.50 stddev:3.21 (2.1%) stddev-sans-first:3.33 23:49:43 INFO - PID 1244 | Values: 147.0 145.0 149.0 152.0 150.0 149.0 147.0 154.0 144.0 152.0 23:49:43 INFO - PID 1244 | 23:49:43 INFO - PID 1244 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:58.80 Median:58.50 stddev:1.69 (2.9%) stddev-sans-first:1.76 23:49:43 INFO - PID 1244 | Values: 58.0 58.0 60.0 62.0 61.0 58.0 57.0 59.0 57.0 58.0 23:49:43 INFO - PID 1244 | -------- Summary: end -------- 23:49:43 INFO - PID 1244 | 23:49:44 INFO - PID 1244 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 23:49:44 INFO - TEST-INFO | 1244: exit 0 23:49:44 INFO - TEST-OK | kraken | took 57937ms 23:49:44 INFO - SUITE-END | took 1163s 23:49:44 INFO - Completed test suite (00:19:24) 23:49:44 INFO - javascript benchmark 23:49:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9317.47958523402, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3969.86105486308, 3970.4242884781706, 3973.1060511384944, 3980.2835489611866, 3981.422693709414, 6409.935900641004, 6429.517786166033, 6446.0, 6484.773032943848, 6493.0, 6364.8727025459575, 6456.322086180942, 6463.159789227406, 6514.283428822838, 6518.934810651892, 5790.102534107199, 5792.044312688412, 5891.646501209942, 5901.822945311647, 5933.0, 5841.5326773858205, 5844.298684157907, 5849.707514624273, 5880.470757631812, 5988.401159884021, 5884.411558844125, 5892.9705351473185, 5900.822975310747, 5920.555958303123, 5920.703964801764, 5934.554908381867, 5953.315368732608, 6002.339742628307, 6007.189029481052, 6014.458698717114, 5843.824685259449, 5853.268341457318, 5903.940960590382, 5983.910241346383, 6005.519558435315, 6335.3981371769605, 6368.522360822957, 6383.234011918553, 6393.360663933569, 6472.773452929125, 7051.612161331124, 7080.044194033791, 7089.397401220903, 7102.715891364339, 7115.217326094125, 7005.054317667152, 7081.044059052014, 7161.462890283249, 7164.856702865965, 7180.8922866157045, 6379.138816259792, 6469.77355792545, 6485.416312531895, 6527.836804079889, 6595.175603049619, 7211.639418029183, 7218.386437152901, 7219.927800722031, 7229.566226026455, 7237.855242895218, 6881.10545629075, 6914.204866440323, 6917.239103698589, 6940.618265995317, 6943.201531823804, 7099.07711997437, 7174.892376614355, 7179.856402871913, 7193.064901562763, 7194.568325900463, 6966.756163534252, 6988.056612357368, 6988.091548098715, 7021.648917554204, 7074.646267686698, 6880.724771009103, 6985.545939513915, 6995.335443132894, 7055.329743674342, 7058.976448414951, 5162.251473536317, 5165.560927321219, 5177.844664660066, 5185.948140518622, 5200.63595548308, 4659.627229821606, 4723.338732577442, 4744.857654270378, 4764.499727528629, 4770.976145119322, 6570.671466426659, 6611.0, 6620.5034622402545, 6653.500987425866, 6720.428763555153, 7087.716491340392, 7096.467764917548, 7122.145342558926, 7122.928770712227, 7138.214796372395, 6528.869422611521, 6538.476921846241, 6608.140941677551, 6620.5034622402545, 6622.701978410983, 5821.85690857718, 5829.242198514166, 5863.296404431496, 5885.941140588625, 5890.6171098879295, 7268.38218751412, 7335.193128755833, 7393.889091663629, 7439.739609113763, 7450.403967682572, 7033.542819716702, 7043.542169758949, 7125.643717814192, 7132.0015197872335, 7151.106111736033, 7288.3076107769675, 7331.083614548182, 7338.743143989935, 7351.963240183765, 7421.666025028994, 6896.034555162181, 6898.403699836014, 6922.342377474132, 6938.236793952762, 6938.930610693828, 7043.190033146254, 7091.1490621125795, 7149.678264478215, 7150.749723759852, 7163.892541611985, 6799.11611490503, 6801.1158549388265, 6882.965585172042, 6893.310668933267, 6894.586324820527, 6711.295313992156, 6715.1941766988275, 6728.024436456784, 6785.491088168308, 6806.727730890709, 6593.044008618627, 6741.764038258638, 6769.763058292936, 6801.489888258499, 6829.52193346461, 6751.0, 6867.278935711878, 6920.342567456084, 6963.7562685305775, 6964.338387853146, 6548.377904099293, 6573.934260657332, 6589.80230593083, 6605.768798092044, 6671.733130674913], "value": 6452.8705871220745, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [981.5386768218939, 985.4678473624248, 1009.2380252909053, 1021.4688362051734, 1046.5761366646507, 44670.32994505085, 44903.55096449039, 45413.772931135296, 45423.77288113563, 45480.54519454809, 42082.0, 42403.78798106013, 42865.571344286625, 42887.785561072225, 42905.35641965365, 8032.999999999985, 8127.390445716565, 8155.225253600898, 8177.0, 8190.221928916773, 7983.880241796378, 8002.719904803333, 8055.879161812578, 8076.71731489398, 8082.313003394718, 8700.521471319074, 8852.513111778882, 8862.158094980967, 8864.246539044158, 8869.246114080312, 8701.651933922636, 8741.868871966926, 8781.912180878173, 8799.692010779656, 8811.0, 8581.871271930926, 8661.523616201106, 8668.869966950439, 8672.56637168139, 8681.609327580274, 41145.79427102875, 41365.0, 41453.792731036454, 41458.37812432786, 41505.0, 3807.638274363931, 3820.9044773880596, 3841.4045822897497, 3842.1547259602844, 3844.058205739612, 33506.83246583776, 33530.497042544135, 33579.496307555404, 33626.83186584051, 33630.83184584086, 5398.568114550866, 5518.558515318765, 5555.388907220203, 5601.131824567198, 5620.606557540974, 236876.0, 237608.0, 238758.8062059696, 239179.0, 239180.0, 52221.7388913053, 52259.47740522622, 52352.73823630858, 52394.21408678873, 52517.47482525202, 55863.720681396335, 55887.44112558904, 55934.44065559374, 55936.72031639897, 56092.71953640206, 17170.570735731457, 17472.737908931376, 17527.29890804379, 17528.12359382026, 17538.210780514906, 14368.281585920871, 14402.495912643008, 14405.207713575644, 14411.85588144126, 14415.927920360331, 15443.459478918185, 15744.0, 15775.368985240691, 15863.920680396755, 15917.761233581505, 5919.0, 5968.761249550056, 6071.423214794588, 6099.207103076572, 6117.938820611826, 1109.1348747976592, 1122.6688127002553, 1122.8484154639182, 1125.5104029747085, 1129.5877004893318, 26071.739282607312, 26311.605325920125, 26397.20808375752, 26704.59943100855, 26784.866075669495, 1215.398377802993, 1216.051479845704, 1233.2970206982113, 1239.5041983206609, 1240.8697086805937, 13587.59237222885, 13602.455901764017, 13999.16005039701, 14159.150450972975, 14186.290685465685, 281156.0, 296198.0, 301015.0, 302712.0, 302834.0, 60340.698296509116, 60490.39509604935, 60527.394726052175, 60819.695901521096, 60934.0, 1506.088816266143, 1515.2499512741263, 1540.7688846673088, 1549.7752825840416, 1581.7627355896707, 30847.383052339275, 30966.380672385974, 31053.689463105078, 31104.0, 31112.377752444372, 42491.0, 42527.787361063, 42576.787116064224, 42668.14663706771, 42725.1454970905, 255634.0, 257183.0, 257392.0, 258074.0, 259916.0, 38671.80664096661, 38847.0, 38850.22299553936, 39058.80470597629, 39190.608093918694, 48033.27950080681, 48361.274580880614, 48895.5110448891, 49180.508194917595, 49291.50708492869, 35367.0, 35733.82133089422, 35949.46075808813, 36095.0, 36900.26199476049, 35359.64640353563, 35574.64425355713, 35608.109797255274, 35811.64188358083, 35942.460863087595, 41186.588134118276, 41516.58483415127, 41768.791156044026, 41808.3728744063, 41989.0, 33482.0, 34153.65846341604, 34193.14517136992, 34442.655573443946, 34836.303273934886, 25921.351966200997, 25940.48119037571, 26259.4748105033, 26451.735482644926, 26536.958775217317], "value": 19277.771175407815, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [619.6777675608681, 627.6140173793118, 630.8422894276431, 648.6918713611035, 660.1253339325393, 23483.0, 24615.384615384624, 24872.0, 24901.875490622544, 26024.089156879512, 27065.188044358652, 27970.881164753384, 27991.440171196617, 28002.159935201926, 28011.159665210027, 7051.365377116059, 7073.540219885691, 7107.680154393065, 7219.8917016244795, 7222.313880181375, 6607.9008814867575, 6927.618980956046, 6937.445004399636, 6943.6875340609795, 6949.374556289933, 6834.726610935557, 6866.588004719732, 6892.931070689304, 6894.034835123087, 6926.549774264682, 6830.8975365369315, 6859.451243900501, 6877.484188685844, 6886.414654754352, 6889.621070841102, 6402.93597064028, 6466.773662921775, 6500.4799616030605, 6503.739850405978, 6511.804645860631, 31794.36411271785, 32913.0, 33179.17052073693, 33349.0, 33369.49945750816, 2229.788170123852, 2233.050953344822, 2233.955320893573, 2235.7205349331334, 2249.403907964391, 20939.26712565068, 21138.78861211399, 21393.57212855734, 21782.237621683165, 21810.781892181032, 2592.40374713815, 2614.045873256267, 2618.5024845279336, 2624.6325514427995, 2626.4090579619624, 145466.0, 151658.0, 162572.0, 167676.0, 169024.1548792248, 17258.568535786453, 17491.737623935653, 18060.9096954517, 18096.638067238844, 18616.348427804962, 28436.289092772848, 28559.857200713865, 28601.141965741062, 28635.713642863306, 28810.567841482396, 11276.210665253517, 11282.94358528202, 11287.040601548797, 11333.320000799979, 11381.374024428736, 10113.69658910234, 10139.746506337253, 10246.795064098676, 10307.433091180057, 10335.379877207391, 10403.47982600867, 10529.210309226839, 10558.630447934285, 10770.78458430827, 10793.136549076055, 2932.310906936868, 2992.371601963612, 2999.4954213232195, 3066.2794243352796, 3101.255698632312, 1049.4228174503992, 1050.805600963809, 1061.877884043345, 1067.9946600266949, 1074.1621535202555, 22673.659895101588, 22890.42773930665, 22955.770442295696, 23074.307770766904, 23299.53400931972, 1127.4306475229957, 1133.2690414682484, 1141.5490881101919, 1142.4230763464398, 1143.988560114405, 12496.0, 12595.622131336075, 12759.043071769654, 12791.872081279254, 12850.614481565568, 566060.0, 566903.0, 571070.0, 609010.0, 609821.0, 132332.0, 132810.0, 133994.0, 134377.0, 134838.0, 1171.9531218751154, 1227.1777908801125, 1228.993855030737, 1255.5668294438588, 1274.6813296675832, 23580.764192358543, 24024.519509610058, 24112.638310425005, 24269.150579729623, 24347.26958191257, 63223.0, 64350.35649643443, 64558.0, 64810.35189648043, 66256.0, 79029.60485197537, 79032.60483697544, 79164.60417697874, 82038.0, 83241.58379208065, 17022.2339994703, 17413.390531331344, 17499.737503937708, 17500.387486437914, 17504.387346443324, 26090.0, 26415.60376594391, 26561.734382655926, 26802.195934122006, 26823.463530728885, 21292.254771083557, 21536.0, 21650.6752398711, 21678.566428671653, 21759.0, 18892.527686807938, 18911.716324255423, 18977.0, 19043.714344285123, 19192.904035479733, 21911.0, 21996.340109796733, 22247.332580022627, 22354.66468003014, 22438.551228975004, 16791.160441978096, 16849.66300674004, 16918.66162676715, 16994.830051699326, 17021.48935531936, 20942.267020654202, 21096.68354974646, 21217.575648486636, 21397.144114235256, 21453.785462145177], "value": 13526.851002598445, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1420.1408148070418, 1476.5127507922386, 1487.2786698451257, 1508.683176532928, 1513.8032055832741, 17496.0, 18184.0, 18199.636007279845, 18206.180721867513, 18206.81793182068, 17634.559136021573, 17672.20475078621, 17723.379681711143, 17796.64406711865, 17814.64370712585, 2917.9416411671755, 2932.9413411731807, 2999.5350720638226, 3005.0, 3008.1877892968887, 3023.4708925937985, 3052.0, 3054.9541756873664, 3061.8622162002653, 3066.3254084101463, 3010.834404107773, 3043.923901902459, 3057.113437103237, 3143.245621050954, 3145.543896135059, 2838.6451693538306, 2847.729465700755, 2853.243890369054, 2871.6984716604666, 2879.539273716206, 3023.2744141406124, 3036.726694597497, 3058.235441139715, 3066.708662677042, 3072.6466456357357, 16920.576985575335, 17178.0, 17228.655426891517, 17243.3964811231, 17271.481855544353, 8640.179182977607, 8968.955155224246, 8970.461772293684, 9003.369764116514, 9010.098990101003, 5870.6477611343025, 5873.794417195378, 6009.57932944694, 6041.184440100574, 6131.754729810802, 1946.6009468059015, 1970.6846904495212, 1975.9308424205228, 2025.402506260642, 2049.405672355015, 32739.18152046194, 32819.67180328214, 32934.176645584055, 32982.340353193045, 33055.00834974954, 7475.401967842559, 7571.659275332623, 7584.0, 7656.234376562299, 7752.26353496417, 20334.694979575317, 20457.0, 20545.0, 20566.0, 20601.072951717208, 8532.616032278562, 8847.071057538995, 8848.203661670352, 8863.556822158866, 8867.379283450096, 7838.3337416320255, 7954.721584744506, 7979.0, 7988.0, 8087.272145506932, 5924.407559244041, 5993.9700301498215, 5997.550183736237, 6105.114758360013, 6319.0837328587095, 1517.8102737157856, 1558.0, 1574.7874037004858, 1582.7151112799577, 1610.1788088075166, 915.7527467583849, 926.5598840550684, 946.9526523673788, 950.8336041192902, 969.96120155193, 9046.366754327266, 9059.229965452878, 9087.636494540277, 9111.453312801254, 9248.16766491019, 843.0599881132493, 847.894013248344, 848.8217474330336, 861.4917198852708, 916.5966974531185, 5542.91685624716, 5950.8809823803285, 5986.311574168939, 6043.063325184604, 6044.24446944132, 26651.733482665313, 26675.466490670467, 26997.460050798873, 27213.591796123073, 27668.723312766615, 26641.86679066592, 26706.332341691224, 27043.1887043389, 27663.723362766515, 27696.584551231746, 13233.0, 13348.125889294703, 13368.6657833553, 13459.0, 13483.662908427368, 9425.575849086945, 9479.857802132836, 9493.240540756584, 9501.762455938657, 9511.57197926081, 22349.441263968532, 22504.32487025392, 22650.43373915665, 23276.06895724152, 23428.297151085495, 23818.642720359556, 24002.0, 24079.398015049763, 24129.276121716375, 24235.63646545268, 12321.815172772236, 12443.502259909503, 12649.430775614936, 12651.93674031624, 12655.81016284738, 15601.375944962074, 16252.918735406247, 16263.75604365959, 16283.430079947146, 16334.346626134822, 12819.743605127658, 13413.66465838362, 13527.594172174851, 13708.451661933412, 13744.793828092786, 12649.430775615303, 12735.80896286538, 12786.232826030468, 12886.742265154831, 13331.066825322134, 11437.0, 11439.0, 11520.769584608428, 11598.362090084789, 11624.07007439386, 8330.75317359639, 8387.748367548984, 8412.443697915905, 8426.536540490331, 8480.872786908078, 8075.192480751878, 8147.0, 8164.8367032657825, 8188.959055204686, 8207.097219305751], "value": 7573.109934384609, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.2915126940056, 569.7494895164101, 577.3043482603463, 593.7803012885232, 601.1163589523402, 6337.904931426032, 6390.0, 6432.356764323566, 6470.320616335282, 6483.902741458882, 6317.36826317368, 6329.1772069631, 6400.967995160029, 6422.165118534584, 6423.100765892767, 5044.016416798726, 5105.0, 5117.106670531908, 5190.221466779975, 5204.141316682742, 5101.336826212587, 5124.180131179012, 5146.9485305146845, 5161.200013997836, 5164.147915593922, 5086.516780905808, 5091.694498330094, 5099.5068378160895, 5117.104506711311, 5121.871953201181, 5050.318207042057, 5050.646454748169, 5120.206368012964, 5142.30578871855, 5149.6910185389, 4657.650676199265, 4687.20317546018, 4689.412599361492, 4718.811247550094, 4725.314829349725, 6159.907601385983, 6166.136740856284, 6252.155958945529, 6269.153664255313, 6371.139896114011, 5926.2295901532525, 5929.436703513159, 5959.672218028007, 5968.552358573124, 5989.520838332966, 6715.589726157513, 6762.628055456948, 6769.255381908036, 6772.153480814898, 6850.691718872663, 4945.579625731817, 5169.586433085344, 5172.301739265189, 5175.560077393426, 5223.921641175385, 6896.7586134485555, 6896.965515172442, 7015.89476157858, 7087.291270872923, 7110.857782844366, 5276.709780962084, 5348.4594817462175, 5349.786008559692, 5353.839384818461, 5373.570114390839, 5365.785368585213, 5427.755750991215, 5449.809256675997, 5472.7263636818, 5490.5882058844945, 5950.256217972754, 5976.85057873548, 6019.367966363468, 6056.212692350055, 6061.484773794277, 6818.420434263143, 6823.215330236987, 6851.109355783816, 6851.910167398892, 6903.1371078615175, 1831.7985021647607, 1854.8145185481344, 1861.088066847262, 1875.2405275863298, 1885.8585606079598, 1291.922484650924, 1320.7584870222151, 1346.8518462969066, 1347.5351003903638, 1356.7354365898555, 6289.55973081889, 6313.40022697843, 6436.935630643728, 6444.291127975919, 6484.383983521558, 6696.59820410777, 6810.6254156020905, 6820.727170913207, 6840.726370945106, 6849.1780986281965, 6365.713542890581, 6448.387403196689, 6448.388402696915, 6458.160439142881, 6503.902441463382, 3591.4612808078996, 3596.3166998270244, 3631.618680038558, 3657.4148136298063, 3664.04734768962, 7182.856342873113, 7233.598265535039, 7261.600611966287, 7274.781756547312, 7295.70817167318, 6916.273791251947, 6991.580505169706, 7059.329363710542, 7082.0, 7139.821929381697, 7050.435965122778, 7249.275072492708, 7269.818254543678, 7283.271672832674, 7323.707051717872, 6886.24251332343, 6903.861922761617, 6924.238333783179, 6962.895556566555, 6995.755148569776, 6826.863462730618, 6839.443489385591, 6850.177978642595, 6924.861502770017, 6972.442204623517, 7152.213256541881, 7164.498485105993, 7181.511555277952, 7222.0, 7261.419086473175, 5359.437259087739, 5384.784608615611, 5385.2460655507475, 5386.192071189196, 5398.703071330958, 6741.561798483083, 6856.348646878539, 6964.398188416591, 7012.333828286304, 7042.366187043191, 6710.564442801347, 6723.848368522222, 6729.024291477806, 6789.367688286743, 6794.912813949942, 6727.629980351127, 6770.35681610266, 6780.1524809398825, 6790.151231096113, 6806.693698783468, 6669.53313268086, 6693.899591506229, 6697.397234248941, 6720.227173875067, 6740.865182696417, 6659.900101498384, 6773.0, 6777.220619628806, 6798.742232686969, 6819.318068193339, 6364.931397295804, 6458.12714312844, 6555.344465553407, 6600.768973085919, 6614.8346291343105], "value": 5318.519756765837, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [997.8503224516321, 998.730342807442, 1017.2065788684823, 1034.5137785240934, 1038.94805259737, 17493.650126997454, 17760.289588416446, 17817.37639182629, 17847.10764461775, 17856.553586160353, 18014.81985180148, 18290.0, 18309.084545772726, 18338.63322733548, 18340.81659183408, 1045.6706137566662, 1047.240750455921, 1053.6575612925792, 1054.8628678271853, 1055.8996895294954, 1084.1922767538194, 1085.592902661502, 1086.7554800169978, 1087.40736298717, 1091.5851976249055, 1054.4464156317956, 1126.881677423871, 1132.6885106595669, 1137.6700756780524, 1147.0364893489468, 1112.7607564373698, 1117.1956191542076, 1117.9608713695063, 1117.9776404471907, 1133.8129208680557, 819.778659761867, 820.1470470710454, 826.0, 826.4380221449472, 828.2752591482453, 19140.904295478573, 20040.599188016156, 20120.597588048302, 20400.28598999028, 20416.693749593767, 18264.726029109574, 18798.90600547002, 18899.62200755977, 18905.90547047256, 18910.810891891044, 18873.96193209373, 19105.0, 19179.424617261506, 19250.326238581583, 19258.903705481524, 3917.7453465524936, 3920.882373528799, 3921.4313924481075, 3927.7054220933546, 3932.6853851691794, 154779.0, 167060.16469917572, 167846.0, 168963.99999999878, 170981.0, 16626.83373166277, 17101.48695539136, 17237.0, 17286.827131728773, 17291.221895014754, 34501.654983449844, 34819.30361392758, 35303.823480882435, 35364.64635353665, 35371.82314088465, 8378.287845533197, 8468.534230617252, 8480.872786908201, 8484.19400156984, 8528.317734581218, 4226.260404429274, 4241.63946064588, 4276.444062271947, 4320.330348795942, 4331.263685173465, 5885.823425297248, 5925.200097986803, 5975.581709280395, 5979.4917432018765, 6000.669963151981, 1251.2367455851922, 1278.2330601639128, 1279.4242590833976, 1280.0655521469193, 1288.1047671868148, 734.5262305812721, 736.5985537881867, 740.326303064209, 749.7825630567183, 754.0687251244708, 11950.223235489666, 12285.877141228651, 12444.253344799341, 13095.738085238241, 13195.20828750278, 715.0811207598211, 717.3794667612477, 720.4740539406263, 727.2291371146601, 728.2535401213798, 6069.696515174223, 6131.448169664752, 6146.754129834757, 6310.148130002391, 6338.176037115146, 148090.0, 148856.0, 149038.0, 149044.0, 150240.0, 131325.34337328444, 132698.0, 135671.32164339116, 138472.3076384632, 138849.0, 120259.0, 120615.39692301658, 121776.39111804562, 122073.0, 123289.5342093171, 11715.707107322045, 11868.643940681794, 11922.821157682814, 11987.400629968291, 12061.396930153633, 57082.7145864268, 57653.71173144107, 57847.710761447604, 58319.12521312269, 58708.41291587029, 70716.64641676759, 70890.0, 71467.64266178636, 71747.28252717406, 72618.63690681513, 13742.875553846252, 14009.859901401263, 14241.21673307978, 14244.928775356057, 14282.500112496013, 17061.744073838654, 17127.57181070483, 17378.39175628847, 17394.0, 17444.389446369318, 15609.68780624404, 15640.687186255984, 15703.528894133195, 15855.841441585899, 15872.920635397211, 16526.173691315627, 16558.83441165573, 16615.916920415322, 16730.916345418194, 16745.33018679239, 16755.07847068374, 16813.0, 16852.57868553296, 16875.831241687425, 16927.15364231808, 12790.0, 12846.42191101384, 13209.471621135048, 13259.0, 13264.137831041338, 12884.613461596167, 12945.223286602833, 13008.414621341873, 13081.542146024844, 13166.868331316564], "value": 9653.680480503059, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1362.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 104.0, 105.0, 108.0, 105.0, 106.0, 105.0, 107.0, 105.0, 105.0], "value": 105.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 110.0, 115.0, 113.0, 111.0, 111.0, 112.0, 111.0, 137.0], "value": 114.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 161.0, 162.0, 161.0, 161.0, 162.0, 165.0, 171.0, 163.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 72.0, 72.0, 74.0, 73.0, 72.0, 75.0, 73.0, 73.0], "value": 73.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 79.0, 78.0, 78.0, 76.0, 76.0, 77.0, 76.0, 78.0], "value": 77.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0, 113.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 149.0, 149.0, 149.0, 149.0, 149.0, 149.0, 148.0, 149.0], "value": 148.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 98.0, 97.0, 94.0, 94.0, 94.0, 96.0, 94.0, 94.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 47.0, 45.0, 45.0, 45.0, 46.0, 44.0, 46.0, 45.0, 46.0], "value": 45.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 44.0, 46.0, 45.0, 45.0, 45.0, 46.0, 45.0, 45.0, 45.0], "value": 45.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 70.0, 68.0, 69.0, 70.0, 69.0, 69.0, 68.0, 70.0, 69.0], "value": 69.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 101.0, 100.0, 107.0, 99.0, 102.0, 104.0, 107.0, 105.0, 107.0], "value": 103.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 149.0, 152.0, 150.0, 149.0, 147.0, 154.0, 144.0, 152.0], "value": 148.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 60.0, 62.0, 61.0, 58.0, 57.0, 59.0, 57.0, 58.0], "value": 58.8, "unit": "score"}]}]} 23:49:44 INFO - Return code: 0 23:49:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:49:44 INFO - # TBPL SUCCESS # 23:49:44 INFO - Running post-action listener: _package_coverage_data 23:49:44 INFO - Running post-action listener: _resource_record_post_action 23:49:44 INFO - [mozharness: 2017-10-05 06:49:44.539668Z] Finished run-tests step (success) 23:49:44 INFO - Running post-run listener: _resource_record_post_run 23:49:44 INFO - Total resource usage - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283197440; Read time: 12; Write time: 190352 23:49:44 INFO - TinderboxPrint: CPU usage
13.0% 23:49:44 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 23:49:44 INFO - TinderboxPrint: I/O write bytes / time
283,197,440 / 190,352 23:49:44 INFO - TinderboxPrint: CPU idle
8,174.1 (86.9%) 23:49:44 INFO - TinderboxPrint: CPU user
1,179.2 (12.5%) 23:49:44 INFO - TinderboxPrint: Swap in / out
0 / 0 23:49:44 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 9048064; Read time: 0; Write time: 1028 23:49:44 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 23:49:44 INFO - run-tests - Wall time: 1164s; CPU: 13.0%; Read bytes: 0; Write bytes: 273731584; Read time: 0; Write time: 189304 23:49:45 INFO - Running post-run listener: _upload_blobber_files 23:49:45 INFO - Blob upload gear active. 23:49:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:49:45 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 23:49:45 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', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:49:45 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 Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:49:45 INFO - (blobuploader) - INFO - Open directory for files ... 23:49:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:49:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:49:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:49:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:49:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:49:46 INFO - (blobuploader) - INFO - Done attempting. 23:49:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 23:49:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:49:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:49:47 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 23:49:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:49:47 INFO - (blobuploader) - INFO - Done attempting. 23:49:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:49:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:49:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:49:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:49:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:49:48 INFO - (blobuploader) - INFO - Done attempting. 23:49:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:49:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:49:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:49:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:49:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:49:54 INFO - (blobuploader) - INFO - Done attempting. 23:49:54 INFO - (blobuploader) - INFO - Iteration through files over. 23:49:54 INFO - Return code: 0 23:49:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:49:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:49:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5cda98a053ff56608b74cd1d71f846c8d6f80dd025c81508825f31462ceb1c38f7a0347cdd48143b61e16186bbdf6825b22e6e7778427fb8ae0c0cb23adb840c", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0c5886fe9ee7ee53d041efd3bb5a754aaa6ad687a88d44f5020094312d2c5cb968a1b6b0402449d84ed0107c973a005c235b91f460968c96fc313c0552bf5965", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/8efb56066b7a15cb34e0936432269db1447a6c4f66e47842076d4660b87a0a05e5f2f83f5904991b2aaea8514f53baee94b5eaebac432ef4e4c9632e99258f81", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ea6f67958896e74121b9aff2ab610b2ce2d66d1f25d9a949b088b94cd071dcbf7a6bc2d0ddfc06724b7324a9311a0d5db7299f3c5f15319d450c765609e28c97"} 23:49:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:49:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:49:54 INFO - Contents: 23:49:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5cda98a053ff56608b74cd1d71f846c8d6f80dd025c81508825f31462ceb1c38f7a0347cdd48143b61e16186bbdf6825b22e6e7778427fb8ae0c0cb23adb840c", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0c5886fe9ee7ee53d041efd3bb5a754aaa6ad687a88d44f5020094312d2c5cb968a1b6b0402449d84ed0107c973a005c235b91f460968c96fc313c0552bf5965", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/8efb56066b7a15cb34e0936432269db1447a6c4f66e47842076d4660b87a0a05e5f2f83f5904991b2aaea8514f53baee94b5eaebac432ef4e4c9632e99258f81", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ea6f67958896e74121b9aff2ab610b2ce2d66d1f25d9a949b088b94cd071dcbf7a6bc2d0ddfc06724b7324a9311a0d5db7299f3c5f15319d450c765609e28c97"} 23:49:54 INFO - Running post-run listener: copy_logs_to_upload_dir 23:49:54 INFO - Copying logs to upload dir... 23:49:54 INFO - mkdir: /builds/slave/test/build/upload/logs 23:49:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.658397 ========= master_lag: -0.30 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2017-10-04 23:49:55.406942) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-04 23:49:55.416196) ========= 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=6d15e502d8e29d5d2676d664000001c3-1507177148.389834-1262642936 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5cda98a053ff56608b74cd1d71f846c8d6f80dd025c81508825f31462ceb1c38f7a0347cdd48143b61e16186bbdf6825b22e6e7778427fb8ae0c0cb23adb840c", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0c5886fe9ee7ee53d041efd3bb5a754aaa6ad687a88d44f5020094312d2c5cb968a1b6b0402449d84ed0107c973a005c235b91f460968c96fc313c0552bf5965", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/8efb56066b7a15cb34e0936432269db1447a6c4f66e47842076d4660b87a0a05e5f2f83f5904991b2aaea8514f53baee94b5eaebac432ef4e4c9632e99258f81", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ea6f67958896e74121b9aff2ab610b2ce2d66d1f25d9a949b088b94cd071dcbf7a6bc2d0ddfc06724b7324a9311a0d5db7299f3c5f15319d450c765609e28c97"} build_url:https://queue.taskcluster.net/v1/task/VzvV0R-ATLmcfM0_Ua3a-w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011234 build_url: 'https://queue.taskcluster.net/v1/task/VzvV0R-ATLmcfM0_Ua3a-w/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5cda98a053ff56608b74cd1d71f846c8d6f80dd025c81508825f31462ceb1c38f7a0347cdd48143b61e16186bbdf6825b22e6e7778427fb8ae0c0cb23adb840c", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0c5886fe9ee7ee53d041efd3bb5a754aaa6ad687a88d44f5020094312d2c5cb968a1b6b0402449d84ed0107c973a005c235b91f460968c96fc313c0552bf5965", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/8efb56066b7a15cb34e0936432269db1447a6c4f66e47842076d4660b87a0a05e5f2f83f5904991b2aaea8514f53baee94b5eaebac432ef4e4c9632e99258f81", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ea6f67958896e74121b9aff2ab610b2ce2d66d1f25d9a949b088b94cd071dcbf7a6bc2d0ddfc06724b7324a9311a0d5db7299f3c5f15319d450c765609e28c97"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-04 23:49:55.452855) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 23:49:55.453177) ========= 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=6d15e502d8e29d5d2676d664000001c3-1507177148.389834-1262642936 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004449 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 23:49:55.533298) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-04 23:49:55.536641) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-04 23:49:55.537064) ========= ========= Total master_lag: -0.13 =========