builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-008 starttime: 1506455288.71 results: success (0) revision: 0bbec589b1fe446103b259b32818a8c3bba0d400 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 12:48:08.713114) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 12:48:08.713566) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 12:48:08.713843) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 12:48:08.815899) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 12:48:08.816154) ========= 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=32c5991c409366f7fec8a718000001d2-1506453887.278188-1175121432 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-26 12:48:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 217M=0s 2017-09-26 12:48:08 (217 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.091599 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 12:48:08.926383) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 12:48:08.929838) ========= 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=32c5991c409366f7fec8a718000001d2-1506453887.278188-1175121432 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019169 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 12:48:08.979507) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 12:48:08.979883) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0bbec589b1fe446103b259b32818a8c3bba0d400 --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 0bbec589b1fe446103b259b32818a8c3bba0d400 --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=32c5991c409366f7fec8a718000001d2-1506453887.278188-1175121432 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-26 12:48:09,034 truncating revision to first 12 chars 2017-09-26 12:48:09,034 Setting DEBUG logging. 2017-09-26 12:48:09,034 attempt 1/10 2017-09-26 12:48:09,034 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/0bbec589b1fe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-26 12:48:09,527 unpacking tar archive at: mozilla-beta-0bbec589b1fe/testing/mozharness/ program finished with exit code 0 elapsedTime=0.832737 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 12:48:09.826690) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 12:48:09.827012) ========= script_repo_revision: 0bbec589b1fe446103b259b32818a8c3bba0d400 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 12:48:09.827403) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 12:48:09.827683) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 12:48:09.840472) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2017-09-26 12:48:09.840894) ========= /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=32c5991c409366f7fec8a718000001d2-1506453887.278188-1175121432 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:48:10 INFO - MultiFileLogger online at 20170926 12:48:10 in /builds/slave/test 12:48:10 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 12:48:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:48:10 INFO - {'append_to_log': False, 12:48:10 INFO - 'base_work_dir': '/builds/slave/test', 12:48:10 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 12:48:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:48:10 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 12:48:10 INFO - 'buildbot_json_path': 'buildprops.json', 12:48:10 INFO - 'code_coverage': False, 12:48:10 INFO - 'config_files': ('talos/linux_config.py',), 12:48:10 INFO - 'default_actions': ('clobber', 12:48:10 INFO - 'read-buildbot-config', 12:48:10 INFO - 'download-and-extract', 12:48:10 INFO - 'populate-webroot', 12:48:10 INFO - 'create-virtualenv', 12:48:10 INFO - 'install', 12:48:10 INFO - 'setup-mitmproxy', 12:48:10 INFO - 'run-tests'), 12:48:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:48:10 INFO - 'disable_ccov_upload': False, 12:48:10 INFO - 'disable_stylo': False, 12:48:10 INFO - 'download_minidump_stackwalk': True, 12:48:10 INFO - 'download_symbols': 'ondemand', 12:48:10 INFO - 'enable_stylo': False, 12:48:10 INFO - 'enable_webrender': False, 12:48:10 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 12:48:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:48:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:48:10 INFO - 'gecko_profile': False, 12:48:10 INFO - 'gecko_profile_interval': 0, 12:48:10 INFO - 'installer_path': 'installer.exe', 12:48:10 INFO - 'log_level': 'info', 12:48:10 INFO - 'log_name': 'talos', 12:48:10 INFO - 'log_to_console': True, 12:48:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:48:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:48:10 INFO - 'opt_config_files': (), 12:48:10 INFO - 'pip_index': False, 12:48:10 INFO - 'suite': 'dromaeojs-e10s', 12:48:10 INFO - 'system_bits': '32', 12:48:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:48:10 INFO - 'title': 'talos-linux64-ix-008', 12:48:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:48:10 INFO - 'use_talos_json': True, 12:48:10 INFO - 'verify': 'False', 12:48:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:48:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:48:10 INFO - 'work_dir': 'build'} 12:48:10 INFO - [mozharness: 2017-09-26 19:48:10.041254Z] Running clobber step. 12:48:10 INFO - Running pre-action listener: _resource_record_pre_action 12:48:10 INFO - Running main action method: clobber 12:48:10 INFO - rmtree: /builds/slave/test/build 12:48:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:48:11 INFO - Running post-action listener: _resource_record_post_action 12:48:11 INFO - [mozharness: 2017-09-26 19:48:11.552355Z] Finished clobber step (success) 12:48:11 INFO - [mozharness: 2017-09-26 19:48:11.552452Z] Running read-buildbot-config step. 12:48:11 INFO - Running pre-action listener: _resource_record_pre_action 12:48:11 INFO - Running main action method: read_buildbot_config 12:48:11 INFO - Using buildbot properties: 12:48:11 INFO - { 12:48:11 INFO - "project": "", 12:48:11 INFO - "product": "firefox", 12:48:11 INFO - "who": "ryanvm@gmail.com", 12:48:11 INFO - "installer_path": "public/build/target.tar.bz2", 12:48:11 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 12:48:11 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 12:48:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 12:48:11 INFO - "stage_platform": "linux64", 12:48:11 INFO - "basedir": "/builds/slave/test", 12:48:11 INFO - "buildnumber": 118, 12:48:11 INFO - "platform": "ubuntu64_hw", 12:48:11 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:48:11 INFO - "slavebuilddir": "test", 12:48:11 INFO - "taskId": "A0ROPhmdTcerbxqcols__Q", 12:48:11 INFO - "branch": "mozilla-beta", 12:48:11 INFO - "script_repo_revision": "production", 12:48:11 INFO - "revision": "0bbec589b1fe446103b259b32818a8c3bba0d400", 12:48:11 INFO - "slavename": "talos-linux64-ix-008", 12:48:11 INFO - "repo_path": "releases/mozilla-beta" 12:48:11 INFO - } 12:48:11 INFO - Finding installer, test and symbols from parent task. 12:48:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A0ROPhmdTcerbxqcols__Q'}, attempt #1 12:48:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A0ROPhmdTcerbxqcols__Q'}, attempt #1 12:48:12 INFO - Task dependencies: ZsCq7lJfRZeT3aFCi1e-1Q 12:48:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZsCq7lJfRZeT3aFCi1e-1Q'}, attempt #1 12:48:12 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ZsCq7lJfRZeT3aFCi1e-1Q/artifacts/public/build/target.tar.bz2 12:48:12 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/ZsCq7lJfRZeT3aFCi1e-1Q/artifacts/public/build/target.test_packages.json 12:48:12 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ZsCq7lJfRZeT3aFCi1e-1Q/artifacts/public/build/target.crashreporter-symbols.zip 12:48:12 INFO - Running post-action listener: _resource_record_post_action 12:48:12 INFO - [mozharness: 2017-09-26 19:48:12.912418Z] Finished read-buildbot-config step (success) 12:48:12 INFO - [mozharness: 2017-09-26 19:48:12.912672Z] Running download-and-extract step. 12:48:12 INFO - Running pre-action listener: _resource_record_pre_action 12:48:12 INFO - Running main action method: download_and_extract 12:48:12 INFO - mkdir: /builds/slave/test/build/tests 12:48:12 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')]} 12:48:12 INFO - trying https://queue.taskcluster.net/v1/task/ZsCq7lJfRZeT3aFCi1e-1Q/artifacts/public/build/target.test_packages.json 12:48:12 INFO - Downloading https://queue.taskcluster.net/v1/task/ZsCq7lJfRZeT3aFCi1e-1Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 12:48:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZsCq7lJfRZeT3aFCi1e-1Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 12:48:13 INFO - Downloaded 989 bytes. 12:48:13 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 12:48:13 INFO - Using the following test package requirements: 12:48:13 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 12:48:13 INFO - u'common': [u'target.common.tests.zip'], 12:48:13 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 12:48:13 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 12:48:13 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 12:48:13 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 12:48:13 INFO - u'mozbase': [u'target.common.tests.zip'], 12:48:13 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 12:48:13 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 12:48:13 INFO - u'web-platform': [u'target.common.tests.zip', 12:48:13 INFO - u'target.web-platform.tests.tar.gz'], 12:48:13 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 12:48:13 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 12:48:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZsCq7lJfRZeT3aFCi1e-1Q/artifacts/public/build/target.common.tests.zip 12:48:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZsCq7lJfRZeT3aFCi1e-1Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:48:13 INFO - Fetch https://queue.taskcluster.net/v1/task/ZsCq7lJfRZeT3aFCi1e-1Q/artifacts/public/build/target.common.tests.zip into memory 12:48:15 INFO - Content-Length response header: 55180187 12:48:15 INFO - Bytes received: 55180187 12:48:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZsCq7lJfRZeT3aFCi1e-1Q/artifacts/public/build/target.talos.tests.zip 12:48:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZsCq7lJfRZeT3aFCi1e-1Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 12:48:25 INFO - Fetch https://queue.taskcluster.net/v1/task/ZsCq7lJfRZeT3aFCi1e-1Q/artifacts/public/build/target.talos.tests.zip into memory 12:48:27 INFO - Content-Length response header: 14509184 12:48:27 INFO - Bytes received: 14509184 12:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:27 INFO - trying https://queue.taskcluster.net/v1/task/ZsCq7lJfRZeT3aFCi1e-1Q/artifacts/public/build/target.tar.bz2 12:48:27 INFO - Downloading https://queue.taskcluster.net/v1/task/ZsCq7lJfRZeT3aFCi1e-1Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 12:48:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZsCq7lJfRZeT3aFCi1e-1Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 12:48:29 INFO - Downloaded 53545973 bytes. 12:48:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZsCq7lJfRZeT3aFCi1e-1Q/artifacts/public/build/target.tar.bz2 12:48:29 INFO - mkdir: /builds/slave/test/properties 12:48:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:48:29 INFO - Writing to file /builds/slave/test/properties/build_url 12:48:29 INFO - Contents: 12:48:29 INFO - build_url:https://queue.taskcluster.net/v1/task/ZsCq7lJfRZeT3aFCi1e-1Q/artifacts/public/build/target.tar.bz2 12:48:29 INFO - Running post-action listener: _resource_record_post_action 12:48:29 INFO - Running post-action listener: find_tests_for_verification 12:48:29 INFO - Running post-action listener: set_extra_try_arguments 12:48:29 INFO - [mozharness: 2017-09-26 19:48:29.654130Z] Finished download-and-extract step (success) 12:48:29 INFO - [mozharness: 2017-09-26 19:48:29.654243Z] Running populate-webroot step. 12:48:29 INFO - Running pre-action listener: _resource_record_pre_action 12:48:29 INFO - Running main action method: populate_webroot 12:48:29 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:48:29 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:48:29 INFO - 'tests': ['tresize', 12:48:29 INFO - 'tcanvasmark']}, 12:48:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:48:29 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:48:29 INFO - 'tests': ['dromaeo_css', 12:48:29 INFO - 'kraken']}, 12:48:29 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:48:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:48:29 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:48:29 INFO - 'talos_options': ['--disable-stylo'], 12:48:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:48:29 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:48:29 INFO - 'tests': ['damp', 'tps']}, 12:48:29 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:48:29 INFO - 'talos_options': ['--disable-stylo'], 12:48:29 INFO - 'tests': ['damp', 'tps']}, 12:48:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:48:29 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:48:29 INFO - 'tests': ['dromaeo_dom']}, 12:48:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 12:48:29 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:48:29 INFO - 'tests': ['basic_compositor_video', 12:48:29 INFO - 'glvideo']}, 12:48:29 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 12:48:29 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 12:48:29 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:48:29 INFO - 'talos_options': ['--disable-stylo'], 12:48:29 INFO - 'tests': ['ts_paint_webext', 12:48:29 INFO - 'tp5o_webext']}, 12:48:29 INFO - 'other-e10s': {'tests': ['a11yr', 12:48:29 INFO - 'ts_paint', 12:48:29 INFO - 'tpaint', 12:48:29 INFO - 'sessionrestore', 12:48:29 INFO - 'sessionrestore_many_windows', 12:48:29 INFO - 'sessionrestore_no_auto_restore', 12:48:29 INFO - 'tabpaint']}, 12:48:29 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:48:29 INFO - 'tests': ['a11yr', 12:48:29 INFO - 'ts_paint', 12:48:29 INFO - 'tpaint', 12:48:29 INFO - 'sessionrestore', 12:48:29 INFO - 'sessionrestore_many_windows', 12:48:29 INFO - 'sessionrestore_no_auto_restore', 12:48:29 INFO - 'tabpaint']}, 12:48:29 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 12:48:29 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 12:48:29 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:48:29 INFO - 'tests': ['perf_reftest_singletons']}, 12:48:29 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:48:29 INFO - 'tests': ['bloom_basic']}, 12:48:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:48:29 INFO - 'tsvgr_opacity', 12:48:29 INFO - 'tart', 12:48:29 INFO - 'tscrollx', 12:48:29 INFO - 'tsvg_static']}, 12:48:29 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:48:29 INFO - 'tests': ['tsvgx', 12:48:29 INFO - 'tsvgr_opacity', 12:48:29 INFO - 'tart', 12:48:29 INFO - 'tscrollx', 12:48:29 INFO - 'tsvg_static']}, 12:48:29 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:48:29 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:48:29 INFO - 'talos_options': ['--disable-stylo'], 12:48:29 INFO - 'tests': ['tp5o']}, 12:48:29 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:48:29 INFO - 'talos_options': ['--mitmproxy', 12:48:29 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:48:29 INFO - '--firstNonBlankPaint'], 12:48:29 INFO - 'tests': ['tp6_google', 12:48:29 INFO - 'tp6_youtube', 12:48:29 INFO - 'tp6_amazon', 12:48:29 INFO - 'tp6_facebook']}, 12:48:29 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:48:29 INFO - 'talos_options': ['--disable-stylo', 12:48:29 INFO - '--mitmproxy', 12:48:29 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:48:29 INFO - '--firstNonBlankPaint'], 12:48:29 INFO - 'tests': ['tp6_google', 12:48:29 INFO - 'tp6_youtube', 12:48:29 INFO - 'tp6_amazon', 12:48:29 INFO - 'tp6_facebook']}, 12:48:29 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:48:29 INFO - 'talos_options': ['--stylo-threads=1', 12:48:29 INFO - '--mitmproxy', 12:48:29 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:48:29 INFO - '--firstNonBlankPaint'], 12:48:29 INFO - 'tests': ['tp6_google', 12:48:29 INFO - 'tp6_youtube', 12:48:29 INFO - 'tp6_amazon', 12:48:29 INFO - 'tp6_facebook']}, 12:48:29 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:48:29 INFO - 'talos_options': ['--xperf_path', 12:48:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:48:29 INFO - 'tests': ['tp5n']}, 12:48:29 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:48:29 INFO - 'talos_options': ['--disable-stylo', 12:48:29 INFO - '--xperf_path', 12:48:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:48:29 INFO - 'tests': ['tp5n']}}} 12:48:29 INFO - Running post-action listener: _resource_record_post_action 12:48:29 INFO - [mozharness: 2017-09-26 19:48:29.669604Z] Finished populate-webroot step (success) 12:48:29 INFO - [mozharness: 2017-09-26 19:48:29.669693Z] Running create-virtualenv step. 12:48:29 INFO - Running pre-action listener: _resource_record_pre_action 12:48:29 INFO - Running main action method: create_virtualenv 12:48:29 INFO - Creating virtualenv /builds/slave/test/build/venv 12:48:29 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:48:29 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 12:48:29 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 12:48:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:48:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:48:30 INFO - Installing distribute.............................................................................................................................................................................................done. 12:48:30 INFO - Installing pip...............done. 12:48:30 INFO - Return code: 0 12:48:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:48:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:48:30 INFO - Reading from file tmpfile_stdout 12:48:30 INFO - Output received: 12:48:30 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 12:48:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:48:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1290a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1433a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1437090>, '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 0x1437d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1431f90>, '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': '32c5991c409366f7fec8a718000001d2-1506453887.278188-1175121432', '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 12:48:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:48:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:48:30 INFO - Using env: {'DISPLAY': ':0', 12:48:30 INFO - 'HOME': '/home/cltbld', 12:48:30 INFO - 'LANG': 'en_US.UTF-8', 12:48:30 INFO - 'LANGUAGE': 'en_US:en', 12:48:30 INFO - 'LOGNAME': 'cltbld', 12:48:30 INFO - 'MAIL': '/var/mail/cltbld', 12:48:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:30 INFO - 'MOZ_NO_REMOTE': '1', 12:48:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:30 INFO - 'NO_EM_RESTART': '1', 12:48:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:30 INFO - 'PWD': '/builds/slave/test', 12:48:30 INFO - 'SHELL': '/bin/bash', 12:48:30 INFO - 'SHLVL': '1', 12:48:30 INFO - 'TERM': 'linux', 12:48:30 INFO - 'TMOUT': '86400', 12:48:30 INFO - 'USER': 'cltbld', 12:48:30 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1506453887.278188-1175121432', 12:48:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:30 INFO - '_': '/tools/buildbot/bin/python'} 12:48:32 INFO - Ignoring indexes: http://pypi.python.org/simple/ 12:48:32 INFO - Downloading/unpacking pip>=1.5 12:48:32 INFO - Running setup.py egg_info for package pip 12:48:32 INFO - warning: no files found matching 'pip/cacert.pem' 12:48:32 INFO - warning: no files found matching '*.html' under directory 'docs' 12:48:32 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 12:48:32 INFO - no previously-included directories found matching 'docs/_build/_sources' 12:48:32 INFO - Installing collected packages: pip 12:48:32 INFO - Found existing installation: pip 1.1 12:48:32 INFO - Uninstalling pip: 12:48:32 INFO - Successfully uninstalled pip 12:48:32 INFO - Running setup.py install for pip 12:48:32 INFO - warning: no files found matching 'pip/cacert.pem' 12:48:32 INFO - warning: no files found matching '*.html' under directory 'docs' 12:48:32 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 12:48:32 INFO - no previously-included directories found matching 'docs/_build/_sources' 12:48:32 INFO - Installing pip script to /builds/slave/test/build/venv/bin 12:48:32 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 12:48:32 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 12:48:32 INFO - Successfully installed pip 12:48:32 INFO - Cleaning up... 12:48:32 INFO - Return code: 0 12:48:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:48:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1290a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1433a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1437090>, '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 0x1437d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1431f90>, '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': '32c5991c409366f7fec8a718000001d2-1506453887.278188-1175121432', '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 12:48:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:48:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:48:32 INFO - Using env: {'DISPLAY': ':0', 12:48:32 INFO - 'HOME': '/home/cltbld', 12:48:32 INFO - 'LANG': 'en_US.UTF-8', 12:48:32 INFO - 'LANGUAGE': 'en_US:en', 12:48:32 INFO - 'LOGNAME': 'cltbld', 12:48:32 INFO - 'MAIL': '/var/mail/cltbld', 12:48:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:32 INFO - 'MOZ_NO_REMOTE': '1', 12:48:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:32 INFO - 'NO_EM_RESTART': '1', 12:48:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:32 INFO - 'PWD': '/builds/slave/test', 12:48:32 INFO - 'SHELL': '/bin/bash', 12:48:32 INFO - 'SHLVL': '1', 12:48:32 INFO - 'TERM': 'linux', 12:48:32 INFO - 'TMOUT': '86400', 12:48:32 INFO - 'USER': 'cltbld', 12:48:32 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1506453887.278188-1175121432', 12:48:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:32 INFO - '_': '/tools/buildbot/bin/python'} 12:48:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:32 INFO - Downloading/unpacking psutil>=3.1.1 12:48:32 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 12:48:32 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 12:48:32 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 12:48:32 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 12:48:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:48:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:48:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:48:33 INFO - Installing collected packages: psutil 12:48:33 INFO - Running setup.py install for psutil 12:48:33 INFO - building 'psutil._psutil_linux' extension 12:48:33 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 12:48:33 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 12:48:33 INFO - building 'psutil._psutil_posix' extension 12:48:33 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 12:48:33 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 12:48:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:48:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:48:34 INFO - Successfully installed psutil 12:48:34 INFO - Cleaning up... 12:48:34 INFO - Return code: 0 12:48:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1290a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1433a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1437090>, '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 0x1437d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1431f90>, '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': '32c5991c409366f7fec8a718000001d2-1506453887.278188-1175121432', '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 12:48:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:48:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:48:34 INFO - Using env: {'DISPLAY': ':0', 12:48:34 INFO - 'HOME': '/home/cltbld', 12:48:34 INFO - 'LANG': 'en_US.UTF-8', 12:48:34 INFO - 'LANGUAGE': 'en_US:en', 12:48:34 INFO - 'LOGNAME': 'cltbld', 12:48:34 INFO - 'MAIL': '/var/mail/cltbld', 12:48:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:34 INFO - 'MOZ_NO_REMOTE': '1', 12:48:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:34 INFO - 'NO_EM_RESTART': '1', 12:48:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:34 INFO - 'PWD': '/builds/slave/test', 12:48:34 INFO - 'SHELL': '/bin/bash', 12:48:34 INFO - 'SHLVL': '1', 12:48:34 INFO - 'TERM': 'linux', 12:48:34 INFO - 'TMOUT': '86400', 12:48:34 INFO - 'USER': 'cltbld', 12:48:34 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1506453887.278188-1175121432', 12:48:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:34 INFO - '_': '/tools/buildbot/bin/python'} 12:48:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:48:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:48:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:48:36 INFO - Installing collected packages: mozsystemmonitor 12:48:36 INFO - Running setup.py install for mozsystemmonitor 12:48:36 INFO - Successfully installed mozsystemmonitor 12:48:36 INFO - Cleaning up... 12:48:37 INFO - Return code: 0 12:48:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:48:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1290a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1433a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1437090>, '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 0x1437d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1431f90>, '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': '32c5991c409366f7fec8a718000001d2-1506453887.278188-1175121432', '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 12:48:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:48:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:48:37 INFO - Using env: {'DISPLAY': ':0', 12:48:37 INFO - 'HOME': '/home/cltbld', 12:48:37 INFO - 'LANG': 'en_US.UTF-8', 12:48:37 INFO - 'LANGUAGE': 'en_US:en', 12:48:37 INFO - 'LOGNAME': 'cltbld', 12:48:37 INFO - 'MAIL': '/var/mail/cltbld', 12:48:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:37 INFO - 'MOZ_NO_REMOTE': '1', 12:48:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:37 INFO - 'NO_EM_RESTART': '1', 12:48:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:37 INFO - 'PWD': '/builds/slave/test', 12:48:37 INFO - 'SHELL': '/bin/bash', 12:48:37 INFO - 'SHLVL': '1', 12:48:37 INFO - 'TERM': 'linux', 12:48:37 INFO - 'TMOUT': '86400', 12:48:37 INFO - 'USER': 'cltbld', 12:48:37 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1506453887.278188-1175121432', 12:48:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:37 INFO - '_': '/tools/buildbot/bin/python'} 12:48:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:37 INFO - Downloading/unpacking jsonschema==2.5.1 12:48:37 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 12:48:37 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 12:48:37 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 12:48:37 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 12:48:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:48:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:38 INFO - Downloading functools32-3.2.3-2.tar.gz 12:48:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:48:39 INFO - warning: no files found matching '*.txt' 12:48:39 INFO - no previously-included directories found matching 'build' 12:48:39 INFO - no previously-included directories found matching 'dist' 12:48:39 INFO - no previously-included directories found matching '.git*' 12:48:39 INFO - Installing collected packages: jsonschema, functools32 12:48:39 INFO - Running setup.py install for functools32 12:48:39 INFO - warning: no files found matching '*.txt' 12:48:39 INFO - no previously-included directories found matching 'build' 12:48:39 INFO - no previously-included directories found matching 'dist' 12:48:39 INFO - no previously-included directories found matching '.git*' 12:48:39 INFO - Successfully installed jsonschema functools32 12:48:39 INFO - Cleaning up... 12:48:39 INFO - Return code: 0 12:48:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:48:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:39 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 0x10c81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1290a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1433a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1437090>, '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 0x1437d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1431f90>, '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': '32c5991c409366f7fec8a718000001d2-1506453887.278188-1175121432', '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 12:48:39 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 12:48:39 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 12:48:39 INFO - Using env: {'DISPLAY': ':0', 12:48:39 INFO - 'HOME': '/home/cltbld', 12:48:39 INFO - 'LANG': 'en_US.UTF-8', 12:48:39 INFO - 'LANGUAGE': 'en_US:en', 12:48:39 INFO - 'LOGNAME': 'cltbld', 12:48:39 INFO - 'MAIL': '/var/mail/cltbld', 12:48:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:39 INFO - 'MOZ_NO_REMOTE': '1', 12:48:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:39 INFO - 'NO_EM_RESTART': '1', 12:48:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:39 INFO - 'PWD': '/builds/slave/test', 12:48:39 INFO - 'SHELL': '/bin/bash', 12:48:39 INFO - 'SHLVL': '1', 12:48:39 INFO - 'TERM': 'linux', 12:48:39 INFO - 'TMOUT': '86400', 12:48:39 INFO - 'USER': 'cltbld', 12:48:39 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1506453887.278188-1175121432', 12:48:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:39 INFO - '_': '/tools/buildbot/bin/python'} 12:48:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:48:39 INFO - Cleaning up... 12:48:39 INFO - Return code: 0 12:48:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:48:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:48:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:39 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 0x10c81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1290a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1433a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1437090>, '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 0x1437d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1431f90>, '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': '32c5991c409366f7fec8a718000001d2-1506453887.278188-1175121432', '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 12:48:39 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 12:48:39 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 12:48:39 INFO - Using env: {'DISPLAY': ':0', 12:48:39 INFO - 'HOME': '/home/cltbld', 12:48:39 INFO - 'LANG': 'en_US.UTF-8', 12:48:39 INFO - 'LANGUAGE': 'en_US:en', 12:48:39 INFO - 'LOGNAME': 'cltbld', 12:48:39 INFO - 'MAIL': '/var/mail/cltbld', 12:48:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:39 INFO - 'MOZ_NO_REMOTE': '1', 12:48:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:39 INFO - 'NO_EM_RESTART': '1', 12:48:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:39 INFO - 'PWD': '/builds/slave/test', 12:48:39 INFO - 'SHELL': '/bin/bash', 12:48:39 INFO - 'SHLVL': '1', 12:48:39 INFO - 'TERM': 'linux', 12:48:39 INFO - 'TMOUT': '86400', 12:48:39 INFO - 'USER': 'cltbld', 12:48:39 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1506453887.278188-1175121432', 12:48:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:39 INFO - '_': '/tools/buildbot/bin/python'} 12:48:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:39 INFO - Downloading/unpacking blobuploader==1.2.4 12:48:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:40 INFO - Downloading blobuploader-1.2.4.tar.gz 12:48:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:48:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:48:40 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 12:48:40 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 12:48:40 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 12:48:40 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 12:48:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:48:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:48:41 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 12:48:41 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 12:48:41 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 12:48:41 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 12:48:41 INFO - Downloading docopt-0.6.1.tar.gz 12:48:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:48:41 INFO - Installing collected packages: blobuploader, requests, docopt 12:48:41 INFO - Running setup.py install for blobuploader 12:48:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:48:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:48:41 INFO - Running setup.py install for requests 12:48:41 INFO - Running setup.py install for docopt 12:48:41 INFO - Successfully installed blobuploader requests docopt 12:48:41 INFO - Cleaning up... 12:48:41 INFO - Return code: 0 12:48:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:48:41 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')]} 12:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:41 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')]} 12:48:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:41 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 0x10c81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1290a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1433a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1437090>, '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 0x1437d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1431f90>, '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': '32c5991c409366f7fec8a718000001d2-1506453887.278188-1175121432', '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 12:48:41 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 12:48:41 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 12:48:41 INFO - Using env: {'DISPLAY': ':0', 12:48:41 INFO - 'HOME': '/home/cltbld', 12:48:41 INFO - 'LANG': 'en_US.UTF-8', 12:48:41 INFO - 'LANGUAGE': 'en_US:en', 12:48:41 INFO - 'LOGNAME': 'cltbld', 12:48:41 INFO - 'MAIL': '/var/mail/cltbld', 12:48:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:41 INFO - 'MOZ_NO_REMOTE': '1', 12:48:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:41 INFO - 'NO_EM_RESTART': '1', 12:48:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:41 INFO - 'PWD': '/builds/slave/test', 12:48:41 INFO - 'SHELL': '/bin/bash', 12:48:41 INFO - 'SHLVL': '1', 12:48:41 INFO - 'TERM': 'linux', 12:48:41 INFO - 'TMOUT': '86400', 12:48:41 INFO - 'USER': 'cltbld', 12:48:41 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1506453887.278188-1175121432', 12:48:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:41 INFO - '_': '/tools/buildbot/bin/python'} 12:48:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:48:42 INFO - Running setup.py (path:/tmp/pip-ySAhRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:48:42 INFO - Running setup.py (path:/tmp/pip-QO4V_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:48:42 INFO - Running setup.py (path:/tmp/pip-HsJ7_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:48:42 INFO - Running setup.py (path:/tmp/pip-Xfgt8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:48:42 INFO - Running setup.py (path:/tmp/pip-ck69Pc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:48:42 INFO - Running setup.py (path:/tmp/pip-XBFUaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:48:42 INFO - Running setup.py (path:/tmp/pip-qafpRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:48:42 INFO - Running setup.py (path:/tmp/pip-w_4iFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:48:42 INFO - Running setup.py (path:/tmp/pip-DmCU6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:48:42 INFO - Running setup.py (path:/tmp/pip-37GPqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:48:42 INFO - Running setup.py (path:/tmp/pip-SJdsRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:48:42 INFO - Running setup.py (path:/tmp/pip-YTwTHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:48:43 INFO - Running setup.py (path:/tmp/pip-w1QdgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:48:43 INFO - Running setup.py (path:/tmp/pip-ZWRa31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:48:43 INFO - Running setup.py (path:/tmp/pip-KLgw2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:48:43 INFO - Running setup.py (path:/tmp/pip-Inb6RK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:48:43 INFO - Running setup.py (path:/tmp/pip-XJxB6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:48:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:48:43 INFO - Running setup.py install for manifestparser 12:48:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:48:43 INFO - Running setup.py install for mozcrash 12:48:43 INFO - Running setup.py install for mozdebug 12:48:43 INFO - Running setup.py install for mozdevice 12:48:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:48:43 INFO - Running setup.py install for mozfile 12:48:43 INFO - Running setup.py install for mozhttpd 12:48:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:48:43 INFO - Running setup.py install for mozinfo 12:48:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:48:44 INFO - Running setup.py install for mozInstall 12:48:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:48:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:48:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:48:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:48:44 INFO - Running setup.py install for mozleak 12:48:44 INFO - Running setup.py install for mozlog 12:48:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:48:44 INFO - Running setup.py install for moznetwork 12:48:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:48:44 INFO - Running setup.py install for mozprocess 12:48:44 INFO - Running setup.py install for mozprofile 12:48:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:48:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:48:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:48:44 INFO - Running setup.py install for mozrunner 12:48:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:48:44 INFO - Running setup.py install for mozscreenshot 12:48:44 INFO - Running setup.py install for moztest 12:48:45 INFO - Running setup.py install for mozversion 12:48:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:48:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:48:45 INFO - Cleaning up... 12:48:45 INFO - Return code: 0 12:48:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:48: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')]} 12:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48: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')]} 12:48:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:45 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 0x10c81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1290a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1433a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1437090>, '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 0x1437d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1431f90>, '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': '32c5991c409366f7fec8a718000001d2-1506453887.278188-1175121432', '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 12:48:45 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 12:48:45 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 12:48:45 INFO - Using env: {'DISPLAY': ':0', 12:48:45 INFO - 'HOME': '/home/cltbld', 12:48:45 INFO - 'LANG': 'en_US.UTF-8', 12:48:45 INFO - 'LANGUAGE': 'en_US:en', 12:48:45 INFO - 'LOGNAME': 'cltbld', 12:48:45 INFO - 'MAIL': '/var/mail/cltbld', 12:48:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:45 INFO - 'MOZ_NO_REMOTE': '1', 12:48:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:45 INFO - 'NO_EM_RESTART': '1', 12:48:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:45 INFO - 'PWD': '/builds/slave/test', 12:48:45 INFO - 'SHELL': '/bin/bash', 12:48:45 INFO - 'SHLVL': '1', 12:48:45 INFO - 'TERM': 'linux', 12:48:45 INFO - 'TMOUT': '86400', 12:48:45 INFO - 'USER': 'cltbld', 12:48:45 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1506453887.278188-1175121432', 12:48:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:45 INFO - '_': '/tools/buildbot/bin/python'} 12:48:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:48:45 INFO - Running setup.py (path:/tmp/pip-GcmHq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:48:45 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)) 12:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:48:45 INFO - Running setup.py (path:/tmp/pip-oPQqm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:48:45 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)) 12:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:48:45 INFO - Running setup.py (path:/tmp/pip-3rvcaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:48:45 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)) 12:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:48:45 INFO - Running setup.py (path:/tmp/pip-UNgaFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:48:45 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)) 12:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:48:45 INFO - Running setup.py (path:/tmp/pip-9VN6w6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:48:45 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)) 12:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:48:45 INFO - Running setup.py (path:/tmp/pip-vnhK3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:48:45 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)) 12:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:48:45 INFO - Running setup.py (path:/tmp/pip-_vBveO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:48:45 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)) 12:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:48:45 INFO - Running setup.py (path:/tmp/pip-6CtTKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:48:45 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)) 12:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:48:45 INFO - Running setup.py (path:/tmp/pip-oLqAJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:48:46 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)) 12:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:48:46 INFO - Running setup.py (path:/tmp/pip-HFPbFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:48:46 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)) 12:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:48:46 INFO - Running setup.py (path:/tmp/pip-qf0Ect-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:48:46 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)) 12:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:48:46 INFO - Running setup.py (path:/tmp/pip-PsKVqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:48:46 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)) 12:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:48:46 INFO - Running setup.py (path:/tmp/pip-TMMoib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:48:46 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)) 12:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:48:46 INFO - Running setup.py (path:/tmp/pip-6UidMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:48:46 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)) 12:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:48:46 INFO - Running setup.py (path:/tmp/pip-1_wtTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:48:46 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)) 12:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:48:46 INFO - Running setup.py (path:/tmp/pip-eVlAva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:48:46 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)) 12:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:48:46 INFO - Running setup.py (path:/tmp/pip-fcw6Nj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:48:46 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)) 12:48:46 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)) 12:48:46 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)) 12:48:46 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)) 12:48:46 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)) 12:48:46 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)) 12:48:46 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)) 12:48:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:48: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 12:48: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 12:48: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 12:48: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 12:48:47 INFO - Downloading blessings-1.6.tar.gz 12:48:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:48:47 INFO - Installing collected packages: blessings 12:48:47 INFO - Running setup.py install for blessings 12:48:47 INFO - Successfully installed blessings 12:48:47 INFO - Cleaning up... 12:48:47 INFO - Return code: 0 12:48:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:48:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:48:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:48:48 INFO - Reading from file tmpfile_stdout 12:48:48 INFO - Current package versions: 12:48:48 INFO - argparse == 1.2.1 12:48:48 INFO - blessings == 1.6 12:48:48 INFO - blobuploader == 1.2.4 12:48:48 INFO - docopt == 0.6.1 12:48:48 INFO - functools32 == 3.2.3-2 12:48:48 INFO - jsonschema == 2.5.1 12:48:48 INFO - manifestparser == 1.1 12:48:48 INFO - mozInstall == 1.13 12:48:48 INFO - mozcrash == 1.0 12:48:48 INFO - mozdebug == 0.1 12:48:48 INFO - mozdevice == 0.51 12:48:48 INFO - mozfile == 1.2 12:48:48 INFO - mozhttpd == 0.7 12:48:48 INFO - mozinfo == 0.10 12:48:48 INFO - mozleak == 0.1 12:48:48 INFO - mozlog == 3.5 12:48:48 INFO - moznetwork == 0.27 12:48:48 INFO - mozprocess == 0.25 12:48:48 INFO - mozprofile == 0.28 12:48:48 INFO - mozrunner == 6.13 12:48:48 INFO - mozscreenshot == 0.1 12:48:48 INFO - mozsystemmonitor == 0.3 12:48:48 INFO - moztest == 0.8 12:48:48 INFO - mozversion == 1.4 12:48:48 INFO - psutil == 3.1.1 12:48:48 INFO - requests == 1.2.3 12:48:48 INFO - wsgiref == 0.1.2 12:48:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:48: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')]} 12:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48: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')]} 12:48:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:48 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 0x10c81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1290a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1433a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1437090>, '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 0x1437d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1431f90>, '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': '32c5991c409366f7fec8a718000001d2-1506453887.278188-1175121432', '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 12:48:48 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 12:48:48 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 12:48:48 INFO - Using env: {'DISPLAY': ':0', 12:48:48 INFO - 'HOME': '/home/cltbld', 12:48:48 INFO - 'LANG': 'en_US.UTF-8', 12:48:48 INFO - 'LANGUAGE': 'en_US:en', 12:48:48 INFO - 'LOGNAME': 'cltbld', 12:48:48 INFO - 'MAIL': '/var/mail/cltbld', 12:48:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:48 INFO - 'MOZ_NO_REMOTE': '1', 12:48:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:48 INFO - 'NO_EM_RESTART': '1', 12:48:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:48 INFO - 'PWD': '/builds/slave/test', 12:48:48 INFO - 'SHELL': '/bin/bash', 12:48:48 INFO - 'SHLVL': '1', 12:48:48 INFO - 'TERM': 'linux', 12:48:48 INFO - 'TMOUT': '86400', 12:48:48 INFO - 'USER': 'cltbld', 12:48:48 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1506453887.278188-1175121432', 12:48:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:48 INFO - '_': '/tools/buildbot/bin/python'} 12:48:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:48 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)) 12:48:48 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)) 12:48:48 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)) 12:48:48 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)) 12:48:48 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)) 12:48:48 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)) 12:48:48 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)) 12:48:48 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)) 12:48:48 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)) 12:48:48 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 12:48: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 12:48: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 12:48: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 12:48: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 12:48:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 12:48:49 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)) 12:48:49 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)) 12:48:49 INFO - Installing collected packages: simplejson 12:48:49 INFO - Running setup.py install for simplejson 12:48:49 INFO - building 'simplejson._speedups' extension 12:48:49 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 12:48:50 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 12:48:50 INFO - Successfully installed simplejson 12:48:50 INFO - Cleaning up... 12:48:50 INFO - Return code: 0 12:48:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:48: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')]} 12:48:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48: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')]} 12:48:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1290a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1433a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1437090>, '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 0x1437d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1431f90>, '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': '32c5991c409366f7fec8a718000001d2-1506453887.278188-1175121432', '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 12:48: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'] in /builds/slave/test/build 12:48: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 12:48:50 INFO - Using env: {'DISPLAY': ':0', 12:48:50 INFO - 'HOME': '/home/cltbld', 12:48:50 INFO - 'LANG': 'en_US.UTF-8', 12:48:50 INFO - 'LANGUAGE': 'en_US:en', 12:48:50 INFO - 'LOGNAME': 'cltbld', 12:48:50 INFO - 'MAIL': '/var/mail/cltbld', 12:48:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:50 INFO - 'MOZ_NO_REMOTE': '1', 12:48:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:50 INFO - 'NO_EM_RESTART': '1', 12:48:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:50 INFO - 'PWD': '/builds/slave/test', 12:48:50 INFO - 'SHELL': '/bin/bash', 12:48:50 INFO - 'SHLVL': '1', 12:48:50 INFO - 'TERM': 'linux', 12:48:50 INFO - 'TMOUT': '86400', 12:48:50 INFO - 'USER': 'cltbld', 12:48:50 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1506453887.278188-1175121432', 12:48:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:50 INFO - '_': '/tools/buildbot/bin/python'} 12:48:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:48:50 INFO - Cleaning up... 12:48:50 INFO - Return code: 0 12:48:50 INFO - Running post-action listener: _resource_record_post_action 12:48:50 INFO - Running post-action listener: _start_resource_monitoring 12:48:50 INFO - Starting resource monitoring. 12:48:50 INFO - [mozharness: 2017-09-26 19:48:50.862975Z] Finished create-virtualenv step (success) 12:48:50 INFO - [mozharness: 2017-09-26 19:48:50.863495Z] Running install step. 12:48:50 INFO - Running pre-action listener: _resource_record_pre_action 12:48:50 INFO - Running main action method: install 12:48:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:48:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:48:51 INFO - Reading from file tmpfile_stdout 12:48:51 INFO - Detecting whether we're running mozinstall >=1.0... 12:48:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:48:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:48:51 INFO - Reading from file tmpfile_stdout 12:48:51 INFO - Output received: 12:48:51 INFO - Usage: mozinstall [options] installer 12:48:51 INFO - Options: 12:48:51 INFO - -h, --help show this help message and exit 12:48:51 INFO - -d DEST, --destination=DEST 12:48:51 INFO - Directory to install application into. [default: 12:48:51 INFO - "/builds/slave/test"] 12:48:51 INFO - --app=APP Application being installed. [default: firefox] 12:48:51 INFO - mkdir: /builds/slave/test/build/application 12:48:51 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'] 12:48:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 12:49:05 INFO - Reading from file tmpfile_stdout 12:49:05 INFO - Output received: 12:49:05 INFO - /builds/slave/test/build/application/firefox/firefox 12:49:05 INFO - Running post-action listener: _resource_record_post_action 12:49:05 INFO - [mozharness: 2017-09-26 19:49:05.853299Z] Finished install step (success) 12:49:05 INFO - [mozharness: 2017-09-26 19:49:05.853551Z] Running setup-mitmproxy step. 12:49:05 INFO - Running pre-action listener: _resource_record_pre_action 12:49:05 INFO - Running main action method: setup_mitmproxy 12:49:05 INFO - Skipping: mitmproxy is not required 12:49:05 INFO - Running post-action listener: _resource_record_post_action 12:49:05 INFO - [mozharness: 2017-09-26 19:49:05.854666Z] Finished setup-mitmproxy step (success) 12:49:05 INFO - [mozharness: 2017-09-26 19:49:05.854885Z] Running run-tests step. 12:49:05 INFO - Running pre-action listener: _resource_record_pre_action 12:49:05 INFO - Running pre-action listener: _set_gcov_prefix 12:49:05 INFO - Running main action method: run_tests 12:49:05 WARNING - Try message not found. 12:49:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:49:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:49:05 INFO - Python 2.7.3 12:49:05 INFO - Return code: 0 12:49:05 INFO - grabbing minidump binary from tooltool 12:49:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:49:05 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 0x1437090>, '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 0x1437d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1431f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:49:05 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 12:49:05 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 12:49:05 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 12:49:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:49:05 INFO - Return code: 0 12:49:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:49:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:49:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:49:05 INFO - ENV: RUST_BACKTRACE is now full 12:49:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:49:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:49:05 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/ZsCq7lJfRZeT3aFCi1e-1Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 12:49:05 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/ZsCq7lJfRZeT3aFCi1e-1Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 12:49:05 INFO - Using env: {'DISPLAY': ':0', 12:49:05 INFO - 'HOME': '/home/cltbld', 12:49:05 INFO - 'LANG': 'en_US.UTF-8', 12:49:05 INFO - 'LANGUAGE': 'en_US:en', 12:49:05 INFO - 'LOGNAME': 'cltbld', 12:49:05 INFO - 'MAIL': '/var/mail/cltbld', 12:49:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:49:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:49:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:05 INFO - 'MOZ_NO_REMOTE': '1', 12:49:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:49:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:49:05 INFO - 'NO_EM_RESTART': '1', 12:49:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:49:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:49:05 INFO - 'PWD': '/builds/slave/test', 12:49:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:49:05 INFO - 'RUST_BACKTRACE': 'full', 12:49:05 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:49:05 INFO - 'SHELL': '/bin/bash', 12:49:05 INFO - 'SHLVL': '1', 12:49:05 INFO - 'TERM': 'linux', 12:49:05 INFO - 'TMOUT': '86400', 12:49:05 INFO - 'USER': 'cltbld', 12:49:05 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1506453887.278188-1175121432', 12:49:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:05 INFO - '_': '/tools/buildbot/bin/python'} 12:49:05 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/ZsCq7lJfRZeT3aFCi1e-1Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 12:49:06 INFO - mozversion application_buildid: 20170926182739 12:49:06 INFO - mozversion application_changeset: 0bbec589b1fe446103b259b32818a8c3bba0d400 12:49:06 INFO - mozversion application_display_name: Firefox 12:49:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:49:06 INFO - mozversion application_name: Firefox 12:49:06 INFO - mozversion application_remotingname: firefox 12:49:06 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:49:06 INFO - mozversion application_vendor: Mozilla 12:49:06 INFO - mozversion application_version: 57.0 12:49:06 INFO - mozversion platform_buildid: 20170926182739 12:49:06 INFO - mozversion platform_changeset: 0bbec589b1fe446103b259b32818a8c3bba0d400 12:49:06 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:49:06 INFO - mozversion platform_version: 57.0 12:49:06 INFO - using testdate: 1506455346 12:49:06 INFO - actual date: 1506455346 12:49:06 INFO - starting webserver on 'localhost:55644' 12:49:06 INFO - SUITE-START | Running 2 tests 12:49:06 INFO - TEST-START | dromaeo_css 12:49:06 INFO - Initialising browser for dromaeo_css test... 12:49:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55644/getInfo.html -profile /tmp/tmpf0vI1V/profile 12:49:06 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/firefox/firefox http://localhost:55644/getInfo.html) 12:49:11 INFO - TEST-INFO | 1647: exit 0 12:49:11 INFO - Browser initialized. 12:49:11 INFO - Running cycle 1/1 for dromaeo_css test... 12:49:11 INFO - Using env: {'DISPLAY': ':0', 12:49:11 INFO - 'HOME': '/home/cltbld', 12:49:11 INFO - 'JSGC_DISABLE_POISONING': '1', 12:49:11 INFO - 'LANG': 'en_US.UTF-8', 12:49:11 INFO - 'LANGUAGE': 'en_US:en', 12:49:11 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 12:49:11 INFO - 'LOGNAME': 'cltbld', 12:49:11 INFO - 'MAIL': '/var/mail/cltbld', 12:49:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:49:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:49:11 INFO - 'MOZ_CRASHREPORTER': '1', 12:49:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:11 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 12:49:11 INFO - 'MOZ_NO_REMOTE': '1', 12:49:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:49:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:49:11 INFO - 'NO_EM_RESTART': '1', 12:49:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:49:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:49:11 INFO - 'PWD': '/builds/slave/test', 12:49:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:49:11 INFO - 'RUST_BACKTRACE': 'full', 12:49:11 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:49:11 INFO - 'SHELL': '/bin/bash', 12:49:11 INFO - 'SHLVL': '1', 12:49:11 INFO - 'TERM': 'linux', 12:49:11 INFO - 'TMOUT': '86400', 12:49:11 INFO - 'USER': 'cltbld', 12:49:11 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1506453887.278188-1175121432', 12:49:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:11 INFO - '_': '/tools/buildbot/bin/python'} 12:49:11 INFO - TEST-INFO | started process 1835 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf0vI1V/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:49:12 INFO - PID 1835 | 12:49:12 INFO - PID 1835 | (/builds/slave/test/build/application/firefox/firefox:1883): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:49:12 INFO - PID 1835 | 12:49:22 INFO - PID 1835 | RSS: Main: 140742656 12:49:22 INFO - PID 1835 | 12:52:19 INFO - PID 1835 | Cycle 1(1): loaded http://localhost:55644/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55644/tests/dromaeo/cssquery-ext.html) 12:52:20 INFO - PID 1835 | RSS: Main: 145035264 12:52:20 INFO - PID 1835 | 12:55:22 INFO - PID 1835 | Cycle 1(1): loaded http://localhost:55644/tests/dromaeo/cssquery-ext.html (next: http://localhost:55644/tests/dromaeo/cssquery-jquery.html) 12:55:22 INFO - PID 1835 | RSS: Main: 143523840 12:55:22 INFO - PID 1835 | 12:58:24 INFO - PID 1835 | Cycle 1(1): loaded http://localhost:55644/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55644/tests/dromaeo/cssquery-mootools.html) 12:58:24 INFO - PID 1835 | RSS: Main: 144728064 12:58:24 INFO - PID 1835 | 13:01:26 INFO - PID 1835 | Cycle 1(1): loaded http://localhost:55644/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55644/tests/dromaeo/cssquery-prototype.html) 13:01:26 INFO - PID 1835 | RSS: Main: 143937536 13:01:26 INFO - PID 1835 | 13:04:29 INFO - PID 1835 | Cycle 1(1): loaded http://localhost:55644/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55644/tests/dromaeo/cssquery-yui.html) 13:04:30 INFO - PID 1835 | RSS: Main: 145690624 13:04:30 INFO - PID 1835 | 13:07:31 INFO - PID 1835 | Cycle 1(1): loaded http://localhost:55644/tests/dromaeo/cssquery-yui.html (next: http://localhost:55644/tests/dromaeo/cssquery-dojo.html) 13:07:31 INFO - PID 1835 | RSS: Main: 148754432 13:07:31 INFO - PID 1835 | 13:07:31 INFO - PID 1835 | __start_tp_report 13:07:31 INFO - PID 1835 | _x_x_mozilla_page_load 13:07:31 INFO - PID 1835 | _x_x_mozilla_page_load_details 13:07:31 INFO - PID 1835 | |i|pagename|runs| 13:07:31 INFO - PID 1835 | |0;dojo.html;3907.218556288742;3911.2959667259884;3912.217556488702;3925.666318362939;3934.606539346064;6542.869142617156;6557.573757705752;6574.112494813205;6638.037484564735;6673.799786006415;6580.243272023718;6594.703238354274;6597.81239376912;6677.5325727199115;6684.1978962524445;5814.680192589406;5919.556033297498;5921.940780592182;5923.437273459014;5979.491743201833;5826.9708651456895;5862.20860183874;5900.203472531218;5950.70246487676;5990.550708696844;5951.58338916276;6006.639601623917;6009.87980240395;6022.8795424091495;6050.546209034318;5877.882442351129;5940.732667029994;5949.494292985101;6033.366496517846;6063.18147050147;5789.797357092523;5829.766809327622;5887.293524777054;5896.882062358772;5933.9406605934255;6404.295527491972;6532.608043517404;6549.0503876938055;6561.606303621798;6650.866982660368;7063.293670632947;7064.505484616079;7067.081279433641;7168.60572668503;7189.245129261404;7152.642367881585;7210.855782884365;7218.061651985261;7241.601711905896;7257.201707812136;6537.117489138953;6600.966995165041;6607.80176594703;6621.33786621334;6643.468522518236;7276.163241227221;7318.451116166309;7403.925960740431;7404.96297518509;7434.962825185839;6934;6992.370686638227;7015.543989640657;7061.152661680529;7078.929210707827;7005.439564834801;7093.1488221413765;7118;7127.643617819088;7148.035015272975;7118.394936430462;7129.60787156701;7144.392726618192;7144.642767861586;7164.498485105993;7009.894851577231;7030.9296907030275;7041.401480874183;7043.612601306875;7136.607486588287;5202.947970520322;5258.3689957204615;5268.841934741964;5328.3605967284175;5336.119540275811;4752.382190315306;4844.806207751721;4857.392825896763;4859.659823812299;4888.169011268093;6530.412262896362;6554.246261679872;6608.041833934052;6634.900476492857;6636.668166591651;6915.930840691629;7045;7151.678174482161;7160.10498687664;7165.462590305644;6470.255920569195;6535.215774107138;6554.344565543408;6607.537472376984;6627.204735431779;5938.8812223755285;5992.041273396323;5997.580169388101;5997.790077347272;6026;7334.413246940232;7345.816354591178;7382.409407247407;7469.402447804163;7483.289087536676;6979.755708550177;7047.788566343018;7059.011738356531;7123.180834204133;7152.141742990771;7392.778216653509;7451.478396512192;7462.514936529108;7492.887606686013;7494.250574942462;6877.862442751217;6940.618265995418;7032.437405007689;7052.400545953651;7059.117610298713;6987.895181572178;7055.506114572136;7057.258987806206;7057.50597458173;7060.293970602898;6812.012258222431;6887.552309099892;6924.134483189601;6938.271481494572;6950.513464057467;6867.656617169022;6882.414994725505;6885.655717214019;6949.895751563629;6970.51206415546;6712.731490740511;6822.829429264308;6826.726930922708;6903.447724181953;6915.792526224222;6869.175698916162;6885.242623311332;6904.378605925491;6931.4108300795;6945.305469453015;6627.23786764509;6630.204375474974;6728.192616886005;6741.157355330583;6746.595204287759 13:07:31 INFO - PID 1835 | |1;ext.html;985.1822986920856;1006.783541538569;1008.1279693065501;1010.7624708193574;1042.244372829698;46079.76960115199;46346;46861.531384686146;46869.531304686985;47065.76467117668;47169.52830471694;47635.285470717965;47744.28383574249;47765.76117119418;47772.52227477724;8857.822843543141;9018.774530636754;9021.097890210993;9024.819503609924;9045.321600879928;8924.509151996637;9009.099090090971;9038.954805225965;9039.41243819153;9046.321525885553;8958.596863141142;9077.95461022694;9099.135582119721;9112.498812565307;9113.68102116426;8960.462372257653;8979.551022448884;9008.549572521413;9012.459252444809;9019.639214431414;8737.825243495157;8777.473351598925;8779.122087791233;8788.736337909873;8789.868151977726;42360;42702.57297427017;42808.571914281085;42855.57144428547;43135.137297254194;3780.773153610792;3810.371288737355;3812.5234345706785;3813.561440434358;3813.9618603813883;35511.28977420437;35528.64471355279;35716.285674286366;35849.10377240564;35852.64147358545;5594.608377413582;5646.576506761969;5654.180143879155;5697.658140511541;5769.653820770767;241643;241724;241845;242322.7883860587;242761;53769;54112;54217;54275;56359.71820140873;59295.70352148298;59655;59693.40306596965;59695.10457343143;59705.70147149323;19144.712829307573;19282;19290.517737056685;19299.131539080776;19306.71039934402;15809.13049782273;15821;15832.28754706018;15878.841211587967;15951.282192301374;16047.277872495766;16190.43333483346;16293.755593666105;16296.26666799997;16334.264958076677;6187.938120618736;6222.719977601018;6270;6286.8428289292215;6292.779752708633;1128.2891778179858;1141.1327391182595;1141.6061458796703;1144.5650652751901;1148.2995372822572;25485;26790.464190716077;26855.86572067127;26916.59625105625;27098.864505677346;1253.6364454308332;1258.314218750783;1260.7982722764314;1261.6971926737701;1272.840894888139;14280.714385712228;14294.928525357307;14360.353784079742;14371.2095834728;14373.6406589834;329614;338492;342343;345136;346924;67778;68183.97724034144;68238.31761682419;68291.3170868285;68363.31636683669;1535.0405996252343;1559.2827299442156;1559.8440155984538;1563.6169138561124;1601.223406647775;31254;31907.840460797546;31944.68055319417;32146.678533215305;32552.34895302128;43847.34228986631;44086.33870492009;44097.55902440935;44108.779456103795;44135.33796993112;276895;279610;280800;280889;282004;39067.80466097765;39962.80018599889;40174.1965160701;40241;40604.79697601493;47564.2865357013;48882.5111748878;49162.75418622884;49199;49535.25697114474;35371;36052.4592131113;36233;36266.8186659065;36658.45012324764;35873;35919.461208081375;36336.45495317625;36517.45223821698;36552;41491.58508414998;42643.57356426396;42648.78675606602;42748;42863.78568107139;34989;35600.64399355973;35617.10957225986;35671.82164089163;35693.62507156507;25447.61828572536;25804.35489112787;26579.734202657724;26707.33231669224;26848.865755671097 13:07:31 INFO - PID 1835 | |2;jquery.html;643.0773891839857;651.6467221773132;651.7760152378686;653.2623222228871;656.9816783984826;24513;25204.243872683826;25403;25462.363440913985;25474.74525254749;26977.190684279452;27460.450790984167;27542.311442213955;27594.862025689843;27597.862010689918;6397.776077837265;6844.041834143224;6894.345037221456;6901.309869013109;6909.205441374231;6741.056252124707;6823.931760682404;6831.351021652935;6850.794476165723;6854.280300568444;6800.727970881158;6802.183737951428;6813.250542440353;7057.964710176442;7110.893336599956;7003.964980175092;7046.436285097231;7046.942958556207;7057.258987806309;7065.788026359218;6573;6579;6588.637624930627;6593;6598.538102332838;29742.70257297421;30729.846350768326;31130.221744456343;31499.685003149905;31755.523667144782;2402.9787340380267;2410.602250628644;2411.9155829546057;2412.32454912623;2412.4089598048413;19867.701984470244;20438;20439.693404598944;20487.795122048738;20490.18039278427;2374.3826605082804;2379.9643005354933;2606.3614414468575;2661.308059904439;2690.5426077566863;141212;148425.25787371103;169484;175103.12448437803;175463;16220.918895405448;16628.501144965427;16881.662366752596;17214.913925430545;17438.56403589895;27604;27623.723762762114;27713.58429623557;27763.167104986882;27790.86104569505;11630.476628551736;11722.120840936965;11743.11926605508;11855.46650400734;11887.583934562248;10863.51114199863;10906.454677266263;10955.780884382268;11004.779904402027;11007.889921100686;10114.190864730952;10193.286469947181;10328.845067323997;10447.425391603534;10543.578256869792;2883.5489833641655;2931.5749216363506;2931.9706802931696;2940.588317635533;3028.212664707192;1071.5767271927546;1079.0558261521169;1091.1979694924225;1092.4319353936069;1092.6721983404946;21942.670859937112;22191.556168876534;22288.219912302993;22327.330180094625;22556.54886902253;1138.7494751154732;1178.6287319494331;1181.167277069681;1185.6324539392815;1197.4192516629428;12283.324417156964;12295.016398688083;12306.81539776904;12326.876731232753;12500.74998500025;609287;617002;650086;661304;666478;140537.29731351277;142427;142978;147290;147831;1268.6638040919163;1294.9546765863338;1329.9933500332436;1345.7712188927906;1352.8444228913604;19034.52413689669;19423.611527769084;19590.314338998065;19644.80355196487;19914.800851991295;62579.37420625918;63556;64316.67841660762;64996.350036500924;65946.99999999808;80463;80967;81088;81404;81829.18170818454;15862.52412427629;16189.514314570582;16369.345226190819;16546.83453165501;16573.58566035859;24697.629535557342;25010.37474063163;25024;25121.49757004886;25187.24438266855;20114.497137571678;20154.69767953511;20228.292009779587;20311.390658280274;20700.79299207049;17826.821731783035;18166.72749908726;18330.617019787343;18479.260829567203;18498.35255766042;20487.180512779323;20796;21153;21301.254456093964;21312.467188320417;16211.918940405223;16213.756793648341;16346.836531634532;16368.672626547164;16375.344986200418;19830.107645155713;20130.19479220815;20186.091625876576;20406.387808365773;20489 13:07:31 INFO - PID 1835 | |3;mootools.html;1379.144930143311;1407.9577612671624;1409.9577012689617;1422.9786553201704;1425.5438259756875;17296.308147674077;17933.193006314716;18919.337823176193;18938.14778334975;18940;18284.634307313878;18575;18575.25698972043;18583.62832743348;18598.535036624093;3144.9056528304072;3157.068664743906;3205.6954589313978;3228.8547015384247;3232.660570640084;3167.6673949235346;3167.683231676837;3207.053919093861;3208.1658768720067;3219.5814544109235;3160.4153231652103;3167.9841600791965;3181.5704879841273;3186.362727454507;3188.3463889902514;3047.7561795056454;3064.908052758421;3091.706287902657;3097.2411759118936;3098.8915387961315;3052.297971466553;3061.173483159557;3065.4022465619214;3069.109958112145;3069.3247485553143;16979.3208271669;17181.7422738659;17270;17304.394346197947;17324.740128898076;8913.866292005625;9132.497712625804;9155.221806146486;9196.770080748034;9233.769155771091;6072.787452439144;6125.816225513242;6133.570650054498;6183.505319574423;6243.968780156116;2133.4986278224605;2176.1513009926143;2180;2208.2271205078255;2228.5988522066023;31633.683663163305;32688;32700.836495817606;32728;32812.83593582017;7766.37868970481;7919.604019798987;8078.23256790604;8078.676852925817;8285.62714677841;24300.27099186992;24320.270391888273;24339.513209735705;24491.510169796504;24519.141830035864;7867.72462963805;9163.083691630784;9205.493697846548;9222.584983675617;9331.06689331075;7144.749933752294;7856.096548896836;7900.407469439815;8129.390295727726;8151.429399942066;6676.666166691646;6690.364415380531;6747.122874026345;6759.797206083826;6862.794116176523;2042.1423002339054;2053.8048885356166;2055.6094342074957;2064.2878207018553;2083.073032500553;973.2019743810149;979.4025644356936;986.7237173591406;990.0347161517462;1014.3052009373603;8962.82074358509;9009.369344145847;9019.549022548847;9103;9175.632974681072;827.611022819274;830.2237408023396;834.6202477872674;837.7779888329597;843.2663582683105;5552.278203833475;5560.86097847549;5567.610267281332;5619.7471113799975;5661.603687741818;25607.61588576173;25862.870685646452;26679.599806002927;26771.732282677312;26840.32899177536;26243;26323.07869224568;26334.73665263323;26524.469510610066;26622.866885665837;11639.709007274716;12241.816372754416;12278.570250041206;12376.133670643148;12393.318367489876;9942.602295908371;10126.746831328981;10141.239407044353;10146.188304935735;10327.173826094046;21878.343649690534;21997.23009694653;22019.559608808053;22115;22406.775932240467;22714.772852271264;22762.089516419157;22846.42883927915;22948.541029179658;23328.53342933166;14297.499587514387;14346.856531434969;14470.782938256145;14501.20243386624;14649.92675036618;16323.347066117221;16434.506964791075;16462.176891155636;16465.176741163134;16516.66966660636;12459;12635.494580216688;12695.619131426072;12728.045396595107;12814.743705126031;12316.322602256962;12441.191322564004;12495.25028498293;12673.683157920757;12742.554010609585;10525.78948421012;10691.946540267249;10756.139508839118;10767.030967212988;10770.838437423601;7998.800029999296;8159.143289954707;8218.21926916942;8223.671053157806;8253.298469629908;7932.6430310635005;7990.400719946144;8021.558814265038;8096.392770542115;8106.554139522383 13:07:31 INFO - PID 1835 | |4;prototype.html;566.909294512878;579.7130420441879;590.4803772680042;608.2883026858576;618;6243.531735119867;6292.608808652705;6340.365963403658;6438.484921206304;6442.067379786063;6350.206224221973;6377.999999999988;6408;6430.742770289183;6436.645984470852;5307.6019298552765;5320.547753440962;5332.200169974496;5350.2777125088005;5356.705381204032;5092.261622064799;5175.301334319856;5197.948020519803;5224.8693782655355;5280.914038954611;5098.158803797369;5104.948950510503;5131.717755523445;5163.380394352665;5171.431142574333;5115.769790359405;5154.252633368178;5155.510226528455;5159.156428460783;5175.482451754813;4720;4723.952760472385;4723.952760472385;4729.9763501182615;4757.666963312569;6265.71804268809;6290.591111577779;6405.871882562323;6444.871102577969;6453.419192272671;5967.403259674042;5984.9401505984815;6026.457618814327;6052.001419765734;6052.273727152726;6744.9090781857785;6772.593644381303;6807.761728339534;6813.965930170318;6858.691358888812;4975.651704380694;5244.449332820037;5256.395514515842;5263.368395792491;5269.578433725293;6791.252962174157;6867.587944723333;6977.988191712224;7068.611226382547;7077.186123595801;5322.33470816148;5335.786568537293;5368.2752828367675;5416.749950029951;5444.237806707064;5490.69801160932;5491.643043202179;5505.724713764376;5522.5581953443625;5529.778808847601;5907.852303692356;6049.21360223177;6050.878982420415;6056.273247210363;6082.391760823971;6780.38976492118;6788.762393316309;6809.659517024129;6836.794896153124;6844.247132815386;1875.409246087478;1877.183425210038;1890.5840715042668;1891.1678861300984;1900.6103748731477;1296.9610911672664;1351.9522370163202;1356.1659579358623;1358.7282543491342;1365.8702423269774;6181.227346581677;6295.276043255084;6321.546044409812;6344.143540622049;6344.270408902943;6700.530962832555;6800.4219641330055;6821.522493425413;6848.897266541006;6952.895706564405;6270.874582508324;6281.466075383552;6299.905501417391;6314.705485375487;6436.259830119502;3609.151849315409;3628.836702348348;3654.250878569887;3658.487811706363;3670.7797532148156;7210.819729506699;7227.13274407064;7236.9276307237305;7286.271372862671;7301.452391070691;6979.89530157048;6988.545744526589;7042.823929401806;7054.753083642048;7070.434365250768;7163.14042314936;7191;7286.234945330876;7287.2712728727765;7296.562206267641;6762.222344430454;6767.221769496571;6848.554843935129;6869.725210991504;6923.9653801730665;6599.571027883172;6687.130673012477;6735.158105236846;6786.321367863175;6858.931410685829;7037.859242815218;7098.609576473137;7101.325374089453;7157;7235.782926512213;5281.102212623787;5307.41618421981;5312.7343632818975;5338.3060202173465;5355.866103347447;6613;6640.501962352746;6723.562968407038;6924.303545631353;6930.896036559557;6618.602883826986;6722.193336799615;6731.831704207238;6761.830954225987;6762.425193858577;6506.479481641362;6543.770968016097;6572.572782769104;6670.366315200048;6710.597364158166;6566.9343306568235;6579.901301480386;6602.986089242827;6625.701843416961;6722.226943901514;6724.529282950147;6732.6297053660555;6761.594304341756;6779.762708305186;6801.761938332134;6497.382748638872;6499.350064993463;6532.5753826001155;6575.849226385459;6615.470762338905 13:07:31 INFO - PID 1835 | |5;yui.html;967.7145242153564;999.9300048996571;999.9900000999988;1013.0072528921661;1030.4281123976193;21272.14911403544;21682.457938551524;21716.348509544718;21721.67417488739;21746.456338591503;19567;19717.802821971774;20602.278920237793;20803;20829.375118746462;1068.647346375696;1090.3457925244868;1091.3124731419196;1091.4651820607885;1091.732525531246;1044.4360045575418;1080.7352198711326;1098.2751384086505;1102.5589764094345;1105.778844231153;1171.2445472670122;1171.572376082728;1172.5720112159042;1172.6950992741906;1175.4886624318406;1154.3016475032568;1161.8141097424414;1161.8431511745891;1164.633140560725;1167.7897978363892;852.663198036772;860.1570460948243;860.9440386374928;862.1464749897619;862.1723145780059;18501.722474162765;18503.537411564685;18503.722444163348;18543.443696688984;19998.80001199984;24240.878795606084;24497.755022449903;24804.751952480423;24809.379765505826;24815.62776558353;18410.35563755262;18529.814701852945;18612.255509779727;18720.438386848415;18766.530836729053;3637.672609465161;3652.3425783358985;3664.175560498893;3667.7249206309634;3671.7796932183887;151998.24000879924;159644.20177899153;160787;162108;164832;16790.664186716196;17036.403725869783;17136.57158571046;17292.394766183123;17294.394696185824;35428.645713543054;35469;35528;35558.64441355605;35773.64226357755;10020.498975051218;10191.337563058378;10238.641647542448;10253.487325633838;10384.740381490372;4952.207646776498;5025.14572522672;5027.874303142451;5044.041632089965;5071.4928507149725;6436.485081193493;6496.123023391876;6501.284858665543;6520.608763474207;6541.542092053511;1198.4067886396115;1211.357980270458;1220.2190598017276;1229.059769276504;1231;763.1224092293795;763.282514436428;780.3406121827047;784.1374488063199;796.5499492786557;13585.116967397087;13812.447502099803;13955.162690238416;14681;14794.193082496988;774.2605811450052;775.8215610409637;778.7780482562442;783.7727059152896;791.192983157188;6669.733210671616;6758.493113016543;6798.796036118924;6805.251422343538;6847.863042739117;151392;153571.2321438408;154739;157184.49854255046;159865;134782.32608836892;135274.32362838121;135672.32163839118;137453;140451.29774351063;116294;116565.4171729136;116947;118871;119023.99999999827;12518.248905065726;12582.622521324374;12618.747625047632;12683.556075537312;12687.619371418872;54426.18360724513;54577.72711136419;54600;55405.72297138489;55540.72229638826;70200.29799701937;71964;72245;72363.27636723565;75104.62447687946;18637.627247454704;18773.436796896116;18831.6233675323;18849.71725424147;19001.23995040183;18519.166637501075;19111.713324300425;19426;19431.902840485705;19450.805491945466;19262.94053827053;19625.607487849877;19690.113944872228;19725.309614163434;20142.59714805725;18755;19006.524836879187;19098.14058367349;19147.425577232705;19217.711734324275;18538.443846684622;18593.070346482353;18729.81270187281;18741.531461713566;18743.250269989592;12791.232526048467;13006.739865202831;13186.011049171158;13364.665883352995;13372;12363.75272494563;12417;12588.748225035632;12599.118061735957;12686.429110690226 13:07:31 INFO - PID 1835 | __end_tp_report 13:07:31 INFO - PID 1835 | __start_cc_report 13:07:31 INFO - PID 1835 | _x_x_mozilla_cycle_collect,256 13:07:31 INFO - PID 1835 | __end_cc_report 13:07:31 INFO - PID 1835 | __startTimestamp1506456451963__endTimestamp 13:07:31 INFO - PID 1835 | 13:07:31 INFO - PID 1835 | ------- Summary: start ------- 13:07:31 INFO - PID 1835 | Number of tests: 6 13:07:31 INFO - PID 1835 | 13:07:31 INFO - PID 1835 | [#0] dojo.html Cycles:165 Average:6561.34 Median:6822.83 stddev:768.59 (11.3%) stddev-sans-first:742.20 13:07:31 INFO - PID 1835 | Values: 3907.2 3911.3 3912.2 3925.7 3934.6 6542.9 6557.6 6574.1 6638.0 6673.8 6580.2 6594.7 6597.8 6677.5 6684.2 5814.7 5919.6 5921.9 5923.4 5979.5 5827.0 5862.2 5900.2 5950.7 5990.6 5951.6 6006.6 6009.9 6022.9 6050.5 5877.9 5940.7 5949.5 6033.4 6063.2 5789.8 5829.8 5887.3 5896.9 5933.9 6404.3 6532.6 6549.1 6561.6 6650.9 7063.3 7064.5 7067.1 7168.6 7189.2 7152.6 7210.9 7218.1 7241.6 7257.2 6537.1 6601.0 6607.8 6621.3 6643.5 7276.2 7318.5 7403.9 7405.0 7435.0 6934.0 6992.4 7015.5 7061.2 7078.9 7005.4 7093.1 7118.0 7127.6 7148.0 7118.4 7129.6 7144.4 7144.6 7164.5 7009.9 7030.9 7041.4 7043.6 7136.6 5202.9 5258.4 5268.8 5328.4 5336.1 4752.4 4844.8 4857.4 4859.7 4888.2 6530.4 6554.2 6608.0 6634.9 6636.7 6915.9 7045.0 7151.7 7160.1 7165.5 6470.3 6535.2 6554.3 6607.5 6627.2 5938.9 5992.0 5997.6 5997.8 6026.0 7334.4 7345.8 7382.4 7469.4 7483.3 6979.8 7047.8 7059.0 7123.2 7152.1 7392.8 7451.5 7462.5 7492.9 7494.3 6877.9 6940.6 7032.4 7052.4 7059.1 6987.9 7055.5 7057.3 7057.5 7060.3 6812.0 6887.6 6924.1 6938.3 6950.5 6867.7 6882.4 6885.7 6949.9 6970.5 6712.7 6822.8 6826.7 6903.4 6915.8 6869.2 6885.2 6904.4 6931.4 6945.3 6627.2 6630.2 6728.2 6741.2 6746.6 13:07:31 INFO - PID 1835 | 13:07:31 INFO - PID 1835 | [#1] ext.html Cycles:180 Average:47695.89 Median:3811.45 stddev:75754.51 (1987.6%) stddev-sans-first:75885.84 13:07:31 INFO - PID 1835 | Values: 985.2 1006.8 1008.1 1010.8 1042.2 46079.8 46346.0 46861.5 46869.5 47065.8 47169.5 47635.3 47744.3 47765.8 47772.5 8857.8 9018.8 9021.1 9024.8 9045.3 8924.5 9009.1 9039.0 9039.4 9046.3 8958.6 9078.0 9099.1 9112.5 9113.7 8960.5 8979.6 9008.5 9012.5 9019.6 8737.8 8777.5 8779.1 8788.7 8789.9 42360.0 42702.6 42808.6 42855.6 43135.1 3780.8 3810.4 3812.5 3813.6 3814.0 35511.3 35528.6 35716.3 35849.1 35852.6 5594.6 5646.6 5654.2 5697.7 5769.7 241643.0 241724.0 241845.0 242322.8 242761.0 53769.0 54112.0 54217.0 54275.0 56359.7 59295.7 59655.0 59693.4 59695.1 59705.7 19144.7 19282.0 19290.5 19299.1 19306.7 15809.1 15821.0 15832.3 15878.8 15951.3 16047.3 16190.4 16293.8 16296.3 16334.3 6187.9 6222.7 6270.0 6286.8 6292.8 1128.3 1141.1 1141.6 1144.6 1148.3 25485.0 26790.5 26855.9 26916.6 27098.9 1253.6 1258.3 1260.8 1261.7 1272.8 14280.7 14294.9 14360.4 14371.2 14373.6 329614.0 338492.0 342343.0 345136.0 346924.0 67778.0 68184.0 68238.3 68291.3 68363.3 1535.0 1559.3 1559.8 1563.6 1601.2 31254.0 31907.8 31944.7 32146.7 32552.3 43847.3 44086.3 44097.6 44108.8 44135.3 276895.0 279610.0 280800.0 280889.0 282004.0 39067.8 39962.8 40174.2 40241.0 40604.8 47564.3 48882.5 49162.8 49199.0 49535.3 35371.0 36052.5 36233.0 36266.8 36658.5 35873.0 35919.5 36336.5 36517.5 36552.0 41491.6 42643.6 42648.8 42748.0 42863.8 34989.0 35600.6 35617.1 35671.8 35693.6 25447.6 25804.4 26579.7 26707.3 26848.9 13:07:31 INFO - PID 1835 | 13:07:31 INFO - PID 1835 | [#2] jquery.html Cycles:180 Average:41994.45 Median:22067.11 stddev:107523.72 (487.3%) stddev-sans-first:107780.53 13:07:31 INFO - PID 1835 | Values: 643.1 651.6 651.8 653.3 657.0 24513.0 25204.2 25403.0 25462.4 25474.7 26977.2 27460.5 27542.3 27594.9 27597.9 6397.8 6844.0 6894.3 6901.3 6909.2 6741.1 6823.9 6831.4 6850.8 6854.3 6800.7 6802.2 6813.3 7058.0 7110.9 7004.0 7046.4 7046.9 7057.3 7065.8 6573.0 6579.0 6588.6 6593.0 6598.5 29742.7 30729.8 31130.2 31499.7 31755.5 2403.0 2410.6 2411.9 2412.3 2412.4 19867.7 20438.0 20439.7 20487.8 20490.2 2374.4 2380.0 2606.4 2661.3 2690.5 141212.0 148425.3 169484.0 175103.1 175463.0 16220.9 16628.5 16881.7 17214.9 17438.6 27604.0 27623.7 27713.6 27763.2 27790.9 11630.5 11722.1 11743.1 11855.5 11887.6 10863.5 10906.5 10955.8 11004.8 11007.9 10114.2 10193.3 10328.8 10447.4 10543.6 2883.5 2931.6 2932.0 2940.6 3028.2 1071.6 1079.1 1091.2 1092.4 1092.7 21942.7 22191.6 22288.2 22327.3 22556.5 1138.7 1178.6 1181.2 1185.6 1197.4 12283.3 12295.0 12306.8 12326.9 12500.7 609287.0 617002.0 650086.0 661304.0 666478.0 140537.3 142427.0 142978.0 147290.0 147831.0 1268.7 1295.0 1330.0 1345.8 1352.8 19034.5 19423.6 19590.3 19644.8 19914.8 62579.4 63556.0 64316.7 64996.4 65947.0 80463.0 80967.0 81088.0 81404.0 81829.2 15862.5 16189.5 16369.3 16546.8 16573.6 24697.6 25010.4 25024.0 25121.5 25187.2 20114.5 20154.7 20228.3 20311.4 20700.8 17826.8 18166.7 18330.6 18479.3 18498.4 20487.2 20796.0 21153.0 21301.3 21312.5 16211.9 16213.8 16346.8 16368.7 16375.3 19830.1 20130.2 20186.1 20406.4 20489.0 13:07:31 INFO - PID 1835 | 13:07:31 INFO - PID 1835 | [#3] mootools.html Cycles:180 Average:11078.07 Median:3050.03 stddev:8290.54 (271.8%) stddev-sans-first:8281.77 13:07:31 INFO - PID 1835 | Values: 1379.1 1408.0 1410.0 1423.0 1425.5 17296.3 17933.2 18919.3 18938.1 18940.0 18284.6 18575.0 18575.3 18583.6 18598.5 3144.9 3157.1 3205.7 3228.9 3232.7 3167.7 3167.7 3207.1 3208.2 3219.6 3160.4 3168.0 3181.6 3186.4 3188.3 3047.8 3064.9 3091.7 3097.2 3098.9 3052.3 3061.2 3065.4 3069.1 3069.3 16979.3 17181.7 17270.0 17304.4 17324.7 8913.9 9132.5 9155.2 9196.8 9233.8 6072.8 6125.8 6133.6 6183.5 6244.0 2133.5 2176.2 2180.0 2208.2 2228.6 31633.7 32688.0 32700.8 32728.0 32812.8 7766.4 7919.6 8078.2 8078.7 8285.6 24300.3 24320.3 24339.5 24491.5 24519.1 7867.7 9163.1 9205.5 9222.6 9331.1 7144.7 7856.1 7900.4 8129.4 8151.4 6676.7 6690.4 6747.1 6759.8 6862.8 2042.1 2053.8 2055.6 2064.3 2083.1 973.2 979.4 986.7 990.0 1014.3 8962.8 9009.4 9019.5 9103.0 9175.6 827.6 830.2 834.6 837.8 843.3 5552.3 5560.9 5567.6 5619.7 5661.6 25607.6 25862.9 26679.6 26771.7 26840.3 26243.0 26323.1 26334.7 26524.5 26622.9 11639.7 12241.8 12278.6 12376.1 12393.3 9942.6 10126.7 10141.2 10146.2 10327.2 21878.3 21997.2 22019.6 22115.0 22406.8 22714.8 22762.1 22846.4 22948.5 23328.5 14297.5 14346.9 14470.8 14501.2 14649.9 16323.3 16434.5 16462.2 16465.2 16516.7 12459.0 12635.5 12695.6 12728.0 12814.7 12316.3 12441.2 12495.3 12673.7 12742.6 10525.8 10691.9 10756.1 10767.0 10770.8 7998.8 8159.1 8218.2 8223.7 8253.3 7932.6 7990.4 8021.6 8096.4 8106.6 13:07:31 INFO - PID 1835 | 13:07:31 INFO - PID 1835 | [#4] prototype.html Cycles:180 Average:5773.09 Median:6391.94 stddev:1589.49 (24.9%) stddev-sans-first:1545.17 13:07:31 INFO - PID 1835 | Values: 566.9 579.7 590.5 608.3 618.0 6243.5 6292.6 6340.4 6438.5 6442.1 6350.2 6378.0 6408.0 6430.7 6436.6 5307.6 5320.5 5332.2 5350.3 5356.7 5092.3 5175.3 5197.9 5224.9 5280.9 5098.2 5104.9 5131.7 5163.4 5171.4 5115.8 5154.3 5155.5 5159.2 5175.5 4720.0 4724.0 4724.0 4730.0 4757.7 6265.7 6290.6 6405.9 6444.9 6453.4 5967.4 5984.9 6026.5 6052.0 6052.3 6744.9 6772.6 6807.8 6814.0 6858.7 4975.7 5244.4 5256.4 5263.4 5269.6 6791.3 6867.6 6978.0 7068.6 7077.2 5322.3 5335.8 5368.3 5416.7 5444.2 5490.7 5491.6 5505.7 5522.6 5529.8 5907.9 6049.2 6050.9 6056.3 6082.4 6780.4 6788.8 6809.7 6836.8 6844.2 1875.4 1877.2 1890.6 1891.2 1900.6 1297.0 1352.0 1356.2 1358.7 1365.9 6181.2 6295.3 6321.5 6344.1 6344.3 6700.5 6800.4 6821.5 6848.9 6952.9 6270.9 6281.5 6299.9 6314.7 6436.3 3609.2 3628.8 3654.3 3658.5 3670.8 7210.8 7227.1 7236.9 7286.3 7301.5 6979.9 6988.5 7042.8 7054.8 7070.4 7163.1 7191.0 7286.2 7287.3 7296.6 6762.2 6767.2 6848.6 6869.7 6924.0 6599.6 6687.1 6735.2 6786.3 6858.9 7037.9 7098.6 7101.3 7157.0 7235.8 5281.1 5307.4 5312.7 5338.3 5355.9 6613.0 6640.5 6723.6 6924.3 6930.9 6618.6 6722.2 6731.8 6761.8 6762.4 6506.5 6543.8 6572.6 6670.4 6710.6 6566.9 6579.9 6603.0 6625.7 6722.2 6724.5 6732.6 6761.6 6779.8 6801.8 6497.4 6499.4 6532.6 6575.8 6615.5 13:07:31 INFO - PID 1835 | 13:07:31 INFO - PID 1835 | [#5] yui.html Cycles:180 Average:28961.46 Median:18742.39 stddev:43194.06 (230.5%) stddev-sans-first:43264.09 13:07:31 INFO - PID 1835 | Values: 967.7 999.9 1000.0 1013.0 1030.4 21272.1 21682.5 21716.3 21721.7 21746.5 19567.0 19717.8 20602.3 20803.0 20829.4 1068.6 1090.3 1091.3 1091.5 1091.7 1044.4 1080.7 1098.3 1102.6 1105.8 1171.2 1171.6 1172.6 1172.7 1175.5 1154.3 1161.8 1161.8 1164.6 1167.8 852.7 860.2 860.9 862.1 862.2 18501.7 18503.5 18503.7 18543.4 19998.8 24240.9 24497.8 24804.8 24809.4 24815.6 18410.4 18529.8 18612.3 18720.4 18766.5 3637.7 3652.3 3664.2 3667.7 3671.8 151998.2 159644.2 160787.0 162108.0 164832.0 16790.7 17036.4 17136.6 17292.4 17294.4 35428.6 35469.0 35528.0 35558.6 35773.6 10020.5 10191.3 10238.6 10253.5 10384.7 4952.2 5025.1 5027.9 5044.0 5071.5 6436.5 6496.1 6501.3 6520.6 6541.5 1198.4 1211.4 1220.2 1229.1 1231.0 763.1 763.3 780.3 784.1 796.5 13585.1 13812.4 13955.2 14681.0 14794.2 774.3 775.8 778.8 783.8 791.2 6669.7 6758.5 6798.8 6805.3 6847.9 151392.0 153571.2 154739.0 157184.5 159865.0 134782.3 135274.3 135672.3 137453.0 140451.3 116294.0 116565.4 116947.0 118871.0 119024.0 12518.2 12582.6 12618.7 12683.6 12687.6 54426.2 54577.7 54600.0 55405.7 55540.7 70200.3 71964.0 72245.0 72363.3 75104.6 18637.6 18773.4 18831.6 18849.7 19001.2 18519.2 19111.7 19426.0 19431.9 19450.8 19262.9 19625.6 19690.1 19725.3 20142.6 18755.0 19006.5 19098.1 19147.4 19217.7 18538.4 18593.1 18729.8 18741.5 18743.3 12791.2 13006.7 13186.0 13364.7 13372.0 12363.8 12417.0 12588.7 12599.1 12686.4 13:07:31 INFO - PID 1835 | -------- Summary: end -------- 13:07:31 INFO - PID 1835 | 13:07:32 INFO - TEST-INFO | 1835: exit 0 13:07:32 INFO - TEST-OK | dromaeo_css | took 1106493ms 13:07:32 INFO - TEST-START | kraken 13:07:32 INFO - Initialising browser for kraken test... 13:07:32 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55644/getInfo.html -profile /tmp/tmpZNu56Z/profile 13:07:32 INFO - TEST-INFO | started process 2202 (/builds/slave/test/build/application/firefox/firefox http://localhost:55644/getInfo.html) 13:07:37 INFO - TEST-INFO | 2202: exit 0 13:07:37 INFO - Browser initialized. 13:07:37 INFO - Running cycle 1/1 for kraken test... 13:07:37 INFO - Using env: {'DISPLAY': ':0', 13:07:37 INFO - 'HOME': '/home/cltbld', 13:07:37 INFO - 'JSGC_DISABLE_POISONING': '1', 13:07:37 INFO - 'LANG': 'en_US.UTF-8', 13:07:37 INFO - 'LANGUAGE': 'en_US:en', 13:07:37 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 13:07:37 INFO - 'LOGNAME': 'cltbld', 13:07:37 INFO - 'MAIL': '/var/mail/cltbld', 13:07:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:07:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:07:37 INFO - 'MOZ_CRASHREPORTER': '1', 13:07:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:37 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 13:07:37 INFO - 'MOZ_NO_REMOTE': '1', 13:07:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:07:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:37 INFO - 'NO_EM_RESTART': '1', 13:07:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:37 INFO - 'PWD': '/builds/slave/test', 13:07:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:07:37 INFO - 'RUST_BACKTRACE': 'full', 13:07:37 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:07:37 INFO - 'SHELL': '/bin/bash', 13:07:37 INFO - 'SHLVL': '1', 13:07:37 INFO - 'TERM': 'linux', 13:07:37 INFO - 'TMOUT': '86400', 13:07:37 INFO - 'USER': 'cltbld', 13:07:37 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1506453887.278188-1175121432', 13:07:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:37 INFO - '_': '/tools/buildbot/bin/python'} 13:07:37 INFO - TEST-INFO | started process 2399 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZNu56Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 13:07:38 INFO - PID 2399 | 13:07:38 INFO - PID 2399 | (/builds/slave/test/build/application/firefox/firefox:2447): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 13:07:38 INFO - PID 2399 | 13:07:49 INFO - PID 2399 | RSS: Main: 141275136 13:07:49 INFO - PID 2399 | 13:07:51 INFO - PID 2399 | Cycle 1(1): loaded http://localhost:55644/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55644/tests/kraken/driver.html?testName=audio-beat-detection) 13:07:52 INFO - PID 2399 | RSS: Main: 147419136 13:07:52 INFO - PID 2399 | 13:07:54 INFO - PID 2399 | Cycle 1(1): loaded http://localhost:55644/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55644/tests/kraken/driver.html?testName=audio-dft) 13:07:55 INFO - PID 2399 | RSS: Main: 148287488 13:07:55 INFO - PID 2399 | 13:07:58 INFO - PID 2399 | Cycle 1(1): loaded http://localhost:55644/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55644/tests/kraken/driver.html?testName=audio-fft) 13:07:58 INFO - PID 2399 | RSS: Main: 149839872 13:07:58 INFO - PID 2399 | 13:08:01 INFO - PID 2399 | Cycle 1(1): loaded http://localhost:55644/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55644/tests/kraken/driver.html?testName=audio-oscillator) 13:08:01 INFO - PID 2399 | RSS: Main: 149434368 13:08:01 INFO - PID 2399 | 13:08:03 INFO - PID 2399 | Cycle 1(1): loaded http://localhost:55644/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55644/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:08:04 INFO - PID 2399 | RSS: Main: 149250048 13:08:04 INFO - PID 2399 | 13:08:07 INFO - PID 2399 | Cycle 1(1): loaded http://localhost:55644/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55644/tests/kraken/driver.html?testName=imaging-darkroom) 13:08:07 INFO - PID 2399 | RSS: Main: 149671936 13:08:07 INFO - PID 2399 | 13:08:11 INFO - PID 2399 | Cycle 1(1): loaded http://localhost:55644/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55644/tests/kraken/driver.html?testName=imaging-desaturate) 13:08:11 INFO - PID 2399 | RSS: Main: 150368256 13:08:11 INFO - PID 2399 | 13:08:14 INFO - PID 2399 | Cycle 1(1): loaded http://localhost:55644/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55644/tests/kraken/driver.html?testName=json-parse-financial) 13:08:15 INFO - PID 2399 | RSS: Main: 152133632 13:08:15 INFO - PID 2399 | 13:08:16 INFO - PID 2399 | Cycle 1(1): loaded http://localhost:55644/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55644/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:08:17 INFO - PID 2399 | RSS: Main: 152096768 13:08:17 INFO - PID 2399 | 13:08:19 INFO - PID 2399 | Cycle 1(1): loaded http://localhost:55644/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55644/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:08:19 INFO - PID 2399 | RSS: Main: 151973888 13:08:19 INFO - PID 2399 | 13:08:21 INFO - PID 2399 | Cycle 1(1): loaded http://localhost:55644/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55644/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:08:22 INFO - PID 2399 | RSS: Main: 148725760 13:08:22 INFO - PID 2399 | 13:08:24 INFO - PID 2399 | Cycle 1(1): loaded http://localhost:55644/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55644/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:08:25 INFO - PID 2399 | RSS: Main: 149131264 13:08:25 INFO - PID 2399 | 13:08:27 INFO - PID 2399 | Cycle 1(1): loaded http://localhost:55644/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55644/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:08:28 INFO - PID 2399 | RSS: Main: 149389312 13:08:28 INFO - PID 2399 | 13:08:30 INFO - PID 2399 | Cycle 1(1): loaded http://localhost:55644/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55644/tests/kraken/driver.html?testName=ai-astar) 13:08:30 INFO - PID 2399 | RSS: Main: 150683648 13:08:30 INFO - PID 2399 | 13:08:30 INFO - PID 2399 | __start_tp_report 13:08:30 INFO - PID 2399 | _x_x_mozilla_page_load 13:08:30 INFO - PID 2399 | _x_x_mozilla_page_load_details 13:08:30 INFO - PID 2399 | |i|pagename|runs| 13:08:30 INFO - PID 2399 | |0;ai-astar;106;105;105;105;105;106;109;108;106;107 13:08:30 INFO - PID 2399 | |1;audio-beat-detection;113;113;112;115;137;112;119;110;110;141 13:08:30 INFO - PID 2399 | |2;audio-dft;162;161;163;161;162;160;163;162;165;161 13:08:30 INFO - PID 2399 | |3;audio-fft;72;74;76;75;74;74;73;77;74;75 13:08:30 INFO - PID 2399 | |4;audio-oscillator;78;77;85;81;77;77;78;76;77;78 13:08:30 INFO - PID 2399 | |5;imaging-gaussian-blur;114;114;114;114;114;113;114;114;114;115 13:08:30 INFO - PID 2399 | |6;imaging-darkroom;149;148;147;148;148;148;148;148;149;149 13:08:30 INFO - PID 2399 | |7;imaging-desaturate;94;94;95;99;98;98;99;97;95;94 13:08:30 INFO - PID 2399 | |8;json-parse-financial;45;47;43;44;43;43;43;44;42;43 13:08:30 INFO - PID 2399 | |9;json-stringify-tinderbox;37;38;38;37;38;38;37;38;38;38 13:08:30 INFO - PID 2399 | |10;stanford-crypto-aes;73;84;70;71;68;69;69;71;70;71 13:08:30 INFO - PID 2399 | |11;stanford-crypto-ccm;105;108;103;103;104;104;107;102;102;117 13:08:30 INFO - PID 2399 | |12;stanford-crypto-pbkdf2;150;146;149;147;152;146;155;148;150;147 13:08:30 INFO - PID 2399 | |13;stanford-crypto-sha256-iterative;59;58;59;63;62;60;59;57;58;57 13:08:30 INFO - PID 2399 | __end_tp_report 13:08:30 INFO - PID 2399 | __start_cc_report 13:08:30 INFO - PID 2399 | _x_x_mozilla_cycle_collect,682 13:08:30 INFO - PID 2399 | __end_cc_report 13:08:30 INFO - PID 2399 | __startTimestamp1506456510416__endTimestamp 13:08:30 INFO - PID 2399 | 13:08:30 INFO - PID 2399 | ------- Summary: start ------- 13:08:30 INFO - PID 2399 | Number of tests: 14 13:08:30 INFO - PID 2399 | 13:08:30 INFO - PID 2399 | [#0] ai-astar Cycles:10 Average:106.20 Median:106.00 stddev:1.40 (1.3%) stddev-sans-first:1.48 13:08:30 INFO - PID 2399 | Values: 106.0 105.0 105.0 105.0 105.0 106.0 109.0 108.0 106.0 107.0 13:08:30 INFO - PID 2399 | 13:08:30 INFO - PID 2399 | [#1] audio-beat-detection Cycles:10 Average:118.20 Median:114.00 stddev:11.30 (9.9%) stddev-sans-first:11.83 13:08:30 INFO - PID 2399 | Values: 113.0 113.0 112.0 115.0 137.0 112.0 119.0 110.0 110.0 141.0 13:08:30 INFO - PID 2399 | 13:08:30 INFO - PID 2399 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.41 (0.9%) stddev-sans-first:1.50 13:08:30 INFO - PID 2399 | Values: 162.0 161.0 163.0 161.0 162.0 160.0 163.0 162.0 165.0 161.0 13:08:30 INFO - PID 2399 | 13:08:30 INFO - PID 2399 | [#3] audio-fft Cycles:10 Average:74.40 Median:74.50 stddev:1.43 (1.9%) stddev-sans-first:1.22 13:08:30 INFO - PID 2399 | Values: 72.0 74.0 76.0 75.0 74.0 74.0 73.0 77.0 74.0 75.0 13:08:30 INFO - PID 2399 | 13:08:30 INFO - PID 2399 | [#4] audio-oscillator Cycles:10 Average:78.40 Median:78.00 stddev:2.67 (3.4%) stddev-sans-first:2.83 13:08:30 INFO - PID 2399 | Values: 78.0 77.0 85.0 81.0 77.0 77.0 78.0 76.0 77.0 78.0 13:08:30 INFO - PID 2399 | 13:08:30 INFO - PID 2399 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 13:08:30 INFO - PID 2399 | Values: 114.0 114.0 114.0 114.0 114.0 113.0 114.0 114.0 114.0 115.0 13:08:30 INFO - PID 2399 | 13:08:30 INFO - PID 2399 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 13:08:30 INFO - PID 2399 | Values: 149.0 148.0 147.0 148.0 148.0 148.0 148.0 148.0 149.0 149.0 13:08:30 INFO - PID 2399 | 13:08:30 INFO - PID 2399 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:97.50 stddev:2.11 (2.2%) stddev-sans-first:2.07 13:08:30 INFO - PID 2399 | Values: 94.0 94.0 95.0 99.0 98.0 98.0 99.0 97.0 95.0 94.0 13:08:30 INFO - PID 2399 | 13:08:30 INFO - PID 2399 | [#8] json-parse-financial Cycles:10 Average:43.70 Median:43.50 stddev:1.42 (3.3%) stddev-sans-first:1.42 13:08:30 INFO - PID 2399 | Values: 45.0 47.0 43.0 44.0 43.0 43.0 43.0 44.0 42.0 43.0 13:08:30 INFO - PID 2399 | 13:08:30 INFO - PID 2399 | [#9] json-stringify-tinderbox Cycles:10 Average:37.70 Median:38.00 stddev:0.48 (1.3%) stddev-sans-first:0.44 13:08:30 INFO - PID 2399 | Values: 37.0 38.0 38.0 37.0 38.0 38.0 37.0 38.0 38.0 38.0 13:08:30 INFO - PID 2399 | 13:08:30 INFO - PID 2399 | [#10] stanford-crypto-aes Cycles:10 Average:71.60 Median:71.00 stddev:4.58 (6.4%) stddev-sans-first:4.82 13:08:30 INFO - PID 2399 | Values: 73.0 84.0 70.0 71.0 68.0 69.0 69.0 71.0 70.0 71.0 13:08:30 INFO - PID 2399 | 13:08:30 INFO - PID 2399 | [#11] stanford-crypto-ccm Cycles:10 Average:105.50 Median:104.50 stddev:4.50 (4.3%) stddev-sans-first:4.77 13:08:30 INFO - PID 2399 | Values: 105.0 108.0 103.0 103.0 104.0 104.0 107.0 102.0 102.0 117.0 13:08:30 INFO - PID 2399 | 13:08:30 INFO - PID 2399 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.00 Median:149.50 stddev:2.87 (1.9%) stddev-sans-first:3.02 13:08:30 INFO - PID 2399 | Values: 150.0 146.0 149.0 147.0 152.0 146.0 155.0 148.0 150.0 147.0 13:08:30 INFO - PID 2399 | 13:08:30 INFO - PID 2399 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.20 Median:59.00 stddev:1.99 (3.4%) stddev-sans-first:2.11 13:08:30 INFO - PID 2399 | Values: 59.0 58.0 59.0 63.0 62.0 60.0 59.0 57.0 58.0 57.0 13:08:30 INFO - PID 2399 | -------- Summary: end -------- 13:08:30 INFO - PID 2399 | 13:08:30 INFO - PID 2399 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 13:08:30 INFO - TEST-INFO | 2399: exit 0 13:08:31 INFO - TEST-OK | kraken | took 58297ms 13:08:31 INFO - SUITE-END | took 1164s 13:08:31 INFO - Completed test suite (00:19:24) 13:08:31 INFO - javascript benchmark 13:08:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9503.847107174683, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3907.218556288742, 3911.2959667259884, 3912.217556488702, 3925.666318362939, 3934.606539346064, 6542.869142617156, 6557.573757705752, 6574.112494813205, 6638.037484564735, 6673.799786006415, 6580.243272023718, 6594.703238354274, 6597.81239376912, 6677.5325727199115, 6684.1978962524445, 5814.680192589406, 5919.556033297498, 5921.940780592182, 5923.437273459014, 5979.491743201833, 5826.9708651456895, 5862.20860183874, 5900.203472531218, 5950.70246487676, 5990.550708696844, 5951.58338916276, 6006.639601623917, 6009.87980240395, 6022.8795424091495, 6050.546209034318, 5877.882442351129, 5940.732667029994, 5949.494292985101, 6033.366496517846, 6063.18147050147, 5789.797357092523, 5829.766809327622, 5887.293524777054, 5896.882062358772, 5933.9406605934255, 6404.295527491972, 6532.608043517404, 6549.0503876938055, 6561.606303621798, 6650.866982660368, 7063.293670632947, 7064.505484616079, 7067.081279433641, 7168.60572668503, 7189.245129261404, 7152.642367881585, 7210.855782884365, 7218.061651985261, 7241.601711905896, 7257.201707812136, 6537.117489138953, 6600.966995165041, 6607.80176594703, 6621.33786621334, 6643.468522518236, 7276.163241227221, 7318.451116166309, 7403.925960740431, 7404.96297518509, 7434.962825185839, 6934.0, 6992.370686638227, 7015.543989640657, 7061.152661680529, 7078.929210707827, 7005.439564834801, 7093.1488221413765, 7118.0, 7127.643617819088, 7148.035015272975, 7118.394936430462, 7129.60787156701, 7144.392726618192, 7144.642767861586, 7164.498485105993, 7009.894851577231, 7030.9296907030275, 7041.401480874183, 7043.612601306875, 7136.607486588287, 5202.947970520322, 5258.3689957204615, 5268.841934741964, 5328.3605967284175, 5336.119540275811, 4752.382190315306, 4844.806207751721, 4857.392825896763, 4859.659823812299, 4888.169011268093, 6530.412262896362, 6554.246261679872, 6608.041833934052, 6634.900476492857, 6636.668166591651, 6915.930840691629, 7045.0, 7151.678174482161, 7160.10498687664, 7165.462590305644, 6470.255920569195, 6535.215774107138, 6554.344565543408, 6607.537472376984, 6627.204735431779, 5938.8812223755285, 5992.041273396323, 5997.580169388101, 5997.790077347272, 6026.0, 7334.413246940232, 7345.816354591178, 7382.409407247407, 7469.402447804163, 7483.289087536676, 6979.755708550177, 7047.788566343018, 7059.011738356531, 7123.180834204133, 7152.141742990771, 7392.778216653509, 7451.478396512192, 7462.514936529108, 7492.887606686013, 7494.250574942462, 6877.862442751217, 6940.618265995418, 7032.437405007689, 7052.400545953651, 7059.117610298713, 6987.895181572178, 7055.506114572136, 7057.258987806206, 7057.50597458173, 7060.293970602898, 6812.012258222431, 6887.552309099892, 6924.134483189601, 6938.271481494572, 6950.513464057467, 6867.656617169022, 6882.414994725505, 6885.655717214019, 6949.895751563629, 6970.51206415546, 6712.731490740511, 6822.829429264308, 6826.726930922708, 6903.447724181953, 6915.792526224222, 6869.175698916162, 6885.242623311332, 6904.378605925491, 6931.4108300795, 6945.305469453015, 6627.23786764509, 6630.204375474974, 6728.192616886005, 6741.157355330583, 6746.595204287759], "value": 6509.059972955956, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [985.1822986920856, 1006.783541538569, 1008.1279693065501, 1010.7624708193574, 1042.244372829698, 46079.76960115199, 46346.0, 46861.531384686146, 46869.531304686985, 47065.76467117668, 47169.52830471694, 47635.285470717965, 47744.28383574249, 47765.76117119418, 47772.52227477724, 8857.822843543141, 9018.774530636754, 9021.097890210993, 9024.819503609924, 9045.321600879928, 8924.509151996637, 9009.099090090971, 9038.954805225965, 9039.41243819153, 9046.321525885553, 8958.596863141142, 9077.95461022694, 9099.135582119721, 9112.498812565307, 9113.68102116426, 8960.462372257653, 8979.551022448884, 9008.549572521413, 9012.459252444809, 9019.639214431414, 8737.825243495157, 8777.473351598925, 8779.122087791233, 8788.736337909873, 8789.868151977726, 42360.0, 42702.57297427017, 42808.571914281085, 42855.57144428547, 43135.137297254194, 3780.773153610792, 3810.371288737355, 3812.5234345706785, 3813.561440434358, 3813.9618603813883, 35511.28977420437, 35528.64471355279, 35716.285674286366, 35849.10377240564, 35852.64147358545, 5594.608377413582, 5646.576506761969, 5654.180143879155, 5697.658140511541, 5769.653820770767, 241643.0, 241724.0, 241845.0, 242322.7883860587, 242761.0, 53769.0, 54112.0, 54217.0, 54275.0, 56359.71820140873, 59295.70352148298, 59655.0, 59693.40306596965, 59695.10457343143, 59705.70147149323, 19144.712829307573, 19282.0, 19290.517737056685, 19299.131539080776, 19306.71039934402, 15809.13049782273, 15821.0, 15832.28754706018, 15878.841211587967, 15951.282192301374, 16047.277872495766, 16190.43333483346, 16293.755593666105, 16296.26666799997, 16334.264958076677, 6187.938120618736, 6222.719977601018, 6270.0, 6286.8428289292215, 6292.779752708633, 1128.2891778179858, 1141.1327391182595, 1141.6061458796703, 1144.5650652751901, 1148.2995372822572, 25485.0, 26790.464190716077, 26855.86572067127, 26916.59625105625, 27098.864505677346, 1253.6364454308332, 1258.314218750783, 1260.7982722764314, 1261.6971926737701, 1272.840894888139, 14280.714385712228, 14294.928525357307, 14360.353784079742, 14371.2095834728, 14373.6406589834, 329614.0, 338492.0, 342343.0, 345136.0, 346924.0, 67778.0, 68183.97724034144, 68238.31761682419, 68291.3170868285, 68363.31636683669, 1535.0405996252343, 1559.2827299442156, 1559.8440155984538, 1563.6169138561124, 1601.223406647775, 31254.0, 31907.840460797546, 31944.68055319417, 32146.678533215305, 32552.34895302128, 43847.34228986631, 44086.33870492009, 44097.55902440935, 44108.779456103795, 44135.33796993112, 276895.0, 279610.0, 280800.0, 280889.0, 282004.0, 39067.80466097765, 39962.80018599889, 40174.1965160701, 40241.0, 40604.79697601493, 47564.2865357013, 48882.5111748878, 49162.75418622884, 49199.0, 49535.25697114474, 35371.0, 36052.4592131113, 36233.0, 36266.8186659065, 36658.45012324764, 35873.0, 35919.461208081375, 36336.45495317625, 36517.45223821698, 36552.0, 41491.58508414998, 42643.57356426396, 42648.78675606602, 42748.0, 42863.78568107139, 34989.0, 35600.64399355973, 35617.10957225986, 35671.82164089163, 35693.62507156507, 25447.61828572536, 25804.35489112787, 26579.734202657724, 26707.33231669224, 26848.865755671097], "value": 20111.03764596512, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [643.0773891839857, 651.6467221773132, 651.7760152378686, 653.2623222228871, 656.9816783984826, 24513.0, 25204.243872683826, 25403.0, 25462.363440913985, 25474.74525254749, 26977.190684279452, 27460.450790984167, 27542.311442213955, 27594.862025689843, 27597.862010689918, 6397.776077837265, 6844.041834143224, 6894.345037221456, 6901.309869013109, 6909.205441374231, 6741.056252124707, 6823.931760682404, 6831.351021652935, 6850.794476165723, 6854.280300568444, 6800.727970881158, 6802.183737951428, 6813.250542440353, 7057.964710176442, 7110.893336599956, 7003.964980175092, 7046.436285097231, 7046.942958556207, 7057.258987806309, 7065.788026359218, 6573.0, 6579.0, 6588.637624930627, 6593.0, 6598.538102332838, 29742.70257297421, 30729.846350768326, 31130.221744456343, 31499.685003149905, 31755.523667144782, 2402.9787340380267, 2410.602250628644, 2411.9155829546057, 2412.32454912623, 2412.4089598048413, 19867.701984470244, 20438.0, 20439.693404598944, 20487.795122048738, 20490.18039278427, 2374.3826605082804, 2379.9643005354933, 2606.3614414468575, 2661.308059904439, 2690.5426077566863, 141212.0, 148425.25787371103, 169484.0, 175103.12448437803, 175463.0, 16220.918895405448, 16628.501144965427, 16881.662366752596, 17214.913925430545, 17438.56403589895, 27604.0, 27623.723762762114, 27713.58429623557, 27763.167104986882, 27790.86104569505, 11630.476628551736, 11722.120840936965, 11743.11926605508, 11855.46650400734, 11887.583934562248, 10863.51114199863, 10906.454677266263, 10955.780884382268, 11004.779904402027, 11007.889921100686, 10114.190864730952, 10193.286469947181, 10328.845067323997, 10447.425391603534, 10543.578256869792, 2883.5489833641655, 2931.5749216363506, 2931.9706802931696, 2940.588317635533, 3028.212664707192, 1071.5767271927546, 1079.0558261521169, 1091.1979694924225, 1092.4319353936069, 1092.6721983404946, 21942.670859937112, 22191.556168876534, 22288.219912302993, 22327.330180094625, 22556.54886902253, 1138.7494751154732, 1178.6287319494331, 1181.167277069681, 1185.6324539392815, 1197.4192516629428, 12283.324417156964, 12295.016398688083, 12306.81539776904, 12326.876731232753, 12500.74998500025, 609287.0, 617002.0, 650086.0, 661304.0, 666478.0, 140537.29731351277, 142427.0, 142978.0, 147290.0, 147831.0, 1268.6638040919163, 1294.9546765863338, 1329.9933500332436, 1345.7712188927906, 1352.8444228913604, 19034.52413689669, 19423.611527769084, 19590.314338998065, 19644.80355196487, 19914.800851991295, 62579.37420625918, 63556.0, 64316.67841660762, 64996.350036500924, 65946.99999999808, 80463.0, 80967.0, 81088.0, 81404.0, 81829.18170818454, 15862.52412427629, 16189.514314570582, 16369.345226190819, 16546.83453165501, 16573.58566035859, 24697.629535557342, 25010.37474063163, 25024.0, 25121.49757004886, 25187.24438266855, 20114.497137571678, 20154.69767953511, 20228.292009779587, 20311.390658280274, 20700.79299207049, 17826.821731783035, 18166.72749908726, 18330.617019787343, 18479.260829567203, 18498.35255766042, 20487.180512779323, 20796.0, 21153.0, 21301.254456093964, 21312.467188320417, 16211.918940405223, 16213.756793648341, 16346.836531634532, 16368.672626547164, 16375.344986200418, 19830.107645155713, 20130.19479220815, 20186.091625876576, 20406.387808365773, 20489.0], "value": 13373.391287863436, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1379.144930143311, 1407.9577612671624, 1409.9577012689617, 1422.9786553201704, 1425.5438259756875, 17296.308147674077, 17933.193006314716, 18919.337823176193, 18938.14778334975, 18940.0, 18284.634307313878, 18575.0, 18575.25698972043, 18583.62832743348, 18598.535036624093, 3144.9056528304072, 3157.068664743906, 3205.6954589313978, 3228.8547015384247, 3232.660570640084, 3167.6673949235346, 3167.683231676837, 3207.053919093861, 3208.1658768720067, 3219.5814544109235, 3160.4153231652103, 3167.9841600791965, 3181.5704879841273, 3186.362727454507, 3188.3463889902514, 3047.7561795056454, 3064.908052758421, 3091.706287902657, 3097.2411759118936, 3098.8915387961315, 3052.297971466553, 3061.173483159557, 3065.4022465619214, 3069.109958112145, 3069.3247485553143, 16979.3208271669, 17181.7422738659, 17270.0, 17304.394346197947, 17324.740128898076, 8913.866292005625, 9132.497712625804, 9155.221806146486, 9196.770080748034, 9233.769155771091, 6072.787452439144, 6125.816225513242, 6133.570650054498, 6183.505319574423, 6243.968780156116, 2133.4986278224605, 2176.1513009926143, 2180.0, 2208.2271205078255, 2228.5988522066023, 31633.683663163305, 32688.0, 32700.836495817606, 32728.0, 32812.83593582017, 7766.37868970481, 7919.604019798987, 8078.23256790604, 8078.676852925817, 8285.62714677841, 24300.27099186992, 24320.270391888273, 24339.513209735705, 24491.510169796504, 24519.141830035864, 7867.72462963805, 9163.083691630784, 9205.493697846548, 9222.584983675617, 9331.06689331075, 7144.749933752294, 7856.096548896836, 7900.407469439815, 8129.390295727726, 8151.429399942066, 6676.666166691646, 6690.364415380531, 6747.122874026345, 6759.797206083826, 6862.794116176523, 2042.1423002339054, 2053.8048885356166, 2055.6094342074957, 2064.2878207018553, 2083.073032500553, 973.2019743810149, 979.4025644356936, 986.7237173591406, 990.0347161517462, 1014.3052009373603, 8962.82074358509, 9009.369344145847, 9019.549022548847, 9103.0, 9175.632974681072, 827.611022819274, 830.2237408023396, 834.6202477872674, 837.7779888329597, 843.2663582683105, 5552.278203833475, 5560.86097847549, 5567.610267281332, 5619.7471113799975, 5661.603687741818, 25607.61588576173, 25862.870685646452, 26679.599806002927, 26771.732282677312, 26840.32899177536, 26243.0, 26323.07869224568, 26334.73665263323, 26524.469510610066, 26622.866885665837, 11639.709007274716, 12241.816372754416, 12278.570250041206, 12376.133670643148, 12393.318367489876, 9942.602295908371, 10126.746831328981, 10141.239407044353, 10146.188304935735, 10327.173826094046, 21878.343649690534, 21997.23009694653, 22019.559608808053, 22115.0, 22406.775932240467, 22714.772852271264, 22762.089516419157, 22846.42883927915, 22948.541029179658, 23328.53342933166, 14297.499587514387, 14346.856531434969, 14470.782938256145, 14501.20243386624, 14649.92675036618, 16323.347066117221, 16434.506964791075, 16462.176891155636, 16465.176741163134, 16516.66966660636, 12459.0, 12635.494580216688, 12695.619131426072, 12728.045396595107, 12814.743705126031, 12316.322602256962, 12441.191322564004, 12495.25028498293, 12673.683157920757, 12742.554010609585, 10525.78948421012, 10691.946540267249, 10756.139508839118, 10767.030967212988, 10770.838437423601, 7998.800029999296, 8159.143289954707, 8218.21926916942, 8223.671053157806, 8253.298469629908, 7932.6430310635005, 7990.400719946144, 8021.558814265038, 8096.392770542115, 8106.554139522383], "value": 7727.233981036683, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.909294512878, 579.7130420441879, 590.4803772680042, 608.2883026858576, 618.0, 6243.531735119867, 6292.608808652705, 6340.365963403658, 6438.484921206304, 6442.067379786063, 6350.206224221973, 6377.999999999988, 6408.0, 6430.742770289183, 6436.645984470852, 5307.6019298552765, 5320.547753440962, 5332.200169974496, 5350.2777125088005, 5356.705381204032, 5092.261622064799, 5175.301334319856, 5197.948020519803, 5224.8693782655355, 5280.914038954611, 5098.158803797369, 5104.948950510503, 5131.717755523445, 5163.380394352665, 5171.431142574333, 5115.769790359405, 5154.252633368178, 5155.510226528455, 5159.156428460783, 5175.482451754813, 4720.0, 4723.952760472385, 4723.952760472385, 4729.9763501182615, 4757.666963312569, 6265.71804268809, 6290.591111577779, 6405.871882562323, 6444.871102577969, 6453.419192272671, 5967.403259674042, 5984.9401505984815, 6026.457618814327, 6052.001419765734, 6052.273727152726, 6744.9090781857785, 6772.593644381303, 6807.761728339534, 6813.965930170318, 6858.691358888812, 4975.651704380694, 5244.449332820037, 5256.395514515842, 5263.368395792491, 5269.578433725293, 6791.252962174157, 6867.587944723333, 6977.988191712224, 7068.611226382547, 7077.186123595801, 5322.33470816148, 5335.786568537293, 5368.2752828367675, 5416.749950029951, 5444.237806707064, 5490.69801160932, 5491.643043202179, 5505.724713764376, 5522.5581953443625, 5529.778808847601, 5907.852303692356, 6049.21360223177, 6050.878982420415, 6056.273247210363, 6082.391760823971, 6780.38976492118, 6788.762393316309, 6809.659517024129, 6836.794896153124, 6844.247132815386, 1875.409246087478, 1877.183425210038, 1890.5840715042668, 1891.1678861300984, 1900.6103748731477, 1296.9610911672664, 1351.9522370163202, 1356.1659579358623, 1358.7282543491342, 1365.8702423269774, 6181.227346581677, 6295.276043255084, 6321.546044409812, 6344.143540622049, 6344.270408902943, 6700.530962832555, 6800.4219641330055, 6821.522493425413, 6848.897266541006, 6952.895706564405, 6270.874582508324, 6281.466075383552, 6299.905501417391, 6314.705485375487, 6436.259830119502, 3609.151849315409, 3628.836702348348, 3654.250878569887, 3658.487811706363, 3670.7797532148156, 7210.819729506699, 7227.13274407064, 7236.9276307237305, 7286.271372862671, 7301.452391070691, 6979.89530157048, 6988.545744526589, 7042.823929401806, 7054.753083642048, 7070.434365250768, 7163.14042314936, 7191.0, 7286.234945330876, 7287.2712728727765, 7296.562206267641, 6762.222344430454, 6767.221769496571, 6848.554843935129, 6869.725210991504, 6923.9653801730665, 6599.571027883172, 6687.130673012477, 6735.158105236846, 6786.321367863175, 6858.931410685829, 7037.859242815218, 7098.609576473137, 7101.325374089453, 7157.0, 7235.782926512213, 5281.102212623787, 5307.41618421981, 5312.7343632818975, 5338.3060202173465, 5355.866103347447, 6613.0, 6640.501962352746, 6723.562968407038, 6924.303545631353, 6930.896036559557, 6618.602883826986, 6722.193336799615, 6731.831704207238, 6761.830954225987, 6762.425193858577, 6506.479481641362, 6543.770968016097, 6572.572782769104, 6670.366315200048, 6710.597364158166, 6566.9343306568235, 6579.901301480386, 6602.986089242827, 6625.701843416961, 6722.226943901514, 6724.529282950147, 6732.6297053660555, 6761.594304341756, 6779.762708305186, 6801.761938332134, 6497.382748638872, 6499.350064993463, 6532.5753826001155, 6575.849226385459, 6615.470762338905], "value": 5320.9496774580375, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [967.7145242153564, 999.9300048996571, 999.9900000999988, 1013.0072528921661, 1030.4281123976193, 21272.14911403544, 21682.457938551524, 21716.348509544718, 21721.67417488739, 21746.456338591503, 19567.0, 19717.802821971774, 20602.278920237793, 20803.0, 20829.375118746462, 1068.647346375696, 1090.3457925244868, 1091.3124731419196, 1091.4651820607885, 1091.732525531246, 1044.4360045575418, 1080.7352198711326, 1098.2751384086505, 1102.5589764094345, 1105.778844231153, 1171.2445472670122, 1171.572376082728, 1172.5720112159042, 1172.6950992741906, 1175.4886624318406, 1154.3016475032568, 1161.8141097424414, 1161.8431511745891, 1164.633140560725, 1167.7897978363892, 852.663198036772, 860.1570460948243, 860.9440386374928, 862.1464749897619, 862.1723145780059, 18501.722474162765, 18503.537411564685, 18503.722444163348, 18543.443696688984, 19998.80001199984, 24240.878795606084, 24497.755022449903, 24804.751952480423, 24809.379765505826, 24815.62776558353, 18410.35563755262, 18529.814701852945, 18612.255509779727, 18720.438386848415, 18766.530836729053, 3637.672609465161, 3652.3425783358985, 3664.175560498893, 3667.7249206309634, 3671.7796932183887, 151998.24000879924, 159644.20177899153, 160787.0, 162108.0, 164832.0, 16790.664186716196, 17036.403725869783, 17136.57158571046, 17292.394766183123, 17294.394696185824, 35428.645713543054, 35469.0, 35528.0, 35558.64441355605, 35773.64226357755, 10020.498975051218, 10191.337563058378, 10238.641647542448, 10253.487325633838, 10384.740381490372, 4952.207646776498, 5025.14572522672, 5027.874303142451, 5044.041632089965, 5071.4928507149725, 6436.485081193493, 6496.123023391876, 6501.284858665543, 6520.608763474207, 6541.542092053511, 1198.4067886396115, 1211.357980270458, 1220.2190598017276, 1229.059769276504, 1231.0, 763.1224092293795, 763.282514436428, 780.3406121827047, 784.1374488063199, 796.5499492786557, 13585.116967397087, 13812.447502099803, 13955.162690238416, 14681.0, 14794.193082496988, 774.2605811450052, 775.8215610409637, 778.7780482562442, 783.7727059152896, 791.192983157188, 6669.733210671616, 6758.493113016543, 6798.796036118924, 6805.251422343538, 6847.863042739117, 151392.0, 153571.2321438408, 154739.0, 157184.49854255046, 159865.0, 134782.32608836892, 135274.32362838121, 135672.32163839118, 137453.0, 140451.29774351063, 116294.0, 116565.4171729136, 116947.0, 118871.0, 119023.99999999827, 12518.248905065726, 12582.622521324374, 12618.747625047632, 12683.556075537312, 12687.619371418872, 54426.18360724513, 54577.72711136419, 54600.0, 55405.72297138489, 55540.72229638826, 70200.29799701937, 71964.0, 72245.0, 72363.27636723565, 75104.62447687946, 18637.627247454704, 18773.436796896116, 18831.6233675323, 18849.71725424147, 19001.23995040183, 18519.166637501075, 19111.713324300425, 19426.0, 19431.902840485705, 19450.805491945466, 19262.94053827053, 19625.607487849877, 19690.113944872228, 19725.309614163434, 20142.59714805725, 18755.0, 19006.524836879187, 19098.14058367349, 19147.425577232705, 19217.711734324275, 18538.443846684622, 18593.070346482353, 18729.81270187281, 18741.531461713566, 18743.250269989592, 12791.232526048467, 13006.739865202831, 13186.011049171158, 13364.665883352995, 13372.0, 12363.75272494563, 12417.0, 12588.748225035632, 12599.118061735957, 12686.429110690226], "value": 10236.75419328718, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1364.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 105.0, 105.0, 105.0, 105.0, 106.0, 109.0, 108.0, 106.0, 107.0], "value": 106.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 112.0, 115.0, 137.0, 112.0, 119.0, 110.0, 110.0, 141.0], "value": 118.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 161.0, 162.0, 160.0, 163.0, 162.0, 165.0, 161.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 76.0, 75.0, 74.0, 74.0, 73.0, 77.0, 74.0, 75.0], "value": 74.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 85.0, 81.0, 77.0, 77.0, 78.0, 76.0, 77.0, 78.0], "value": 78.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 114.0, 114.0, 114.0, 115.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 147.0, 148.0, 148.0, 148.0, 148.0, 148.0, 149.0, 149.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 99.0, 98.0, 98.0, 99.0, 97.0, 95.0, 94.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 47.0, 43.0, 44.0, 43.0, 43.0, 43.0, 44.0, 42.0, 43.0], "value": 43.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 38.0, 38.0, 37.0, 38.0, 38.0, 37.0, 38.0, 38.0, 38.0], "value": 37.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 84.0, 70.0, 71.0, 68.0, 69.0, 69.0, 71.0, 70.0, 71.0], "value": 71.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 108.0, 103.0, 103.0, 104.0, 104.0, 107.0, 102.0, 102.0, 117.0], "value": 105.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 146.0, 149.0, 147.0, 152.0, 146.0, 155.0, 148.0, 150.0, 147.0], "value": 149.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 59.0, 63.0, 62.0, 60.0, 59.0, 57.0, 58.0, 57.0], "value": 59.2, "unit": "score"}]}]} 13:08:31 INFO - Return code: 0 13:08:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:08:31 INFO - # TBPL SUCCESS # 13:08:31 INFO - Running post-action listener: _package_coverage_data 13:08:31 INFO - Running post-action listener: _resource_record_post_action 13:08:31 INFO - [mozharness: 2017-09-26 20:08:31.220849Z] Finished run-tests step (success) 13:08:31 INFO - Running post-run listener: _resource_record_post_run 13:08:31 INFO - Total resource usage - Wall time: 1180s; CPU: 13.0%; Read bytes: 139264; Write bytes: 283529216; Read time: 532; Write time: 156364 13:08:31 INFO - TinderboxPrint: CPU usage
13.0% 13:08:31 INFO - TinderboxPrint: I/O read bytes / time
139,264 / 532 13:08:31 INFO - TinderboxPrint: I/O write bytes / time
283,529,216 / 156,364 13:08:31 INFO - TinderboxPrint: CPU idle
8,181.3 (86.9%) 13:08:31 INFO - TinderboxPrint: CPU user
1,178.5 (12.5%) 13:08:31 INFO - TinderboxPrint: Swap in / out
0 / 0 13:08:31 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 9129984; Read time: 0; Write time: 1456 13:08:31 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 13:08:31 INFO - run-tests - Wall time: 1165s; CPU: 13.0%; Read bytes: 139264; Write bytes: 274399232; Read time: 532; Write time: 154908 13:08:31 INFO - Running post-run listener: _upload_blobber_files 13:08:31 INFO - Blob upload gear active. 13:08:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:08:31 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 13:08:31 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'] 13:08:31 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 13:08:32 INFO - (blobuploader) - INFO - Open directory for files ... 13:08:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:08:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:08:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:08:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:08:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:08:36 INFO - (blobuploader) - INFO - Done attempting. 13:08:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:08:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:08:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:08:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:08:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:08:37 INFO - (blobuploader) - INFO - Done attempting. 13:08:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:08:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:08:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:08:38 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:08:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:08:38 INFO - (blobuploader) - INFO - Done attempting. 13:08:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:08:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:08:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:08:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:08:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:08:39 INFO - (blobuploader) - INFO - Done attempting. 13:08:39 INFO - (blobuploader) - INFO - Iteration through files over. 13:08:39 INFO - Return code: 0 13:08:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:08:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:08:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0a6780ca6f6bf95a2413c9b8532b0283913d10ca931a94cc0920804446579794655be385079aea31483725981c15620ece76b20d15a9a65c0f31ebd8254024ed", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/bd51a4c40cadc33502646c6822feec0a0746a30cfe55ab8c9d69180785e841a826b85fe9bb46179e3dc82ccab6eed9e0f77b5a6d248ffddf381b160a368e900a", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/345db03ae555334560556ccf61142105c1b5cdcbd42baafc75f5f242e5ea40d406aa9ae2cf7021386d0432e79a0fa4f89eb744485de93d097d2ef94d34a8981d", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/496aeabe99b09ff194b578fb27f5f83355c2dd2c9794b10e7a5df2fed9735c1d51fc0f58a52e10ea910562499a4c2c7c614f58c54b281f02e152a4001d7845f8"} 13:08:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:08:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:08:39 INFO - Contents: 13:08:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0a6780ca6f6bf95a2413c9b8532b0283913d10ca931a94cc0920804446579794655be385079aea31483725981c15620ece76b20d15a9a65c0f31ebd8254024ed", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/bd51a4c40cadc33502646c6822feec0a0746a30cfe55ab8c9d69180785e841a826b85fe9bb46179e3dc82ccab6eed9e0f77b5a6d248ffddf381b160a368e900a", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/345db03ae555334560556ccf61142105c1b5cdcbd42baafc75f5f242e5ea40d406aa9ae2cf7021386d0432e79a0fa4f89eb744485de93d097d2ef94d34a8981d", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/496aeabe99b09ff194b578fb27f5f83355c2dd2c9794b10e7a5df2fed9735c1d51fc0f58a52e10ea910562499a4c2c7c614f58c54b281f02e152a4001d7845f8"} 13:08:39 INFO - Running post-run listener: copy_logs_to_upload_dir 13:08:39 INFO - Copying logs to upload dir... 13:08:39 INFO - mkdir: /builds/slave/test/build/upload/logs 13:08:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.363014 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2017-09-26 13:08:39.236182) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 13:08:39.240223) ========= 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=32c5991c409366f7fec8a718000001d2-1506453887.278188-1175121432 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/0a6780ca6f6bf95a2413c9b8532b0283913d10ca931a94cc0920804446579794655be385079aea31483725981c15620ece76b20d15a9a65c0f31ebd8254024ed", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/bd51a4c40cadc33502646c6822feec0a0746a30cfe55ab8c9d69180785e841a826b85fe9bb46179e3dc82ccab6eed9e0f77b5a6d248ffddf381b160a368e900a", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/345db03ae555334560556ccf61142105c1b5cdcbd42baafc75f5f242e5ea40d406aa9ae2cf7021386d0432e79a0fa4f89eb744485de93d097d2ef94d34a8981d", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/496aeabe99b09ff194b578fb27f5f83355c2dd2c9794b10e7a5df2fed9735c1d51fc0f58a52e10ea910562499a4c2c7c614f58c54b281f02e152a4001d7845f8"} build_url:https://queue.taskcluster.net/v1/task/ZsCq7lJfRZeT3aFCi1e-1Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011495 build_url: 'https://queue.taskcluster.net/v1/task/ZsCq7lJfRZeT3aFCi1e-1Q/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/0a6780ca6f6bf95a2413c9b8532b0283913d10ca931a94cc0920804446579794655be385079aea31483725981c15620ece76b20d15a9a65c0f31ebd8254024ed", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/bd51a4c40cadc33502646c6822feec0a0746a30cfe55ab8c9d69180785e841a826b85fe9bb46179e3dc82ccab6eed9e0f77b5a6d248ffddf381b160a368e900a", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/345db03ae555334560556ccf61142105c1b5cdcbd42baafc75f5f242e5ea40d406aa9ae2cf7021386d0432e79a0fa4f89eb744485de93d097d2ef94d34a8981d", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/496aeabe99b09ff194b578fb27f5f83355c2dd2c9794b10e7a5df2fed9735c1d51fc0f58a52e10ea910562499a4c2c7c614f58c54b281f02e152a4001d7845f8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 13:08:39.270193) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 13:08:39.270598) ========= 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=32c5991c409366f7fec8a718000001d2-1506453887.278188-1175121432 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004529 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 13:08:39.354814) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 13:08:39.355182) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 13:08:39.355533) ========= ========= Total master_lag: 0.19 =========