builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-008 starttime: 1507837828.93 results: success (0) revision: c8d3b27528f758e9291946fa16b1269b6ec71acb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-12 12:50:28.934702) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-12 12:50:28.935282) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-12 12:50:28.935584) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-12 12:50:28.954580) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-12 12:50:28.954862) ========= 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-1507836858.180558-968221669 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-12 12:50:28-- 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% 45.8M=0s 2017-10-12 12:50:29 (45.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.154976 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-12 12:50:29.128878) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-12 12:50:29.129179) ========= 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-1507836858.180558-968221669 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020390 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-12 12:50:29.178328) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-12 12:50:29.178670) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c8d3b27528f758e9291946fa16b1269b6ec71acb --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 c8d3b27528f758e9291946fa16b1269b6ec71acb --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-1507836858.180558-968221669 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-12 12:50:29,229 truncating revision to first 12 chars 2017-10-12 12:50:29,229 Setting DEBUG logging. 2017-10-12 12:50:29,230 attempt 1/10 2017-10-12 12:50:29,230 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/c8d3b27528f7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-12 12:50:29,808 unpacking tar archive at: mozilla-beta-c8d3b27528f7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.944238 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-12 12:50:30.143524) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-12 12:50:30.143830) ========= script_repo_revision: c8d3b27528f758e9291946fa16b1269b6ec71acb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-12 12:50:30.144478) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-12 12:50:30.145206) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-12 12:50:30.161051) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2017-10-12 12:50:30.161550) ========= /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-1507836858.180558-968221669 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:50:30 INFO - MultiFileLogger online at 20171012 12:50:30 in /builds/slave/test 12:50:30 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:50:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:50:30 INFO - {'append_to_log': False, 12:50:30 INFO - 'base_work_dir': '/builds/slave/test', 12:50:30 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 12:50:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:50:30 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 12:50:30 INFO - 'buildbot_json_path': 'buildprops.json', 12:50:30 INFO - 'code_coverage': False, 12:50:30 INFO - 'config_files': ('talos/linux_config.py',), 12:50:30 INFO - 'default_actions': ('clobber', 12:50:30 INFO - 'read-buildbot-config', 12:50:30 INFO - 'download-and-extract', 12:50:30 INFO - 'populate-webroot', 12:50:30 INFO - 'create-virtualenv', 12:50:30 INFO - 'install', 12:50:30 INFO - 'setup-mitmproxy', 12:50:30 INFO - 'run-tests'), 12:50:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:50:30 INFO - 'disable_ccov_upload': False, 12:50:30 INFO - 'disable_stylo': False, 12:50:30 INFO - 'download_minidump_stackwalk': True, 12:50:30 INFO - 'download_symbols': 'ondemand', 12:50:30 INFO - 'enable_stylo': False, 12:50:30 INFO - 'enable_webrender': False, 12:50:30 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 12:50:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:50:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:50:30 INFO - 'gecko_profile': False, 12:50:30 INFO - 'gecko_profile_interval': 0, 12:50:30 INFO - 'installer_path': 'installer.exe', 12:50:30 INFO - 'log_level': 'info', 12:50:30 INFO - 'log_name': 'talos', 12:50:30 INFO - 'log_to_console': True, 12:50:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:50:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:50:30 INFO - 'opt_config_files': (), 12:50:30 INFO - 'pip_index': False, 12:50:30 INFO - 'suite': 'dromaeojs-e10s', 12:50:30 INFO - 'system_bits': '32', 12:50:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:50:30 INFO - 'title': 'talos-linux64-ix-008', 12:50:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:50:30 INFO - 'use_talos_json': True, 12:50:30 INFO - 'verify': 'False', 12:50:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:50:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:50:30 INFO - 'work_dir': 'build'} 12:50:30 INFO - [mozharness: 2017-10-12 19:50:30.353163Z] Running clobber step. 12:50:30 INFO - Running pre-action listener: _resource_record_pre_action 12:50:30 INFO - Running main action method: clobber 12:50:30 INFO - rmtree: /builds/slave/test/build 12:50:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:50:31 INFO - Running post-action listener: _resource_record_post_action 12:50:31 INFO - [mozharness: 2017-10-12 19:50:31.399263Z] Finished clobber step (success) 12:50:31 INFO - [mozharness: 2017-10-12 19:50:31.399358Z] Running read-buildbot-config step. 12:50:31 INFO - Running pre-action listener: _resource_record_pre_action 12:50:31 INFO - Running main action method: read_buildbot_config 12:50:31 INFO - Using buildbot properties: 12:50:31 INFO - { 12:50:31 INFO - "project": "", 12:50:31 INFO - "product": "firefox", 12:50:31 INFO - "who": "ryanvm@gmail.com", 12:50:31 INFO - "installer_path": "public/build/target.tar.bz2", 12:50:31 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 12:50:31 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 12:50:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 12:50:31 INFO - "stage_platform": "linux64", 12:50:31 INFO - "basedir": "/builds/slave/test", 12:50:31 INFO - "buildnumber": 136, 12:50:31 INFO - "platform": "ubuntu64_hw", 12:50:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:50:31 INFO - "slavebuilddir": "test", 12:50:31 INFO - "taskId": "FV7p29hGQ9-JGrzEA2Cejg", 12:50:31 INFO - "branch": "mozilla-beta", 12:50:31 INFO - "script_repo_revision": "production", 12:50:31 INFO - "revision": "c8d3b27528f758e9291946fa16b1269b6ec71acb", 12:50:31 INFO - "slavename": "talos-linux64-ix-008", 12:50:31 INFO - "repo_path": "releases/mozilla-beta" 12:50:31 INFO - } 12:50:31 INFO - Finding installer, test and symbols from parent task. 12:50:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FV7p29hGQ9-JGrzEA2Cejg'}, attempt #1 12:50:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FV7p29hGQ9-JGrzEA2Cejg'}, attempt #1 12:50:32 INFO - Task dependencies: Kp4_jGBTQHegYf4_Zs6oIg 12:50:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kp4_jGBTQHegYf4_Zs6oIg'}, attempt #1 12:50:32 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Kp4_jGBTQHegYf4_Zs6oIg/artifacts/public/build/target.tar.bz2 12:50:32 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Kp4_jGBTQHegYf4_Zs6oIg/artifacts/public/build/target.test_packages.json 12:50:32 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Kp4_jGBTQHegYf4_Zs6oIg/artifacts/public/build/target.crashreporter-symbols.zip 12:50:32 INFO - Running post-action listener: _resource_record_post_action 12:50:32 INFO - [mozharness: 2017-10-12 19:50:32.792970Z] Finished read-buildbot-config step (success) 12:50:32 INFO - [mozharness: 2017-10-12 19:50:32.793185Z] Running download-and-extract step. 12:50:32 INFO - Running pre-action listener: _resource_record_pre_action 12:50:32 INFO - Running main action method: download_and_extract 12:50:32 INFO - mkdir: /builds/slave/test/build/tests 12:50: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:50:32 INFO - trying https://queue.taskcluster.net/v1/task/Kp4_jGBTQHegYf4_Zs6oIg/artifacts/public/build/target.test_packages.json 12:50:32 INFO - Downloading https://queue.taskcluster.net/v1/task/Kp4_jGBTQHegYf4_Zs6oIg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 12:50:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kp4_jGBTQHegYf4_Zs6oIg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 12:50:33 INFO - Downloaded 989 bytes. 12:50:33 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 12:50:33 INFO - Using the following test package requirements: 12:50:33 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 12:50:33 INFO - u'common': [u'target.common.tests.zip'], 12:50:33 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 12:50:33 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 12:50:33 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 12:50:33 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 12:50:33 INFO - u'mozbase': [u'target.common.tests.zip'], 12:50:33 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 12:50:33 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 12:50:33 INFO - u'web-platform': [u'target.common.tests.zip', 12:50:33 INFO - u'target.web-platform.tests.tar.gz'], 12:50:33 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 12:50:33 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 12:50:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kp4_jGBTQHegYf4_Zs6oIg/artifacts/public/build/target.common.tests.zip 12:50:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kp4_jGBTQHegYf4_Zs6oIg/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:50:33 INFO - Fetch https://queue.taskcluster.net/v1/task/Kp4_jGBTQHegYf4_Zs6oIg/artifacts/public/build/target.common.tests.zip into memory 12:50:34 INFO - Content-Length response header: 55185954 12:50:34 INFO - Bytes received: 55185954 12:50:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kp4_jGBTQHegYf4_Zs6oIg/artifacts/public/build/target.talos.tests.zip 12:50:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kp4_jGBTQHegYf4_Zs6oIg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 12:50:45 INFO - Fetch https://queue.taskcluster.net/v1/task/Kp4_jGBTQHegYf4_Zs6oIg/artifacts/public/build/target.talos.tests.zip into memory 12:50:45 INFO - Content-Length response header: 14509251 12:50:45 INFO - Bytes received: 14509251 12:50:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:46 INFO - trying https://queue.taskcluster.net/v1/task/Kp4_jGBTQHegYf4_Zs6oIg/artifacts/public/build/target.tar.bz2 12:50:46 INFO - Downloading https://queue.taskcluster.net/v1/task/Kp4_jGBTQHegYf4_Zs6oIg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 12:50:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kp4_jGBTQHegYf4_Zs6oIg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 12:50:47 INFO - Downloaded 53562586 bytes. 12:50:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Kp4_jGBTQHegYf4_Zs6oIg/artifacts/public/build/target.tar.bz2 12:50:47 INFO - mkdir: /builds/slave/test/properties 12:50:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:50:47 INFO - Writing to file /builds/slave/test/properties/build_url 12:50:47 INFO - Contents: 12:50:47 INFO - build_url:https://queue.taskcluster.net/v1/task/Kp4_jGBTQHegYf4_Zs6oIg/artifacts/public/build/target.tar.bz2 12:50:47 INFO - Running post-action listener: _resource_record_post_action 12:50:47 INFO - Running post-action listener: find_tests_for_verification 12:50:47 INFO - Running post-action listener: set_extra_try_arguments 12:50:47 INFO - [mozharness: 2017-10-12 19:50:47.041020Z] Finished download-and-extract step (success) 12:50:47 INFO - [mozharness: 2017-10-12 19:50:47.041119Z] Running populate-webroot step. 12:50:47 INFO - Running pre-action listener: _resource_record_pre_action 12:50:47 INFO - Running main action method: populate_webroot 12:50:47 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:50:47 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:50:47 INFO - 'tests': ['tresize', 12:50:47 INFO - 'tcanvasmark']}, 12:50:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:50:47 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:50:47 INFO - 'tests': ['dromaeo_css', 12:50:47 INFO - 'kraken']}, 12:50:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:50:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:50:47 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:50:47 INFO - 'talos_options': ['--disable-stylo'], 12:50:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:50:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:50:47 INFO - 'tests': ['damp', 'tps']}, 12:50:47 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:50:47 INFO - 'talos_options': ['--disable-stylo'], 12:50:47 INFO - 'tests': ['damp', 'tps']}, 12:50:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:50:47 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:50:47 INFO - 'tests': ['dromaeo_dom']}, 12:50:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 12:50:47 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:50:47 INFO - 'tests': ['basic_compositor_video', 12:50:47 INFO - 'glvideo']}, 12:50:47 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 12:50:47 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 12:50:47 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:50:47 INFO - 'talos_options': ['--disable-stylo'], 12:50:47 INFO - 'tests': ['ts_paint_webext', 12:50:47 INFO - 'tp5o_webext']}, 12:50:47 INFO - 'other-e10s': {'tests': ['a11yr', 12:50:47 INFO - 'ts_paint', 12:50:47 INFO - 'tpaint', 12:50:47 INFO - 'sessionrestore', 12:50:47 INFO - 'sessionrestore_many_windows', 12:50:47 INFO - 'sessionrestore_no_auto_restore', 12:50:47 INFO - 'tabpaint']}, 12:50:47 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:50:47 INFO - 'tests': ['a11yr', 12:50:47 INFO - 'ts_paint', 12:50:47 INFO - 'tpaint', 12:50:47 INFO - 'sessionrestore', 12:50:47 INFO - 'sessionrestore_many_windows', 12:50:47 INFO - 'sessionrestore_no_auto_restore', 12:50:47 INFO - 'tabpaint']}, 12:50:47 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 12:50:47 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 12:50:47 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:50:47 INFO - 'tests': ['perf_reftest_singletons']}, 12:50:47 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:50:47 INFO - 'tests': ['bloom_basic']}, 12:50:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:50:47 INFO - 'tsvgr_opacity', 12:50:47 INFO - 'tart', 12:50:47 INFO - 'tscrollx', 12:50:47 INFO - 'tsvg_static']}, 12:50:47 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:50:47 INFO - 'tests': ['tsvgx', 12:50:47 INFO - 'tsvgr_opacity', 12:50:47 INFO - 'tart', 12:50:47 INFO - 'tscrollx', 12:50:47 INFO - 'tsvg_static']}, 12:50:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:50:47 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:50:47 INFO - 'talos_options': ['--disable-stylo'], 12:50:47 INFO - 'tests': ['tp5o']}, 12:50:47 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:50:47 INFO - 'talos_options': ['--mitmproxy', 12:50:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:50:47 INFO - '--firstNonBlankPaint'], 12:50:47 INFO - 'tests': ['tp6_google', 12:50:47 INFO - 'tp6_youtube', 12:50:47 INFO - 'tp6_amazon', 12:50:47 INFO - 'tp6_facebook']}, 12:50:47 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:50:47 INFO - 'talos_options': ['--disable-stylo', 12:50:47 INFO - '--mitmproxy', 12:50:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:50:47 INFO - '--firstNonBlankPaint'], 12:50:47 INFO - 'tests': ['tp6_google', 12:50:47 INFO - 'tp6_youtube', 12:50:47 INFO - 'tp6_amazon', 12:50:47 INFO - 'tp6_facebook']}, 12:50:47 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:50:47 INFO - 'talos_options': ['--stylo-threads=1', 12:50:47 INFO - '--mitmproxy', 12:50:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:50:47 INFO - '--firstNonBlankPaint'], 12:50:47 INFO - 'tests': ['tp6_google', 12:50:47 INFO - 'tp6_youtube', 12:50:47 INFO - 'tp6_amazon', 12:50:47 INFO - 'tp6_facebook']}, 12:50:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:50:47 INFO - 'talos_options': ['--xperf_path', 12:50:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:50:47 INFO - 'tests': ['tp5n']}, 12:50:47 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:50:47 INFO - 'talos_options': ['--disable-stylo', 12:50:47 INFO - '--xperf_path', 12:50:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:50:47 INFO - 'tests': ['tp5n']}}} 12:50:47 INFO - Running post-action listener: _resource_record_post_action 12:50:47 INFO - [mozharness: 2017-10-12 19:50:47.055854Z] Finished populate-webroot step (success) 12:50:47 INFO - [mozharness: 2017-10-12 19:50:47.055941Z] Running create-virtualenv step. 12:50:47 INFO - Running pre-action listener: _resource_record_pre_action 12:50:47 INFO - Running main action method: create_virtualenv 12:50:47 INFO - Creating virtualenv /builds/slave/test/build/venv 12:50:47 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:50:47 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 12:50:47 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 12:50:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:50:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:50:47 INFO - Installing distribute.............................................................................................................................................................................................done. 12:50:47 INFO - Installing pip...............done. 12:50:47 INFO - Return code: 0 12:50:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:50:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:50:48 INFO - Reading from file tmpfile_stdout 12:50:48 INFO - Output received: 12:50:48 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:50:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:50: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:50:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50: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:50:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2225a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cc090>, '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 0x23ccd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c6f90>, '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-1507836858.180558-968221669', '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:50:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:50:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:50:48 INFO - Using env: {'DISPLAY': ':0', 12:50:48 INFO - 'HOME': '/home/cltbld', 12:50:48 INFO - 'LANG': 'en_US.UTF-8', 12:50:48 INFO - 'LANGUAGE': 'en_US:en', 12:50:48 INFO - 'LOGNAME': 'cltbld', 12:50:48 INFO - 'MAIL': '/var/mail/cltbld', 12:50:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:48 INFO - 'MOZ_NO_REMOTE': '1', 12:50:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:48 INFO - 'NO_EM_RESTART': '1', 12:50:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:48 INFO - 'PWD': '/builds/slave/test', 12:50:48 INFO - 'SHELL': '/bin/bash', 12:50:48 INFO - 'SHLVL': '1', 12:50:48 INFO - 'TERM': 'linux', 12:50:48 INFO - 'TMOUT': '86400', 12:50:48 INFO - 'USER': 'cltbld', 12:50:48 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1507836858.180558-968221669', 12:50:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:48 INFO - '_': '/tools/buildbot/bin/python'} 12:50:49 INFO - Ignoring indexes: http://pypi.python.org/simple/ 12:50:49 INFO - Downloading/unpacking pip>=1.5 12:50:49 INFO - Running setup.py egg_info for package pip 12:50:49 INFO - warning: no files found matching 'pip/cacert.pem' 12:50:49 INFO - warning: no files found matching '*.html' under directory 'docs' 12:50:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 12:50:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 12:50:49 INFO - Installing collected packages: pip 12:50:49 INFO - Found existing installation: pip 1.1 12:50:49 INFO - Uninstalling pip: 12:50:49 INFO - Successfully uninstalled pip 12:50:49 INFO - Running setup.py install for pip 12:50:49 INFO - warning: no files found matching 'pip/cacert.pem' 12:50:49 INFO - warning: no files found matching '*.html' under directory 'docs' 12:50:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 12:50:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 12:50:49 INFO - Installing pip script to /builds/slave/test/build/venv/bin 12:50:49 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 12:50:49 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 12:50:49 INFO - Successfully installed pip 12:50:49 INFO - Cleaning up... 12:50:49 INFO - Return code: 0 12:50:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:50:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x205d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2225a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cc090>, '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 0x23ccd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c6f90>, '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-1507836858.180558-968221669', '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:50:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:50:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:50:49 INFO - Using env: {'DISPLAY': ':0', 12:50:49 INFO - 'HOME': '/home/cltbld', 12:50:49 INFO - 'LANG': 'en_US.UTF-8', 12:50:49 INFO - 'LANGUAGE': 'en_US:en', 12:50:49 INFO - 'LOGNAME': 'cltbld', 12:50:49 INFO - 'MAIL': '/var/mail/cltbld', 12:50:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:49 INFO - 'MOZ_NO_REMOTE': '1', 12:50:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:49 INFO - 'NO_EM_RESTART': '1', 12:50:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:49 INFO - 'PWD': '/builds/slave/test', 12:50:49 INFO - 'SHELL': '/bin/bash', 12:50:49 INFO - 'SHLVL': '1', 12:50:49 INFO - 'TERM': 'linux', 12:50:49 INFO - 'TMOUT': '86400', 12:50:49 INFO - 'USER': 'cltbld', 12:50:49 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1507836858.180558-968221669', 12:50:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:49 INFO - '_': '/tools/buildbot/bin/python'} 12:50:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:49 INFO - Downloading/unpacking psutil>=3.1.1 12:50:49 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:50:49 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:50:49 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:50:49 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:50:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:50:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:50:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:50:50 INFO - Installing collected packages: psutil 12:50:50 INFO - Running setup.py install for psutil 12:50:50 INFO - building 'psutil._psutil_linux' extension 12:50:50 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:50:50 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:50:51 INFO - building 'psutil._psutil_posix' extension 12:50:51 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:50:51 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:50:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:50:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:50:51 INFO - Successfully installed psutil 12:50:51 INFO - Cleaning up... 12:50:51 INFO - Return code: 0 12:50:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:50:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2225a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cc090>, '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 0x23ccd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c6f90>, '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-1507836858.180558-968221669', '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:50:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:50:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:50:51 INFO - Using env: {'DISPLAY': ':0', 12:50:51 INFO - 'HOME': '/home/cltbld', 12:50:51 INFO - 'LANG': 'en_US.UTF-8', 12:50:51 INFO - 'LANGUAGE': 'en_US:en', 12:50:51 INFO - 'LOGNAME': 'cltbld', 12:50:51 INFO - 'MAIL': '/var/mail/cltbld', 12:50:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:51 INFO - 'MOZ_NO_REMOTE': '1', 12:50:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:51 INFO - 'NO_EM_RESTART': '1', 12:50:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:51 INFO - 'PWD': '/builds/slave/test', 12:50:51 INFO - 'SHELL': '/bin/bash', 12:50:51 INFO - 'SHLVL': '1', 12:50:51 INFO - 'TERM': 'linux', 12:50:51 INFO - 'TMOUT': '86400', 12:50:51 INFO - 'USER': 'cltbld', 12:50:51 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1507836858.180558-968221669', 12:50:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:51 INFO - '_': '/tools/buildbot/bin/python'} 12:50:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:50:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:50:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:50:52 INFO - Installing collected packages: mozsystemmonitor 12:50:52 INFO - Running setup.py install for mozsystemmonitor 12:50:52 INFO - Successfully installed mozsystemmonitor 12:50:52 INFO - Cleaning up... 12:50:53 INFO - Return code: 0 12:50:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:50:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x205d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2225a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cc090>, '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 0x23ccd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c6f90>, '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-1507836858.180558-968221669', '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:50:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:50:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:50:53 INFO - Using env: {'DISPLAY': ':0', 12:50:53 INFO - 'HOME': '/home/cltbld', 12:50:53 INFO - 'LANG': 'en_US.UTF-8', 12:50:53 INFO - 'LANGUAGE': 'en_US:en', 12:50:53 INFO - 'LOGNAME': 'cltbld', 12:50:53 INFO - 'MAIL': '/var/mail/cltbld', 12:50:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:53 INFO - 'MOZ_NO_REMOTE': '1', 12:50:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:53 INFO - 'NO_EM_RESTART': '1', 12:50:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:53 INFO - 'PWD': '/builds/slave/test', 12:50:53 INFO - 'SHELL': '/bin/bash', 12:50:53 INFO - 'SHLVL': '1', 12:50:53 INFO - 'TERM': 'linux', 12:50:53 INFO - 'TMOUT': '86400', 12:50:53 INFO - 'USER': 'cltbld', 12:50:53 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1507836858.180558-968221669', 12:50:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:53 INFO - '_': '/tools/buildbot/bin/python'} 12:50:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:53 INFO - Downloading/unpacking jsonschema==2.5.1 12:50:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:50:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:55 INFO - Downloading functools32-3.2.3-2.tar.gz 12:50:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:50:56 INFO - warning: no files found matching '*.txt' 12:50:56 INFO - no previously-included directories found matching 'build' 12:50:56 INFO - no previously-included directories found matching 'dist' 12:50:56 INFO - no previously-included directories found matching '.git*' 12:50:56 INFO - Installing collected packages: jsonschema, functools32 12:50:56 INFO - Running setup.py install for functools32 12:50:56 INFO - warning: no files found matching '*.txt' 12:50:56 INFO - no previously-included directories found matching 'build' 12:50:56 INFO - no previously-included directories found matching 'dist' 12:50:56 INFO - no previously-included directories found matching '.git*' 12:50:56 INFO - Successfully installed jsonschema functools32 12:50:56 INFO - Cleaning up... 12:50:56 INFO - Return code: 0 12:50:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:56 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 0x205d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2225a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cc090>, '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 0x23ccd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c6f90>, '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-1507836858.180558-968221669', '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:50:56 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:50:56 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:50:56 INFO - Using env: {'DISPLAY': ':0', 12:50:56 INFO - 'HOME': '/home/cltbld', 12:50:56 INFO - 'LANG': 'en_US.UTF-8', 12:50:56 INFO - 'LANGUAGE': 'en_US:en', 12:50:56 INFO - 'LOGNAME': 'cltbld', 12:50:56 INFO - 'MAIL': '/var/mail/cltbld', 12:50:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:56 INFO - 'MOZ_NO_REMOTE': '1', 12:50:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:56 INFO - 'NO_EM_RESTART': '1', 12:50:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:56 INFO - 'PWD': '/builds/slave/test', 12:50:56 INFO - 'SHELL': '/bin/bash', 12:50:56 INFO - 'SHLVL': '1', 12:50:56 INFO - 'TERM': 'linux', 12:50:56 INFO - 'TMOUT': '86400', 12:50:56 INFO - 'USER': 'cltbld', 12:50:56 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1507836858.180558-968221669', 12:50:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:56 INFO - '_': '/tools/buildbot/bin/python'} 12:50:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:50:56 INFO - Cleaning up... 12:50:56 INFO - Return code: 0 12:50:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:56 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 0x205d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2225a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cc090>, '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 0x23ccd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c6f90>, '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-1507836858.180558-968221669', '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:50:56 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:50:56 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:50:56 INFO - Using env: {'DISPLAY': ':0', 12:50:56 INFO - 'HOME': '/home/cltbld', 12:50:56 INFO - 'LANG': 'en_US.UTF-8', 12:50:56 INFO - 'LANGUAGE': 'en_US:en', 12:50:56 INFO - 'LOGNAME': 'cltbld', 12:50:56 INFO - 'MAIL': '/var/mail/cltbld', 12:50:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:56 INFO - 'MOZ_NO_REMOTE': '1', 12:50:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:56 INFO - 'NO_EM_RESTART': '1', 12:50:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:56 INFO - 'PWD': '/builds/slave/test', 12:50:56 INFO - 'SHELL': '/bin/bash', 12:50:56 INFO - 'SHLVL': '1', 12:50:56 INFO - 'TERM': 'linux', 12:50:56 INFO - 'TMOUT': '86400', 12:50:56 INFO - 'USER': 'cltbld', 12:50:56 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1507836858.180558-968221669', 12:50:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:56 INFO - '_': '/tools/buildbot/bin/python'} 12:50:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:56 INFO - Downloading/unpacking blobuploader==1.2.4 12:50:56 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:50:56 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:50:56 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:50:56 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:50:57 INFO - Downloading blobuploader-1.2.4.tar.gz 12:50:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:50:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:50:57 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:50:57 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:50:57 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:50:57 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:50:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:50:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:58 INFO - Downloading docopt-0.6.1.tar.gz 12:50:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:50:58 INFO - Installing collected packages: blobuploader, requests, docopt 12:50:58 INFO - Running setup.py install for blobuploader 12:50:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:50:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:50:58 INFO - Running setup.py install for requests 12:50:58 INFO - Running setup.py install for docopt 12:50:58 INFO - Successfully installed blobuploader requests docopt 12:50:58 INFO - Cleaning up... 12:50:58 INFO - Return code: 0 12:50:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:50:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:58 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 0x205d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2225a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cc090>, '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 0x23ccd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c6f90>, '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-1507836858.180558-968221669', '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:50:58 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:50:58 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:50:58 INFO - Using env: {'DISPLAY': ':0', 12:50:58 INFO - 'HOME': '/home/cltbld', 12:50:58 INFO - 'LANG': 'en_US.UTF-8', 12:50:58 INFO - 'LANGUAGE': 'en_US:en', 12:50:58 INFO - 'LOGNAME': 'cltbld', 12:50:58 INFO - 'MAIL': '/var/mail/cltbld', 12:50:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:58 INFO - 'MOZ_NO_REMOTE': '1', 12:50:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:58 INFO - 'NO_EM_RESTART': '1', 12:50:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:58 INFO - 'PWD': '/builds/slave/test', 12:50:58 INFO - 'SHELL': '/bin/bash', 12:50:59 INFO - 'SHLVL': '1', 12:50:59 INFO - 'TERM': 'linux', 12:50:59 INFO - 'TMOUT': '86400', 12:50:59 INFO - 'USER': 'cltbld', 12:50:59 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1507836858.180558-968221669', 12:50:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:59 INFO - '_': '/tools/buildbot/bin/python'} 12:50:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:50:59 INFO - Running setup.py (path:/tmp/pip-Df9bYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:50:59 INFO - Running setup.py (path:/tmp/pip-oRZetp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:50:59 INFO - Running setup.py (path:/tmp/pip-As14LS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:50:59 INFO - Running setup.py (path:/tmp/pip-2ZzG3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:50:59 INFO - Running setup.py (path:/tmp/pip-_SJoET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:50:59 INFO - Running setup.py (path:/tmp/pip-AzzQvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:50:59 INFO - Running setup.py (path:/tmp/pip-MMICI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:50:59 INFO - Running setup.py (path:/tmp/pip-nNZe7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:50:59 INFO - Running setup.py (path:/tmp/pip-xMcGXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:50:59 INFO - Running setup.py (path:/tmp/pip-tAQKt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:50:59 INFO - Running setup.py (path:/tmp/pip-eyCVT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:50:59 INFO - Running setup.py (path:/tmp/pip-5suQGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:51:00 INFO - Running setup.py (path:/tmp/pip-0MyOc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:51:00 INFO - Running setup.py (path:/tmp/pip-3Rb1tE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:51:00 INFO - Running setup.py (path:/tmp/pip-ArCCcv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:51:00 INFO - Running setup.py (path:/tmp/pip-yQ4gvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:51:00 INFO - Running setup.py (path:/tmp/pip-WYzzMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:51:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:51:00 INFO - Running setup.py install for manifestparser 12:51:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:51:00 INFO - Running setup.py install for mozcrash 12:51:00 INFO - Running setup.py install for mozdebug 12:51:00 INFO - Running setup.py install for mozdevice 12:51:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:51:00 INFO - Running setup.py install for mozfile 12:51:00 INFO - Running setup.py install for mozhttpd 12:51:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:51:00 INFO - Running setup.py install for mozinfo 12:51:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:51:01 INFO - Running setup.py install for mozInstall 12:51:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:51:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:51:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:51:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:51:01 INFO - Running setup.py install for mozleak 12:51:01 INFO - Running setup.py install for mozlog 12:51:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:51:01 INFO - Running setup.py install for moznetwork 12:51:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:51:01 INFO - Running setup.py install for mozprocess 12:51:01 INFO - Running setup.py install for mozprofile 12:51:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:51:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:51:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:51:01 INFO - Running setup.py install for mozrunner 12:51:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:51:01 INFO - Running setup.py install for mozscreenshot 12:51:01 INFO - Running setup.py install for moztest 12:51:02 INFO - Running setup.py install for mozversion 12:51:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:51:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:51:02 INFO - Cleaning up... 12:51:02 INFO - Return code: 0 12:51:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:51:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:51:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:02 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 0x205d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2225a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cc090>, '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 0x23ccd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c6f90>, '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-1507836858.180558-968221669', '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:51:02 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:51:02 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:51:02 INFO - Using env: {'DISPLAY': ':0', 12:51:02 INFO - 'HOME': '/home/cltbld', 12:51:02 INFO - 'LANG': 'en_US.UTF-8', 12:51:02 INFO - 'LANGUAGE': 'en_US:en', 12:51:02 INFO - 'LOGNAME': 'cltbld', 12:51:02 INFO - 'MAIL': '/var/mail/cltbld', 12:51:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:02 INFO - 'MOZ_NO_REMOTE': '1', 12:51:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:02 INFO - 'NO_EM_RESTART': '1', 12:51:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:02 INFO - 'PWD': '/builds/slave/test', 12:51:02 INFO - 'SHELL': '/bin/bash', 12:51:02 INFO - 'SHLVL': '1', 12:51:02 INFO - 'TERM': 'linux', 12:51:02 INFO - 'TMOUT': '86400', 12:51:02 INFO - 'USER': 'cltbld', 12:51:02 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1507836858.180558-968221669', 12:51:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:02 INFO - '_': '/tools/buildbot/bin/python'} 12:51:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:51:02 INFO - Running setup.py (path:/tmp/pip-qsLlCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:51:02 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:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:51:02 INFO - Running setup.py (path:/tmp/pip-K19goR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:51:02 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:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:51:02 INFO - Running setup.py (path:/tmp/pip-eFZVpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:51:02 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:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:51:02 INFO - Running setup.py (path:/tmp/pip-jK4fdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:51:02 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:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:51:02 INFO - Running setup.py (path:/tmp/pip-7MuXc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:51:02 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:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:51:02 INFO - Running setup.py (path:/tmp/pip-hb9fUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:51:02 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:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:51:02 INFO - Running setup.py (path:/tmp/pip-UmtDIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:51:02 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:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:51:02 INFO - Running setup.py (path:/tmp/pip-8yy6FC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:51:02 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:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:51:02 INFO - Running setup.py (path:/tmp/pip-LQFhQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:51:03 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:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:51:03 INFO - Running setup.py (path:/tmp/pip-jbhGet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:51:03 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:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:51:03 INFO - Running setup.py (path:/tmp/pip-GFvcK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:51:03 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:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:51:03 INFO - Running setup.py (path:/tmp/pip-tjsDu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:51:03 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:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:51:03 INFO - Running setup.py (path:/tmp/pip-5Wl70z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:51:03 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:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:51:03 INFO - Running setup.py (path:/tmp/pip-rCXZan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:51:03 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:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:51:03 INFO - Running setup.py (path:/tmp/pip-pXJQsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:51:03 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:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:51:03 INFO - Running setup.py (path:/tmp/pip-dqdrec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:51:03 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:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:51:03 INFO - Running setup.py (path:/tmp/pip-dYtWfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:51:03 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:51:03 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:51:03 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:51:03 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:51:03 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:51:03 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:51:03 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:51:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:51:03 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:51:03 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:51:03 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:51:03 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:51:04 INFO - Downloading blessings-1.6.tar.gz 12:51:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:51:04 INFO - Installing collected packages: blessings 12:51:04 INFO - Running setup.py install for blessings 12:51:04 INFO - Successfully installed blessings 12:51:04 INFO - Cleaning up... 12:51:04 INFO - Return code: 0 12:51:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:51:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:51:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:51:05 INFO - Reading from file tmpfile_stdout 12:51:05 INFO - Current package versions: 12:51:05 INFO - argparse == 1.2.1 12:51:05 INFO - blessings == 1.6 12:51:05 INFO - blobuploader == 1.2.4 12:51:05 INFO - docopt == 0.6.1 12:51:05 INFO - functools32 == 3.2.3-2 12:51:05 INFO - jsonschema == 2.5.1 12:51:05 INFO - manifestparser == 1.1 12:51:05 INFO - mozInstall == 1.13 12:51:05 INFO - mozcrash == 1.0 12:51:05 INFO - mozdebug == 0.1 12:51:05 INFO - mozdevice == 0.51 12:51:05 INFO - mozfile == 1.2 12:51:05 INFO - mozhttpd == 0.7 12:51:05 INFO - mozinfo == 0.10 12:51:05 INFO - mozleak == 0.1 12:51:05 INFO - mozlog == 3.5 12:51:05 INFO - moznetwork == 0.27 12:51:05 INFO - mozprocess == 0.25 12:51:05 INFO - mozprofile == 0.28 12:51:05 INFO - mozrunner == 6.13 12:51:05 INFO - mozscreenshot == 0.1 12:51:05 INFO - mozsystemmonitor == 0.3 12:51:05 INFO - moztest == 0.8 12:51:05 INFO - mozversion == 1.4 12:51:05 INFO - psutil == 3.1.1 12:51:05 INFO - requests == 1.2.3 12:51:05 INFO - wsgiref == 0.1.2 12:51:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:51: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:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51: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:51:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:05 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 0x205d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2225a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cc090>, '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 0x23ccd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c6f90>, '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-1507836858.180558-968221669', '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:51:05 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:51:05 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:51:05 INFO - Using env: {'DISPLAY': ':0', 12:51:05 INFO - 'HOME': '/home/cltbld', 12:51:05 INFO - 'LANG': 'en_US.UTF-8', 12:51:05 INFO - 'LANGUAGE': 'en_US:en', 12:51:05 INFO - 'LOGNAME': 'cltbld', 12:51:05 INFO - 'MAIL': '/var/mail/cltbld', 12:51:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:05 INFO - 'MOZ_NO_REMOTE': '1', 12:51:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:05 INFO - 'NO_EM_RESTART': '1', 12:51:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:05 INFO - 'PWD': '/builds/slave/test', 12:51:05 INFO - 'SHELL': '/bin/bash', 12:51:05 INFO - 'SHLVL': '1', 12:51:05 INFO - 'TERM': 'linux', 12:51:05 INFO - 'TMOUT': '86400', 12:51:05 INFO - 'USER': 'cltbld', 12:51:05 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1507836858.180558-968221669', 12:51:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:05 INFO - '_': '/tools/buildbot/bin/python'} 12:51:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:05 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:51:05 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:51:05 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:51:05 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:51:05 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:51:05 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:51:05 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:51:05 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:51:05 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:51:05 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 12:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 12:51:06 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:51:06 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:51:06 INFO - Installing collected packages: simplejson 12:51:06 INFO - Running setup.py install for simplejson 12:51:06 INFO - building 'simplejson._speedups' extension 12:51:06 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:51:07 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:51:07 INFO - Successfully installed simplejson 12:51:07 INFO - Cleaning up... 12:51:07 INFO - Return code: 0 12:51:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:51:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2225a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c8a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cc090>, '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 0x23ccd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c6f90>, '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-1507836858.180558-968221669', '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:51:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:51:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:51:07 INFO - Using env: {'DISPLAY': ':0', 12:51:07 INFO - 'HOME': '/home/cltbld', 12:51:07 INFO - 'LANG': 'en_US.UTF-8', 12:51:07 INFO - 'LANGUAGE': 'en_US:en', 12:51:07 INFO - 'LOGNAME': 'cltbld', 12:51:07 INFO - 'MAIL': '/var/mail/cltbld', 12:51:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:07 INFO - 'MOZ_NO_REMOTE': '1', 12:51:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:07 INFO - 'NO_EM_RESTART': '1', 12:51:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:07 INFO - 'PWD': '/builds/slave/test', 12:51:07 INFO - 'SHELL': '/bin/bash', 12:51:07 INFO - 'SHLVL': '1', 12:51:07 INFO - 'TERM': 'linux', 12:51:07 INFO - 'TMOUT': '86400', 12:51:07 INFO - 'USER': 'cltbld', 12:51:07 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1507836858.180558-968221669', 12:51:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:07 INFO - '_': '/tools/buildbot/bin/python'} 12:51:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:51:07 INFO - Cleaning up... 12:51:07 INFO - Return code: 0 12:51:07 INFO - Running post-action listener: _resource_record_post_action 12:51:07 INFO - Running post-action listener: _start_resource_monitoring 12:51:07 INFO - Starting resource monitoring. 12:51:07 INFO - [mozharness: 2017-10-12 19:51:07.802874Z] Finished create-virtualenv step (success) 12:51:07 INFO - [mozharness: 2017-10-12 19:51:07.803347Z] Running install step. 12:51:07 INFO - Running pre-action listener: _resource_record_pre_action 12:51:07 INFO - Running main action method: install 12:51:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:51:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:51:08 INFO - Reading from file tmpfile_stdout 12:51:08 INFO - Detecting whether we're running mozinstall >=1.0... 12:51:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:51:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:51:08 INFO - Reading from file tmpfile_stdout 12:51:08 INFO - Output received: 12:51:08 INFO - Usage: mozinstall [options] installer 12:51:08 INFO - Options: 12:51:08 INFO - -h, --help show this help message and exit 12:51:08 INFO - -d DEST, --destination=DEST 12:51:08 INFO - Directory to install application into. [default: 12:51:08 INFO - "/builds/slave/test"] 12:51:08 INFO - --app=APP Application being installed. [default: firefox] 12:51:08 INFO - mkdir: /builds/slave/test/build/application 12:51:08 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:51:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 12:51:22 INFO - Reading from file tmpfile_stdout 12:51:22 INFO - Output received: 12:51:22 INFO - /builds/slave/test/build/application/firefox/firefox 12:51:22 INFO - Running post-action listener: _resource_record_post_action 12:51:22 INFO - [mozharness: 2017-10-12 19:51:22.720459Z] Finished install step (success) 12:51:22 INFO - [mozharness: 2017-10-12 19:51:22.720603Z] Running setup-mitmproxy step. 12:51:22 INFO - Running pre-action listener: _resource_record_pre_action 12:51:22 INFO - Running main action method: setup_mitmproxy 12:51:22 INFO - Skipping: mitmproxy is not required 12:51:22 INFO - Running post-action listener: _resource_record_post_action 12:51:22 INFO - [mozharness: 2017-10-12 19:51:22.721128Z] Finished setup-mitmproxy step (success) 12:51:22 INFO - [mozharness: 2017-10-12 19:51:22.721230Z] Running run-tests step. 12:51:22 INFO - Running pre-action listener: _resource_record_pre_action 12:51:22 INFO - Running pre-action listener: _set_gcov_prefix 12:51:22 INFO - Running main action method: run_tests 12:51:22 WARNING - Try message not found. 12:51:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:51:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:51:22 INFO - Python 2.7.3 12:51:22 INFO - Return code: 0 12:51:22 INFO - grabbing minidump binary from tooltool 12:51:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:51:22 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 0x23cc090>, '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 0x23ccd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c6f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:51:22 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:51:22 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:51:22 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:51:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:51:22 INFO - Return code: 0 12:51:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:51:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:51:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:51:22 INFO - ENV: RUST_BACKTRACE is now full 12:51:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:51:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:51:22 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/Kp4_jGBTQHegYf4_Zs6oIg/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:51:22 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/Kp4_jGBTQHegYf4_Zs6oIg/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:51:22 INFO - Using env: {'DISPLAY': ':0', 12:51:22 INFO - 'HOME': '/home/cltbld', 12:51:22 INFO - 'LANG': 'en_US.UTF-8', 12:51:22 INFO - 'LANGUAGE': 'en_US:en', 12:51:22 INFO - 'LOGNAME': 'cltbld', 12:51:22 INFO - 'MAIL': '/var/mail/cltbld', 12:51:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:51:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:51:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:22 INFO - 'MOZ_NO_REMOTE': '1', 12:51:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:51:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:22 INFO - 'NO_EM_RESTART': '1', 12:51:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:22 INFO - 'PWD': '/builds/slave/test', 12:51:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:51:22 INFO - 'RUST_BACKTRACE': 'full', 12:51:22 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:51:22 INFO - 'SHELL': '/bin/bash', 12:51:22 INFO - 'SHLVL': '1', 12:51:22 INFO - 'TERM': 'linux', 12:51:22 INFO - 'TMOUT': '86400', 12:51:22 INFO - 'USER': 'cltbld', 12:51:22 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1507836858.180558-968221669', 12:51:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:22 INFO - '_': '/tools/buildbot/bin/python'} 12:51:22 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/Kp4_jGBTQHegYf4_Zs6oIg/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:51:23 INFO - mozversion application_buildid: 20171012182639 12:51:23 INFO - mozversion application_changeset: c8d3b27528f758e9291946fa16b1269b6ec71acb 12:51:23 INFO - mozversion application_display_name: Firefox 12:51:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:51:23 INFO - mozversion application_name: Firefox 12:51:23 INFO - mozversion application_remotingname: firefox 12:51:23 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:51:23 INFO - mozversion application_vendor: Mozilla 12:51:23 INFO - mozversion application_version: 57.0 12:51:23 INFO - mozversion platform_buildid: 20171012182639 12:51:23 INFO - mozversion platform_changeset: c8d3b27528f758e9291946fa16b1269b6ec71acb 12:51:23 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:51:23 INFO - mozversion platform_version: 57.0 12:51:23 INFO - using testdate: 1507837883 12:51:23 INFO - actual date: 1507837883 12:51:23 INFO - starting webserver on 'localhost:53541' 12:51:23 INFO - SUITE-START | Running 2 tests 12:51:23 INFO - TEST-START | dromaeo_css 12:51:23 INFO - Initialising browser for dromaeo_css test... 12:51:23 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53541/getInfo.html -profile /tmp/tmpxH4fmt/profile 12:51:23 INFO - TEST-INFO | started process 23601 (/builds/slave/test/build/application/firefox/firefox http://localhost:53541/getInfo.html) 12:51:28 INFO - TEST-INFO | 23601: exit 0 12:51:28 INFO - Browser initialized. 12:51:28 INFO - Running cycle 1/1 for dromaeo_css test... 12:51:28 INFO - Using env: {'DISPLAY': ':0', 12:51:28 INFO - 'HOME': '/home/cltbld', 12:51:28 INFO - 'JSGC_DISABLE_POISONING': '1', 12:51:28 INFO - 'LANG': 'en_US.UTF-8', 12:51:28 INFO - 'LANGUAGE': 'en_US:en', 12:51:28 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 12:51:28 INFO - 'LOGNAME': 'cltbld', 12:51:28 INFO - 'MAIL': '/var/mail/cltbld', 12:51:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:51:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:51:28 INFO - 'MOZ_CRASHREPORTER': '1', 12:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:28 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 12:51:28 INFO - 'MOZ_NO_REMOTE': '1', 12:51:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:51:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:28 INFO - 'NO_EM_RESTART': '1', 12:51:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:28 INFO - 'PWD': '/builds/slave/test', 12:51:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:51:28 INFO - 'RUST_BACKTRACE': 'full', 12:51:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:51:28 INFO - 'SHELL': '/bin/bash', 12:51:28 INFO - 'SHLVL': '1', 12:51:28 INFO - 'TERM': 'linux', 12:51:28 INFO - 'TMOUT': '86400', 12:51:28 INFO - 'USER': 'cltbld', 12:51:28 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1507836858.180558-968221669', 12:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:28 INFO - '_': '/tools/buildbot/bin/python'} 12:51:28 INFO - TEST-INFO | started process 23838 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxH4fmt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:51:28 INFO - PID 23838 | 12:51:28 INFO - PID 23838 | (/builds/slave/test/build/application/firefox/firefox:23887): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:51:28 INFO - PID 23838 | 12:51:39 INFO - PID 23838 | RSS: Main: 141742080 12:51:39 INFO - PID 23838 | 12:54:36 INFO - PID 23838 | Cycle 1(1): loaded http://localhost:53541/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53541/tests/dromaeo/cssquery-ext.html) 12:54:37 INFO - PID 23838 | RSS: Main: 145203200 12:54:37 INFO - PID 23838 | 12:57:39 INFO - PID 23838 | Cycle 1(1): loaded http://localhost:53541/tests/dromaeo/cssquery-ext.html (next: http://localhost:53541/tests/dromaeo/cssquery-jquery.html) 12:57:40 INFO - PID 23838 | RSS: Main: 143773696 12:57:40 INFO - PID 23838 | 13:00:41 INFO - PID 23838 | Cycle 1(1): loaded http://localhost:53541/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53541/tests/dromaeo/cssquery-mootools.html) 13:00:42 INFO - PID 23838 | RSS: Main: 145141760 13:00:42 INFO - PID 23838 | 13:03:43 INFO - PID 23838 | Cycle 1(1): loaded http://localhost:53541/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53541/tests/dromaeo/cssquery-prototype.html) 13:03:44 INFO - PID 23838 | RSS: Main: 145338368 13:03:44 INFO - PID 23838 | 13:06:47 INFO - PID 23838 | Cycle 1(1): loaded http://localhost:53541/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53541/tests/dromaeo/cssquery-yui.html) 13:06:47 INFO - PID 23838 | RSS: Main: 146001920 13:06:47 INFO - PID 23838 | 13:09:49 INFO - PID 23838 | Cycle 1(1): loaded http://localhost:53541/tests/dromaeo/cssquery-yui.html (next: http://localhost:53541/tests/dromaeo/cssquery-dojo.html) 13:09:49 INFO - PID 23838 | RSS: Main: 149213184 13:09:49 INFO - PID 23838 | 13:09:49 INFO - PID 23838 | __start_tp_report 13:09:49 INFO - PID 23838 | _x_x_mozilla_page_load 13:09:49 INFO - PID 23838 | _x_x_mozilla_page_load_details 13:09:49 INFO - PID 23838 | |i|pagename|runs| 13:09:49 INFO - PID 23838 | |0;dojo.html;4035.818388172532;4048.5748996355383;4066.3697126945317;4072.1448495815876;4103.958960410397;6455;6510.18622672166;6579.769708060219;6600.438962688171;6608.339166083395;6487.967560162205;6505.316941721122;6551.377619126175;6611.173603299588;6625;5764.8847023059725;5859.472647461727;5908.438698323663;5920.378360272174;5922.3485416604135;5846.298444186704;5872.354041055481;5881.764729410818;5965.671888046156;5979.730912108944;5949.4348036936635;5987.191729116557;5994.700264986755;6006.609570377933;6010.308814486324;5845.1232315153065;5943.375945525744;5956.434138756811;6009.5192384609345;6019.428154325332;5783.248177736909;5813.970930145365;5824.504917082053;5862.560307976876;5916.408359164049;6486.90269645951;6489.902651460185;6498;6498.610083394964;6530.6734663267125;7090.645467726593;7096.609686467243;7171.103612048494;7172.820679483002;7184.748533801344;7053.294670532957;7127.4654400920135;7140.28597140287;7170.175429825585;7174.3184397482155;6580.670966451658;6605.207375114969;6634.767783127616;6667.533272670915;6674.43267322283;7319.231480694557;7320.633968301564;7387.187409384964;7393.963030184815;7416.40668746499;6982.301769823079;6988.161420629557;7053.0830991970715;7081.858362832714;7103.325184107502;7065.399441047569;7115.430765538745;7138.000679904818;7197.568145911157;7238.131424229126;7025.262347453444;7041.788746337618;7081.964590177016;7092.148942126978;7126.109236345457;7017.859642807115;7020.92979070213;7028.964855175692;7103.715851365991;7128.144622645212;5244.449332819999;5246.160614301693;5302.28419163408;5318.095923692981;5322.654027488278;4789.592884604778;4842.58837998767;4882.707037577757;4908.042931628298;4927.236278376858;6659.267480577133;6670.899936500957;6728.6972086255255;6741.359570840762;6744.7976560703255;7056.435485161175;7068.11648543932;7069.434445244368;7076.044733960953;7164.426845852319;6654.467642588581;6683.699233534406;6698.5980841149685;6701.29636388182;6715.227748808852;5985.551083668743;6035.66803825785;6054.303755068224;6061.363556826558;6071.180390647294;7331.156916954512;7414.25857414265;7425.517341372793;7510.211427800112;7535.54786712799;7071.116110486087;7074.964625176841;7077.115360579927;7087.7164913402885;7100.680469378787;7334.413246940126;7390.482666213314;7401.0748656417945;7443.739469118555;7517.43619228571;6850.965745171442;7031.367176953894;7044.823879403056;7050.294970502909;7062.011318415529;6989.930100698928;7102.431805455448;7116.857662846611;7212.098487689039;7230.060092187982;6729.0915726376315;6832.760853370109;6842.55523390978;6871.175458944758;6873.931260687529;6841.692123854339;6847.041414202115;6859.2454829969665;6860.03959445688;6868.553544019623;6761.121054263111;6776.525643204928;6848.7260509579055;6853.383195512428;6861.4510839133745;6929.826754331182;6970.128733908262;6975.162980442379;7029.859402812018;7040.753573624898;6664.366885145903;6741;6741.696623651849;6819.4544436443975;6823.795286141423 13:09:49 INFO - PID 23838 | |1;ext.html;986.8798913233478;991.3506653142192;1012.5544760305465;1015.5937624950019;1016.6645007147638;45275.547244527545;46168.76915615417;46251.07497850041;46291.305630415525;46311.30533042007;43643;43837;43955.560444395545;44110;44193.45322913698;8126.471779334354;8129.309008734264;8203.58982050895;8208.05607355156;8244.628991695357;8103.756887293391;8173.060098088707;8225.95887020567;8237.423380363376;8237.546934918608;8171.795705107361;8914.242289405376;9032.729018129434;9049.547522623876;9051;8898.777530561723;8962.327825413087;8965;8970.237529809974;8972;8910.465372077697;8985.101489851028;9017.143371379709;9017.819643607158;9018.954905225432;42042.369364459555;42400.36399454011;42510.78744606288;42531.787341063406;42533;3900.1029763154634;3912.3349030664854;3930.8231129599235;3933.1347103637154;3935.5277366716177;34512.48231276533;34853.651463485294;34925.30149397023;34968.65031349679;34976.82511587451;4405.140997505488;4415.11697660466;4419.071994881079;4420.690551661385;4442.267025940716;236911;238481;238654;238696;239326;50334.24498632523;50750.238746418836;55577.444225558036;56940.71529642325;57335;60020;60173.09740353898;60182.69908650516;60208.69895650581;60251.39748602545;18658.253669853053;18773.90613046926;18877.528061798566;18883.339083132025;18892;15405.075695458308;15446;15446.768298475532;15677.921610391875;15680;15689;15748.370065197263;15806.288717007763;15810.683786324209;15896.682066358608;6349.682515874188;6369.617822930639;6434.8391290218115;6514.837129071811;6539;1049.511976930731;1079.8920107989138;1088.4448931045224;1091.1325496230515;1127.785720713062;25987.22038338853;26085;26446.206613801616;26476.47047059048;26496.602550961365;1194.498310709504;1197.5988044005182;1200.765850659113;1202.699325168708;1215.2040413529153;13720.65698357529;13768.931155344158;13871.930640346734;13904.51334203298;13941.721165576631;313948;316809;317458;317732;318161;62188;62446;62528;62783;63001.68499157475;1578.3213218316234;1580.6601580659983;1583.4774524406919;1604.2139351717808;1612.274476485586;26278;26336.604950926136;26440.603390949535;26702.732972670026;26866.865665671547;42505.57494425016;42627;42663.5733642672;42699.7865010673;42798.78600606977;267367;270216;270598;273474;273536;37600.62399375971;38265.23469530649;38760.6123938757;41032.79483602563;41543.37684934668;55137.44862551323;55595.44404555903;55654;56057.15914261208;56505.71747141238;38918.80540597279;39021.8048909765;39048.609513905634;39156.60843391644;39476.80261598674;38851.805740972246;39041.80479097586;39150.80424597859;39396.80301598473;39405;45597.3664623578;46351.30473042974;46804.29793553031;46906.296405554625;46917.2962405571;36295.63704362923;36398;36943.630563694016;37067.8146609276;37956.810215948746;28260.293492662848;28260.85869570639;28407.857960710066;28743.425131497672;28870.566941496316 13:09:49 INFO - PID 23838 | |2;jquery.html;629.7235254932596;650.8922565583824;652.5708697951488;662.5031226580065;668.6623255256095;23452.179173728924;24140.396490087736;24154.75845241549;24198.879005604947;24240.636390454158;27047.323816904536;27318.180454586392;27377.86311068447;27432.862835685843;27471.313217169532;6415.967920160404;6563.671816409161;6563.901541476857;6566.047923051155;6568.310327415625;6567.54027218095;6654.534182607219;6669.43309818666;6669.69986350613;6669.9666501667425;6662.167229096363;6911.758088466905;6937;6945.652717364137;6949.826254343631;6872.175338959332;6894.793156205322;6904.067950826624;6904.067950826675;6917.273686262945;6412.807615771488;6417.871642567169;6434.774782882577;6471.83820404489;6497.610143391412;30433.69566304331;30944.38111237785;31208;31447.84276078605;31526.36947261042;2354.7880690737743;2385.8210634202333;2386.4869053153657;2387.582173119697;2392.246442370648;20285.290014849408;20776.065077071416;20826.37520874376;21025.369238922856;21116;2547.1339744486777;2570.69151701797;2610.530104581175;2612.3338548669967;2625.094342451851;148573;156272;158069;162001;169121;16541.421050263183;17314.220860061076;17374.739378909326;17570.912145439448;17592.912035439742;27414.725852741216;27563;27609;27625.309367265978;27642.72357276442;11229.775404491864;11305.830412543819;11344;11542.19204655683;11547.422628868522;10272.229582781321;10295.74260643475;10331;10426.739331516772;10474.319169253975;9811.411315321104;10058.245631577662;10058.446785426726;10064.647737329158;10147.188224942134;3127.8748850045745;3143;3159.0403067184757;3163;3269.1500209945584;1052.2529004406804;1063.707480442869;1066.8186408310605;1067.1142951350516;1068.5885933915342;21665.35003949884;21694.34916952494;21936.561268774854;21943.561128777656;21986.670199947013;1146.2262972493534;1147.3402793393666;1149.1840793037038;1150.7525881935258;1157.8031734605138;11829.76340473203;11919.225250358699;11958.880411195776;11976.52093916251;12085.939570302093;639592;650044;651107;672160;688251;136816;139872;140092;141675.2916235412;142729;1139.9829002564968;1182.8817118288102;1226.9141160118706;1257.1953949472345;1297.571801305548;21750.6737398936;22406.25420678168;22486.226924494236;22630.98160582745;22674.773252267925;64500;64734.35265647283;64741.67629161824;66440.66779666071;66705.3329466699;79938.60184194484;81020.18979810126;83314.58342708247;83728.16271837204;85144.57427712822;15796.526104216891;16227.756583651491;16356.509304720877;16391.75412368839;16458.670826583642;24631.753682462946;24680;24696.753032470166;25008.749912500643;25120.62319065179;19033;19214.80785192186;19345.51636209106;19499.51251218731;19511.219551217793;16930;17186.742198867276;17269;17484.91257543704;17986.19062142233;19125.13936872872;19888.70166947468;19915.900420497805;20108.497287567927;20177.495562611053;15863.286152123414;15957.122358270406;15978.840211597735;15993.68012639764;16055.839441605902;19327.710084348466;19384.418467445998;19436.70844937299;19468.707969380186;19507.609847803247 13:09:49 INFO - PID 23838 | |3;mootools.html;1402.4600528796414;1475.2623688155923;1480.962975925602;1481.7481028225207;1489.0317304383818;17556;18271.72592411113;18278.725819112726;18292.085395730195;18295.90852045741;17888.373906913228;17905.104744762775;18000.9298930623;18082.3671171509;18083.27666893326;3162.4465718499287;3200.1679563313473;3247.5291082792983;3249.301400198957;3249.8375081245963;3233.6927991840853;3234.191452136966;3262.869485220588;3265.0368141398344;3265.363254165427;3252.9349413011846;3326.6507016763135;3332.100332910125;3332.2502436951736;3333.6166340870745;3211.6788321167696;3230.580024596799;3287.079617707022;3289.3750187464425;3291.555639988595;3226.3869864725625;3228.1284053305712;3228.1929517620597;3241.481362981935;3243.5459035735016;17033.48899533016;17257.395991140376;17331.306747730076;17339.393121240697;17348.56628584283;9004.77488062797;9193.126652967958;9290.442573445547;9291.256699464027;9296.95351523238;6107.4503294703245;6231.626102433868;6319.58922670025;6372.681365931685;6411.294757576663;2104.684297355409;2136.9679454808033;2147.366526874576;2176.9891150544304;2204.0302267002626;32545.51181732276;32782.6721732782;32848.17879553006;32850.83574582136;32854.178645533815;7856.646450909723;7967.56178410193;8013.358931285483;8165.2243036911395;8192.918070819334;20926.895365523378;21074.683879741817;21170;21228.469288267606;21251.78748212529;9067.274618030542;9298.628054877865;9376.249900007982;9394.812103757886;9398.577064032135;8314.127016663284;8417.537035463109;8449.915500845036;8681.52251626154;8692.478451292942;6325.841853953688;6326.49388048955;6366.872662546723;6392.648404337713;6428.453581445536;1747.7028905086165;1791.7133258678548;1850.0666803190697;1853.4161739052156;1879.2201236486978;962.3552220012608;969.8787651543557;975.8341082016075;987.5654711926729;988.7478692933399;10140.99972548732;10245.84631230532;10288.074073333435;10413.895861041445;10521.52653130611;1067.4982758103833;1079.3847506921136;1084.8047351476653;1085.1915323084352;1113.6580420593166;5797.9420205797405;6324.525660575475;6438.742450301936;6445.838854028687;6486.027095935648;25963.22110336693;26578.202653920413;27115.1865444037;27218.863905680344;27485.86257068702;27277.86361068182;27287.727122728917;27696.169114926586;27724.168274951782;27810.470424126463;12223.266604003788;12620.30588317633;12961.15752476086;12966.80549791754;12981.675458113623;9853.261005424765;10065.094141527004;10133.695989120339;10134.797304054026;10382.948085259828;22339.329820105424;22452.214172503885;22894.771052289263;22978.19576314821;23341.649875252224;23255.3023409298;23435.53128937446;23583.174588889993;23846.761532384455;23947;12793.488260469478;12922.095453318178;12956.35218239103;12996.675083122998;13005.934970325088;15939.282732277306;16044.679106417572;16060.839391605934;16150.919245403698;16176.110313932846;12011.879881201427;12238.08214383907;12335.629931102081;12477.188982716094;12617.684557886127;11745.17783755129;11888.28670279786;11979.161458697807;12039.398030098286;12150.08874334446;10922.18083643714;10986.121110311316;11115.22193446451;11118.833217501582;11121.499532520895;8110.675572977015;8250.422470427253;8280.171982801672;8301.294389976678;8358.08061113265;7965.522068675898;8060.476069055727;8062.8790568142695;8073.313768329758;8111.351091912515 13:09:49 INFO - PID 23838 | |4;prototype.html;570.9514691251244;573.2490437526839;578.4533615733134;600.612604869859;607.1681795939561;6218.22272215973;6245.534442873344;6407.903881441771;6461.903071453932;6469.223693156828;6381.872362552758;6402.135711678922;6411.230652321717;6425.903611445832;6427.260865000515;5297.099493086175;5317.5480084192695;5338.572914166877;5344.4922732340365;5348.331458567679;5064.341635587387;5176.197689358137;5212;5224;5314.441983591725;5148.794048238066;5166.276721259027;5170.974145129269;5175.741212939338;5182.766775495093;5147.845564633067;5173.42210625759;5186.870328241786;5190.429052804188;5206.114960456732;4716.551927566876;4720.875605977324;4725.621950244006;4730.668853180278;4740.360051393052;6376.968115159394;6377.744890204386;6401.1678481797535;6419.454346380563;6425.261094974091;6001.699915004232;6087.604305720114;6100.054491553817;6139.21962630841;6160;6741;6807.591544507345;6819.113515243036;6894.13823272091;6908.998195261659;5042.747862606855;5295.205719142121;5307.893842123174;5313.893722125575;5321.787128514855;6996.195437524699;6997.335253150943;7057.364837164629;7072.823179420504;7084.893726594105;5355.678659280456;5367.677939323653;5381.650192737459;5388.218708287355;5443.8094666686475;5464.180372944011;5468.617196796186;5485.424030476743;5489.423610520837;5517.834464966058;5947.821565353046;6052.213212282375;6078.1186727924205;6088.817335479943;6105.358937311607;6924.58452492852;6931.202911665223;6937.479689023344;6946.270641582662;6950.6177160256675;1874.09106583307;1882.2753240002423;1894.128700797621;1897.1652472911874;1915.808419158073;1291.2123604601186;1337.946482140723;1357.138217232045;1366.4217828408205;1366.7334869700312;6272.421132573247;6336.461400780985;6397.10440538325;6536.444402225769;6563.9343606563325;6679.09459385169;6797.966010169917;6811.25076241613;6869.725210991504;6904.896426553606;6389.616623002635;6436.645984470805;6447.871042579122;6473.579217350857;6516.446102081281;3641.5630124385243;3661.6155303693263;3667.303212389691;3692.7415080944074;3697.5378077740284;7218.8917166242545;7228.710851565984;7263.709451621876;7302.415806735448;7333.413326933833;7143.749968751173;7161.713531458788;7177.318154775288;7184;7272.709091636381;7242.239564845615;7248.565086094851;7259.637018149071;7276.96361518189;7280.199178090405;6863.6568171590225;6895.689693963884;6902.344277293649;6999.475039371966;7013.544119632207;6779.610179913007;6784.457243420416;6808.863822723419;6889.483288753263;6904.13698287714;7177.497575169688;7181;7187.471892707561;7261.5280006799385;7314.829627259613;5418.376886657927;5422.48486393792;5425.348958125051;5427.6200665953;5439.374471935778;6773.356531129535;6905;6968.128983877015;6989.790306290819;7012.123484564429;6729.427998620172;6745.2242992056545;6750.223724271772;6758.9723083073895;6761.256261811099;6557.458972155174;6684.955601860998;6716.093327400738;6746.9662651688395;6785.89821152693;6445.323241059808;6508.787012415802;6574.112494813139;6647.767328143492;6671.866562668816;6671.46628269747;6805.285445028201;6805.9659701701175;6810.761623343159;6825.931740682529;6594.736210551716;6615.37153970372;6642.169728783902;6715.328467153246;6747.831304217434 13:09:49 INFO - PID 23838 | |5;yui.html;984.3404918704467;999.9150921250443;1021.4331046269322;1031.6698656429944;1032.287721472184;21747.130114795407;22203;22213.66679499807;22245.44386390341;22251.22120725775;18709.532261693465;20001.59996800063;20203;20220.292289769863;20237.291694790685;1075.6181555547785;1076.2896488317713;1077.4505002448768;1079.9082078023378;1079.929804562705;1064.9574017039347;1082.393859438713;1090.3839330778085;1091.9235653504259;1123.4663534820936;1142.7885841119378;1151.4990978924195;1153.596241315537;1154.0363796230115;1154.607433472619;1144.9885501144965;1145.5017067575548;1146.3122126723981;1147.0479502013309;1147.391882302381;845.813920937399;847.563504795031;853.0190281176634;853.1212850763724;854.2183901729971;20845.79154208454;21135.894320528452;21686.566268674538;21865.890670546545;21872.125114995382;22853.42866428336;23181.188658397044;23555;23597.7640223599;23786.88106559456;18069;18491.44525664232;18503.537411564685;18520.53698657531;18562.72155917662;4138.151678905847;4176.4570605821045;4181.372794080912;4182.2890108681295;4182.853600124012;166597;170849.99999999875;171155;171823;173924;17793.822061779218;18112;18161.36435224761;18162.364317248834;18171.182296796676;34886.383521236006;36121.09697257537;36133.63866361355;36214.275714485564;36247.63752362443;9742.561584728704;9955.303128780915;9969.80060398788;9989.500524973722;10007.749806254902;4937.851864444073;4993.525615066563;4995.100881841304;5029.1450453423;5040.873978150502;6074.605150665193;6125.509959203253;6135.938640613536;6170.50635949123;6179.567430279927;1184.1829137894824;1188.3939191012646;1200.6458094862037;1210.2980271442543;1218.03775017735;744.5197847388404;771.067008919214;774.5855967057597;783.6669415498391;796.0129439494984;12956.222626642431;12958.676033099247;13081.149725267827;13161.53934612284;13293.667658308426;623.0685125736961;630.7256343490504;632.6520413772407;634.8007927559163;637.3594537489793;6092.421219984094;6126.663033533198;6200.0699895016105;6224.782132625336;6231.283402408781;150408;153362;154133;154383;161968;121948.39025804814;123921;126207.36896315643;129005;132210;119519.40240298917;119932;120153;122067;122248.38875805742;11875.287482751062;11894.821577676168;11921.642350729491;12023.338716370683;12091.51633934668;56325.71837140788;56972;57248.71375643095;57876.710616446646;58010;70832.64583677049;71259.28740712734;72675.63662181655;72744.6362768204;74053.62973185099;16944.40694575684;17039;17041.829581704023;17041.829581704522;17160.828391715924;17453.82546174522;18173.909130454264;18200.908995454938;18201.271949122416;18202.90898545499;17136.14319284006;17345.653086938444;17362.826371736122;17612.823871761117;17624.383146589807;15243.466478673194;15594.376224950875;15629.609259768597;15745.527634170992;15818.209089545708;16815.159242038095;16897.577560561083;16988.320467181173;17158.828411715724;17166.313347465963;12392.256464612152;12592.622221333375;12792.168509046882;12801.93599031999;12897.677558061123;12782.552610658582;13023.674408139872;13156.40796164194;13243.735125297248;13266.204027758366 13:09:49 INFO - PID 23838 | __end_tp_report 13:09:49 INFO - PID 23838 | __start_cc_report 13:09:49 INFO - PID 23838 | _x_x_mozilla_cycle_collect,250 13:09:49 INFO - PID 23838 | __end_cc_report 13:09:49 INFO - PID 23838 | __startTimestamp1507838989256__endTimestamp 13:09:49 INFO - PID 23838 | 13:09:49 INFO - PID 23838 | ------- Summary: start ------- 13:09:49 INFO - PID 23838 | Number of tests: 6 13:09:49 INFO - PID 23838 | 13:09:49 INFO - PID 23838 | [#0] dojo.html Cycles:165 Average:6571.61 Median:6823.80 stddev:754.06 (11.1%) stddev-sans-first:729.66 13:09:49 INFO - PID 23838 | Values: 4035.8 4048.6 4066.4 4072.1 4104.0 6455.0 6510.2 6579.8 6600.4 6608.3 6488.0 6505.3 6551.4 6611.2 6625.0 5764.9 5859.5 5908.4 5920.4 5922.3 5846.3 5872.4 5881.8 5965.7 5979.7 5949.4 5987.2 5994.7 6006.6 6010.3 5845.1 5943.4 5956.4 6009.5 6019.4 5783.2 5814.0 5824.5 5862.6 5916.4 6486.9 6489.9 6498.0 6498.6 6530.7 7090.6 7096.6 7171.1 7172.8 7184.7 7053.3 7127.5 7140.3 7170.2 7174.3 6580.7 6605.2 6634.8 6667.5 6674.4 7319.2 7320.6 7387.2 7394.0 7416.4 6982.3 6988.2 7053.1 7081.9 7103.3 7065.4 7115.4 7138.0 7197.6 7238.1 7025.3 7041.8 7082.0 7092.1 7126.1 7017.9 7020.9 7029.0 7103.7 7128.1 5244.4 5246.2 5302.3 5318.1 5322.7 4789.6 4842.6 4882.7 4908.0 4927.2 6659.3 6670.9 6728.7 6741.4 6744.8 7056.4 7068.1 7069.4 7076.0 7164.4 6654.5 6683.7 6698.6 6701.3 6715.2 5985.6 6035.7 6054.3 6061.4 6071.2 7331.2 7414.3 7425.5 7510.2 7535.5 7071.1 7075.0 7077.1 7087.7 7100.7 7334.4 7390.5 7401.1 7443.7 7517.4 6851.0 7031.4 7044.8 7050.3 7062.0 6989.9 7102.4 7116.9 7212.1 7230.1 6729.1 6832.8 6842.6 6871.2 6873.9 6841.7 6847.0 6859.2 6860.0 6868.6 6761.1 6776.5 6848.7 6853.4 6861.5 6929.8 6970.1 6975.2 7029.9 7040.8 6664.4 6741.0 6741.7 6819.5 6823.8 13:09:49 INFO - PID 23838 | 13:09:49 INFO - PID 23838 | [#1] ext.html Cycles:180 Average:46618.17 Median:3931.98 stddev:72231.51 (1837.0%) stddev-sans-first:72352.88 13:09:49 INFO - PID 23838 | Values: 986.9 991.4 1012.6 1015.6 1016.7 45275.5 46168.8 46251.1 46291.3 46311.3 43643.0 43837.0 43955.6 44110.0 44193.5 8126.5 8129.3 8203.6 8208.1 8244.6 8103.8 8173.1 8226.0 8237.4 8237.5 8171.8 8914.2 9032.7 9049.5 9051.0 8898.8 8962.3 8965.0 8970.2 8972.0 8910.5 8985.1 9017.1 9017.8 9019.0 42042.4 42400.4 42510.8 42531.8 42533.0 3900.1 3912.3 3930.8 3933.1 3935.5 34512.5 34853.7 34925.3 34968.7 34976.8 4405.1 4415.1 4419.1 4420.7 4442.3 236911.0 238481.0 238654.0 238696.0 239326.0 50334.2 50750.2 55577.4 56940.7 57335.0 60020.0 60173.1 60182.7 60208.7 60251.4 18658.3 18773.9 18877.5 18883.3 18892.0 15405.1 15446.0 15446.8 15677.9 15680.0 15689.0 15748.4 15806.3 15810.7 15896.7 6349.7 6369.6 6434.8 6514.8 6539.0 1049.5 1079.9 1088.4 1091.1 1127.8 25987.2 26085.0 26446.2 26476.5 26496.6 1194.5 1197.6 1200.8 1202.7 1215.2 13720.7 13768.9 13871.9 13904.5 13941.7 313948.0 316809.0 317458.0 317732.0 318161.0 62188.0 62446.0 62528.0 62783.0 63001.7 1578.3 1580.7 1583.5 1604.2 1612.3 26278.0 26336.6 26440.6 26702.7 26866.9 42505.6 42627.0 42663.6 42699.8 42798.8 267367.0 270216.0 270598.0 273474.0 273536.0 37600.6 38265.2 38760.6 41032.8 41543.4 55137.4 55595.4 55654.0 56057.2 56505.7 38918.8 39021.8 39048.6 39156.6 39476.8 38851.8 39041.8 39150.8 39396.8 39405.0 45597.4 46351.3 46804.3 46906.3 46917.3 36295.6 36398.0 36943.6 37067.8 37956.8 28260.3 28260.9 28407.9 28743.4 28870.6 13:09:49 INFO - PID 23838 | 13:09:49 INFO - PID 23838 | [#2] jquery.html Cycles:180 Average:42280.03 Median:22446.24 stddev:110355.39 (491.6%) stddev-sans-first:110620.65 13:09:49 INFO - PID 23838 | Values: 629.7 650.9 652.6 662.5 668.7 23452.2 24140.4 24154.8 24198.9 24240.6 27047.3 27318.2 27377.9 27432.9 27471.3 6416.0 6563.7 6563.9 6566.0 6568.3 6567.5 6654.5 6669.4 6669.7 6670.0 6662.2 6911.8 6937.0 6945.7 6949.8 6872.2 6894.8 6904.1 6904.1 6917.3 6412.8 6417.9 6434.8 6471.8 6497.6 30433.7 30944.4 31208.0 31447.8 31526.4 2354.8 2385.8 2386.5 2387.6 2392.2 20285.3 20776.1 20826.4 21025.4 21116.0 2547.1 2570.7 2610.5 2612.3 2625.1 148573.0 156272.0 158069.0 162001.0 169121.0 16541.4 17314.2 17374.7 17570.9 17592.9 27414.7 27563.0 27609.0 27625.3 27642.7 11229.8 11305.8 11344.0 11542.2 11547.4 10272.2 10295.7 10331.0 10426.7 10474.3 9811.4 10058.2 10058.4 10064.6 10147.2 3127.9 3143.0 3159.0 3163.0 3269.2 1052.3 1063.7 1066.8 1067.1 1068.6 21665.4 21694.3 21936.6 21943.6 21986.7 1146.2 1147.3 1149.2 1150.8 1157.8 11829.8 11919.2 11958.9 11976.5 12085.9 639592.0 650044.0 651107.0 672160.0 688251.0 136816.0 139872.0 140092.0 141675.3 142729.0 1140.0 1182.9 1226.9 1257.2 1297.6 21750.7 22406.3 22486.2 22631.0 22674.8 64500.0 64734.4 64741.7 66440.7 66705.3 79938.6 81020.2 83314.6 83728.2 85144.6 15796.5 16227.8 16356.5 16391.8 16458.7 24631.8 24680.0 24696.8 25008.7 25120.6 19033.0 19214.8 19345.5 19499.5 19511.2 16930.0 17186.7 17269.0 17484.9 17986.2 19125.1 19888.7 19915.9 20108.5 20177.5 15863.3 15957.1 15978.8 15993.7 16055.8 19327.7 19384.4 19436.7 19468.7 19507.6 13:09:49 INFO - PID 23838 | 13:09:49 INFO - PID 23838 | [#3] mootools.html Cycles:180 Average:11106.29 Median:26846.69 stddev:8242.79 (30.7%) stddev-sans-first:8233.67 13:09:49 INFO - PID 23838 | Values: 1402.5 1475.3 1481.0 1481.7 1489.0 17556.0 18271.7 18278.7 18292.1 18295.9 17888.4 17905.1 18000.9 18082.4 18083.3 3162.4 3200.2 3247.5 3249.3 3249.8 3233.7 3234.2 3262.9 3265.0 3265.4 3252.9 3326.7 3332.1 3332.3 3333.6 3211.7 3230.6 3287.1 3289.4 3291.6 3226.4 3228.1 3228.2 3241.5 3243.5 17033.5 17257.4 17331.3 17339.4 17348.6 9004.8 9193.1 9290.4 9291.3 9297.0 6107.5 6231.6 6319.6 6372.7 6411.3 2104.7 2137.0 2147.4 2177.0 2204.0 32545.5 32782.7 32848.2 32850.8 32854.2 7856.6 7967.6 8013.4 8165.2 8192.9 20926.9 21074.7 21170.0 21228.5 21251.8 9067.3 9298.6 9376.2 9394.8 9398.6 8314.1 8417.5 8449.9 8681.5 8692.5 6325.8 6326.5 6366.9 6392.6 6428.5 1747.7 1791.7 1850.1 1853.4 1879.2 962.4 969.9 975.8 987.6 988.7 10141.0 10245.8 10288.1 10413.9 10521.5 1067.5 1079.4 1084.8 1085.2 1113.7 5797.9 6324.5 6438.7 6445.8 6486.0 25963.2 26578.2 27115.2 27218.9 27485.9 27277.9 27287.7 27696.2 27724.2 27810.5 12223.3 12620.3 12961.2 12966.8 12981.7 9853.3 10065.1 10133.7 10134.8 10382.9 22339.3 22452.2 22894.8 22978.2 23341.6 23255.3 23435.5 23583.2 23846.8 23947.0 12793.5 12922.1 12956.4 12996.7 13005.9 15939.3 16044.7 16060.8 16150.9 16176.1 12011.9 12238.1 12335.6 12477.2 12617.7 11745.2 11888.3 11979.2 12039.4 12150.1 10922.2 10986.1 11115.2 11118.8 11121.5 8110.7 8250.4 8280.2 8301.3 8358.1 7965.5 8060.5 8062.9 8073.3 8111.4 13:09:49 INFO - PID 23838 | 13:09:49 INFO - PID 23838 | [#4] prototype.html Cycles:180 Average:5821.74 Median:6426.58 stddev:1611.64 (25.1%) stddev-sans-first:1567.24 13:09:49 INFO - PID 23838 | Values: 571.0 573.2 578.5 600.6 607.2 6218.2 6245.5 6407.9 6461.9 6469.2 6381.9 6402.1 6411.2 6425.9 6427.3 5297.1 5317.5 5338.6 5344.5 5348.3 5064.3 5176.2 5212.0 5224.0 5314.4 5148.8 5166.3 5171.0 5175.7 5182.8 5147.8 5173.4 5186.9 5190.4 5206.1 4716.6 4720.9 4725.6 4730.7 4740.4 6377.0 6377.7 6401.2 6419.5 6425.3 6001.7 6087.6 6100.1 6139.2 6160.0 6741.0 6807.6 6819.1 6894.1 6909.0 5042.7 5295.2 5307.9 5313.9 5321.8 6996.2 6997.3 7057.4 7072.8 7084.9 5355.7 5367.7 5381.7 5388.2 5443.8 5464.2 5468.6 5485.4 5489.4 5517.8 5947.8 6052.2 6078.1 6088.8 6105.4 6924.6 6931.2 6937.5 6946.3 6950.6 1874.1 1882.3 1894.1 1897.2 1915.8 1291.2 1337.9 1357.1 1366.4 1366.7 6272.4 6336.5 6397.1 6536.4 6563.9 6679.1 6798.0 6811.3 6869.7 6904.9 6389.6 6436.6 6447.9 6473.6 6516.4 3641.6 3661.6 3667.3 3692.7 3697.5 7218.9 7228.7 7263.7 7302.4 7333.4 7143.7 7161.7 7177.3 7184.0 7272.7 7242.2 7248.6 7259.6 7277.0 7280.2 6863.7 6895.7 6902.3 6999.5 7013.5 6779.6 6784.5 6808.9 6889.5 6904.1 7177.5 7181.0 7187.5 7261.5 7314.8 5418.4 5422.5 5425.3 5427.6 5439.4 6773.4 6905.0 6968.1 6989.8 7012.1 6729.4 6745.2 6750.2 6759.0 6761.3 6557.5 6685.0 6716.1 6747.0 6785.9 6445.3 6508.8 6574.1 6647.8 6671.9 6671.5 6805.3 6806.0 6810.8 6825.9 6594.7 6615.4 6642.2 6715.3 6747.8 13:09:49 INFO - PID 23838 | 13:09:49 INFO - PID 23838 | [#5] yui.html Cycles:180 Average:28844.18 Median:17931.41 stddev:43767.90 (244.1%) stddev-sans-first:43840.69 13:09:49 INFO - PID 23838 | Values: 984.3 999.9 1021.4 1031.7 1032.3 21747.1 22203.0 22213.7 22245.4 22251.2 18709.5 20001.6 20203.0 20220.3 20237.3 1075.6 1076.3 1077.5 1079.9 1079.9 1065.0 1082.4 1090.4 1091.9 1123.5 1142.8 1151.5 1153.6 1154.0 1154.6 1145.0 1145.5 1146.3 1147.0 1147.4 845.8 847.6 853.0 853.1 854.2 20845.8 21135.9 21686.6 21865.9 21872.1 22853.4 23181.2 23555.0 23597.8 23786.9 18069.0 18491.4 18503.5 18520.5 18562.7 4138.2 4176.5 4181.4 4182.3 4182.9 166597.0 170850.0 171155.0 171823.0 173924.0 17793.8 18112.0 18161.4 18162.4 18171.2 34886.4 36121.1 36133.6 36214.3 36247.6 9742.6 9955.3 9969.8 9989.5 10007.7 4937.9 4993.5 4995.1 5029.1 5040.9 6074.6 6125.5 6135.9 6170.5 6179.6 1184.2 1188.4 1200.6 1210.3 1218.0 744.5 771.1 774.6 783.7 796.0 12956.2 12958.7 13081.1 13161.5 13293.7 623.1 630.7 632.7 634.8 637.4 6092.4 6126.7 6200.1 6224.8 6231.3 150408.0 153362.0 154133.0 154383.0 161968.0 121948.4 123921.0 126207.4 129005.0 132210.0 119519.4 119932.0 120153.0 122067.0 122248.4 11875.3 11894.8 11921.6 12023.3 12091.5 56325.7 56972.0 57248.7 57876.7 58010.0 70832.6 71259.3 72675.6 72744.6 74053.6 16944.4 17039.0 17041.8 17041.8 17160.8 17453.8 18173.9 18200.9 18201.3 18202.9 17136.1 17345.7 17362.8 17612.8 17624.4 15243.5 15594.4 15629.6 15745.5 15818.2 16815.2 16897.6 16988.3 17158.8 17166.3 12392.3 12592.6 12792.2 12801.9 12897.7 12782.6 13023.7 13156.4 13243.7 13266.2 13:09:49 INFO - PID 23838 | -------- Summary: end -------- 13:09:49 INFO - PID 23838 | 13:09:49 INFO - TEST-INFO | 23838: exit 0 13:09:49 INFO - TEST-OK | dromaeo_css | took 1106823ms 13:09:49 INFO - TEST-START | kraken 13:09:49 INFO - Initialising browser for kraken test... 13:09:49 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53541/getInfo.html -profile /tmp/tmpVhtiMe/profile 13:09:49 INFO - TEST-INFO | started process 24196 (/builds/slave/test/build/application/firefox/firefox http://localhost:53541/getInfo.html) 13:09:54 INFO - TEST-INFO | 24196: exit 0 13:09:54 INFO - Browser initialized. 13:09:54 INFO - Running cycle 1/1 for kraken test... 13:09:54 INFO - Using env: {'DISPLAY': ':0', 13:09:54 INFO - 'HOME': '/home/cltbld', 13:09:54 INFO - 'JSGC_DISABLE_POISONING': '1', 13:09:54 INFO - 'LANG': 'en_US.UTF-8', 13:09:54 INFO - 'LANGUAGE': 'en_US:en', 13:09:54 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 13:09:54 INFO - 'LOGNAME': 'cltbld', 13:09:54 INFO - 'MAIL': '/var/mail/cltbld', 13:09:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:09:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:09:54 INFO - 'MOZ_CRASHREPORTER': '1', 13:09:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:54 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 13:09:54 INFO - 'MOZ_NO_REMOTE': '1', 13:09:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:09:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:54 INFO - 'NO_EM_RESTART': '1', 13:09:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:54 INFO - 'PWD': '/builds/slave/test', 13:09:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:09:54 INFO - 'RUST_BACKTRACE': 'full', 13:09:54 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:09:54 INFO - 'SHELL': '/bin/bash', 13:09:54 INFO - 'SHLVL': '1', 13:09:54 INFO - 'TERM': 'linux', 13:09:54 INFO - 'TMOUT': '86400', 13:09:54 INFO - 'USER': 'cltbld', 13:09:54 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1507836858.180558-968221669', 13:09:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:54 INFO - '_': '/tools/buildbot/bin/python'} 13:09:54 INFO - TEST-INFO | started process 24428 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVhtiMe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 13:09:55 INFO - PID 24428 | 13:09:55 INFO - PID 24428 | (/builds/slave/test/build/application/firefox/firefox:24477): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 13:09:55 INFO - PID 24428 | 13:10:05 INFO - PID 24428 | RSS: Main: 143458304 13:10:05 INFO - PID 24428 | 13:10:08 INFO - PID 24428 | Cycle 1(1): loaded http://localhost:53541/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53541/tests/kraken/driver.html?testName=audio-beat-detection) 13:10:09 INFO - PID 24428 | RSS: Main: 149512192 13:10:09 INFO - PID 24428 | 13:10:11 INFO - PID 24428 | Cycle 1(1): loaded http://localhost:53541/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53541/tests/kraken/driver.html?testName=audio-dft) 13:10:12 INFO - PID 24428 | RSS: Main: 150048768 13:10:12 INFO - PID 24428 | 13:10:15 INFO - PID 24428 | Cycle 1(1): loaded http://localhost:53541/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53541/tests/kraken/driver.html?testName=audio-fft) 13:10:15 INFO - PID 24428 | RSS: Main: 151785472 13:10:15 INFO - PID 24428 | 13:10:17 INFO - PID 24428 | Cycle 1(1): loaded http://localhost:53541/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53541/tests/kraken/driver.html?testName=audio-oscillator) 13:10:18 INFO - PID 24428 | RSS: Main: 151711744 13:10:18 INFO - PID 24428 | 13:10:20 INFO - PID 24428 | Cycle 1(1): loaded http://localhost:53541/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53541/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:10:20 INFO - PID 24428 | RSS: Main: 151805952 13:10:20 INFO - PID 24428 | 13:10:23 INFO - PID 24428 | Cycle 1(1): loaded http://localhost:53541/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53541/tests/kraken/driver.html?testName=imaging-darkroom) 13:10:24 INFO - PID 24428 | RSS: Main: 151355392 13:10:24 INFO - PID 24428 | 13:10:28 INFO - PID 24428 | Cycle 1(1): loaded http://localhost:53541/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53541/tests/kraken/driver.html?testName=imaging-desaturate) 13:10:28 INFO - PID 24428 | RSS: Main: 151871488 13:10:28 INFO - PID 24428 | 13:10:31 INFO - PID 24428 | Cycle 1(1): loaded http://localhost:53541/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53541/tests/kraken/driver.html?testName=json-parse-financial) 13:10:32 INFO - PID 24428 | RSS: Main: 153669632 13:10:32 INFO - PID 24428 | 13:10:33 INFO - PID 24428 | Cycle 1(1): loaded http://localhost:53541/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53541/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:10:34 INFO - PID 24428 | RSS: Main: 153481216 13:10:34 INFO - PID 24428 | 13:10:35 INFO - PID 24428 | Cycle 1(1): loaded http://localhost:53541/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53541/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:10:36 INFO - PID 24428 | RSS: Main: 153681920 13:10:36 INFO - PID 24428 | 13:10:38 INFO - PID 24428 | Cycle 1(1): loaded http://localhost:53541/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53541/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:10:39 INFO - PID 24428 | RSS: Main: 150757376 13:10:39 INFO - PID 24428 | 13:10:41 INFO - PID 24428 | Cycle 1(1): loaded http://localhost:53541/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53541/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:10:42 INFO - PID 24428 | RSS: Main: 150585344 13:10:42 INFO - PID 24428 | 13:10:44 INFO - PID 24428 | Cycle 1(1): loaded http://localhost:53541/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53541/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:10:45 INFO - PID 24428 | RSS: Main: 151412736 13:10:45 INFO - PID 24428 | 13:10:46 INFO - PID 24428 | Cycle 1(1): loaded http://localhost:53541/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53541/tests/kraken/driver.html?testName=ai-astar) 13:10:47 INFO - PID 24428 | RSS: Main: 152354816 13:10:47 INFO - PID 24428 | 13:10:47 INFO - PID 24428 | __start_tp_report 13:10:47 INFO - PID 24428 | _x_x_mozilla_page_load 13:10:47 INFO - PID 24428 | _x_x_mozilla_page_load_details 13:10:47 INFO - PID 24428 | |i|pagename|runs| 13:10:47 INFO - PID 24428 | |0;ai-astar;105;105;104;106;105;105;106;105;104;105 13:10:47 INFO - PID 24428 | |1;audio-beat-detection;110;111;110;110;110;140;112;111;148;112 13:10:47 INFO - PID 24428 | |2;audio-dft;161;163;162;162;162;162;162;164;161;161 13:10:47 INFO - PID 24428 | |3;audio-fft;73;73;72;73;73;73;73;75;72;73 13:10:47 INFO - PID 24428 | |4;audio-oscillator;77;78;78;77;77;77;80;78;78;77 13:10:47 INFO - PID 24428 | |5;imaging-gaussian-blur;110;113;114;113;113;114;113;114;113;114 13:10:47 INFO - PID 24428 | |6;imaging-darkroom;160;149;149;153;148;148;147;148;148;149 13:10:47 INFO - PID 24428 | |7;imaging-desaturate;94;93;94;94;93;98;94;95;94;93 13:10:47 INFO - PID 24428 | |8;json-parse-financial;46;46;44;43;43;48;43;44;44;44 13:10:47 INFO - PID 24428 | |9;json-stringify-tinderbox;40;36;35;36;36;36;36;36;36;37 13:10:47 INFO - PID 24428 | |10;stanford-crypto-aes;78;72;70;74;71;69;68;68;68;68 13:10:47 INFO - PID 24428 | |11;stanford-crypto-ccm;100;99;99;101;106;101;111;100;106;111 13:10:47 INFO - PID 24428 | |12;stanford-crypto-pbkdf2;158;146;148;148;159;146;147;154;156;149 13:10:47 INFO - PID 24428 | |13;stanford-crypto-sha256-iterative;60;60;58;59;57;57;59;62;61;65 13:10:47 INFO - PID 24428 | __end_tp_report 13:10:47 INFO - PID 24428 | __start_cc_report 13:10:47 INFO - PID 24428 | _x_x_mozilla_cycle_collect,685 13:10:47 INFO - PID 24428 | __end_cc_report 13:10:47 INFO - PID 24428 | __startTimestamp1507839047194__endTimestamp 13:10:47 INFO - PID 24428 | 13:10:47 INFO - PID 24428 | ------- Summary: start ------- 13:10:47 INFO - PID 24428 | Number of tests: 14 13:10:47 INFO - PID 24428 | 13:10:47 INFO - PID 24428 | [#0] ai-astar Cycles:10 Average:105.00 Median:105.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 13:10:47 INFO - PID 24428 | Values: 105.0 105.0 104.0 106.0 105.0 105.0 106.0 105.0 104.0 105.0 13:10:47 INFO - PID 24428 | 13:10:47 INFO - PID 24428 | [#1] audio-beat-detection Cycles:10 Average:117.40 Median:111.50 stddev:14.17 (12.7%) stddev-sans-first:14.77 13:10:47 INFO - PID 24428 | Values: 110.0 111.0 110.0 110.0 110.0 140.0 112.0 111.0 148.0 112.0 13:10:47 INFO - PID 24428 | 13:10:47 INFO - PID 24428 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.94 (0.6%) stddev-sans-first:0.93 13:10:47 INFO - PID 24428 | Values: 161.0 163.0 162.0 162.0 162.0 162.0 162.0 164.0 161.0 161.0 13:10:47 INFO - PID 24428 | 13:10:47 INFO - PID 24428 | [#3] audio-fft Cycles:10 Average:73.00 Median:73.00 stddev:0.82 (1.1%) stddev-sans-first:0.87 13:10:47 INFO - PID 24428 | Values: 73.0 73.0 72.0 73.0 73.0 73.0 73.0 75.0 72.0 73.0 13:10:47 INFO - PID 24428 | 13:10:47 INFO - PID 24428 | [#4] audio-oscillator Cycles:10 Average:77.70 Median:78.00 stddev:0.95 (1.2%) stddev-sans-first:0.97 13:10:47 INFO - PID 24428 | Values: 77.0 78.0 78.0 77.0 77.0 77.0 80.0 78.0 78.0 77.0 13:10:47 INFO - PID 24428 | 13:10:47 INFO - PID 24428 | [#5] imaging-gaussian-blur Cycles:10 Average:113.10 Median:113.50 stddev:1.20 (1.1%) stddev-sans-first:0.53 13:10:47 INFO - PID 24428 | Values: 110.0 113.0 114.0 113.0 113.0 114.0 113.0 114.0 113.0 114.0 13:10:47 INFO - PID 24428 | 13:10:47 INFO - PID 24428 | [#6] imaging-darkroom Cycles:10 Average:149.90 Median:149.00 stddev:3.90 (2.6%) stddev-sans-first:1.72 13:10:47 INFO - PID 24428 | Values: 160.0 149.0 149.0 153.0 148.0 148.0 147.0 148.0 148.0 149.0 13:10:47 INFO - PID 24428 | 13:10:47 INFO - PID 24428 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:1.48 (1.6%) stddev-sans-first:1.56 13:10:47 INFO - PID 24428 | Values: 94.0 93.0 94.0 94.0 93.0 98.0 94.0 95.0 94.0 93.0 13:10:47 INFO - PID 24428 | 13:10:47 INFO - PID 24428 | [#8] json-parse-financial Cycles:10 Average:44.50 Median:44.00 stddev:1.65 (3.7%) stddev-sans-first:1.66 13:10:47 INFO - PID 24428 | Values: 46.0 46.0 44.0 43.0 43.0 48.0 43.0 44.0 44.0 44.0 13:10:47 INFO - PID 24428 | 13:10:47 INFO - PID 24428 | [#9] json-stringify-tinderbox Cycles:10 Average:36.40 Median:36.00 stddev:1.35 (3.7%) stddev-sans-first:0.50 13:10:47 INFO - PID 24428 | Values: 40.0 36.0 35.0 36.0 36.0 36.0 36.0 36.0 36.0 37.0 13:10:47 INFO - PID 24428 | 13:10:47 INFO - PID 24428 | [#10] stanford-crypto-aes Cycles:10 Average:70.60 Median:70.50 stddev:3.31 (4.7%) stddev-sans-first:2.17 13:10:47 INFO - PID 24428 | Values: 78.0 72.0 70.0 74.0 71.0 69.0 68.0 68.0 68.0 68.0 13:10:47 INFO - PID 24428 | 13:10:47 INFO - PID 24428 | [#11] stanford-crypto-ccm Cycles:10 Average:103.40 Median:108.50 stddev:4.74 (4.4%) stddev-sans-first:4.87 13:10:47 INFO - PID 24428 | Values: 100.0 99.0 99.0 101.0 106.0 101.0 111.0 100.0 106.0 111.0 13:10:47 INFO - PID 24428 | 13:10:47 INFO - PID 24428 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.10 Median:151.50 stddev:5.11 (3.4%) stddev-sans-first:4.77 13:10:47 INFO - PID 24428 | Values: 158.0 146.0 148.0 148.0 159.0 146.0 147.0 154.0 156.0 149.0 13:10:47 INFO - PID 24428 | 13:10:47 INFO - PID 24428 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.80 Median:60.00 stddev:2.44 (4.1%) stddev-sans-first:2.59 13:10:47 INFO - PID 24428 | Values: 60.0 60.0 58.0 59.0 57.0 57.0 59.0 62.0 61.0 65.0 13:10:47 INFO - PID 24428 | -------- Summary: end -------- 13:10:47 INFO - PID 24428 | 13:10:47 INFO - PID 24428 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 13:10:47 INFO - TEST-INFO | 24428: exit 0 13:10:47 INFO - TEST-OK | kraken | took 57959ms 13:10:47 INFO - SUITE-END | took 1164s 13:10:48 INFO - Completed test suite (00:19:25) 13:10:48 INFO - javascript benchmark 13:10:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9459.298257025686, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [4035.818388172532, 4048.5748996355383, 4066.3697126945317, 4072.1448495815876, 4103.958960410397, 6455.0, 6510.18622672166, 6579.769708060219, 6600.438962688171, 6608.339166083395, 6487.967560162205, 6505.316941721122, 6551.377619126175, 6611.173603299588, 6625.0, 5764.8847023059725, 5859.472647461727, 5908.438698323663, 5920.378360272174, 5922.3485416604135, 5846.298444186704, 5872.354041055481, 5881.764729410818, 5965.671888046156, 5979.730912108944, 5949.4348036936635, 5987.191729116557, 5994.700264986755, 6006.609570377933, 6010.308814486324, 5845.1232315153065, 5943.375945525744, 5956.434138756811, 6009.5192384609345, 6019.428154325332, 5783.248177736909, 5813.970930145365, 5824.504917082053, 5862.560307976876, 5916.408359164049, 6486.90269645951, 6489.902651460185, 6498.0, 6498.610083394964, 6530.6734663267125, 7090.645467726593, 7096.609686467243, 7171.103612048494, 7172.820679483002, 7184.748533801344, 7053.294670532957, 7127.4654400920135, 7140.28597140287, 7170.175429825585, 7174.3184397482155, 6580.670966451658, 6605.207375114969, 6634.767783127616, 6667.533272670915, 6674.43267322283, 7319.231480694557, 7320.633968301564, 7387.187409384964, 7393.963030184815, 7416.40668746499, 6982.301769823079, 6988.161420629557, 7053.0830991970715, 7081.858362832714, 7103.325184107502, 7065.399441047569, 7115.430765538745, 7138.000679904818, 7197.568145911157, 7238.131424229126, 7025.262347453444, 7041.788746337618, 7081.964590177016, 7092.148942126978, 7126.109236345457, 7017.859642807115, 7020.92979070213, 7028.964855175692, 7103.715851365991, 7128.144622645212, 5244.449332819999, 5246.160614301693, 5302.28419163408, 5318.095923692981, 5322.654027488278, 4789.592884604778, 4842.58837998767, 4882.707037577757, 4908.042931628298, 4927.236278376858, 6659.267480577133, 6670.899936500957, 6728.6972086255255, 6741.359570840762, 6744.7976560703255, 7056.435485161175, 7068.11648543932, 7069.434445244368, 7076.044733960953, 7164.426845852319, 6654.467642588581, 6683.699233534406, 6698.5980841149685, 6701.29636388182, 6715.227748808852, 5985.551083668743, 6035.66803825785, 6054.303755068224, 6061.363556826558, 6071.180390647294, 7331.156916954512, 7414.25857414265, 7425.517341372793, 7510.211427800112, 7535.54786712799, 7071.116110486087, 7074.964625176841, 7077.115360579927, 7087.7164913402885, 7100.680469378787, 7334.413246940126, 7390.482666213314, 7401.0748656417945, 7443.739469118555, 7517.43619228571, 6850.965745171442, 7031.367176953894, 7044.823879403056, 7050.294970502909, 7062.011318415529, 6989.930100698928, 7102.431805455448, 7116.857662846611, 7212.098487689039, 7230.060092187982, 6729.0915726376315, 6832.760853370109, 6842.55523390978, 6871.175458944758, 6873.931260687529, 6841.692123854339, 6847.041414202115, 6859.2454829969665, 6860.03959445688, 6868.553544019623, 6761.121054263111, 6776.525643204928, 6848.7260509579055, 6853.383195512428, 6861.4510839133745, 6929.826754331182, 6970.128733908262, 6975.162980442379, 7029.859402812018, 7040.753573624898, 6664.366885145903, 6741.0, 6741.696623651849, 6819.4544436443975, 6823.795286141423], "value": 6522.07688890974, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [986.8798913233478, 991.3506653142192, 1012.5544760305465, 1015.5937624950019, 1016.6645007147638, 45275.547244527545, 46168.76915615417, 46251.07497850041, 46291.305630415525, 46311.30533042007, 43643.0, 43837.0, 43955.560444395545, 44110.0, 44193.45322913698, 8126.471779334354, 8129.309008734264, 8203.58982050895, 8208.05607355156, 8244.628991695357, 8103.756887293391, 8173.060098088707, 8225.95887020567, 8237.423380363376, 8237.546934918608, 8171.795705107361, 8914.242289405376, 9032.729018129434, 9049.547522623876, 9051.0, 8898.777530561723, 8962.327825413087, 8965.0, 8970.237529809974, 8972.0, 8910.465372077697, 8985.101489851028, 9017.143371379709, 9017.819643607158, 9018.954905225432, 42042.369364459555, 42400.36399454011, 42510.78744606288, 42531.787341063406, 42533.0, 3900.1029763154634, 3912.3349030664854, 3930.8231129599235, 3933.1347103637154, 3935.5277366716177, 34512.48231276533, 34853.651463485294, 34925.30149397023, 34968.65031349679, 34976.82511587451, 4405.140997505488, 4415.11697660466, 4419.071994881079, 4420.690551661385, 4442.267025940716, 236911.0, 238481.0, 238654.0, 238696.0, 239326.0, 50334.24498632523, 50750.238746418836, 55577.444225558036, 56940.71529642325, 57335.0, 60020.0, 60173.09740353898, 60182.69908650516, 60208.69895650581, 60251.39748602545, 18658.253669853053, 18773.90613046926, 18877.528061798566, 18883.339083132025, 18892.0, 15405.075695458308, 15446.0, 15446.768298475532, 15677.921610391875, 15680.0, 15689.0, 15748.370065197263, 15806.288717007763, 15810.683786324209, 15896.682066358608, 6349.682515874188, 6369.617822930639, 6434.8391290218115, 6514.837129071811, 6539.0, 1049.511976930731, 1079.8920107989138, 1088.4448931045224, 1091.1325496230515, 1127.785720713062, 25987.22038338853, 26085.0, 26446.206613801616, 26476.47047059048, 26496.602550961365, 1194.498310709504, 1197.5988044005182, 1200.765850659113, 1202.699325168708, 1215.2040413529153, 13720.65698357529, 13768.931155344158, 13871.930640346734, 13904.51334203298, 13941.721165576631, 313948.0, 316809.0, 317458.0, 317732.0, 318161.0, 62188.0, 62446.0, 62528.0, 62783.0, 63001.68499157475, 1578.3213218316234, 1580.6601580659983, 1583.4774524406919, 1604.2139351717808, 1612.274476485586, 26278.0, 26336.604950926136, 26440.603390949535, 26702.732972670026, 26866.865665671547, 42505.57494425016, 42627.0, 42663.5733642672, 42699.7865010673, 42798.78600606977, 267367.0, 270216.0, 270598.0, 273474.0, 273536.0, 37600.62399375971, 38265.23469530649, 38760.6123938757, 41032.79483602563, 41543.37684934668, 55137.44862551323, 55595.44404555903, 55654.0, 56057.15914261208, 56505.71747141238, 38918.80540597279, 39021.8048909765, 39048.609513905634, 39156.60843391644, 39476.80261598674, 38851.805740972246, 39041.80479097586, 39150.80424597859, 39396.80301598473, 39405.0, 45597.3664623578, 46351.30473042974, 46804.29793553031, 46906.296405554625, 46917.2962405571, 36295.63704362923, 36398.0, 36943.630563694016, 37067.8146609276, 37956.810215948746, 28260.293492662848, 28260.85869570639, 28407.857960710066, 28743.425131497672, 28870.566941496316], "value": 19752.17868027135, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [629.7235254932596, 650.8922565583824, 652.5708697951488, 662.5031226580065, 668.6623255256095, 23452.179173728924, 24140.396490087736, 24154.75845241549, 24198.879005604947, 24240.636390454158, 27047.323816904536, 27318.180454586392, 27377.86311068447, 27432.862835685843, 27471.313217169532, 6415.967920160404, 6563.671816409161, 6563.901541476857, 6566.047923051155, 6568.310327415625, 6567.54027218095, 6654.534182607219, 6669.43309818666, 6669.69986350613, 6669.9666501667425, 6662.167229096363, 6911.758088466905, 6937.0, 6945.652717364137, 6949.826254343631, 6872.175338959332, 6894.793156205322, 6904.067950826624, 6904.067950826675, 6917.273686262945, 6412.807615771488, 6417.871642567169, 6434.774782882577, 6471.83820404489, 6497.610143391412, 30433.69566304331, 30944.38111237785, 31208.0, 31447.84276078605, 31526.36947261042, 2354.7880690737743, 2385.8210634202333, 2386.4869053153657, 2387.582173119697, 2392.246442370648, 20285.290014849408, 20776.065077071416, 20826.37520874376, 21025.369238922856, 21116.0, 2547.1339744486777, 2570.69151701797, 2610.530104581175, 2612.3338548669967, 2625.094342451851, 148573.0, 156272.0, 158069.0, 162001.0, 169121.0, 16541.421050263183, 17314.220860061076, 17374.739378909326, 17570.912145439448, 17592.912035439742, 27414.725852741216, 27563.0, 27609.0, 27625.309367265978, 27642.72357276442, 11229.775404491864, 11305.830412543819, 11344.0, 11542.19204655683, 11547.422628868522, 10272.229582781321, 10295.74260643475, 10331.0, 10426.739331516772, 10474.319169253975, 9811.411315321104, 10058.245631577662, 10058.446785426726, 10064.647737329158, 10147.188224942134, 3127.8748850045745, 3143.0, 3159.0403067184757, 3163.0, 3269.1500209945584, 1052.2529004406804, 1063.707480442869, 1066.8186408310605, 1067.1142951350516, 1068.5885933915342, 21665.35003949884, 21694.34916952494, 21936.561268774854, 21943.561128777656, 21986.670199947013, 1146.2262972493534, 1147.3402793393666, 1149.1840793037038, 1150.7525881935258, 1157.8031734605138, 11829.76340473203, 11919.225250358699, 11958.880411195776, 11976.52093916251, 12085.939570302093, 639592.0, 650044.0, 651107.0, 672160.0, 688251.0, 136816.0, 139872.0, 140092.0, 141675.2916235412, 142729.0, 1139.9829002564968, 1182.8817118288102, 1226.9141160118706, 1257.1953949472345, 1297.571801305548, 21750.6737398936, 22406.25420678168, 22486.226924494236, 22630.98160582745, 22674.773252267925, 64500.0, 64734.35265647283, 64741.67629161824, 66440.66779666071, 66705.3329466699, 79938.60184194484, 81020.18979810126, 83314.58342708247, 83728.16271837204, 85144.57427712822, 15796.526104216891, 16227.756583651491, 16356.509304720877, 16391.75412368839, 16458.670826583642, 24631.753682462946, 24680.0, 24696.753032470166, 25008.749912500643, 25120.62319065179, 19033.0, 19214.80785192186, 19345.51636209106, 19499.51251218731, 19511.219551217793, 16930.0, 17186.742198867276, 17269.0, 17484.91257543704, 17986.19062142233, 19125.13936872872, 19888.70166947468, 19915.900420497805, 20108.497287567927, 20177.495562611053, 15863.286152123414, 15957.122358270406, 15978.840211597735, 15993.68012639764, 16055.839441605902, 19327.710084348466, 19384.418467445998, 19436.70844937299, 19468.707969380186, 19507.609847803247], "value": 13228.70352504709, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1402.4600528796414, 1475.2623688155923, 1480.962975925602, 1481.7481028225207, 1489.0317304383818, 17556.0, 18271.72592411113, 18278.725819112726, 18292.085395730195, 18295.90852045741, 17888.373906913228, 17905.104744762775, 18000.9298930623, 18082.3671171509, 18083.27666893326, 3162.4465718499287, 3200.1679563313473, 3247.5291082792983, 3249.301400198957, 3249.8375081245963, 3233.6927991840853, 3234.191452136966, 3262.869485220588, 3265.0368141398344, 3265.363254165427, 3252.9349413011846, 3326.6507016763135, 3332.100332910125, 3332.2502436951736, 3333.6166340870745, 3211.6788321167696, 3230.580024596799, 3287.079617707022, 3289.3750187464425, 3291.555639988595, 3226.3869864725625, 3228.1284053305712, 3228.1929517620597, 3241.481362981935, 3243.5459035735016, 17033.48899533016, 17257.395991140376, 17331.306747730076, 17339.393121240697, 17348.56628584283, 9004.77488062797, 9193.126652967958, 9290.442573445547, 9291.256699464027, 9296.95351523238, 6107.4503294703245, 6231.626102433868, 6319.58922670025, 6372.681365931685, 6411.294757576663, 2104.684297355409, 2136.9679454808033, 2147.366526874576, 2176.9891150544304, 2204.0302267002626, 32545.51181732276, 32782.6721732782, 32848.17879553006, 32850.83574582136, 32854.178645533815, 7856.646450909723, 7967.56178410193, 8013.358931285483, 8165.2243036911395, 8192.918070819334, 20926.895365523378, 21074.683879741817, 21170.0, 21228.469288267606, 21251.78748212529, 9067.274618030542, 9298.628054877865, 9376.249900007982, 9394.812103757886, 9398.577064032135, 8314.127016663284, 8417.537035463109, 8449.915500845036, 8681.52251626154, 8692.478451292942, 6325.841853953688, 6326.49388048955, 6366.872662546723, 6392.648404337713, 6428.453581445536, 1747.7028905086165, 1791.7133258678548, 1850.0666803190697, 1853.4161739052156, 1879.2201236486978, 962.3552220012608, 969.8787651543557, 975.8341082016075, 987.5654711926729, 988.7478692933399, 10140.99972548732, 10245.84631230532, 10288.074073333435, 10413.895861041445, 10521.52653130611, 1067.4982758103833, 1079.3847506921136, 1084.8047351476653, 1085.1915323084352, 1113.6580420593166, 5797.9420205797405, 6324.525660575475, 6438.742450301936, 6445.838854028687, 6486.027095935648, 25963.22110336693, 26578.202653920413, 27115.1865444037, 27218.863905680344, 27485.86257068702, 27277.86361068182, 27287.727122728917, 27696.169114926586, 27724.168274951782, 27810.470424126463, 12223.266604003788, 12620.30588317633, 12961.15752476086, 12966.80549791754, 12981.675458113623, 9853.261005424765, 10065.094141527004, 10133.695989120339, 10134.797304054026, 10382.948085259828, 22339.329820105424, 22452.214172503885, 22894.771052289263, 22978.19576314821, 23341.649875252224, 23255.3023409298, 23435.53128937446, 23583.174588889993, 23846.761532384455, 23947.0, 12793.488260469478, 12922.095453318178, 12956.35218239103, 12996.675083122998, 13005.934970325088, 15939.282732277306, 16044.679106417572, 16060.839391605934, 16150.919245403698, 16176.110313932846, 12011.879881201427, 12238.08214383907, 12335.629931102081, 12477.188982716094, 12617.684557886127, 11745.17783755129, 11888.28670279786, 11979.161458697807, 12039.398030098286, 12150.08874334446, 10922.18083643714, 10986.121110311316, 11115.22193446451, 11118.833217501582, 11121.499532520895, 8110.675572977015, 8250.422470427253, 8280.171982801672, 8301.294389976678, 8358.08061113265, 7965.522068675898, 8060.476069055727, 8062.8790568142695, 8073.313768329758, 8111.351091912515], "value": 7837.924348429366, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.9514691251244, 573.2490437526839, 578.4533615733134, 600.612604869859, 607.1681795939561, 6218.22272215973, 6245.534442873344, 6407.903881441771, 6461.903071453932, 6469.223693156828, 6381.872362552758, 6402.135711678922, 6411.230652321717, 6425.903611445832, 6427.260865000515, 5297.099493086175, 5317.5480084192695, 5338.572914166877, 5344.4922732340365, 5348.331458567679, 5064.341635587387, 5176.197689358137, 5212.0, 5224.0, 5314.441983591725, 5148.794048238066, 5166.276721259027, 5170.974145129269, 5175.741212939338, 5182.766775495093, 5147.845564633067, 5173.42210625759, 5186.870328241786, 5190.429052804188, 5206.114960456732, 4716.551927566876, 4720.875605977324, 4725.621950244006, 4730.668853180278, 4740.360051393052, 6376.968115159394, 6377.744890204386, 6401.1678481797535, 6419.454346380563, 6425.261094974091, 6001.699915004232, 6087.604305720114, 6100.054491553817, 6139.21962630841, 6160.0, 6741.0, 6807.591544507345, 6819.113515243036, 6894.13823272091, 6908.998195261659, 5042.747862606855, 5295.205719142121, 5307.893842123174, 5313.893722125575, 5321.787128514855, 6996.195437524699, 6997.335253150943, 7057.364837164629, 7072.823179420504, 7084.893726594105, 5355.678659280456, 5367.677939323653, 5381.650192737459, 5388.218708287355, 5443.8094666686475, 5464.180372944011, 5468.617196796186, 5485.424030476743, 5489.423610520837, 5517.834464966058, 5947.821565353046, 6052.213212282375, 6078.1186727924205, 6088.817335479943, 6105.358937311607, 6924.58452492852, 6931.202911665223, 6937.479689023344, 6946.270641582662, 6950.6177160256675, 1874.09106583307, 1882.2753240002423, 1894.128700797621, 1897.1652472911874, 1915.808419158073, 1291.2123604601186, 1337.946482140723, 1357.138217232045, 1366.4217828408205, 1366.7334869700312, 6272.421132573247, 6336.461400780985, 6397.10440538325, 6536.444402225769, 6563.9343606563325, 6679.09459385169, 6797.966010169917, 6811.25076241613, 6869.725210991504, 6904.896426553606, 6389.616623002635, 6436.645984470805, 6447.871042579122, 6473.579217350857, 6516.446102081281, 3641.5630124385243, 3661.6155303693263, 3667.303212389691, 3692.7415080944074, 3697.5378077740284, 7218.8917166242545, 7228.710851565984, 7263.709451621876, 7302.415806735448, 7333.413326933833, 7143.749968751173, 7161.713531458788, 7177.318154775288, 7184.0, 7272.709091636381, 7242.239564845615, 7248.565086094851, 7259.637018149071, 7276.96361518189, 7280.199178090405, 6863.6568171590225, 6895.689693963884, 6902.344277293649, 6999.475039371966, 7013.544119632207, 6779.610179913007, 6784.457243420416, 6808.863822723419, 6889.483288753263, 6904.13698287714, 7177.497575169688, 7181.0, 7187.471892707561, 7261.5280006799385, 7314.829627259613, 5418.376886657927, 5422.48486393792, 5425.348958125051, 5427.6200665953, 5439.374471935778, 6773.356531129535, 6905.0, 6968.128983877015, 6989.790306290819, 7012.123484564429, 6729.427998620172, 6745.2242992056545, 6750.223724271772, 6758.9723083073895, 6761.256261811099, 6557.458972155174, 6684.955601860998, 6716.093327400738, 6746.9662651688395, 6785.89821152693, 6445.323241059808, 6508.787012415802, 6574.112494813139, 6647.767328143492, 6671.866562668816, 6671.46628269747, 6805.285445028201, 6805.9659701701175, 6810.761623343159, 6825.931740682529, 6594.736210551716, 6615.37153970372, 6642.169728783902, 6715.328467153246, 6747.831304217434], "value": 5360.018516574413, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [984.3404918704467, 999.9150921250443, 1021.4331046269322, 1031.6698656429944, 1032.287721472184, 21747.130114795407, 22203.0, 22213.66679499807, 22245.44386390341, 22251.22120725775, 18709.532261693465, 20001.59996800063, 20203.0, 20220.292289769863, 20237.291694790685, 1075.6181555547785, 1076.2896488317713, 1077.4505002448768, 1079.9082078023378, 1079.929804562705, 1064.9574017039347, 1082.393859438713, 1090.3839330778085, 1091.9235653504259, 1123.4663534820936, 1142.7885841119378, 1151.4990978924195, 1153.596241315537, 1154.0363796230115, 1154.607433472619, 1144.9885501144965, 1145.5017067575548, 1146.3122126723981, 1147.0479502013309, 1147.391882302381, 845.813920937399, 847.563504795031, 853.0190281176634, 853.1212850763724, 854.2183901729971, 20845.79154208454, 21135.894320528452, 21686.566268674538, 21865.890670546545, 21872.125114995382, 22853.42866428336, 23181.188658397044, 23555.0, 23597.7640223599, 23786.88106559456, 18069.0, 18491.44525664232, 18503.537411564685, 18520.53698657531, 18562.72155917662, 4138.151678905847, 4176.4570605821045, 4181.372794080912, 4182.2890108681295, 4182.853600124012, 166597.0, 170849.99999999875, 171155.0, 171823.0, 173924.0, 17793.822061779218, 18112.0, 18161.36435224761, 18162.364317248834, 18171.182296796676, 34886.383521236006, 36121.09697257537, 36133.63866361355, 36214.275714485564, 36247.63752362443, 9742.561584728704, 9955.303128780915, 9969.80060398788, 9989.500524973722, 10007.749806254902, 4937.851864444073, 4993.525615066563, 4995.100881841304, 5029.1450453423, 5040.873978150502, 6074.605150665193, 6125.509959203253, 6135.938640613536, 6170.50635949123, 6179.567430279927, 1184.1829137894824, 1188.3939191012646, 1200.6458094862037, 1210.2980271442543, 1218.03775017735, 744.5197847388404, 771.067008919214, 774.5855967057597, 783.6669415498391, 796.0129439494984, 12956.222626642431, 12958.676033099247, 13081.149725267827, 13161.53934612284, 13293.667658308426, 623.0685125736961, 630.7256343490504, 632.6520413772407, 634.8007927559163, 637.3594537489793, 6092.421219984094, 6126.663033533198, 6200.0699895016105, 6224.782132625336, 6231.283402408781, 150408.0, 153362.0, 154133.0, 154383.0, 161968.0, 121948.39025804814, 123921.0, 126207.36896315643, 129005.0, 132210.0, 119519.40240298917, 119932.0, 120153.0, 122067.0, 122248.38875805742, 11875.287482751062, 11894.821577676168, 11921.642350729491, 12023.338716370683, 12091.51633934668, 56325.71837140788, 56972.0, 57248.71375643095, 57876.710616446646, 58010.0, 70832.64583677049, 71259.28740712734, 72675.63662181655, 72744.6362768204, 74053.62973185099, 16944.40694575684, 17039.0, 17041.829581704023, 17041.829581704522, 17160.828391715924, 17453.82546174522, 18173.909130454264, 18200.908995454938, 18201.271949122416, 18202.90898545499, 17136.14319284006, 17345.653086938444, 17362.826371736122, 17612.823871761117, 17624.383146589807, 15243.466478673194, 15594.376224950875, 15629.609259768597, 15745.527634170992, 15818.209089545708, 16815.159242038095, 16897.577560561083, 16988.320467181173, 17158.828411715724, 17166.313347465963, 12392.256464612152, 12592.622221333375, 12792.168509046882, 12801.93599031999, 12897.677558061123, 12782.552610658582, 13023.674408139872, 13156.40796164194, 13243.735125297248, 13266.204027758366], "value": 10005.57811843097, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1358.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 105.0, 104.0, 106.0, 105.0, 105.0, 106.0, 105.0, 104.0, 105.0], "value": 105.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 110.0, 110.0, 110.0, 140.0, 112.0, 111.0, 148.0, 112.0], "value": 117.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 162.0, 162.0, 162.0, 162.0, 162.0, 164.0, 161.0, 161.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 72.0, 73.0, 73.0, 73.0, 73.0, 75.0, 72.0, 73.0], "value": 73.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 78.0, 77.0, 77.0, 77.0, 80.0, 78.0, 78.0, 77.0], "value": 77.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 114.0, 113.0, 113.0, 114.0, 113.0, 114.0, 113.0, 114.0], "value": 113.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 149.0, 149.0, 153.0, 148.0, 148.0, 147.0, 148.0, 148.0, 149.0], "value": 149.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 94.0, 93.0, 98.0, 94.0, 95.0, 94.0, 93.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 46.0, 44.0, 43.0, 43.0, 48.0, 43.0, 44.0, 44.0, 44.0], "value": 44.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [40.0, 36.0, 35.0, 36.0, 36.0, 36.0, 36.0, 36.0, 36.0, 37.0], "value": 36.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 72.0, 70.0, 74.0, 71.0, 69.0, 68.0, 68.0, 68.0, 68.0], "value": 70.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 99.0, 99.0, 101.0, 106.0, 101.0, 111.0, 100.0, 106.0, 111.0], "value": 103.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 146.0, 148.0, 148.0, 159.0, 146.0, 147.0, 154.0, 156.0, 149.0], "value": 151.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 58.0, 59.0, 57.0, 57.0, 59.0, 62.0, 61.0, 65.0], "value": 59.8, "unit": "score"}]}]} 13:10:48 INFO - Return code: 0 13:10:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:10:48 INFO - # TBPL SUCCESS # 13:10:48 INFO - Running post-action listener: _package_coverage_data 13:10:48 INFO - Running post-action listener: _resource_record_post_action 13:10:48 INFO - [mozharness: 2017-10-12 20:10:48.497067Z] Finished run-tests step (success) 13:10:48 INFO - Running post-run listener: _resource_record_post_run 13:10:48 INFO - Total resource usage - Wall time: 1180s; CPU: 13.0%; Read bytes: 8192; Write bytes: 291688448; Read time: 192; Write time: 159148 13:10:48 INFO - TinderboxPrint: CPU usage
13.0% 13:10:48 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 192 13:10:48 INFO - TinderboxPrint: I/O write bytes / time
291,688,448 / 159,148 13:10:48 INFO - TinderboxPrint: CPU idle
8,181.1 (86.9%) 13:10:48 INFO - TinderboxPrint: CPU user
1,180.6 (12.5%) 13:10:48 INFO - TinderboxPrint: Swap in / out
0 / 0 13:10:48 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 9449472; Read time: 0; Write time: 1304 13:10:48 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 13:10:48 INFO - run-tests - Wall time: 1166s; CPU: 13.0%; Read bytes: 8192; Write bytes: 282238976; Read time: 192; Write time: 157844 13:10:49 INFO - Running post-run listener: _upload_blobber_files 13:10:49 INFO - Blob upload gear active. 13:10:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:10:49 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:10:49 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:10:49 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:10:49 INFO - (blobuploader) - INFO - Open directory for files ... 13:10:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:10:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:10:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:10:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:10:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:10:54 INFO - (blobuploader) - INFO - Done attempting. 13:10:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:10:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:10:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:10:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:10:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:10:55 INFO - (blobuploader) - INFO - Done attempting. 13:10:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:10:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:10:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:10:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:10:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:10:56 INFO - (blobuploader) - INFO - Done attempting. 13:10:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:10:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:10:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:10:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:10:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:10:57 INFO - (blobuploader) - INFO - Done attempting. 13:10:57 INFO - (blobuploader) - INFO - Iteration through files over. 13:10:57 INFO - Return code: 0 13:10:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:10:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:10:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1ffd41a8e16e956507063e1fdb635a2948bf6f0266aa72936de71026f587b18309a0c2ebe72e2b0510bb2888c3e6237e7a05e0ab3a12e524eef2e8ab24748270", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0104873d430c00e6c448312a79ca7e9c15ce3f7da03d395b497edd5016f65b7dd2292eca796bae776e51b0d299f21f27937f7c7d1e08d2b346089073e28a828b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c15f9c4aeaa5a23a7c43eea8d3df9749dbe7493559ecea621be878a5a01dbb375e1305a5d81a3d49000b8810534f0b91c90f48f24e562f697b1fe91e0f79ffdd", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3132aaf0c5c3a915fa62925412f733ff95bc2507b296833faf9df2bf4c9cb19c4fe2722eaf17c99e336b4b54f9c136bc1f84878259850833d6d8030e21779f15"} 13:10:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:10:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:10:57 INFO - Contents: 13:10:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1ffd41a8e16e956507063e1fdb635a2948bf6f0266aa72936de71026f587b18309a0c2ebe72e2b0510bb2888c3e6237e7a05e0ab3a12e524eef2e8ab24748270", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0104873d430c00e6c448312a79ca7e9c15ce3f7da03d395b497edd5016f65b7dd2292eca796bae776e51b0d299f21f27937f7c7d1e08d2b346089073e28a828b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c15f9c4aeaa5a23a7c43eea8d3df9749dbe7493559ecea621be878a5a01dbb375e1305a5d81a3d49000b8810534f0b91c90f48f24e562f697b1fe91e0f79ffdd", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3132aaf0c5c3a915fa62925412f733ff95bc2507b296833faf9df2bf4c9cb19c4fe2722eaf17c99e336b4b54f9c136bc1f84878259850833d6d8030e21779f15"} 13:10:57 INFO - Running post-run listener: copy_logs_to_upload_dir 13:10:57 INFO - Copying logs to upload dir... 13:10:57 INFO - mkdir: /builds/slave/test/build/upload/logs 13:10:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1227.484719 ========= master_lag: -0.13 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2017-10-12 13:10:57.520937) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-12 13:10:57.524257) ========= 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-1507836858.180558-968221669 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/1ffd41a8e16e956507063e1fdb635a2948bf6f0266aa72936de71026f587b18309a0c2ebe72e2b0510bb2888c3e6237e7a05e0ab3a12e524eef2e8ab24748270", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0104873d430c00e6c448312a79ca7e9c15ce3f7da03d395b497edd5016f65b7dd2292eca796bae776e51b0d299f21f27937f7c7d1e08d2b346089073e28a828b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c15f9c4aeaa5a23a7c43eea8d3df9749dbe7493559ecea621be878a5a01dbb375e1305a5d81a3d49000b8810534f0b91c90f48f24e562f697b1fe91e0f79ffdd", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3132aaf0c5c3a915fa62925412f733ff95bc2507b296833faf9df2bf4c9cb19c4fe2722eaf17c99e336b4b54f9c136bc1f84878259850833d6d8030e21779f15"} build_url:https://queue.taskcluster.net/v1/task/Kp4_jGBTQHegYf4_Zs6oIg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011299 build_url: 'https://queue.taskcluster.net/v1/task/Kp4_jGBTQHegYf4_Zs6oIg/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/1ffd41a8e16e956507063e1fdb635a2948bf6f0266aa72936de71026f587b18309a0c2ebe72e2b0510bb2888c3e6237e7a05e0ab3a12e524eef2e8ab24748270", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0104873d430c00e6c448312a79ca7e9c15ce3f7da03d395b497edd5016f65b7dd2292eca796bae776e51b0d299f21f27937f7c7d1e08d2b346089073e28a828b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c15f9c4aeaa5a23a7c43eea8d3df9749dbe7493559ecea621be878a5a01dbb375e1305a5d81a3d49000b8810534f0b91c90f48f24e562f697b1fe91e0f79ffdd", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3132aaf0c5c3a915fa62925412f733ff95bc2507b296833faf9df2bf4c9cb19c4fe2722eaf17c99e336b4b54f9c136bc1f84878259850833d6d8030e21779f15"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-12 13:10:57.553998) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-12 13:10:57.554537) ========= 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-1507836858.180558-968221669 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004521 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-12 13:10:57.639842) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-12 13:10:57.640202) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-12 13:10:57.640585) ========= ========= Total master_lag: 0.04 =========