builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-080 starttime: 1507131615.79 results: success (0) revision: 2fe5daa147a7d0ce90bf12be60533d6b6cc5e6cc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-04 08:40:15.789959) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-04 08:40:15.790500) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-04 08:40:15.790781) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-04 08:40:15.809559) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 08:40:15.809944) ========= 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=781b77c4c33858b1f599d705000001c1-1507131384.967951-1166287135 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-04 08:40:16-- 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% 32.3M=0s 2017-10-04 08:40:16 (32.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124868 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 08:40:15.960171) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 08:40:15.960500) ========= 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=781b77c4c33858b1f599d705000001c1-1507131384.967951-1166287135 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017135 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 08:40:16.018329) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 08:40:16.018672) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 2fe5daa147a7d0ce90bf12be60533d6b6cc5e6cc --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 2fe5daa147a7d0ce90bf12be60533d6b6cc5e6cc --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=781b77c4c33858b1f599d705000001c1-1507131384.967951-1166287135 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-04 08:40:16,368 truncating revision to first 12 chars 2017-10-04 08:40:16,368 Setting DEBUG logging. 2017-10-04 08:40:16,368 attempt 1/10 2017-10-04 08:40:16,368 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/2fe5daa147a7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-04 08:40:16,876 unpacking tar archive at: mozilla-beta-2fe5daa147a7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.788095 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 08:40:16.827575) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-04 08:40:16.827903) ========= script_repo_revision: 2fe5daa147a7d0ce90bf12be60533d6b6cc5e6cc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-04 08:40:16.831382) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-04 08:40:16.831651) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-04 08:40:16.851224) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-10-04 08:40:16.851617) ========= /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=781b77c4c33858b1f599d705000001c1-1507131384.967951-1166287135 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:40:17 INFO - MultiFileLogger online at 20171004 08:40:17 in /builds/slave/test 08:40:17 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 08:40:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:40:17 INFO - {'append_to_log': False, 08:40:17 INFO - 'base_work_dir': '/builds/slave/test', 08:40:17 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 08:40:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:40:17 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 08:40:17 INFO - 'buildbot_json_path': 'buildprops.json', 08:40:17 INFO - 'code_coverage': False, 08:40:17 INFO - 'config_files': ('talos/linux_config.py',), 08:40:17 INFO - 'default_actions': ('clobber', 08:40:17 INFO - 'read-buildbot-config', 08:40:17 INFO - 'download-and-extract', 08:40:17 INFO - 'populate-webroot', 08:40:17 INFO - 'create-virtualenv', 08:40:17 INFO - 'install', 08:40:17 INFO - 'setup-mitmproxy', 08:40:17 INFO - 'run-tests'), 08:40:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:40:17 INFO - 'disable_ccov_upload': False, 08:40:17 INFO - 'disable_stylo': False, 08:40:17 INFO - 'download_minidump_stackwalk': True, 08:40:17 INFO - 'download_symbols': 'ondemand', 08:40:17 INFO - 'enable_stylo': False, 08:40:17 INFO - 'enable_webrender': False, 08:40:17 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 08:40:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:40:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:40:17 INFO - 'gecko_profile': False, 08:40:17 INFO - 'gecko_profile_interval': 0, 08:40:17 INFO - 'installer_path': 'installer.exe', 08:40:17 INFO - 'log_level': 'info', 08:40:17 INFO - 'log_name': 'talos', 08:40:17 INFO - 'log_to_console': True, 08:40:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:40:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:40:17 INFO - 'opt_config_files': (), 08:40:17 INFO - 'pip_index': False, 08:40:17 INFO - 'suite': 'dromaeojs-e10s', 08:40:17 INFO - 'system_bits': '32', 08:40:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:40:17 INFO - 'title': 'talos-linux64-ix-080', 08:40:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:40:17 INFO - 'use_talos_json': True, 08:40:17 INFO - 'verify': 'False', 08:40:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:40:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:40:17 INFO - 'work_dir': 'build'} 08:40:17 INFO - [mozharness: 2017-10-04 15:40:17.343356Z] Running clobber step. 08:40:17 INFO - Running pre-action listener: _resource_record_pre_action 08:40:17 INFO - Running main action method: clobber 08:40:17 INFO - rmtree: /builds/slave/test/build 08:40:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:40:18 INFO - Running post-action listener: _resource_record_post_action 08:40:18 INFO - [mozharness: 2017-10-04 15:40:18.336591Z] Finished clobber step (success) 08:40:18 INFO - [mozharness: 2017-10-04 15:40:18.336689Z] Running read-buildbot-config step. 08:40:18 INFO - Running pre-action listener: _resource_record_pre_action 08:40:18 INFO - Running main action method: read_buildbot_config 08:40:18 INFO - Using buildbot properties: 08:40:18 INFO - { 08:40:18 INFO - "project": "", 08:40:18 INFO - "product": "firefox", 08:40:18 INFO - "who": "ffxbld@noreply.mozilla.org", 08:40:18 INFO - "installer_path": "public/build/target.tar.bz2", 08:40:18 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 08:40:18 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 08:40:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 08:40:18 INFO - "stage_platform": "linux64", 08:40:18 INFO - "basedir": "/builds/slave/test", 08:40:18 INFO - "buildnumber": 153, 08:40:18 INFO - "platform": "ubuntu64_hw", 08:40:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:40:18 INFO - "slavebuilddir": "test", 08:40:18 INFO - "taskId": "RrsPTncMRJGKhiHjXUyzOg", 08:40:18 INFO - "branch": "mozilla-beta", 08:40:18 INFO - "script_repo_revision": "production", 08:40:18 INFO - "revision": "2fe5daa147a7d0ce90bf12be60533d6b6cc5e6cc", 08:40:18 INFO - "slavename": "talos-linux64-ix-080", 08:40:18 INFO - "repo_path": "releases/mozilla-beta" 08:40:18 INFO - } 08:40:18 INFO - Finding installer, test and symbols from parent task. 08:40:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RrsPTncMRJGKhiHjXUyzOg'}, attempt #1 08:40:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RrsPTncMRJGKhiHjXUyzOg'}, attempt #1 08:40:19 INFO - Task dependencies: YSmRtkdFTqGjM3An2RSqaQ 08:40:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YSmRtkdFTqGjM3An2RSqaQ'}, attempt #1 08:40:19 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/YSmRtkdFTqGjM3An2RSqaQ/artifacts/public/build/target.tar.bz2 08:40:19 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/YSmRtkdFTqGjM3An2RSqaQ/artifacts/public/build/target.test_packages.json 08:40:19 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/YSmRtkdFTqGjM3An2RSqaQ/artifacts/public/build/target.crashreporter-symbols.zip 08:40:19 INFO - Running post-action listener: _resource_record_post_action 08:40:19 INFO - [mozharness: 2017-10-04 15:40:19.789222Z] Finished read-buildbot-config step (success) 08:40:19 INFO - [mozharness: 2017-10-04 15:40:19.789438Z] Running download-and-extract step. 08:40:19 INFO - Running pre-action listener: _resource_record_pre_action 08:40:19 INFO - Running main action method: download_and_extract 08:40:19 INFO - mkdir: /builds/slave/test/build/tests 08:40:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:19 INFO - trying https://queue.taskcluster.net/v1/task/YSmRtkdFTqGjM3An2RSqaQ/artifacts/public/build/target.test_packages.json 08:40:19 INFO - Downloading https://queue.taskcluster.net/v1/task/YSmRtkdFTqGjM3An2RSqaQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:40:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YSmRtkdFTqGjM3An2RSqaQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:40:20 INFO - Downloaded 989 bytes. 08:40:20 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:40:20 INFO - Using the following test package requirements: 08:40:20 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:40:20 INFO - u'common': [u'target.common.tests.zip'], 08:40:20 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:40:20 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:40:20 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:40:20 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:40:20 INFO - u'mozbase': [u'target.common.tests.zip'], 08:40:20 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:40:20 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:40:20 INFO - u'web-platform': [u'target.common.tests.zip', 08:40:20 INFO - u'target.web-platform.tests.tar.gz'], 08:40:20 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:40:20 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 08:40:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YSmRtkdFTqGjM3An2RSqaQ/artifacts/public/build/target.common.tests.zip 08:40:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YSmRtkdFTqGjM3An2RSqaQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:40:20 INFO - Fetch https://queue.taskcluster.net/v1/task/YSmRtkdFTqGjM3An2RSqaQ/artifacts/public/build/target.common.tests.zip into memory 08:40:23 INFO - Content-Length response header: 55177227 08:40:23 INFO - Bytes received: 55177227 08:40:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YSmRtkdFTqGjM3An2RSqaQ/artifacts/public/build/target.talos.tests.zip 08:40:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YSmRtkdFTqGjM3An2RSqaQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:40:34 INFO - Fetch https://queue.taskcluster.net/v1/task/YSmRtkdFTqGjM3An2RSqaQ/artifacts/public/build/target.talos.tests.zip into memory 08:40:35 INFO - Content-Length response header: 14509184 08:40:35 INFO - Bytes received: 14509184 08:40:35 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')]} 08:40:35 INFO - trying https://queue.taskcluster.net/v1/task/YSmRtkdFTqGjM3An2RSqaQ/artifacts/public/build/target.tar.bz2 08:40:35 INFO - Downloading https://queue.taskcluster.net/v1/task/YSmRtkdFTqGjM3An2RSqaQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:40:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YSmRtkdFTqGjM3An2RSqaQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:40:37 INFO - Downloaded 53545320 bytes. 08:40:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YSmRtkdFTqGjM3An2RSqaQ/artifacts/public/build/target.tar.bz2 08:40:37 INFO - mkdir: /builds/slave/test/properties 08:40:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:40:37 INFO - Writing to file /builds/slave/test/properties/build_url 08:40:37 INFO - Contents: 08:40:37 INFO - build_url:https://queue.taskcluster.net/v1/task/YSmRtkdFTqGjM3An2RSqaQ/artifacts/public/build/target.tar.bz2 08:40:37 INFO - Running post-action listener: _resource_record_post_action 08:40:37 INFO - Running post-action listener: find_tests_for_verification 08:40:37 INFO - Running post-action listener: set_extra_try_arguments 08:40:37 INFO - [mozharness: 2017-10-04 15:40:37.690675Z] Finished download-and-extract step (success) 08:40:37 INFO - [mozharness: 2017-10-04 15:40:37.690773Z] Running populate-webroot step. 08:40:37 INFO - Running pre-action listener: _resource_record_pre_action 08:40:37 INFO - Running main action method: populate_webroot 08:40:37 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:40:37 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:40:37 INFO - 'tests': ['tresize', 08:40:37 INFO - 'tcanvasmark']}, 08:40:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:40:37 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:40:37 INFO - 'tests': ['dromaeo_css', 08:40:37 INFO - 'kraken']}, 08:40:37 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:40:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:40:37 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:40:37 INFO - 'talos_options': ['--disable-stylo'], 08:40:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:40:37 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:40:37 INFO - 'tests': ['damp', 'tps']}, 08:40:37 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:40:37 INFO - 'talos_options': ['--disable-stylo'], 08:40:37 INFO - 'tests': ['damp', 'tps']}, 08:40:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:40:37 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:40:37 INFO - 'tests': ['dromaeo_dom']}, 08:40:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:40:37 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:40:37 INFO - 'tests': ['basic_compositor_video', 08:40:37 INFO - 'glvideo']}, 08:40:37 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:40:37 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:40:37 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:40:37 INFO - 'talos_options': ['--disable-stylo'], 08:40:37 INFO - 'tests': ['ts_paint_webext', 08:40:37 INFO - 'tp5o_webext']}, 08:40:37 INFO - 'other-e10s': {'tests': ['a11yr', 08:40:37 INFO - 'ts_paint', 08:40:37 INFO - 'tpaint', 08:40:37 INFO - 'sessionrestore', 08:40:37 INFO - 'sessionrestore_many_windows', 08:40:37 INFO - 'sessionrestore_no_auto_restore', 08:40:37 INFO - 'tabpaint']}, 08:40:37 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:40:37 INFO - 'tests': ['a11yr', 08:40:37 INFO - 'ts_paint', 08:40:37 INFO - 'tpaint', 08:40:37 INFO - 'sessionrestore', 08:40:37 INFO - 'sessionrestore_many_windows', 08:40:37 INFO - 'sessionrestore_no_auto_restore', 08:40:37 INFO - 'tabpaint']}, 08:40:37 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 08:40:37 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 08:40:37 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:40:37 INFO - 'tests': ['perf_reftest_singletons']}, 08:40:37 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:40:37 INFO - 'tests': ['bloom_basic']}, 08:40:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:40:37 INFO - 'tsvgr_opacity', 08:40:37 INFO - 'tart', 08:40:37 INFO - 'tscrollx', 08:40:37 INFO - 'tsvg_static']}, 08:40:37 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:40:37 INFO - 'tests': ['tsvgx', 08:40:37 INFO - 'tsvgr_opacity', 08:40:37 INFO - 'tart', 08:40:37 INFO - 'tscrollx', 08:40:37 INFO - 'tsvg_static']}, 08:40:37 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:40:37 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:40:37 INFO - 'talos_options': ['--disable-stylo'], 08:40:37 INFO - 'tests': ['tp5o']}, 08:40:37 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:40:37 INFO - 'talos_options': ['--mitmproxy', 08:40:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:40:37 INFO - '--firstNonBlankPaint'], 08:40:37 INFO - 'tests': ['tp6_google', 08:40:37 INFO - 'tp6_youtube', 08:40:37 INFO - 'tp6_amazon', 08:40:37 INFO - 'tp6_facebook']}, 08:40:37 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:40:37 INFO - 'talos_options': ['--disable-stylo', 08:40:37 INFO - '--mitmproxy', 08:40:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:40:37 INFO - '--firstNonBlankPaint'], 08:40:37 INFO - 'tests': ['tp6_google', 08:40:37 INFO - 'tp6_youtube', 08:40:37 INFO - 'tp6_amazon', 08:40:37 INFO - 'tp6_facebook']}, 08:40:37 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:40:37 INFO - 'talos_options': ['--stylo-threads=1', 08:40:37 INFO - '--mitmproxy', 08:40:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:40:37 INFO - '--firstNonBlankPaint'], 08:40:37 INFO - 'tests': ['tp6_google', 08:40:37 INFO - 'tp6_youtube', 08:40:37 INFO - 'tp6_amazon', 08:40:37 INFO - 'tp6_facebook']}, 08:40:37 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:40:37 INFO - 'talos_options': ['--xperf_path', 08:40:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:40:37 INFO - 'tests': ['tp5n']}, 08:40:37 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:40:37 INFO - 'talos_options': ['--disable-stylo', 08:40:37 INFO - '--xperf_path', 08:40:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:40:37 INFO - 'tests': ['tp5n']}}} 08:40:37 INFO - Running post-action listener: _resource_record_post_action 08:40:37 INFO - [mozharness: 2017-10-04 15:40:37.706083Z] Finished populate-webroot step (success) 08:40:37 INFO - [mozharness: 2017-10-04 15:40:37.706172Z] Running create-virtualenv step. 08:40:37 INFO - Running pre-action listener: _resource_record_pre_action 08:40:37 INFO - Running main action method: create_virtualenv 08:40:37 INFO - Creating virtualenv /builds/slave/test/build/venv 08:40:37 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:40:37 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 08:40:37 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 08:40:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:40:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:40:39 INFO - Installing distribute.............................................................................................................................................................................................done. 08:40:39 INFO - Installing pip...............done. 08:40:39 INFO - Return code: 0 08:40:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:40:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:40:40 INFO - Reading from file tmpfile_stdout 08:40:40 INFO - Output received: 08:40:40 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 08:40:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:40:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:40 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 0x18db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c46a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a090>, '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 0x1c4ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c44f90>, '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': '781b77c4c33858b1f599d705000001c1-1507131384.967951-1166287135', '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 08:40:40 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 08:40:40 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 08:40:40 INFO - Using env: {'DISPLAY': ':0', 08:40:40 INFO - 'HOME': '/home/cltbld', 08:40:40 INFO - 'LANG': 'en_US.UTF-8', 08:40:40 INFO - 'LANGUAGE': 'en_US:en', 08:40:40 INFO - 'LOGNAME': 'cltbld', 08:40:40 INFO - 'MAIL': '/var/mail/cltbld', 08:40:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:40 INFO - 'MOZ_NO_REMOTE': '1', 08:40:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:40 INFO - 'NO_EM_RESTART': '1', 08:40:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:40 INFO - 'PWD': '/builds/slave/test', 08:40:40 INFO - 'SHELL': '/bin/bash', 08:40:40 INFO - 'SHLVL': '1', 08:40:40 INFO - 'TERM': 'linux', 08:40:40 INFO - 'TMOUT': '86400', 08:40:40 INFO - 'USER': 'cltbld', 08:40:40 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1507131384.967951-1166287135', 08:40:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:40 INFO - '_': '/tools/buildbot/bin/python'} 08:40:41 INFO - Ignoring indexes: http://pypi.python.org/simple/ 08:40:41 INFO - Downloading/unpacking pip>=1.5 08:40:41 INFO - Running setup.py egg_info for package pip 08:40:41 INFO - warning: no files found matching 'pip/cacert.pem' 08:40:41 INFO - warning: no files found matching '*.html' under directory 'docs' 08:40:41 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 08:40:41 INFO - no previously-included directories found matching 'docs/_build/_sources' 08:40:41 INFO - Installing collected packages: pip 08:40:41 INFO - Found existing installation: pip 1.1 08:40:41 INFO - Uninstalling pip: 08:40:41 INFO - Successfully uninstalled pip 08:40:41 INFO - Running setup.py install for pip 08:40:41 INFO - warning: no files found matching 'pip/cacert.pem' 08:40:41 INFO - warning: no files found matching '*.html' under directory 'docs' 08:40:41 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 08:40:41 INFO - no previously-included directories found matching 'docs/_build/_sources' 08:40:41 INFO - Installing pip script to /builds/slave/test/build/venv/bin 08:40:41 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 08:40:41 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 08:40:41 INFO - Successfully installed pip 08:40:41 INFO - Cleaning up... 08:40:41 INFO - Return code: 0 08:40:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:40:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:41 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 0x18db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c46a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a090>, '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 0x1c4ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c44f90>, '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': '781b77c4c33858b1f599d705000001c1-1507131384.967951-1166287135', '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 08:40:41 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 08:40:41 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 08:40:41 INFO - Using env: {'DISPLAY': ':0', 08:40:41 INFO - 'HOME': '/home/cltbld', 08:40:41 INFO - 'LANG': 'en_US.UTF-8', 08:40:41 INFO - 'LANGUAGE': 'en_US:en', 08:40:41 INFO - 'LOGNAME': 'cltbld', 08:40:41 INFO - 'MAIL': '/var/mail/cltbld', 08:40:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:41 INFO - 'MOZ_NO_REMOTE': '1', 08:40:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:41 INFO - 'NO_EM_RESTART': '1', 08:40:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:41 INFO - 'PWD': '/builds/slave/test', 08:40:41 INFO - 'SHELL': '/bin/bash', 08:40:41 INFO - 'SHLVL': '1', 08:40:41 INFO - 'TERM': 'linux', 08:40:41 INFO - 'TMOUT': '86400', 08:40:41 INFO - 'USER': 'cltbld', 08:40:41 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1507131384.967951-1166287135', 08:40:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:41 INFO - '_': '/tools/buildbot/bin/python'} 08:40:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:41 INFO - Downloading/unpacking psutil>=3.1.1 08:40:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:40:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:40:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:40:42 INFO - Installing collected packages: psutil 08:40:42 INFO - Running setup.py install for psutil 08:40:43 INFO - building 'psutil._psutil_linux' extension 08:40:43 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 08:40:43 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 08:40:43 INFO - building 'psutil._psutil_posix' extension 08:40:43 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 08:40:43 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 08:40:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:40:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:40:43 INFO - Successfully installed psutil 08:40:43 INFO - Cleaning up... 08:40:43 INFO - Return code: 0 08:40:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:40:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c46a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a090>, '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 0x1c4ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c44f90>, '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': '781b77c4c33858b1f599d705000001c1-1507131384.967951-1166287135', '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 08:40:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:40:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:40:43 INFO - Using env: {'DISPLAY': ':0', 08:40:43 INFO - 'HOME': '/home/cltbld', 08:40:43 INFO - 'LANG': 'en_US.UTF-8', 08:40:43 INFO - 'LANGUAGE': 'en_US:en', 08:40:43 INFO - 'LOGNAME': 'cltbld', 08:40:43 INFO - 'MAIL': '/var/mail/cltbld', 08:40:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:43 INFO - 'MOZ_NO_REMOTE': '1', 08:40:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:43 INFO - 'NO_EM_RESTART': '1', 08:40:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:43 INFO - 'PWD': '/builds/slave/test', 08:40:43 INFO - 'SHELL': '/bin/bash', 08:40:43 INFO - 'SHLVL': '1', 08:40:43 INFO - 'TERM': 'linux', 08:40:43 INFO - 'TMOUT': '86400', 08:40:43 INFO - 'USER': 'cltbld', 08:40:43 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1507131384.967951-1166287135', 08:40:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:43 INFO - '_': '/tools/buildbot/bin/python'} 08:40:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:40:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:40:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:40:44 INFO - Installing collected packages: mozsystemmonitor 08:40:44 INFO - Running setup.py install for mozsystemmonitor 08:40:45 INFO - Successfully installed mozsystemmonitor 08:40:45 INFO - Cleaning up... 08:40:45 INFO - Return code: 0 08:40:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:40:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x18db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c46a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a090>, '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 0x1c4ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c44f90>, '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': '781b77c4c33858b1f599d705000001c1-1507131384.967951-1166287135', '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 08:40:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:40:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:40:45 INFO - Using env: {'DISPLAY': ':0', 08:40:45 INFO - 'HOME': '/home/cltbld', 08:40:45 INFO - 'LANG': 'en_US.UTF-8', 08:40:45 INFO - 'LANGUAGE': 'en_US:en', 08:40:45 INFO - 'LOGNAME': 'cltbld', 08:40:45 INFO - 'MAIL': '/var/mail/cltbld', 08:40:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:45 INFO - 'MOZ_NO_REMOTE': '1', 08:40:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:45 INFO - 'NO_EM_RESTART': '1', 08:40:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:45 INFO - 'PWD': '/builds/slave/test', 08:40:45 INFO - 'SHELL': '/bin/bash', 08:40:45 INFO - 'SHLVL': '1', 08:40:45 INFO - 'TERM': 'linux', 08:40:45 INFO - 'TMOUT': '86400', 08:40:45 INFO - 'USER': 'cltbld', 08:40:45 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1507131384.967951-1166287135', 08:40:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:45 INFO - '_': '/tools/buildbot/bin/python'} 08:40:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:45 INFO - Downloading/unpacking jsonschema==2.5.1 08:40:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:40:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:40:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:47 INFO - Downloading functools32-3.2.3-2.tar.gz 08:40:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:40:47 INFO - warning: no files found matching '*.txt' 08:40:47 INFO - no previously-included directories found matching 'build' 08:40:47 INFO - no previously-included directories found matching 'dist' 08:40:47 INFO - no previously-included directories found matching '.git*' 08:40:47 INFO - Installing collected packages: jsonschema, functools32 08:40:47 INFO - Running setup.py install for functools32 08:40:47 INFO - warning: no files found matching '*.txt' 08:40:47 INFO - no previously-included directories found matching 'build' 08:40:47 INFO - no previously-included directories found matching 'dist' 08:40:47 INFO - no previously-included directories found matching '.git*' 08:40:47 INFO - Successfully installed jsonschema functools32 08:40:47 INFO - Cleaning up... 08:40:47 INFO - Return code: 0 08:40:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:40:47 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')]} 08:40:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:47 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')]} 08:40:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:47 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 0x18db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c46a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a090>, '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 0x1c4ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c44f90>, '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': '781b77c4c33858b1f599d705000001c1-1507131384.967951-1166287135', '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 08:40:47 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 08:40:47 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 08:40:47 INFO - Using env: {'DISPLAY': ':0', 08:40:47 INFO - 'HOME': '/home/cltbld', 08:40:47 INFO - 'LANG': 'en_US.UTF-8', 08:40:47 INFO - 'LANGUAGE': 'en_US:en', 08:40:47 INFO - 'LOGNAME': 'cltbld', 08:40:47 INFO - 'MAIL': '/var/mail/cltbld', 08:40:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:47 INFO - 'MOZ_NO_REMOTE': '1', 08:40:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:47 INFO - 'NO_EM_RESTART': '1', 08:40:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:47 INFO - 'PWD': '/builds/slave/test', 08:40:47 INFO - 'SHELL': '/bin/bash', 08:40:47 INFO - 'SHLVL': '1', 08:40:47 INFO - 'TERM': 'linux', 08:40:47 INFO - 'TMOUT': '86400', 08:40:47 INFO - 'USER': 'cltbld', 08:40:47 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1507131384.967951-1166287135', 08:40:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:47 INFO - '_': '/tools/buildbot/bin/python'} 08:40:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:40:47 INFO - Cleaning up... 08:40:47 INFO - Return code: 0 08:40:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:40:47 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')]} 08:40:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:47 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')]} 08:40:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:47 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 0x18db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c46a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a090>, '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 0x1c4ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c44f90>, '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': '781b77c4c33858b1f599d705000001c1-1507131384.967951-1166287135', '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 08:40:47 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 08:40:47 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 08:40:47 INFO - Using env: {'DISPLAY': ':0', 08:40:47 INFO - 'HOME': '/home/cltbld', 08:40:47 INFO - 'LANG': 'en_US.UTF-8', 08:40:47 INFO - 'LANGUAGE': 'en_US:en', 08:40:47 INFO - 'LOGNAME': 'cltbld', 08:40:47 INFO - 'MAIL': '/var/mail/cltbld', 08:40:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:47 INFO - 'MOZ_NO_REMOTE': '1', 08:40:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:47 INFO - 'NO_EM_RESTART': '1', 08:40:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:47 INFO - 'PWD': '/builds/slave/test', 08:40:47 INFO - 'SHELL': '/bin/bash', 08:40:47 INFO - 'SHLVL': '1', 08:40:47 INFO - 'TERM': 'linux', 08:40:47 INFO - 'TMOUT': '86400', 08:40:47 INFO - 'USER': 'cltbld', 08:40:47 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1507131384.967951-1166287135', 08:40:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:47 INFO - '_': '/tools/buildbot/bin/python'} 08:40:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:47 INFO - Downloading/unpacking blobuploader==1.2.4 08:40:47 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 08:40:47 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 08:40:47 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 08:40:47 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 08:40:48 INFO - Downloading blobuploader-1.2.4.tar.gz 08:40:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:40:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:40:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:40:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:40: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 08:40: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 08:40: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 08:40: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 08:40:49 INFO - Downloading docopt-0.6.1.tar.gz 08:40:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:40:49 INFO - Installing collected packages: blobuploader, requests, docopt 08:40:49 INFO - Running setup.py install for blobuploader 08:40:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:40:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:40:49 INFO - Running setup.py install for requests 08:40:49 INFO - Running setup.py install for docopt 08:40:50 INFO - Successfully installed blobuploader requests docopt 08:40:50 INFO - Cleaning up... 08:40:50 INFO - Return code: 0 08:40:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:40:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:50 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 0x18db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c46a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a090>, '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 0x1c4ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c44f90>, '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': '781b77c4c33858b1f599d705000001c1-1507131384.967951-1166287135', '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 08:40:50 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 08:40:50 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 08:40:50 INFO - Using env: {'DISPLAY': ':0', 08:40:50 INFO - 'HOME': '/home/cltbld', 08:40:50 INFO - 'LANG': 'en_US.UTF-8', 08:40:50 INFO - 'LANGUAGE': 'en_US:en', 08:40:50 INFO - 'LOGNAME': 'cltbld', 08:40:50 INFO - 'MAIL': '/var/mail/cltbld', 08:40:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:50 INFO - 'MOZ_NO_REMOTE': '1', 08:40:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:50 INFO - 'NO_EM_RESTART': '1', 08:40:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:50 INFO - 'PWD': '/builds/slave/test', 08:40:50 INFO - 'SHELL': '/bin/bash', 08:40:50 INFO - 'SHLVL': '1', 08:40:50 INFO - 'TERM': 'linux', 08:40:50 INFO - 'TMOUT': '86400', 08:40:50 INFO - 'USER': 'cltbld', 08:40:50 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1507131384.967951-1166287135', 08:40:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:50 INFO - '_': '/tools/buildbot/bin/python'} 08:40:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:40:50 INFO - Running setup.py (path:/tmp/pip-OaXuUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:40:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:40:50 INFO - Running setup.py (path:/tmp/pip-XpR6YJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:40:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:40:50 INFO - Running setup.py (path:/tmp/pip-Nmflf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:40:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:40:50 INFO - Running setup.py (path:/tmp/pip-ES9uEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:40:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:40:50 INFO - Running setup.py (path:/tmp/pip-BnBh7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:40:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:40:50 INFO - Running setup.py (path:/tmp/pip-XCVMAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:40:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:40:50 INFO - Running setup.py (path:/tmp/pip-_NteTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:40:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:40:50 INFO - Running setup.py (path:/tmp/pip-mp8UqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:40:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:40:50 INFO - Running setup.py (path:/tmp/pip-KKC4r0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:40:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:40:50 INFO - Running setup.py (path:/tmp/pip-LJ21Fx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:40:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:40:50 INFO - Running setup.py (path:/tmp/pip-Bw8Qzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:40:51 INFO - Running setup.py (path:/tmp/pip-GwcTGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:40:51 INFO - Running setup.py (path:/tmp/pip-MZbCxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:40:51 INFO - Running setup.py (path:/tmp/pip-GVhcRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:51 INFO - Running setup.py (path:/tmp/pip-ecJMut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:40:51 INFO - Running setup.py (path:/tmp/pip-D6w05T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:40:51 INFO - Running setup.py (path:/tmp/pip-uc1NgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:40:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:40:51 INFO - Running setup.py install for manifestparser 08:40:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:40:51 INFO - Running setup.py install for mozcrash 08:40:51 INFO - Running setup.py install for mozdebug 08:40:51 INFO - Running setup.py install for mozdevice 08:40:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:40:51 INFO - Running setup.py install for mozfile 08:40:51 INFO - Running setup.py install for mozhttpd 08:40:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:40:52 INFO - Running setup.py install for mozinfo 08:40:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:40:52 INFO - Running setup.py install for mozInstall 08:40:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:40:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:40:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:40:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:40:52 INFO - Running setup.py install for mozleak 08:40:52 INFO - Running setup.py install for mozlog 08:40:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:40:52 INFO - Running setup.py install for moznetwork 08:40:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:40:52 INFO - Running setup.py install for mozprocess 08:40:52 INFO - Running setup.py install for mozprofile 08:40:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:40:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:40:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:40:52 INFO - Running setup.py install for mozrunner 08:40:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:40:52 INFO - Running setup.py install for mozscreenshot 08:40:52 INFO - Running setup.py install for moztest 08:40:53 INFO - Running setup.py install for mozversion 08:40:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:40:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:40:53 INFO - Cleaning up... 08:40:53 INFO - Return code: 0 08:40:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:40: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')]} 08:40:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40: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')]} 08:40:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:53 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 0x18db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c46a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a090>, '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 0x1c4ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c44f90>, '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': '781b77c4c33858b1f599d705000001c1-1507131384.967951-1166287135', '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 08:40:53 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 08:40:53 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 08:40:53 INFO - Using env: {'DISPLAY': ':0', 08:40:53 INFO - 'HOME': '/home/cltbld', 08:40:53 INFO - 'LANG': 'en_US.UTF-8', 08:40:53 INFO - 'LANGUAGE': 'en_US:en', 08:40:53 INFO - 'LOGNAME': 'cltbld', 08:40:53 INFO - 'MAIL': '/var/mail/cltbld', 08:40:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:53 INFO - 'MOZ_NO_REMOTE': '1', 08:40:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:53 INFO - 'NO_EM_RESTART': '1', 08:40:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:53 INFO - 'PWD': '/builds/slave/test', 08:40:53 INFO - 'SHELL': '/bin/bash', 08:40:53 INFO - 'SHLVL': '1', 08:40:53 INFO - 'TERM': 'linux', 08:40:53 INFO - 'TMOUT': '86400', 08:40:53 INFO - 'USER': 'cltbld', 08:40:53 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1507131384.967951-1166287135', 08:40:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:53 INFO - '_': '/tools/buildbot/bin/python'} 08:40:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:40:53 INFO - Running setup.py (path:/tmp/pip-H6T3Xb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:40:53 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)) 08:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:40:53 INFO - Running setup.py (path:/tmp/pip-PO3fhP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:40:53 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)) 08:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:40:53 INFO - Running setup.py (path:/tmp/pip-WTvjaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:40:53 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)) 08:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:40:53 INFO - Running setup.py (path:/tmp/pip-SKknOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:40:53 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)) 08:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:40:53 INFO - Running setup.py (path:/tmp/pip-_Tmn6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:40:53 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)) 08:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:40:53 INFO - Running setup.py (path:/tmp/pip-sK341z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:40:53 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)) 08:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:40:53 INFO - Running setup.py (path:/tmp/pip-LBwfh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:40:53 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)) 08:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:40:53 INFO - Running setup.py (path:/tmp/pip-8p_kms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:40:54 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)) 08:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:40:54 INFO - Running setup.py (path:/tmp/pip-KToQ1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:40:54 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)) 08:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:40:54 INFO - Running setup.py (path:/tmp/pip-N9fipg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:40:54 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)) 08:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:40:54 INFO - Running setup.py (path:/tmp/pip-2MwC4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:40:54 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)) 08:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:40:54 INFO - Running setup.py (path:/tmp/pip-oWTiLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:40:54 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)) 08:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:40:54 INFO - Running setup.py (path:/tmp/pip-673f5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:40:54 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)) 08:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:40:54 INFO - Running setup.py (path:/tmp/pip-zB3Bvu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:40:54 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)) 08:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:54 INFO - Running setup.py (path:/tmp/pip-reFyng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:54 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)) 08:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:40:54 INFO - Running setup.py (path:/tmp/pip-c2PB12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:40:54 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)) 08:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:40:54 INFO - Running setup.py (path:/tmp/pip-rgPjZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:40:54 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)) 08:40:54 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)) 08:40:54 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)) 08:40:54 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)) 08:40:54 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)) 08:40:54 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)) 08:40:54 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)) 08:40:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:40:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:55 INFO - Downloading blessings-1.6.tar.gz 08:40:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:40:55 INFO - Installing collected packages: blessings 08:40:55 INFO - Running setup.py install for blessings 08:40:55 INFO - Successfully installed blessings 08:40:55 INFO - Cleaning up... 08:40:56 INFO - Return code: 0 08:40:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:40:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:40:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:40:56 INFO - Reading from file tmpfile_stdout 08:40:56 INFO - Current package versions: 08:40:56 INFO - argparse == 1.2.1 08:40:56 INFO - blessings == 1.6 08:40:56 INFO - blobuploader == 1.2.4 08:40:56 INFO - docopt == 0.6.1 08:40:56 INFO - functools32 == 3.2.3-2 08:40:56 INFO - jsonschema == 2.5.1 08:40:56 INFO - manifestparser == 1.1 08:40:56 INFO - mozInstall == 1.13 08:40:56 INFO - mozcrash == 1.0 08:40:56 INFO - mozdebug == 0.1 08:40:56 INFO - mozdevice == 0.51 08:40:56 INFO - mozfile == 1.2 08:40:56 INFO - mozhttpd == 0.7 08:40:56 INFO - mozinfo == 0.10 08:40:56 INFO - mozleak == 0.1 08:40:56 INFO - mozlog == 3.5 08:40:56 INFO - moznetwork == 0.27 08:40:56 INFO - mozprocess == 0.25 08:40:56 INFO - mozprofile == 0.28 08:40:56 INFO - mozrunner == 6.13 08:40:56 INFO - mozscreenshot == 0.1 08:40:56 INFO - mozsystemmonitor == 0.3 08:40:56 INFO - moztest == 0.8 08:40:56 INFO - mozversion == 1.4 08:40:56 INFO - psutil == 3.1.1 08:40:56 INFO - requests == 1.2.3 08:40:56 INFO - wsgiref == 0.1.2 08:40:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:40: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')]} 08:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40: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')]} 08:40:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:56 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 0x18db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c46a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a090>, '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 0x1c4ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c44f90>, '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': '781b77c4c33858b1f599d705000001c1-1507131384.967951-1166287135', '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 08:40:56 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 08:40:56 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 08:40:56 INFO - Using env: {'DISPLAY': ':0', 08:40:56 INFO - 'HOME': '/home/cltbld', 08:40:56 INFO - 'LANG': 'en_US.UTF-8', 08:40:56 INFO - 'LANGUAGE': 'en_US:en', 08:40:56 INFO - 'LOGNAME': 'cltbld', 08:40:56 INFO - 'MAIL': '/var/mail/cltbld', 08:40:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:56 INFO - 'MOZ_NO_REMOTE': '1', 08:40:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:56 INFO - 'NO_EM_RESTART': '1', 08:40:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:56 INFO - 'PWD': '/builds/slave/test', 08:40:56 INFO - 'SHELL': '/bin/bash', 08:40:56 INFO - 'SHLVL': '1', 08:40:56 INFO - 'TERM': 'linux', 08:40:56 INFO - 'TMOUT': '86400', 08:40:56 INFO - 'USER': 'cltbld', 08:40:56 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1507131384.967951-1166287135', 08:40:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:56 INFO - '_': '/tools/buildbot/bin/python'} 08:40:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:56 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)) 08:40:56 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)) 08:40:56 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)) 08:40:56 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)) 08:40:56 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)) 08:40:56 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)) 08:40:56 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)) 08:40:56 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)) 08:40:56 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)) 08:40:56 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:40: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 08:40: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 08:40: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 08:40: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 08:40:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 08:40:57 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)) 08:40:57 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)) 08:40:57 INFO - Installing collected packages: simplejson 08:40:57 INFO - Running setup.py install for simplejson 08:40:57 INFO - building 'simplejson._speedups' extension 08:40:57 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 08:40:58 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 08:40:58 INFO - Successfully installed simplejson 08:40:58 INFO - Cleaning up... 08:40:58 INFO - Return code: 0 08:40:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:40: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')]} 08:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40: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')]} 08:40:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:58 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 0x18db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c46a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a090>, '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 0x1c4ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c44f90>, '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': '781b77c4c33858b1f599d705000001c1-1507131384.967951-1166287135', '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 08:40:58 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 08:40:58 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 08:40:58 INFO - Using env: {'DISPLAY': ':0', 08:40:58 INFO - 'HOME': '/home/cltbld', 08:40:58 INFO - 'LANG': 'en_US.UTF-8', 08:40:58 INFO - 'LANGUAGE': 'en_US:en', 08:40:58 INFO - 'LOGNAME': 'cltbld', 08:40:58 INFO - 'MAIL': '/var/mail/cltbld', 08:40:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:58 INFO - 'MOZ_NO_REMOTE': '1', 08:40:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:58 INFO - 'NO_EM_RESTART': '1', 08:40:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:58 INFO - 'PWD': '/builds/slave/test', 08:40:58 INFO - 'SHELL': '/bin/bash', 08:40:58 INFO - 'SHLVL': '1', 08:40:58 INFO - 'TERM': 'linux', 08:40:58 INFO - 'TMOUT': '86400', 08:40:58 INFO - 'USER': 'cltbld', 08:40:58 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1507131384.967951-1166287135', 08:40:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:58 INFO - '_': '/tools/buildbot/bin/python'} 08:40:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:40:58 INFO - Cleaning up... 08:40:58 INFO - Return code: 0 08:40:58 INFO - Running post-action listener: _resource_record_post_action 08:40:58 INFO - Running post-action listener: _start_resource_monitoring 08:40:58 INFO - Starting resource monitoring. 08:40:58 INFO - [mozharness: 2017-10-04 15:40:58.983128Z] Finished create-virtualenv step (success) 08:40:58 INFO - [mozharness: 2017-10-04 15:40:58.983639Z] Running install step. 08:40:58 INFO - Running pre-action listener: _resource_record_pre_action 08:40:58 INFO - Running main action method: install 08:40:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:40:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:40:59 INFO - Reading from file tmpfile_stdout 08:40:59 INFO - Detecting whether we're running mozinstall >=1.0... 08:40:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:40:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:40:59 INFO - Reading from file tmpfile_stdout 08:40:59 INFO - Output received: 08:40:59 INFO - Usage: mozinstall [options] installer 08:40:59 INFO - Options: 08:40:59 INFO - -h, --help show this help message and exit 08:40:59 INFO - -d DEST, --destination=DEST 08:40:59 INFO - Directory to install application into. [default: 08:40:59 INFO - "/builds/slave/test"] 08:40:59 INFO - --app=APP Application being installed. [default: firefox] 08:40:59 INFO - mkdir: /builds/slave/test/build/application 08:40:59 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'] 08:40:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:41:13 INFO - Reading from file tmpfile_stdout 08:41:13 INFO - Output received: 08:41:13 INFO - /builds/slave/test/build/application/firefox/firefox 08:41:13 INFO - Running post-action listener: _resource_record_post_action 08:41:13 INFO - [mozharness: 2017-10-04 15:41:13.889998Z] Finished install step (success) 08:41:13 INFO - [mozharness: 2017-10-04 15:41:13.890247Z] Running setup-mitmproxy step. 08:41:13 INFO - Running pre-action listener: _resource_record_pre_action 08:41:13 INFO - Running main action method: setup_mitmproxy 08:41:13 INFO - Skipping: mitmproxy is not required 08:41:13 INFO - Running post-action listener: _resource_record_post_action 08:41:13 INFO - [mozharness: 2017-10-04 15:41:13.891368Z] Finished setup-mitmproxy step (success) 08:41:13 INFO - [mozharness: 2017-10-04 15:41:13.891588Z] Running run-tests step. 08:41:13 INFO - Running pre-action listener: _resource_record_pre_action 08:41:13 INFO - Running pre-action listener: _set_gcov_prefix 08:41:13 INFO - Running main action method: run_tests 08:41:13 WARNING - Try message not found. 08:41:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:41:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:41:13 INFO - Python 2.7.3 08:41:13 INFO - Return code: 0 08:41:13 INFO - grabbing minidump binary from tooltool 08:41:13 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')]} 08:41:13 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 0x1c4a090>, '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 0x1c4ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c44f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:41:13 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 08:41:13 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 08:41:13 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 08:41:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:41:14 INFO - Return code: 0 08:41:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:41:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:41:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:41:14 INFO - ENV: RUST_BACKTRACE is now full 08:41:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:41:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:41:14 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/YSmRtkdFTqGjM3An2RSqaQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-080', '--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 08:41:14 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/YSmRtkdFTqGjM3An2RSqaQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-080 --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 08:41:14 INFO - Using env: {'DISPLAY': ':0', 08:41:14 INFO - 'HOME': '/home/cltbld', 08:41:14 INFO - 'LANG': 'en_US.UTF-8', 08:41:14 INFO - 'LANGUAGE': 'en_US:en', 08:41:14 INFO - 'LOGNAME': 'cltbld', 08:41:14 INFO - 'MAIL': '/var/mail/cltbld', 08:41:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:41:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:41:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:14 INFO - 'MOZ_NO_REMOTE': '1', 08:41:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:41:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:14 INFO - 'NO_EM_RESTART': '1', 08:41:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:14 INFO - 'PWD': '/builds/slave/test', 08:41:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:41:14 INFO - 'RUST_BACKTRACE': 'full', 08:41:14 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:41:14 INFO - 'SHELL': '/bin/bash', 08:41:14 INFO - 'SHLVL': '1', 08:41:14 INFO - 'TERM': 'linux', 08:41:14 INFO - 'TMOUT': '86400', 08:41:14 INFO - 'USER': 'cltbld', 08:41:14 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1507131384.967951-1166287135', 08:41:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:14 INFO - '_': '/tools/buildbot/bin/python'} 08:41:14 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/YSmRtkdFTqGjM3An2RSqaQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-080', '--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 08:41:14 INFO - mozversion application_buildid: 20171004142035 08:41:14 INFO - mozversion application_changeset: 2fe5daa147a7d0ce90bf12be60533d6b6cc5e6cc 08:41:14 INFO - mozversion application_display_name: Firefox 08:41:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:41:14 INFO - mozversion application_name: Firefox 08:41:14 INFO - mozversion application_remotingname: firefox 08:41:14 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:41:14 INFO - mozversion application_vendor: Mozilla 08:41:14 INFO - mozversion application_version: 57.0 08:41:14 INFO - mozversion platform_buildid: 20171004142035 08:41:14 INFO - mozversion platform_changeset: 2fe5daa147a7d0ce90bf12be60533d6b6cc5e6cc 08:41:14 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:41:14 INFO - mozversion platform_version: 57.0 08:41:14 INFO - using testdate: 1507131674 08:41:14 INFO - actual date: 1507131674 08:41:14 INFO - starting webserver on 'localhost:33302' 08:41:14 INFO - SUITE-START | Running 2 tests 08:41:14 INFO - TEST-START | dromaeo_css 08:41:14 INFO - Initialising browser for dromaeo_css test... 08:41:14 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33302/getInfo.html -profile /tmp/tmpDxqBww/profile 08:41:14 INFO - TEST-INFO | started process 5271 (/builds/slave/test/build/application/firefox/firefox http://localhost:33302/getInfo.html) 08:41:19 INFO - TEST-INFO | 5271: exit 0 08:41:19 INFO - Browser initialized. 08:41:19 INFO - Running cycle 1/1 for dromaeo_css test... 08:41:19 INFO - Using env: {'DISPLAY': ':0', 08:41:19 INFO - 'HOME': '/home/cltbld', 08:41:19 INFO - 'JSGC_DISABLE_POISONING': '1', 08:41:19 INFO - 'LANG': 'en_US.UTF-8', 08:41:19 INFO - 'LANGUAGE': 'en_US:en', 08:41:19 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 08:41:19 INFO - 'LOGNAME': 'cltbld', 08:41:19 INFO - 'MAIL': '/var/mail/cltbld', 08:41:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:41:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:41:19 INFO - 'MOZ_CRASHREPORTER': '1', 08:41:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:19 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 08:41:19 INFO - 'MOZ_NO_REMOTE': '1', 08:41:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:41:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:19 INFO - 'NO_EM_RESTART': '1', 08:41:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:19 INFO - 'PWD': '/builds/slave/test', 08:41:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:41:19 INFO - 'RUST_BACKTRACE': 'full', 08:41:19 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:41:19 INFO - 'SHELL': '/bin/bash', 08:41:19 INFO - 'SHLVL': '1', 08:41:19 INFO - 'TERM': 'linux', 08:41:19 INFO - 'TMOUT': '86400', 08:41:19 INFO - 'USER': 'cltbld', 08:41:19 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1507131384.967951-1166287135', 08:41:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:19 INFO - '_': '/tools/buildbot/bin/python'} 08:41:19 INFO - TEST-INFO | started process 5508 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDxqBww/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:41:20 INFO - PID 5508 | 08:41:20 INFO - PID 5508 | (/builds/slave/test/build/application/firefox/firefox:5557): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:41:20 INFO - PID 5508 | 08:41:31 INFO - PID 5508 | RSS: Main: 141361152 08:41:31 INFO - PID 5508 | 08:44:28 INFO - PID 5508 | Cycle 1(1): loaded http://localhost:33302/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33302/tests/dromaeo/cssquery-ext.html) 08:44:29 INFO - PID 5508 | RSS: Main: 145453056 08:44:29 INFO - PID 5508 | 08:47:31 INFO - PID 5508 | Cycle 1(1): loaded http://localhost:33302/tests/dromaeo/cssquery-ext.html (next: http://localhost:33302/tests/dromaeo/cssquery-jquery.html) 08:47:31 INFO - PID 5508 | RSS: Main: 143962112 08:47:31 INFO - PID 5508 | 08:50:33 INFO - PID 5508 | Cycle 1(1): loaded http://localhost:33302/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33302/tests/dromaeo/cssquery-mootools.html) 08:50:33 INFO - PID 5508 | RSS: Main: 144736256 08:50:33 INFO - PID 5508 | 08:53:35 INFO - PID 5508 | Cycle 1(1): loaded http://localhost:33302/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33302/tests/dromaeo/cssquery-prototype.html) 08:53:35 INFO - PID 5508 | RSS: Main: 144396288 08:53:35 INFO - PID 5508 | 08:56:38 INFO - PID 5508 | Cycle 1(1): loaded http://localhost:33302/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33302/tests/dromaeo/cssquery-yui.html) 08:56:39 INFO - PID 5508 | RSS: Main: 145977344 08:56:39 INFO - PID 5508 | 08:59:40 INFO - PID 5508 | Cycle 1(1): loaded http://localhost:33302/tests/dromaeo/cssquery-yui.html (next: http://localhost:33302/tests/dromaeo/cssquery-dojo.html) 08:59:40 INFO - PID 5508 | RSS: Main: 148221952 08:59:40 INFO - PID 5508 | 08:59:40 INFO - PID 5508 | __start_tp_report 08:59:40 INFO - PID 5508 | _x_x_mozilla_page_load 08:59:40 INFO - PID 5508 | _x_x_mozilla_page_load_details 08:59:40 INFO - PID 5508 | |i|pagename|runs| 08:59:40 INFO - PID 5508 | |0;dojo.html;4008.859689910853;4021.7586944783316;4033.677305815533;4034.657054150398;4036.838526458942;6444.355564443554;6454.064160696702;6525.3800888915475;6543.280239173687;6562.835929101775;6487.156669632953;6513.869722605545;6560.475161987041;6562.770303039395;6588.769393071243;5848.356680765112;5851.297844258695;5889.823305300848;5922.88154236915;5938.079597662369;5881.059030555112;5895.675737834417;5915.260592425947;5922.2005029321135;5981.9401805981815;5871.559633027518;5908.02517584598;5913.379095194986;5936.732847021873;5984.072468767348;5936.436038576328;5940.49505792006;5985.491233245201;5990.490808281302;5992.880142397127;5879.559033072536;5884.764609415618;5980.13288073227;5987.341392446828;5990.670513121777;6425.646589437579;6426.518011149183;6433.7426502939825;6517.283098859121;6529.967350163219;7097.716091356339;7114.608696521689;7123.145222573325;7126.2161162272105;7137.536060156073;7117.608531530764;7120.572765634079;7210.026646402721;7211.855762884713;7232.457565682595;6471.838204044937;6559.344065593403;6590.736370545173;6663.533552651316;6675.699593518303;7302.598357090411;7305.232950540117;7309.671064802096;7317.158526769384;7380.852382952311;7009.684564194624;7035.788926332219;7047.859042819115;7084.43324534036;7089.397401220851;7087.007818905357;7096.645167741593;7122.394596459359;7210.819729506699;7226.963865180641;6920.065791118235;7038.824029399306;7052.33002864727;7131.928680713127;7161.9641901790155;7040.612766297801;7051.682674279669;7056.54132481387;7075.327843854929;7108.822279442952;5241.266222728821;5273.2617433559335;5286.9471305287225;5295;5306.8142615009065;4744.1934871072;4762.357081793983;4788.880277993078;4807.086653535817;4830.661853670209;6520.706568204442;6596.472282217411;6607.702653380609;6652.634105124168;6660.600363978177;7052.576845389293;7122.358987691133;7128.322809333105;7128.786136415916;7131.857362852714;6527.967360163264;6571;6645.66771661415;6675.065490831287;6685.6322902240845;5852.414758524199;5921.911171332434;5941.58408911372;6006.759729610767;6020.247469066367;7238.710451581877;7250.492465527468;7338.596377199306;7355.632218389166;7357.0803649543805;7061.858762824612;7090.397316228075;7148.821279467847;7150.320719531636;7161.069061022034;7275.490715649854;7383.2985866342615;7460.888086678596;7471.551706897603;7489.213632568501;6889.862202756017;6914.308569143045;6922.58464492132;7000.789976300719;7103.786886393416;7084.645767711697;7091.397231235403;7101.360877521048;7121.786346409616;7123.679434425567;6783.491238157059;6874.828129296808;6930;6973.930260697328;6988.266232045562;6707.195136583641;6808.080909077409;6820.35206655367;6821.317868213139;6840.794776156723;6789.388954994074;6805.591664500146;6806.625635589892;6811;6811.489138314547;6834.521583489108;6891.241963383924;6928.515003949675;6932.792016239521;6991.196012458632;6647.833804154935;6698.531102822755;6714.83212919681;6790.354916282945;6801.965990170018 08:59:40 INFO - PID 5508 | |1;ext.html;941.618644448998;953.1850268020846;976.501983988166;1007.9798404031915;1023.488255872064;45187.77406112969;45348;45975.31037034447;46009.53990460094;46114;42292.57707422925;42579.36130958038;42645.573544264626;42761.35857962133;42815.785921070354;8130.105688374274;8262.83474330513;8276.83446331073;8288;8290.129536398681;7861.528308301492;7901.960490197541;7948.642311095986;7956.880646790303;7982.521048737065;8709.782255443633;8920.50937198457;9000.414973026733;9000.594973226187;9003.459792412443;8872.37893347466;8901.020887702347;8929.687460938836;8949.105089491064;8957.507337096456;8780.692675756318;8860.158284962918;8866.778330541723;8868.911310886873;8886.111388861127;42351;42765.358519622234;42772.93067673333;42784.144317113794;42815;3895.02624343914;3934;3939.428782826474;3943.2310699413624;3944.467496887941;34525.30949381024;34615.480767788504;34793.30413391743;34810;34813.47779783305;5611.803586874481;5658.405867383906;5668.178114173463;5674.375818659944;5788.131780232957;232805;233098.9999999983;234040;235514;236666;52799;52817.2077418839;52966.735166323924;52972.735136324074;53114;56275.15587266194;56802.14796778052;56830.147547786815;56919.71540142356;56988.71505642445;17122.315107395814;17194.484165475056;17221.138943052796;17272.309107635807;17312.394066207624;13633.931830340785;13691.178529288274;13744.518941836988;13749.862501375059;13753.862461375258;15430.691386172213;15675.843241567438;15703.842961570466;15731.921340393224;15747;6064.784974442809;6210.130581718473;6272.843178920563;6390.8721825563225;6402.199725034371;1108.578740078781;1121.657894342217;1124.3422597780227;1124.5501799280353;1128.7403897103547;26025.869870650906;26190.86904565465;26219.868900655376;26370.472590548467;26456.603150952753;1199.5381778015526;1211.4064108586906;1247.8003519436847;1250.2560976219136;1252.2799390350585;13739.793903091462;13813.378397972116;13820.170789752647;13910.165390076629;13958.441662333596;289454;290401;293668;294499;294502;58889.41110588925;58963;63239.36760632427;63575.68212159002;63914;1525.519461369665;1567.3338830996781;1573.1033311012613;1584.9920750396404;1590.6103004763675;30790.53814192744;30816;31183.688163118077;31294.217644559067;31383.84308078445;42140;42158;42177;42236;42275;249693;249822;250143;250181;250940;34739.4789078159;35618.82190589134;35664.82167589146;35710.8214458926;35987.820060899525;46655.53344466512;46776.532234678576;47308.29037564508;47325.763371182926;47387.76306118447;35020.12449688778;35135.29729405347;35238;35768;35856;34921.30157396787;34951.475727863595;34955.47566786551;35067.47398789071;35158.64841351554;39907.40138897977;40011.399829003174;40101;40133.598664012985;40497.79751101226;33270.66729332772;33818.830905845316;34162.82918585391;34277.48583771195;34308.48537271893;24885.875570622033;25623.871880640476;25862.353441164123;25966.78179246416;26091.478170436105 08:59:40 INFO - PID 5508 | |2;jquery.html;649.6460071985128;651.3263055158574;655.7901471529111;656.8128083496199;660.0824853453697;24445.511089778192;25155;25220;25228.117015904423;25945.351366215855;27446.17661470159;28306.292342691442;28318.43363132736;28322.575161372595;28383;6923.273056329076;7075.610841403721;7080;7080.716771329141;7087.078679771623;6847.589144651312;7102.538335008208;7127.4654400920135;7134.571925684476;7135.53619014765;7045.4715896307725;7051.330123638246;7088.4683648726295;7095.503314767969;7097;7006;7027.824304392406;7049.7885063448175;7074;7083.397911177531;6585.637789921552;6586.506012049115;6599.934000660028;6627.2378676452345;6639.203295604559;31084;32319.676803232138;32420.837895810604;32623.6737632623;32668.509972350435;2325.5813953488364;2328.5342931413616;2345.5308938212424;2348.0842471436154;2355.1756885090253;20968.266110686207;21277.787222127736;21951.560968780534;21967.560648787094;22013.22953696629;2676.130257666266;2686.3821321096257;2726.82275652082;2732.0574401831336;2734.9726502735116;159452;164791;165396;165811.9999999988;166167;17166.39917602878;17225.22486488111;17256.482305530855;17672.469825905242;18034.458966231035;28182.15453536397;28187.71812281851;28204.717952820618;28222.576661350096;28249.858750706117;11115.722106947229;11413.714657133638;11446.677295057672;11466.48400821965;11483.540658373571;9697.757556061155;9731.491618798957;10055.899441005497;10275.486225688686;10368.170546356274;10190.592376304865;10248.333858299187;10352.70591176103;10489.685309440729;10708.78582428347;2949.9410011799646;2951.778616603763;3056.7161792047395;3131.890383836555;3170.556122142902;1062.4793851012948;1068.6526878764432;1077.6605369308643;1091.4051841746268;1099.164634877483;22466.438339041655;22693.773062269494;22719.88640056789;22760.886195568917;22807.175425966216;1166.6091859227083;1171.7305019845483;1175.5297880847559;1176.8411264479187;1177.4289469607234;12035.578754743718;12450.75098498025;12502.624921252376;12515.374231288399;12630;689000;696880;698030;714442;720156;137486;142679;143293;143856.28071859575;144212;1266.7403182347596;1307.6534718299658;1324.311358093805;1327.7809161488246;1339.0292038272175;19082;19244.326448574233;19271.421857344303;19639.0180490972;19871.105800239315;65352.34647653463;66494;66887.66556167188;67495.66252168707;67599.32400676126;84703;85219.5739021301;85701;85781;85831.14168858482;15737.606559835638;15977.760333594773;15997.280122394288;16017.439389621308;16041.27814248385;24486.63270050915;24631;24821.50356992814;24946.750532494443;25040.123595674064;18675.906620466812;18856.811431885504;18895.527611809815;19452.513687157934;19561.510962226057;17524.422801947887;17760.555986099935;18324;18493.630127397646;18579.34972276018;20348.186072557524;20511.38465846027;20531.38405847827;20576;20582.794172058686;15798.842011579736;15957.68084638324;15996;16006;16026.278817453009;19998.50003749918;20010.59978800445;20097.899510502353;20219.797802021792;20273.695894561297 08:59:40 INFO - PID 5508 | |3;mootools.html;1432.1693417817664;1485.3093311610098;1489.90315629484;1498.8276348219954;1513.1526345246664;17735.55661108473;18476;18486.075696215168;18496.815031849677;18497.907510462446;17968.37110701126;18081.54796130094;18096.909515452437;18157.54606134844;18209.90895045523;3155.0692545699017;3155.558221848943;3205.134613654312;3215.437298472758;3240.821754803485;3203.887863924763;3218.5654936583614;3234.2561210921504;3235.6440791512914;3236.045366616842;3188.1551388881967;3206.7594930380315;3210.855511501988;3287.5068739689;3291.226561757985;3230.4669729494603;3289.2434740009694;3289.8190599517015;3289.9506507402407;3291.2594666200152;3151.11768704763;3170.4927211646027;3179.8887038953526;3181.109289398972;3186.952195717066;17248.91375543127;17601.471955841345;17604.823951760445;17610.295588176457;17734.91132544342;9018.053104424072;9265.490398028105;9589.232861371074;9594;9602.90397096034;6044.576879618428;6222.751089956397;6276.089966954812;6296.496280297565;6385;2124.1609564222044;2131.6695912133646;2145.6566949288194;2148.237375731624;2181.1057466438842;32752;32806.6719332806;32822;32946.67053329484;33027.174320641934;8072.798180045545;8143.959280203561;8172.591370431454;8307.252347288773;8352.33181345503;20968.68546971766;21038.579228415347;21109.68335474969;21111.944402779798;21159.78840211609;8793.736187914374;9099.363044586815;9119.772005699779;9123.726288211365;9130.543472826332;7711;8242.052164001216;8382.706605268786;8384.161583841567;8401.20188582096;6270.529710271748;6276.968615156895;6395.936040639534;6472.741090356427;6566.8358291043105;1868.1219826681709;1872.1481725814722;1878.2580880552105;1909.8567607429497;1915.2147619475948;960.1118964957386;967.883853937532;974.6198982396871;977.452626529146;979.485769970771;8357.373197010127;8375.497470151811;8382.79043023917;8393.916060839436;8486.533240671699;794.4518282385136;813.4793732011517;833.0628043451118;833.5707110837923;836.1304243586602;5012.624053195952;5027.622928280393;5051.520105589963;5079.3650793650795;5084.161113416319;26465.735342646713;27064;27835.16494505168;27867.30331741682;27884.721152788617;25792.48415031689;26484.735152648613;26693.733062669515;26709.332266693487;26848.194554163405;12697.873021269854;12893.290869002107;12920.547780827626;12987.870121298854;13093.083484156208;9811.067948544876;10032.398056116657;10107.7473063174;10152.746181345525;10206.489675516046;22481.100755970234;22732.20437284687;22739.65890511677;22979.425514362276;23227.3031809046;23106.768932311134;23361;23493.53012939766;23606.645900311167;23629.88185059064;12060.15578909503;12170.75658486843;12195.451204695988;12234.75530489403;12254.509819607116;15919.124448155462;16103.597410064842;16268.67462650764;16362.918185408997;16398.26207820627;12316.630501084981;12387.380630968235;12453.501859925502;12478.313692746986;12688.619341419771;12029.819552706542;12092.214006089576;12139.696507587381;12193.207441516273;12429.440675169459;11030.393328366696;11167.553297867995;11167.888321116685;11290.717732056435;11332.773344532898;8504.319654427507;8525.275351595184;8525.531095789791;8573.399862009848;8690.826183476169;8684.34867384936;8727.607257673548;8761.912380876365;8763.123687631185;8857.424267422597 08:59:40 INFO - PID 5508 | |4;prototype.html;577.3360635269443;584.2463222443047;599.4305409860633;605.9515238780898;616.4544378225271;6253.187085678866;6271.1847459830215;6345.460635845947;6365.649889256089;6378.712957916893;6220.346863579327;6266.404691554295;6268.561200715941;6305.117283580303;6319.241690997075;5122.718250496221;5200.375954885419;5216.452272511388;5229.346331708546;5252.264682944372;4917.926231106536;5084.389873215201;5200.531952124308;5215.71313577755;5224.45143259958;4998.400191976968;5013.448520662742;5018.899622007558;5044.82343117991;5095.490450954912;5020.874478138039;5046.09170349337;5055.9241611375855;5077.136886729265;5101.642884998052;4602.585767280961;4622.583967442946;4630.884227894329;4649.581877527353;4675.555822196886;6115.602485838406;6160.5071594272795;6173.351798061184;6205.596636218676;6250.124982502453;5791.88416231673;5925.851853703649;5958.433948774859;5964.433378829048;5993.6104153230335;6563.901541476882;6638.402543771083;6653.733850645968;6670.599764014126;6684.699188536479;4895.0454661341055;5009.974950125263;5073.594112471031;5143.996920600484;5151.896962060738;6862.245153033163;6923.065386172852;7031.332023457763;7051.801193797016;7103.928960710378;5320.52115309624;5352;5355.410904800468;5355.678659280456;5361.115415956324;5400.4599540046465;5411.350637923474;5419.807642318684;5428.050091234098;5437.238786569884;5958.433948774859;5978.163057172;5988.610740301867;5994.610350327215;6003.399660034049;6738.663066846638;6740.865182696417;6782.152230971129;6799.868196387446;6821.386075253251;1824.6806808808406;1826.1873466307632;1851.3520267906395;1878.6806242938733;1879.9718004229946;1302.5180683147296;1317.6244770240435;1322.8346456692914;1323.8411390633187;1344.2270694350786;6222.751089956441;6274.905876411857;6301.684915754194;6371.490280777527;6378.266499352541;6637.6349300788925;6665.500087493458;6716.764913228014;6726.831829204211;6846.418054465326;6207.720652570645;6229.501639868799;6271.895411771203;6279.7488100476385;6391.904121438182;3566.1619519412916;3567.6967457765863;3578.570571531433;3592.8383222754514;3621.8370173342264;7024.613646249403;7060.505764596532;7078.256783037707;7146.531360338016;7179.712811487482;6867.553609015398;6931.792046238621;6960.443164546824;6970.337817907291;6980.975517100086;7050.2597227292445;7094.4679149062995;7119.96440017807;7134.92865071353;7208.026916366223;6655.800325990228;6702.162229721285;6722.386627209532;6739.326067393222;6798.116244888133;6719.193696756225;6730.697118629576;6731.528792984444;6746.69639866217;6762.256151823197;7034.437245020488;7059.329363710439;7071.797794375071;7178.712851486091;7200.783976480714;5292.867678308073;5329.360476742816;5331.413544510178;5334.386545547157;5340.477963780304;6533.314002029719;6545.639989800607;6786.93213067863;6889.655517224019;6909.654517274217;6531.542792004514;6551.344865513411;6593.769218077345;6628.204615446178;6663.167104111986;6516.771912983212;6546.574472659262;6548.80353589374;6581.506387020897;6610.272869984202;6486.189226346707;6499.707513162014;6535.509836762167;6563.9343606565235;6594.8351291218105;6643.335666433318;6644.534882558174;6696.129503164558;6726.8990965136545;6737.585107127362;6437.485001199799;6459.289478157493;6496.870062598627;6522.804315870531;6531.379518945692 08:59:40 INFO - PID 5508 | |5;yui.html;972.7081875437367;987.7135630667107;996.9551370188341;1012.5392946209475;1019.7756493571414;21055.789442105575;21137.894310528445;21288.89355553222;21453.463663408384;21592.784072159255;19642;19683.704744428844;19832.603347933033;19947.900260498678;20012.399628011182;1043.6503771236644;1061.3048453263125;1065.9573617055328;1066.1524088349743;1073.4525392050073;1083.7073990022689;1090.8091084060297;1091.1979694924225;1097.9231453798238;1101.867775866893;1088.6516314779274;1140.4411838199305;1149.1840793036954;1151.0561339701449;1151.9827202591969;1126.5606413498742;1129.2095533126762;1132.0264572467672;1134.0587312530579;1136.079775381939;831.9084900660922;832.5004997001811;833.5623797506297;834.0325222741651;834.7913021744564;19763.505912352164;19874.503137421536;19918.701219481718;20059.1976320947;21238.46903827417;23542.411439713975;24094.51810963771;24119.517609647883;24138.758612413825;24163.7583624165;18105.818941810547;18147.364842230458;18181.909090454596;18234;18335.358262460883;4115.97942010291;4142.523609784883;4187.895302617429;4190.224808410423;4192.140611174702;120028;124898;158553.20723396423;160081;161462.19268903698;18757.81242187588;18923;19017.14422850975;19139.712904306445;19208.71186932197;35011.64988350135;35961.82019089888;36055;36385.45421818675;36653;10586.629467968583;10596.841047384141;10607.257491975643;10607.734806629896;10612.20408469368;4855.6601037927;4864.6594738368685;4878.853634390903;4880.463149053601;4912.38595175603;6405.19935008124;6479.319671434431;6483.610983341015;6512.316206798313;6519.4132528072705;1255.604484587352;1296.5915736542959;1300.5318085489216;1305.106002388367;1311.3312210772383;713.7930000299855;724.1274264511251;735.1141874041767;739.098300073909;746.115852714535;13659.180449173082;13709.491955884845;14188;15140.697186056217;15326.463573774865;728.6101935464607;730.4412124724483;733.6038539188778;739.4010851210537;743.605888878895;6334.556581039283;6362.650054247061;6412.97991132801;6516.511261655395;6616.636085015274;161170;161703;163187;166198.16900915417;166947;128425;129269;133581;134458;136519;115721;116994;117163.41418292854;118836.40581797209;119384;11922.582709605469;11934.940325298317;11949.522019119486;11983.520659173884;12252.203606765532;55981.720091399286;56378.43621563732;56696.433035670765;56792.296231113134;57725.422745772004;73107.26892731218;73454;73516;75101.24898751162;75734;16563.585910352336;16812.159392030593;16819.579510512336;16874.746878797072;17039.23323450423;15722.292496837441;15894.364225430852;15979.840201597835;16106.114163721108;16109.436169734472;17879;17889.73165402546;18015.81984180194;18256.634867302313;18257.726134107732;16928.746068809225;16962.575935601708;17088.829111708725;17123.315067397165;17180.22688979024;17784.644307113525;18205.27178912829;18243.270269189616;18320.26718931228;18418.631627367646;13292.667683307995;13368.532101376406;13417.798733019208;13459.730805383642;13534.458621655023;12428.375514275029;12493.500259989498;12606.180598261084;12639.3680315982;12671.80992285135 08:59:40 INFO - PID 5508 | __end_tp_report 08:59:40 INFO - PID 5508 | __start_cc_report 08:59:40 INFO - PID 5508 | _x_x_mozilla_cycle_collect,243 08:59:40 INFO - PID 5508 | __end_cc_report 08:59:40 INFO - PID 5508 | __startTimestamp1507132780838__endTimestamp 08:59:40 INFO - PID 5508 | 08:59:40 INFO - PID 5508 | ------- Summary: start ------- 08:59:40 INFO - PID 5508 | Number of tests: 6 08:59:40 INFO - PID 5508 | 08:59:40 INFO - PID 5508 | [#0] dojo.html Cycles:165 Average:6550.52 Median:6801.97 stddev:757.18 (11.1%) stddev-sans-first:732.78 08:59:40 INFO - PID 5508 | Values: 4008.9 4021.8 4033.7 4034.7 4036.8 6444.4 6454.1 6525.4 6543.3 6562.8 6487.2 6513.9 6560.5 6562.8 6588.8 5848.4 5851.3 5889.8 5922.9 5938.1 5881.1 5895.7 5915.3 5922.2 5981.9 5871.6 5908.0 5913.4 5936.7 5984.1 5936.4 5940.5 5985.5 5990.5 5992.9 5879.6 5884.8 5980.1 5987.3 5990.7 6425.6 6426.5 6433.7 6517.3 6530.0 7097.7 7114.6 7123.1 7126.2 7137.5 7117.6 7120.6 7210.0 7211.9 7232.5 6471.8 6559.3 6590.7 6663.5 6675.7 7302.6 7305.2 7309.7 7317.2 7380.9 7009.7 7035.8 7047.9 7084.4 7089.4 7087.0 7096.6 7122.4 7210.8 7227.0 6920.1 7038.8 7052.3 7131.9 7162.0 7040.6 7051.7 7056.5 7075.3 7108.8 5241.3 5273.3 5286.9 5295.0 5306.8 4744.2 4762.4 4788.9 4807.1 4830.7 6520.7 6596.5 6607.7 6652.6 6660.6 7052.6 7122.4 7128.3 7128.8 7131.9 6528.0 6571.0 6645.7 6675.1 6685.6 5852.4 5921.9 5941.6 6006.8 6020.2 7238.7 7250.5 7338.6 7355.6 7357.1 7061.9 7090.4 7148.8 7150.3 7161.1 7275.5 7383.3 7460.9 7471.6 7489.2 6889.9 6914.3 6922.6 7000.8 7103.8 7084.6 7091.4 7101.4 7121.8 7123.7 6783.5 6874.8 6930.0 6973.9 6988.3 6707.2 6808.1 6820.4 6821.3 6840.8 6789.4 6805.6 6806.6 6811.0 6811.5 6834.5 6891.2 6928.5 6932.8 6991.2 6647.8 6698.5 6714.8 6790.4 6802.0 08:59:40 INFO - PID 5508 | 08:59:40 INFO - PID 5508 | [#1] ext.html Cycles:180 Average:44187.22 Median:35921.91 stddev:67639.27 (188.3%) stddev-sans-first:67751.08 08:59:40 INFO - PID 5508 | Values: 941.6 953.2 976.5 1008.0 1023.5 45187.8 45348.0 45975.3 46009.5 46114.0 42292.6 42579.4 42645.6 42761.4 42815.8 8130.1 8262.8 8276.8 8288.0 8290.1 7861.5 7902.0 7948.6 7956.9 7982.5 8709.8 8920.5 9000.4 9000.6 9003.5 8872.4 8901.0 8929.7 8949.1 8957.5 8780.7 8860.2 8866.8 8868.9 8886.1 42351.0 42765.4 42772.9 42784.1 42815.0 3895.0 3934.0 3939.4 3943.2 3944.5 34525.3 34615.5 34793.3 34810.0 34813.5 5611.8 5658.4 5668.2 5674.4 5788.1 232805.0 233099.0 234040.0 235514.0 236666.0 52799.0 52817.2 52966.7 52972.7 53114.0 56275.2 56802.1 56830.1 56919.7 56988.7 17122.3 17194.5 17221.1 17272.3 17312.4 13633.9 13691.2 13744.5 13749.9 13753.9 15430.7 15675.8 15703.8 15731.9 15747.0 6064.8 6210.1 6272.8 6390.9 6402.2 1108.6 1121.7 1124.3 1124.6 1128.7 26025.9 26190.9 26219.9 26370.5 26456.6 1199.5 1211.4 1247.8 1250.3 1252.3 13739.8 13813.4 13820.2 13910.2 13958.4 289454.0 290401.0 293668.0 294499.0 294502.0 58889.4 58963.0 63239.4 63575.7 63914.0 1525.5 1567.3 1573.1 1585.0 1590.6 30790.5 30816.0 31183.7 31294.2 31383.8 42140.0 42158.0 42177.0 42236.0 42275.0 249693.0 249822.0 250143.0 250181.0 250940.0 34739.5 35618.8 35664.8 35710.8 35987.8 46655.5 46776.5 47308.3 47325.8 47387.8 35020.1 35135.3 35238.0 35768.0 35856.0 34921.3 34951.5 34955.5 35067.5 35158.6 39907.4 40011.4 40101.0 40133.6 40497.8 33270.7 33818.8 34162.8 34277.5 34308.5 24885.9 25623.9 25862.4 25966.8 26091.5 08:59:40 INFO - PID 5508 | 08:59:40 INFO - PID 5508 | [#2] jquery.html Cycles:180 Average:43986.42 Median:22740.39 stddev:117354.19 (516.1%) stddev-sans-first:117638.29 08:59:40 INFO - PID 5508 | Values: 649.6 651.3 655.8 656.8 660.1 24445.5 25155.0 25220.0 25228.1 25945.4 27446.2 28306.3 28318.4 28322.6 28383.0 6923.3 7075.6 7080.0 7080.7 7087.1 6847.6 7102.5 7127.5 7134.6 7135.5 7045.5 7051.3 7088.5 7095.5 7097.0 7006.0 7027.8 7049.8 7074.0 7083.4 6585.6 6586.5 6599.9 6627.2 6639.2 31084.0 32319.7 32420.8 32623.7 32668.5 2325.6 2328.5 2345.5 2348.1 2355.2 20968.3 21277.8 21951.6 21967.6 22013.2 2676.1 2686.4 2726.8 2732.1 2735.0 159452.0 164791.0 165396.0 165812.0 166167.0 17166.4 17225.2 17256.5 17672.5 18034.5 28182.2 28187.7 28204.7 28222.6 28249.9 11115.7 11413.7 11446.7 11466.5 11483.5 9697.8 9731.5 10055.9 10275.5 10368.2 10190.6 10248.3 10352.7 10489.7 10708.8 2949.9 2951.8 3056.7 3131.9 3170.6 1062.5 1068.7 1077.7 1091.4 1099.2 22466.4 22693.8 22719.9 22760.9 22807.2 1166.6 1171.7 1175.5 1176.8 1177.4 12035.6 12450.8 12502.6 12515.4 12630.0 689000.0 696880.0 698030.0 714442.0 720156.0 137486.0 142679.0 143293.0 143856.3 144212.0 1266.7 1307.7 1324.3 1327.8 1339.0 19082.0 19244.3 19271.4 19639.0 19871.1 65352.3 66494.0 66887.7 67495.7 67599.3 84703.0 85219.6 85701.0 85781.0 85831.1 15737.6 15977.8 15997.3 16017.4 16041.3 24486.6 24631.0 24821.5 24946.8 25040.1 18675.9 18856.8 18895.5 19452.5 19561.5 17524.4 17760.6 18324.0 18493.6 18579.3 20348.2 20511.4 20531.4 20576.0 20582.8 15798.8 15957.7 15996.0 16006.0 16026.3 19998.5 20010.6 20097.9 20219.8 20273.7 08:59:40 INFO - PID 5508 | 08:59:40 INFO - PID 5508 | [#3] mootools.html Cycles:180 Average:11030.62 Median:3155.31 stddev:8267.73 (262.0%) stddev-sans-first:8259.47 08:59:40 INFO - PID 5508 | Values: 1432.2 1485.3 1489.9 1498.8 1513.2 17735.6 18476.0 18486.1 18496.8 18497.9 17968.4 18081.5 18096.9 18157.5 18209.9 3155.1 3155.6 3205.1 3215.4 3240.8 3203.9 3218.6 3234.3 3235.6 3236.0 3188.2 3206.8 3210.9 3287.5 3291.2 3230.5 3289.2 3289.8 3290.0 3291.3 3151.1 3170.5 3179.9 3181.1 3187.0 17248.9 17601.5 17604.8 17610.3 17734.9 9018.1 9265.5 9589.2 9594.0 9602.9 6044.6 6222.8 6276.1 6296.5 6385.0 2124.2 2131.7 2145.7 2148.2 2181.1 32752.0 32806.7 32822.0 32946.7 33027.2 8072.8 8144.0 8172.6 8307.3 8352.3 20968.7 21038.6 21109.7 21111.9 21159.8 8793.7 9099.4 9119.8 9123.7 9130.5 7711.0 8242.1 8382.7 8384.2 8401.2 6270.5 6277.0 6395.9 6472.7 6566.8 1868.1 1872.1 1878.3 1909.9 1915.2 960.1 967.9 974.6 977.5 979.5 8357.4 8375.5 8382.8 8393.9 8486.5 794.5 813.5 833.1 833.6 836.1 5012.6 5027.6 5051.5 5079.4 5084.2 26465.7 27064.0 27835.2 27867.3 27884.7 25792.5 26484.7 26693.7 26709.3 26848.2 12697.9 12893.3 12920.5 12987.9 13093.1 9811.1 10032.4 10107.7 10152.7 10206.5 22481.1 22732.2 22739.7 22979.4 23227.3 23106.8 23361.0 23493.5 23606.6 23629.9 12060.2 12170.8 12195.5 12234.8 12254.5 15919.1 16103.6 16268.7 16362.9 16398.3 12316.6 12387.4 12453.5 12478.3 12688.6 12029.8 12092.2 12139.7 12193.2 12429.4 11030.4 11167.6 11167.9 11290.7 11332.8 8504.3 8525.3 8525.5 8573.4 8690.8 8684.3 8727.6 8761.9 8763.1 8857.4 08:59:40 INFO - PID 5508 | 08:59:40 INFO - PID 5508 | [#4] prototype.html Cycles:180 Average:5703.15 Median:6290.72 stddev:1576.70 (25.1%) stddev-sans-first:1533.46 08:59:40 INFO - PID 5508 | Values: 577.3 584.2 599.4 606.0 616.5 6253.2 6271.2 6345.5 6365.6 6378.7 6220.3 6266.4 6268.6 6305.1 6319.2 5122.7 5200.4 5216.5 5229.3 5252.3 4917.9 5084.4 5200.5 5215.7 5224.5 4998.4 5013.4 5018.9 5044.8 5095.5 5020.9 5046.1 5055.9 5077.1 5101.6 4602.6 4622.6 4630.9 4649.6 4675.6 6115.6 6160.5 6173.4 6205.6 6250.1 5791.9 5925.9 5958.4 5964.4 5993.6 6563.9 6638.4 6653.7 6670.6 6684.7 4895.0 5010.0 5073.6 5144.0 5151.9 6862.2 6923.1 7031.3 7051.8 7103.9 5320.5 5352.0 5355.4 5355.7 5361.1 5400.5 5411.4 5419.8 5428.1 5437.2 5958.4 5978.2 5988.6 5994.6 6003.4 6738.7 6740.9 6782.2 6799.9 6821.4 1824.7 1826.2 1851.4 1878.7 1880.0 1302.5 1317.6 1322.8 1323.8 1344.2 6222.8 6274.9 6301.7 6371.5 6378.3 6637.6 6665.5 6716.8 6726.8 6846.4 6207.7 6229.5 6271.9 6279.7 6391.9 3566.2 3567.7 3578.6 3592.8 3621.8 7024.6 7060.5 7078.3 7146.5 7179.7 6867.6 6931.8 6960.4 6970.3 6981.0 7050.3 7094.5 7120.0 7134.9 7208.0 6655.8 6702.2 6722.4 6739.3 6798.1 6719.2 6730.7 6731.5 6746.7 6762.3 7034.4 7059.3 7071.8 7178.7 7200.8 5292.9 5329.4 5331.4 5334.4 5340.5 6533.3 6545.6 6786.9 6889.7 6909.7 6531.5 6551.3 6593.8 6628.2 6663.2 6516.8 6546.6 6548.8 6581.5 6610.3 6486.2 6499.7 6535.5 6563.9 6594.8 6643.3 6644.5 6696.1 6726.9 6737.6 6437.5 6459.3 6496.9 6522.8 6531.4 08:59:40 INFO - PID 5508 | 08:59:40 INFO - PID 5508 | [#5] yui.html Cycles:180 Average:28567.49 Median:18060.82 stddev:42672.99 (236.3%) stddev-sans-first:42742.40 08:59:40 INFO - PID 5508 | Values: 972.7 987.7 997.0 1012.5 1019.8 21055.8 21137.9 21288.9 21453.5 21592.8 19642.0 19683.7 19832.6 19947.9 20012.4 1043.7 1061.3 1066.0 1066.2 1073.5 1083.7 1090.8 1091.2 1097.9 1101.9 1088.7 1140.4 1149.2 1151.1 1152.0 1126.6 1129.2 1132.0 1134.1 1136.1 831.9 832.5 833.6 834.0 834.8 19763.5 19874.5 19918.7 20059.2 21238.5 23542.4 24094.5 24119.5 24138.8 24163.8 18105.8 18147.4 18181.9 18234.0 18335.4 4116.0 4142.5 4187.9 4190.2 4192.1 120028.0 124898.0 158553.2 160081.0 161462.2 18757.8 18923.0 19017.1 19139.7 19208.7 35011.6 35961.8 36055.0 36385.5 36653.0 10586.6 10596.8 10607.3 10607.7 10612.2 4855.7 4864.7 4878.9 4880.5 4912.4 6405.2 6479.3 6483.6 6512.3 6519.4 1255.6 1296.6 1300.5 1305.1 1311.3 713.8 724.1 735.1 739.1 746.1 13659.2 13709.5 14188.0 15140.7 15326.5 728.6 730.4 733.6 739.4 743.6 6334.6 6362.7 6413.0 6516.5 6616.6 161170.0 161703.0 163187.0 166198.2 166947.0 128425.0 129269.0 133581.0 134458.0 136519.0 115721.0 116994.0 117163.4 118836.4 119384.0 11922.6 11934.9 11949.5 11983.5 12252.2 55981.7 56378.4 56696.4 56792.3 57725.4 73107.3 73454.0 73516.0 75101.2 75734.0 16563.6 16812.2 16819.6 16874.7 17039.2 15722.3 15894.4 15979.8 16106.1 16109.4 17879.0 17889.7 18015.8 18256.6 18257.7 16928.7 16962.6 17088.8 17123.3 17180.2 17784.6 18205.3 18243.3 18320.3 18418.6 13292.7 13368.5 13417.8 13459.7 13534.5 12428.4 12493.5 12606.2 12639.4 12671.8 08:59:40 INFO - PID 5508 | -------- Summary: end -------- 08:59:40 INFO - PID 5508 | 08:59:41 INFO - TEST-INFO | 5508: exit 0 08:59:41 INFO - TEST-OK | dromaeo_css | took 1107248ms 08:59:41 INFO - TEST-START | kraken 08:59:41 INFO - Initialising browser for kraken test... 08:59:41 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33302/getInfo.html -profile /tmp/tmpzGZR4v/profile 08:59:41 INFO - TEST-INFO | started process 5875 (/builds/slave/test/build/application/firefox/firefox http://localhost:33302/getInfo.html) 08:59:47 INFO - TEST-INFO | 5875: exit 0 08:59:47 INFO - Browser initialized. 08:59:47 INFO - Running cycle 1/1 for kraken test... 08:59:47 INFO - Using env: {'DISPLAY': ':0', 08:59:47 INFO - 'HOME': '/home/cltbld', 08:59:47 INFO - 'JSGC_DISABLE_POISONING': '1', 08:59:47 INFO - 'LANG': 'en_US.UTF-8', 08:59:47 INFO - 'LANGUAGE': 'en_US:en', 08:59:47 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 08:59:47 INFO - 'LOGNAME': 'cltbld', 08:59:47 INFO - 'MAIL': '/var/mail/cltbld', 08:59:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:59:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:59:47 INFO - 'MOZ_CRASHREPORTER': '1', 08:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:47 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 08:59:47 INFO - 'MOZ_NO_REMOTE': '1', 08:59:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:59:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:47 INFO - 'NO_EM_RESTART': '1', 08:59:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:47 INFO - 'PWD': '/builds/slave/test', 08:59:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:59:47 INFO - 'RUST_BACKTRACE': 'full', 08:59:47 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:59:47 INFO - 'SHELL': '/bin/bash', 08:59:47 INFO - 'SHLVL': '1', 08:59:47 INFO - 'TERM': 'linux', 08:59:47 INFO - 'TMOUT': '86400', 08:59:47 INFO - 'USER': 'cltbld', 08:59:47 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1507131384.967951-1166287135', 08:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:47 INFO - '_': '/tools/buildbot/bin/python'} 08:59:47 INFO - TEST-INFO | started process 6112 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzGZR4v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:59:47 INFO - PID 6112 | 08:59:47 INFO - PID 6112 | (/builds/slave/test/build/application/firefox/firefox:6160): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:59:47 INFO - PID 6112 | 08:59:58 INFO - PID 6112 | RSS: Main: 141815808 08:59:58 INFO - PID 6112 | 09:00:00 INFO - PID 6112 | Cycle 1(1): loaded http://localhost:33302/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33302/tests/kraken/driver.html?testName=audio-beat-detection) 09:00:01 INFO - PID 6112 | RSS: Main: 148328448 09:00:01 INFO - PID 6112 | 09:00:04 INFO - PID 6112 | Cycle 1(1): loaded http://localhost:33302/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33302/tests/kraken/driver.html?testName=audio-dft) 09:00:04 INFO - PID 6112 | RSS: Main: 148447232 09:00:04 INFO - PID 6112 | 09:00:07 INFO - PID 6112 | Cycle 1(1): loaded http://localhost:33302/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33302/tests/kraken/driver.html?testName=audio-fft) 09:00:08 INFO - PID 6112 | RSS: Main: 150052864 09:00:08 INFO - PID 6112 | 09:00:10 INFO - PID 6112 | Cycle 1(1): loaded http://localhost:33302/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33302/tests/kraken/driver.html?testName=audio-oscillator) 09:00:10 INFO - PID 6112 | RSS: Main: 149929984 09:00:10 INFO - PID 6112 | 09:00:12 INFO - PID 6112 | Cycle 1(1): loaded http://localhost:33302/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33302/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:00:13 INFO - PID 6112 | RSS: Main: 149716992 09:00:13 INFO - PID 6112 | 09:00:16 INFO - PID 6112 | Cycle 1(1): loaded http://localhost:33302/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33302/tests/kraken/driver.html?testName=imaging-darkroom) 09:00:17 INFO - PID 6112 | RSS: Main: 149692416 09:00:17 INFO - PID 6112 | 09:00:20 INFO - PID 6112 | Cycle 1(1): loaded http://localhost:33302/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33302/tests/kraken/driver.html?testName=imaging-desaturate) 09:00:21 INFO - PID 6112 | RSS: Main: 150835200 09:00:21 INFO - PID 6112 | 09:00:24 INFO - PID 6112 | Cycle 1(1): loaded http://localhost:33302/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33302/tests/kraken/driver.html?testName=json-parse-financial) 09:00:24 INFO - PID 6112 | RSS: Main: 152313856 09:00:24 INFO - PID 6112 | 09:00:26 INFO - PID 6112 | Cycle 1(1): loaded http://localhost:33302/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33302/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:00:26 INFO - PID 6112 | RSS: Main: 152387584 09:00:26 INFO - PID 6112 | 09:00:28 INFO - PID 6112 | Cycle 1(1): loaded http://localhost:33302/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33302/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:00:28 INFO - PID 6112 | RSS: Main: 152268800 09:00:28 INFO - PID 6112 | 09:00:30 INFO - PID 6112 | Cycle 1(1): loaded http://localhost:33302/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33302/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:00:31 INFO - PID 6112 | RSS: Main: 149450752 09:00:31 INFO - PID 6112 | 09:00:33 INFO - PID 6112 | Cycle 1(1): loaded http://localhost:33302/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33302/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:00:34 INFO - PID 6112 | RSS: Main: 149164032 09:00:34 INFO - PID 6112 | 09:00:37 INFO - PID 6112 | Cycle 1(1): loaded http://localhost:33302/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33302/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:00:37 INFO - PID 6112 | RSS: Main: 149950464 09:00:37 INFO - PID 6112 | 09:00:39 INFO - PID 6112 | Cycle 1(1): loaded http://localhost:33302/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33302/tests/kraken/driver.html?testName=ai-astar) 09:00:39 INFO - PID 6112 | RSS: Main: 151031808 09:00:39 INFO - PID 6112 | 09:00:39 INFO - PID 6112 | __start_tp_report 09:00:39 INFO - PID 6112 | _x_x_mozilla_page_load 09:00:39 INFO - PID 6112 | _x_x_mozilla_page_load_details 09:00:39 INFO - PID 6112 | |i|pagename|runs| 09:00:39 INFO - PID 6112 | |0;ai-astar;103;104;105;103;105;105;103;107;106;104 09:00:39 INFO - PID 6112 | |1;audio-beat-detection;122;114;117;112;111;112;133;116;110;123 09:00:39 INFO - PID 6112 | |2;audio-dft;162;163;163;161;159;161;161;159;165;163 09:00:39 INFO - PID 6112 | |3;audio-fft;73;72;73;74;73;74;73;73;72;73 09:00:39 INFO - PID 6112 | |4;audio-oscillator;78;80;77;77;76;77;76;80;77;77 09:00:39 INFO - PID 6112 | |5;imaging-gaussian-blur;109;114;114;114;114;110;114;111;114;114 09:00:39 INFO - PID 6112 | |6;imaging-darkroom;151;148;150;150;148;148;148;148;148;148 09:00:39 INFO - PID 6112 | |7;imaging-desaturate;93;94;94;93;94;93;94;94;94;95 09:00:39 INFO - PID 6112 | |8;json-parse-financial;45;46;49;44;42;45;44;43;42;43 09:00:39 INFO - PID 6112 | |9;json-stringify-tinderbox;39;44;40;39;39;39;39;39;39;40 09:00:39 INFO - PID 6112 | |10;stanford-crypto-aes;72;71;68;69;74;69;69;71;70;70 09:00:39 INFO - PID 6112 | |11;stanford-crypto-ccm;106;102;103;101;108;104;101;102;116;100 09:00:39 INFO - PID 6112 | |12;stanford-crypto-pbkdf2;159;149;145;149;148;149;152;149;154;152 09:00:39 INFO - PID 6112 | |13;stanford-crypto-sha256-iterative;60;60;58;57;58;57;59;58;63;58 09:00:39 INFO - PID 6112 | __end_tp_report 09:00:39 INFO - PID 6112 | __start_cc_report 09:00:39 INFO - PID 6112 | _x_x_mozilla_cycle_collect,673 09:00:39 INFO - PID 6112 | __end_cc_report 09:00:39 INFO - PID 6112 | __startTimestamp1507132839777__endTimestamp 09:00:39 INFO - PID 6112 | 09:00:39 INFO - PID 6112 | ------- Summary: start ------- 09:00:39 INFO - PID 6112 | Number of tests: 14 09:00:39 INFO - PID 6112 | 09:00:39 INFO - PID 6112 | [#0] ai-astar Cycles:10 Average:104.50 Median:105.00 stddev:1.35 (1.3%) stddev-sans-first:1.32 09:00:39 INFO - PID 6112 | Values: 103.0 104.0 105.0 103.0 105.0 105.0 103.0 107.0 106.0 104.0 09:00:39 INFO - PID 6112 | 09:00:39 INFO - PID 6112 | [#1] audio-beat-detection Cycles:10 Average:117.00 Median:116.50 stddev:7.16 (6.1%) stddev-sans-first:7.37 09:00:39 INFO - PID 6112 | Values: 122.0 114.0 117.0 112.0 111.0 112.0 133.0 116.0 110.0 123.0 09:00:39 INFO - PID 6112 | 09:00:39 INFO - PID 6112 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.50 stddev:1.89 (1.2%) stddev-sans-first:2.00 09:00:39 INFO - PID 6112 | Values: 162.0 163.0 163.0 161.0 159.0 161.0 161.0 159.0 165.0 163.0 09:00:39 INFO - PID 6112 | 09:00:39 INFO - PID 6112 | [#3] audio-fft Cycles:10 Average:73.00 Median:73.00 stddev:0.67 (0.9%) stddev-sans-first:0.71 09:00:39 INFO - PID 6112 | Values: 73.0 72.0 73.0 74.0 73.0 74.0 73.0 73.0 72.0 73.0 09:00:39 INFO - PID 6112 | 09:00:39 INFO - PID 6112 | [#4] audio-oscillator Cycles:10 Average:77.50 Median:77.00 stddev:1.43 (1.9%) stddev-sans-first:1.51 09:00:39 INFO - PID 6112 | Values: 78.0 80.0 77.0 77.0 76.0 77.0 76.0 80.0 77.0 77.0 09:00:39 INFO - PID 6112 | 09:00:39 INFO - PID 6112 | [#5] imaging-gaussian-blur Cycles:10 Average:112.80 Median:114.00 stddev:1.99 (1.7%) stddev-sans-first:1.56 09:00:39 INFO - PID 6112 | Values: 109.0 114.0 114.0 114.0 114.0 110.0 114.0 111.0 114.0 114.0 09:00:39 INFO - PID 6112 | 09:00:39 INFO - PID 6112 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:148.00 stddev:1.16 (0.8%) stddev-sans-first:0.88 09:00:39 INFO - PID 6112 | Values: 151.0 148.0 150.0 150.0 148.0 148.0 148.0 148.0 148.0 148.0 09:00:39 INFO - PID 6112 | 09:00:39 INFO - PID 6112 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 09:00:39 INFO - PID 6112 | Values: 93.0 94.0 94.0 93.0 94.0 93.0 94.0 94.0 94.0 95.0 09:00:39 INFO - PID 6112 | 09:00:39 INFO - PID 6112 | [#8] json-parse-financial Cycles:10 Average:44.30 Median:44.50 stddev:2.11 (4.7%) stddev-sans-first:2.22 09:00:39 INFO - PID 6112 | Values: 45.0 46.0 49.0 44.0 42.0 45.0 44.0 43.0 42.0 43.0 09:00:39 INFO - PID 6112 | 09:00:39 INFO - PID 6112 | [#9] json-stringify-tinderbox Cycles:10 Average:39.70 Median:39.00 stddev:1.57 (4.0%) stddev-sans-first:1.64 09:00:39 INFO - PID 6112 | Values: 39.0 44.0 40.0 39.0 39.0 39.0 39.0 39.0 39.0 40.0 09:00:39 INFO - PID 6112 | 09:00:39 INFO - PID 6112 | [#10] stanford-crypto-aes Cycles:10 Average:70.30 Median:70.50 stddev:1.77 (2.5%) stddev-sans-first:1.76 09:00:39 INFO - PID 6112 | Values: 72.0 71.0 68.0 69.0 74.0 69.0 69.0 71.0 70.0 70.0 09:00:39 INFO - PID 6112 | 09:00:39 INFO - PID 6112 | [#11] stanford-crypto-ccm Cycles:10 Average:104.30 Median:103.50 stddev:4.79 (4.6%) stddev-sans-first:5.04 09:00:39 INFO - PID 6112 | Values: 106.0 102.0 103.0 101.0 108.0 104.0 101.0 102.0 116.0 100.0 09:00:39 INFO - PID 6112 | 09:00:39 INFO - PID 6112 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.60 Median:150.50 stddev:3.86 (2.6%) stddev-sans-first:2.65 09:00:39 INFO - PID 6112 | Values: 159.0 149.0 145.0 149.0 148.0 149.0 152.0 149.0 154.0 152.0 09:00:39 INFO - PID 6112 | 09:00:39 INFO - PID 6112 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:58.80 Median:58.50 stddev:1.81 (3.1%) stddev-sans-first:1.87 09:00:39 INFO - PID 6112 | Values: 60.0 60.0 58.0 57.0 58.0 57.0 59.0 58.0 63.0 58.0 09:00:39 INFO - PID 6112 | -------- Summary: end -------- 09:00:39 INFO - PID 6112 | 09:00:40 INFO - PID 6112 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 09:00:40 INFO - TEST-INFO | 6112: exit 0 09:00:40 INFO - TEST-OK | kraken | took 58808ms 09:00:40 INFO - SUITE-END | took 1166s 09:00:40 INFO - Completed test suite (00:19:26) 09:00:40 INFO - javascript benchmark 09:00:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9395.245952128305, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [4008.859689910853, 4021.7586944783316, 4033.677305815533, 4034.657054150398, 4036.838526458942, 6444.355564443554, 6454.064160696702, 6525.3800888915475, 6543.280239173687, 6562.835929101775, 6487.156669632953, 6513.869722605545, 6560.475161987041, 6562.770303039395, 6588.769393071243, 5848.356680765112, 5851.297844258695, 5889.823305300848, 5922.88154236915, 5938.079597662369, 5881.059030555112, 5895.675737834417, 5915.260592425947, 5922.2005029321135, 5981.9401805981815, 5871.559633027518, 5908.02517584598, 5913.379095194986, 5936.732847021873, 5984.072468767348, 5936.436038576328, 5940.49505792006, 5985.491233245201, 5990.490808281302, 5992.880142397127, 5879.559033072536, 5884.764609415618, 5980.13288073227, 5987.341392446828, 5990.670513121777, 6425.646589437579, 6426.518011149183, 6433.7426502939825, 6517.283098859121, 6529.967350163219, 7097.716091356339, 7114.608696521689, 7123.145222573325, 7126.2161162272105, 7137.536060156073, 7117.608531530764, 7120.572765634079, 7210.026646402721, 7211.855762884713, 7232.457565682595, 6471.838204044937, 6559.344065593403, 6590.736370545173, 6663.533552651316, 6675.699593518303, 7302.598357090411, 7305.232950540117, 7309.671064802096, 7317.158526769384, 7380.852382952311, 7009.684564194624, 7035.788926332219, 7047.859042819115, 7084.43324534036, 7089.397401220851, 7087.007818905357, 7096.645167741593, 7122.394596459359, 7210.819729506699, 7226.963865180641, 6920.065791118235, 7038.824029399306, 7052.33002864727, 7131.928680713127, 7161.9641901790155, 7040.612766297801, 7051.682674279669, 7056.54132481387, 7075.327843854929, 7108.822279442952, 5241.266222728821, 5273.2617433559335, 5286.9471305287225, 5295.0, 5306.8142615009065, 4744.1934871072, 4762.357081793983, 4788.880277993078, 4807.086653535817, 4830.661853670209, 6520.706568204442, 6596.472282217411, 6607.702653380609, 6652.634105124168, 6660.600363978177, 7052.576845389293, 7122.358987691133, 7128.322809333105, 7128.786136415916, 7131.857362852714, 6527.967360163264, 6571.0, 6645.66771661415, 6675.065490831287, 6685.6322902240845, 5852.414758524199, 5921.911171332434, 5941.58408911372, 6006.759729610767, 6020.247469066367, 7238.710451581877, 7250.492465527468, 7338.596377199306, 7355.632218389166, 7357.0803649543805, 7061.858762824612, 7090.397316228075, 7148.821279467847, 7150.320719531636, 7161.069061022034, 7275.490715649854, 7383.2985866342615, 7460.888086678596, 7471.551706897603, 7489.213632568501, 6889.862202756017, 6914.308569143045, 6922.58464492132, 7000.789976300719, 7103.786886393416, 7084.645767711697, 7091.397231235403, 7101.360877521048, 7121.786346409616, 7123.679434425567, 6783.491238157059, 6874.828129296808, 6930.0, 6973.930260697328, 6988.266232045562, 6707.195136583641, 6808.080909077409, 6820.35206655367, 6821.317868213139, 6840.794776156723, 6789.388954994074, 6805.591664500146, 6806.625635589892, 6811.0, 6811.489138314547, 6834.521583489108, 6891.241963383924, 6928.515003949675, 6932.792016239521, 6991.196012458632, 6647.833804154935, 6698.531102822755, 6714.83212919681, 6790.354916282945, 6801.965990170018], "value": 6500.212817123162, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [941.618644448998, 953.1850268020846, 976.501983988166, 1007.9798404031915, 1023.488255872064, 45187.77406112969, 45348.0, 45975.31037034447, 46009.53990460094, 46114.0, 42292.57707422925, 42579.36130958038, 42645.573544264626, 42761.35857962133, 42815.785921070354, 8130.105688374274, 8262.83474330513, 8276.83446331073, 8288.0, 8290.129536398681, 7861.528308301492, 7901.960490197541, 7948.642311095986, 7956.880646790303, 7982.521048737065, 8709.782255443633, 8920.50937198457, 9000.414973026733, 9000.594973226187, 9003.459792412443, 8872.37893347466, 8901.020887702347, 8929.687460938836, 8949.105089491064, 8957.507337096456, 8780.692675756318, 8860.158284962918, 8866.778330541723, 8868.911310886873, 8886.111388861127, 42351.0, 42765.358519622234, 42772.93067673333, 42784.144317113794, 42815.0, 3895.02624343914, 3934.0, 3939.428782826474, 3943.2310699413624, 3944.467496887941, 34525.30949381024, 34615.480767788504, 34793.30413391743, 34810.0, 34813.47779783305, 5611.803586874481, 5658.405867383906, 5668.178114173463, 5674.375818659944, 5788.131780232957, 232805.0, 233098.9999999983, 234040.0, 235514.0, 236666.0, 52799.0, 52817.2077418839, 52966.735166323924, 52972.735136324074, 53114.0, 56275.15587266194, 56802.14796778052, 56830.147547786815, 56919.71540142356, 56988.71505642445, 17122.315107395814, 17194.484165475056, 17221.138943052796, 17272.309107635807, 17312.394066207624, 13633.931830340785, 13691.178529288274, 13744.518941836988, 13749.862501375059, 13753.862461375258, 15430.691386172213, 15675.843241567438, 15703.842961570466, 15731.921340393224, 15747.0, 6064.784974442809, 6210.130581718473, 6272.843178920563, 6390.8721825563225, 6402.199725034371, 1108.578740078781, 1121.657894342217, 1124.3422597780227, 1124.5501799280353, 1128.7403897103547, 26025.869870650906, 26190.86904565465, 26219.868900655376, 26370.472590548467, 26456.603150952753, 1199.5381778015526, 1211.4064108586906, 1247.8003519436847, 1250.2560976219136, 1252.2799390350585, 13739.793903091462, 13813.378397972116, 13820.170789752647, 13910.165390076629, 13958.441662333596, 289454.0, 290401.0, 293668.0, 294499.0, 294502.0, 58889.41110588925, 58963.0, 63239.36760632427, 63575.68212159002, 63914.0, 1525.519461369665, 1567.3338830996781, 1573.1033311012613, 1584.9920750396404, 1590.6103004763675, 30790.53814192744, 30816.0, 31183.688163118077, 31294.217644559067, 31383.84308078445, 42140.0, 42158.0, 42177.0, 42236.0, 42275.0, 249693.0, 249822.0, 250143.0, 250181.0, 250940.0, 34739.4789078159, 35618.82190589134, 35664.82167589146, 35710.8214458926, 35987.820060899525, 46655.53344466512, 46776.532234678576, 47308.29037564508, 47325.763371182926, 47387.76306118447, 35020.12449688778, 35135.29729405347, 35238.0, 35768.0, 35856.0, 34921.30157396787, 34951.475727863595, 34955.47566786551, 35067.47398789071, 35158.64841351554, 39907.40138897977, 40011.399829003174, 40101.0, 40133.598664012985, 40497.79751101226, 33270.66729332772, 33818.830905845316, 34162.82918585391, 34277.48583771195, 34308.48537271893, 24885.875570622033, 25623.871880640476, 25862.353441164123, 25966.78179246416, 26091.478170436105], "value": 19213.54504764273, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [649.6460071985128, 651.3263055158574, 655.7901471529111, 656.8128083496199, 660.0824853453697, 24445.511089778192, 25155.0, 25220.0, 25228.117015904423, 25945.351366215855, 27446.17661470159, 28306.292342691442, 28318.43363132736, 28322.575161372595, 28383.0, 6923.273056329076, 7075.610841403721, 7080.0, 7080.716771329141, 7087.078679771623, 6847.589144651312, 7102.538335008208, 7127.4654400920135, 7134.571925684476, 7135.53619014765, 7045.4715896307725, 7051.330123638246, 7088.4683648726295, 7095.503314767969, 7097.0, 7006.0, 7027.824304392406, 7049.7885063448175, 7074.0, 7083.397911177531, 6585.637789921552, 6586.506012049115, 6599.934000660028, 6627.2378676452345, 6639.203295604559, 31084.0, 32319.676803232138, 32420.837895810604, 32623.6737632623, 32668.509972350435, 2325.5813953488364, 2328.5342931413616, 2345.5308938212424, 2348.0842471436154, 2355.1756885090253, 20968.266110686207, 21277.787222127736, 21951.560968780534, 21967.560648787094, 22013.22953696629, 2676.130257666266, 2686.3821321096257, 2726.82275652082, 2732.0574401831336, 2734.9726502735116, 159452.0, 164791.0, 165396.0, 165811.9999999988, 166167.0, 17166.39917602878, 17225.22486488111, 17256.482305530855, 17672.469825905242, 18034.458966231035, 28182.15453536397, 28187.71812281851, 28204.717952820618, 28222.576661350096, 28249.858750706117, 11115.722106947229, 11413.714657133638, 11446.677295057672, 11466.48400821965, 11483.540658373571, 9697.757556061155, 9731.491618798957, 10055.899441005497, 10275.486225688686, 10368.170546356274, 10190.592376304865, 10248.333858299187, 10352.70591176103, 10489.685309440729, 10708.78582428347, 2949.9410011799646, 2951.778616603763, 3056.7161792047395, 3131.890383836555, 3170.556122142902, 1062.4793851012948, 1068.6526878764432, 1077.6605369308643, 1091.4051841746268, 1099.164634877483, 22466.438339041655, 22693.773062269494, 22719.88640056789, 22760.886195568917, 22807.175425966216, 1166.6091859227083, 1171.7305019845483, 1175.5297880847559, 1176.8411264479187, 1177.4289469607234, 12035.578754743718, 12450.75098498025, 12502.624921252376, 12515.374231288399, 12630.0, 689000.0, 696880.0, 698030.0, 714442.0, 720156.0, 137486.0, 142679.0, 143293.0, 143856.28071859575, 144212.0, 1266.7403182347596, 1307.6534718299658, 1324.311358093805, 1327.7809161488246, 1339.0292038272175, 19082.0, 19244.326448574233, 19271.421857344303, 19639.0180490972, 19871.105800239315, 65352.34647653463, 66494.0, 66887.66556167188, 67495.66252168707, 67599.32400676126, 84703.0, 85219.5739021301, 85701.0, 85781.0, 85831.14168858482, 15737.606559835638, 15977.760333594773, 15997.280122394288, 16017.439389621308, 16041.27814248385, 24486.63270050915, 24631.0, 24821.50356992814, 24946.750532494443, 25040.123595674064, 18675.906620466812, 18856.811431885504, 18895.527611809815, 19452.513687157934, 19561.510962226057, 17524.422801947887, 17760.555986099935, 18324.0, 18493.630127397646, 18579.34972276018, 20348.186072557524, 20511.38465846027, 20531.38405847827, 20576.0, 20582.794172058686, 15798.842011579736, 15957.68084638324, 15996.0, 16006.0, 16026.278817453009, 19998.50003749918, 20010.59978800445, 20097.899510502353, 20219.797802021792, 20273.695894561297], "value": 13480.196606192603, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1432.1693417817664, 1485.3093311610098, 1489.90315629484, 1498.8276348219954, 1513.1526345246664, 17735.55661108473, 18476.0, 18486.075696215168, 18496.815031849677, 18497.907510462446, 17968.37110701126, 18081.54796130094, 18096.909515452437, 18157.54606134844, 18209.90895045523, 3155.0692545699017, 3155.558221848943, 3205.134613654312, 3215.437298472758, 3240.821754803485, 3203.887863924763, 3218.5654936583614, 3234.2561210921504, 3235.6440791512914, 3236.045366616842, 3188.1551388881967, 3206.7594930380315, 3210.855511501988, 3287.5068739689, 3291.226561757985, 3230.4669729494603, 3289.2434740009694, 3289.8190599517015, 3289.9506507402407, 3291.2594666200152, 3151.11768704763, 3170.4927211646027, 3179.8887038953526, 3181.109289398972, 3186.952195717066, 17248.91375543127, 17601.471955841345, 17604.823951760445, 17610.295588176457, 17734.91132544342, 9018.053104424072, 9265.490398028105, 9589.232861371074, 9594.0, 9602.90397096034, 6044.576879618428, 6222.751089956397, 6276.089966954812, 6296.496280297565, 6385.0, 2124.1609564222044, 2131.6695912133646, 2145.6566949288194, 2148.237375731624, 2181.1057466438842, 32752.0, 32806.6719332806, 32822.0, 32946.67053329484, 33027.174320641934, 8072.798180045545, 8143.959280203561, 8172.591370431454, 8307.252347288773, 8352.33181345503, 20968.68546971766, 21038.579228415347, 21109.68335474969, 21111.944402779798, 21159.78840211609, 8793.736187914374, 9099.363044586815, 9119.772005699779, 9123.726288211365, 9130.543472826332, 7711.0, 8242.052164001216, 8382.706605268786, 8384.161583841567, 8401.20188582096, 6270.529710271748, 6276.968615156895, 6395.936040639534, 6472.741090356427, 6566.8358291043105, 1868.1219826681709, 1872.1481725814722, 1878.2580880552105, 1909.8567607429497, 1915.2147619475948, 960.1118964957386, 967.883853937532, 974.6198982396871, 977.452626529146, 979.485769970771, 8357.373197010127, 8375.497470151811, 8382.79043023917, 8393.916060839436, 8486.533240671699, 794.4518282385136, 813.4793732011517, 833.0628043451118, 833.5707110837923, 836.1304243586602, 5012.624053195952, 5027.622928280393, 5051.520105589963, 5079.3650793650795, 5084.161113416319, 26465.735342646713, 27064.0, 27835.16494505168, 27867.30331741682, 27884.721152788617, 25792.48415031689, 26484.735152648613, 26693.733062669515, 26709.332266693487, 26848.194554163405, 12697.873021269854, 12893.290869002107, 12920.547780827626, 12987.870121298854, 13093.083484156208, 9811.067948544876, 10032.398056116657, 10107.7473063174, 10152.746181345525, 10206.489675516046, 22481.100755970234, 22732.20437284687, 22739.65890511677, 22979.425514362276, 23227.3031809046, 23106.768932311134, 23361.0, 23493.53012939766, 23606.645900311167, 23629.88185059064, 12060.15578909503, 12170.75658486843, 12195.451204695988, 12234.75530489403, 12254.509819607116, 15919.124448155462, 16103.597410064842, 16268.67462650764, 16362.918185408997, 16398.26207820627, 12316.630501084981, 12387.380630968235, 12453.501859925502, 12478.313692746986, 12688.619341419771, 12029.819552706542, 12092.214006089576, 12139.696507587381, 12193.207441516273, 12429.440675169459, 11030.393328366696, 11167.553297867995, 11167.888321116685, 11290.717732056435, 11332.773344532898, 8504.319654427507, 8525.275351595184, 8525.531095789791, 8573.399862009848, 8690.826183476169, 8684.34867384936, 8727.607257673548, 8761.912380876365, 8763.123687631185, 8857.424267422597], "value": 7704.982942876073, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.3360635269443, 584.2463222443047, 599.4305409860633, 605.9515238780898, 616.4544378225271, 6253.187085678866, 6271.1847459830215, 6345.460635845947, 6365.649889256089, 6378.712957916893, 6220.346863579327, 6266.404691554295, 6268.561200715941, 6305.117283580303, 6319.241690997075, 5122.718250496221, 5200.375954885419, 5216.452272511388, 5229.346331708546, 5252.264682944372, 4917.926231106536, 5084.389873215201, 5200.531952124308, 5215.71313577755, 5224.45143259958, 4998.400191976968, 5013.448520662742, 5018.899622007558, 5044.82343117991, 5095.490450954912, 5020.874478138039, 5046.09170349337, 5055.9241611375855, 5077.136886729265, 5101.642884998052, 4602.585767280961, 4622.583967442946, 4630.884227894329, 4649.581877527353, 4675.555822196886, 6115.602485838406, 6160.5071594272795, 6173.351798061184, 6205.596636218676, 6250.124982502453, 5791.88416231673, 5925.851853703649, 5958.433948774859, 5964.433378829048, 5993.6104153230335, 6563.901541476882, 6638.402543771083, 6653.733850645968, 6670.599764014126, 6684.699188536479, 4895.0454661341055, 5009.974950125263, 5073.594112471031, 5143.996920600484, 5151.896962060738, 6862.245153033163, 6923.065386172852, 7031.332023457763, 7051.801193797016, 7103.928960710378, 5320.52115309624, 5352.0, 5355.410904800468, 5355.678659280456, 5361.115415956324, 5400.4599540046465, 5411.350637923474, 5419.807642318684, 5428.050091234098, 5437.238786569884, 5958.433948774859, 5978.163057172, 5988.610740301867, 5994.610350327215, 6003.399660034049, 6738.663066846638, 6740.865182696417, 6782.152230971129, 6799.868196387446, 6821.386075253251, 1824.6806808808406, 1826.1873466307632, 1851.3520267906395, 1878.6806242938733, 1879.9718004229946, 1302.5180683147296, 1317.6244770240435, 1322.8346456692914, 1323.8411390633187, 1344.2270694350786, 6222.751089956441, 6274.905876411857, 6301.684915754194, 6371.490280777527, 6378.266499352541, 6637.6349300788925, 6665.500087493458, 6716.764913228014, 6726.831829204211, 6846.418054465326, 6207.720652570645, 6229.501639868799, 6271.895411771203, 6279.7488100476385, 6391.904121438182, 3566.1619519412916, 3567.6967457765863, 3578.570571531433, 3592.8383222754514, 3621.8370173342264, 7024.613646249403, 7060.505764596532, 7078.256783037707, 7146.531360338016, 7179.712811487482, 6867.553609015398, 6931.792046238621, 6960.443164546824, 6970.337817907291, 6980.975517100086, 7050.2597227292445, 7094.4679149062995, 7119.96440017807, 7134.92865071353, 7208.026916366223, 6655.800325990228, 6702.162229721285, 6722.386627209532, 6739.326067393222, 6798.116244888133, 6719.193696756225, 6730.697118629576, 6731.528792984444, 6746.69639866217, 6762.256151823197, 7034.437245020488, 7059.329363710439, 7071.797794375071, 7178.712851486091, 7200.783976480714, 5292.867678308073, 5329.360476742816, 5331.413544510178, 5334.386545547157, 5340.477963780304, 6533.314002029719, 6545.639989800607, 6786.93213067863, 6889.655517224019, 6909.654517274217, 6531.542792004514, 6551.344865513411, 6593.769218077345, 6628.204615446178, 6663.167104111986, 6516.771912983212, 6546.574472659262, 6548.80353589374, 6581.506387020897, 6610.272869984202, 6486.189226346707, 6499.707513162014, 6535.509836762167, 6563.9343606565235, 6594.8351291218105, 6643.335666433318, 6644.534882558174, 6696.129503164558, 6726.8990965136545, 6737.585107127362, 6437.485001199799, 6459.289478157493, 6496.870062598627, 6522.804315870531, 6531.379518945692], "value": 5256.097933036418, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [972.7081875437367, 987.7135630667107, 996.9551370188341, 1012.5392946209475, 1019.7756493571414, 21055.789442105575, 21137.894310528445, 21288.89355553222, 21453.463663408384, 21592.784072159255, 19642.0, 19683.704744428844, 19832.603347933033, 19947.900260498678, 20012.399628011182, 1043.6503771236644, 1061.3048453263125, 1065.9573617055328, 1066.1524088349743, 1073.4525392050073, 1083.7073990022689, 1090.8091084060297, 1091.1979694924225, 1097.9231453798238, 1101.867775866893, 1088.6516314779274, 1140.4411838199305, 1149.1840793036954, 1151.0561339701449, 1151.9827202591969, 1126.5606413498742, 1129.2095533126762, 1132.0264572467672, 1134.0587312530579, 1136.079775381939, 831.9084900660922, 832.5004997001811, 833.5623797506297, 834.0325222741651, 834.7913021744564, 19763.505912352164, 19874.503137421536, 19918.701219481718, 20059.1976320947, 21238.46903827417, 23542.411439713975, 24094.51810963771, 24119.517609647883, 24138.758612413825, 24163.7583624165, 18105.818941810547, 18147.364842230458, 18181.909090454596, 18234.0, 18335.358262460883, 4115.97942010291, 4142.523609784883, 4187.895302617429, 4190.224808410423, 4192.140611174702, 120028.0, 124898.0, 158553.20723396423, 160081.0, 161462.19268903698, 18757.81242187588, 18923.0, 19017.14422850975, 19139.712904306445, 19208.71186932197, 35011.64988350135, 35961.82019089888, 36055.0, 36385.45421818675, 36653.0, 10586.629467968583, 10596.841047384141, 10607.257491975643, 10607.734806629896, 10612.20408469368, 4855.6601037927, 4864.6594738368685, 4878.853634390903, 4880.463149053601, 4912.38595175603, 6405.19935008124, 6479.319671434431, 6483.610983341015, 6512.316206798313, 6519.4132528072705, 1255.604484587352, 1296.5915736542959, 1300.5318085489216, 1305.106002388367, 1311.3312210772383, 713.7930000299855, 724.1274264511251, 735.1141874041767, 739.098300073909, 746.115852714535, 13659.180449173082, 13709.491955884845, 14188.0, 15140.697186056217, 15326.463573774865, 728.6101935464607, 730.4412124724483, 733.6038539188778, 739.4010851210537, 743.605888878895, 6334.556581039283, 6362.650054247061, 6412.97991132801, 6516.511261655395, 6616.636085015274, 161170.0, 161703.0, 163187.0, 166198.16900915417, 166947.0, 128425.0, 129269.0, 133581.0, 134458.0, 136519.0, 115721.0, 116994.0, 117163.41418292854, 118836.40581797209, 119384.0, 11922.582709605469, 11934.940325298317, 11949.522019119486, 11983.520659173884, 12252.203606765532, 55981.720091399286, 56378.43621563732, 56696.433035670765, 56792.296231113134, 57725.422745772004, 73107.26892731218, 73454.0, 73516.0, 75101.24898751162, 75734.0, 16563.585910352336, 16812.159392030593, 16819.579510512336, 16874.746878797072, 17039.23323450423, 15722.292496837441, 15894.364225430852, 15979.840201597835, 16106.114163721108, 16109.436169734472, 17879.0, 17889.73165402546, 18015.81984180194, 18256.634867302313, 18257.726134107732, 16928.746068809225, 16962.575935601708, 17088.829111708725, 17123.315067397165, 17180.22688979024, 17784.644307113525, 18205.27178912829, 18243.270269189616, 18320.26718931228, 18418.631627367646, 13292.667683307995, 13368.532101376406, 13417.798733019208, 13459.730805383642, 13534.458621655023, 12428.375514275029, 12493.500259989498, 12606.180598261084, 12639.3680315982, 12671.80992285135], "value": 10086.863914485471, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1356.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 104.0, 105.0, 103.0, 105.0, 105.0, 103.0, 107.0, 106.0, 104.0], "value": 104.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 114.0, 117.0, 112.0, 111.0, 112.0, 133.0, 116.0, 110.0, 123.0], "value": 117.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 161.0, 159.0, 161.0, 161.0, 159.0, 165.0, 163.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 73.0, 74.0, 73.0, 74.0, 73.0, 73.0, 72.0, 73.0], "value": 73.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 80.0, 77.0, 77.0, 76.0, 77.0, 76.0, 80.0, 77.0, 77.0], "value": 77.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 114.0, 114.0, 114.0, 114.0, 110.0, 114.0, 111.0, 114.0, 114.0], "value": 112.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 148.0, 150.0, 150.0, 148.0, 148.0, 148.0, 148.0, 148.0, 148.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 93.0, 94.0, 93.0, 94.0, 94.0, 94.0, 95.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 46.0, 49.0, 44.0, 42.0, 45.0, 44.0, 43.0, 42.0, 43.0], "value": 44.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 44.0, 40.0, 39.0, 39.0, 39.0, 39.0, 39.0, 39.0, 40.0], "value": 39.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 68.0, 69.0, 74.0, 69.0, 69.0, 71.0, 70.0, 70.0], "value": 70.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 102.0, 103.0, 101.0, 108.0, 104.0, 101.0, 102.0, 116.0, 100.0], "value": 104.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 149.0, 145.0, 149.0, 148.0, 149.0, 152.0, 149.0, 154.0, 152.0], "value": 150.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 58.0, 57.0, 58.0, 57.0, 59.0, 58.0, 63.0, 58.0], "value": 58.8, "unit": "score"}]}]} 09:00:40 INFO - Return code: 0 09:00:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:00:40 INFO - # TBPL SUCCESS # 09:00:40 INFO - Running post-action listener: _package_coverage_data 09:00:40 INFO - Running post-action listener: _resource_record_post_action 09:00:40 INFO - [mozharness: 2017-10-04 16:00:40.577338Z] Finished run-tests step (success) 09:00:40 INFO - Running post-run listener: _resource_record_post_run 09:00:40 INFO - Total resource usage - Wall time: 1181s; CPU: 13.0%; Read bytes: 8192; Write bytes: 337965056; Read time: 140; Write time: 180428 09:00:40 INFO - TinderboxPrint: CPU usage
13.0% 09:00:40 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 140 09:00:40 INFO - TinderboxPrint: I/O write bytes / time
337,965,056 / 180,428 09:00:40 INFO - TinderboxPrint: CPU idle
8,188.5 (86.9%) 09:00:40 INFO - TinderboxPrint: CPU user
1,178.4 (12.5%) 09:00:40 INFO - TinderboxPrint: Swap in / out
0 / 0 09:00:40 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 58478592; Read time: 0; Write time: 35916 09:00:40 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:00:40 INFO - run-tests - Wall time: 1167s; CPU: 13.0%; Read bytes: 8192; Write bytes: 279486464; Read time: 140; Write time: 144512 09:00:41 INFO - Running post-run listener: _upload_blobber_files 09:00:41 INFO - Blob upload gear active. 09:00:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:00:41 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 09:00:41 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'] 09:00:41 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 09:00:41 INFO - (blobuploader) - INFO - Open directory for files ... 09:00:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:00:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:00:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:00:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:00:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:00:42 INFO - (blobuploader) - INFO - Done attempting. 09:00:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:00:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:00:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:00:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:00:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:00:43 INFO - (blobuploader) - INFO - Done attempting. 09:00:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:00:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:00:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:00:44 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:00:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:00:44 INFO - (blobuploader) - INFO - Done attempting. 09:00:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:00:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:00:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:00:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:00:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:00:51 INFO - (blobuploader) - INFO - Done attempting. 09:00:51 INFO - (blobuploader) - INFO - Iteration through files over. 09:00:51 INFO - Return code: 0 09:00:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:00:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:00:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/9445aa70d7c30c3e2ad33bc868a27d402a18f3f8a8624ad1779ccf2849748283622f65f26a2a015d7e8b0c3cb74e0c027e252dd045a5d4c866101c8b039f8278", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4dd4209e3da1b6564bf4a3af849a4675b49bc16b17054c1081155cb7bc2727cdbce7aafc8499f5d78498a590ffa218d6fb6a50d90f6d0a9f17523a42fb4f00a7", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3ca3eea3e269fe6a8957ac8e43ac565d100b3f83b30455edc202d778e3eff6e1f048dfa63a423853cc845c64830ddf26a6e6eebaa7f7f40a82472f810c5abcaf", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4f87db9f217ef0552f38a38f9362c2b83344e0a5d7522f2d201977252e7c9a2061c5085270391bbeccc4879d7ff5140284119c1cf0890e6d9f87c9cf932ed9c1"} 09:00:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:00:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:00:51 INFO - Contents: 09:00:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/9445aa70d7c30c3e2ad33bc868a27d402a18f3f8a8624ad1779ccf2849748283622f65f26a2a015d7e8b0c3cb74e0c027e252dd045a5d4c866101c8b039f8278", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4dd4209e3da1b6564bf4a3af849a4675b49bc16b17054c1081155cb7bc2727cdbce7aafc8499f5d78498a590ffa218d6fb6a50d90f6d0a9f17523a42fb4f00a7", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3ca3eea3e269fe6a8957ac8e43ac565d100b3f83b30455edc202d778e3eff6e1f048dfa63a423853cc845c64830ddf26a6e6eebaa7f7f40a82472f810c5abcaf", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4f87db9f217ef0552f38a38f9362c2b83344e0a5d7522f2d201977252e7c9a2061c5085270391bbeccc4879d7ff5140284119c1cf0890e6d9f87c9cf932ed9c1"} 09:00:51 INFO - Running post-run listener: copy_logs_to_upload_dir 09:00:51 INFO - Copying logs to upload dir... 09:00:51 INFO - mkdir: /builds/slave/test/build/upload/logs 09:00:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.244346 ========= master_lag: 0.32 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-10-04 09:00:51.414290) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-04 09:00:51.418685) ========= 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=781b77c4c33858b1f599d705000001c1-1507131384.967951-1166287135 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/9445aa70d7c30c3e2ad33bc868a27d402a18f3f8a8624ad1779ccf2849748283622f65f26a2a015d7e8b0c3cb74e0c027e252dd045a5d4c866101c8b039f8278", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4dd4209e3da1b6564bf4a3af849a4675b49bc16b17054c1081155cb7bc2727cdbce7aafc8499f5d78498a590ffa218d6fb6a50d90f6d0a9f17523a42fb4f00a7", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3ca3eea3e269fe6a8957ac8e43ac565d100b3f83b30455edc202d778e3eff6e1f048dfa63a423853cc845c64830ddf26a6e6eebaa7f7f40a82472f810c5abcaf", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4f87db9f217ef0552f38a38f9362c2b83344e0a5d7522f2d201977252e7c9a2061c5085270391bbeccc4879d7ff5140284119c1cf0890e6d9f87c9cf932ed9c1"} build_url:https://queue.taskcluster.net/v1/task/YSmRtkdFTqGjM3An2RSqaQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011341 build_url: 'https://queue.taskcluster.net/v1/task/YSmRtkdFTqGjM3An2RSqaQ/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/9445aa70d7c30c3e2ad33bc868a27d402a18f3f8a8624ad1779ccf2849748283622f65f26a2a015d7e8b0c3cb74e0c027e252dd045a5d4c866101c8b039f8278", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4dd4209e3da1b6564bf4a3af849a4675b49bc16b17054c1081155cb7bc2727cdbce7aafc8499f5d78498a590ffa218d6fb6a50d90f6d0a9f17523a42fb4f00a7", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3ca3eea3e269fe6a8957ac8e43ac565d100b3f83b30455edc202d778e3eff6e1f048dfa63a423853cc845c64830ddf26a6e6eebaa7f7f40a82472f810c5abcaf", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4f87db9f217ef0552f38a38f9362c2b83344e0a5d7522f2d201977252e7c9a2061c5085270391bbeccc4879d7ff5140284119c1cf0890e6d9f87c9cf932ed9c1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-04 09:00:51.450961) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 09:00:51.451380) ========= 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=781b77c4c33858b1f599d705000001c1-1507131384.967951-1166287135 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004513 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 09:00:51.533166) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-04 09:00:51.533527) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-04 09:00:51.533850) ========= ========= Total master_lag: 0.50 =========