builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-046 starttime: 1504958194.95 results: success (0) revision: 2a9cffb19ab58a7875aee5492c565c549c037511 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-09 04:56:34.950251) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-09 04:56:34.950712) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-09 04:56:34.950998) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-09 04:56:34.983625) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 04:56:34.984012) ========= 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=652eb03db935cfc1c15ebda0000001ad-1504958193.571302-813399221 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-09 04:56:35-- 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% 225M=0s 2017-09-09 04:56:35 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.195512 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 04:56:35.197062) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 04:56:35.197399) ========= 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=652eb03db935cfc1c15ebda0000001ad-1504958193.571302-813399221 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017840 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 04:56:35.250055) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 04:56:35.250551) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2a9cffb19ab58a7875aee5492c565c549c037511 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 2a9cffb19ab58a7875aee5492c565c549c037511 --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=652eb03db935cfc1c15ebda0000001ad-1504958193.571302-813399221 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-09 04:56:35,326 truncating revision to first 12 chars 2017-09-09 04:56:35,326 Setting DEBUG logging. 2017-09-09 04:56:35,326 attempt 1/10 2017-09-09 04:56:35,326 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2a9cffb19ab5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-09 04:56:35,750 unpacking tar archive at: mozilla-central-2a9cffb19ab5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.720875 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 04:56:35.988353) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-09 04:56:35.988708) ========= script_repo_revision: 2a9cffb19ab58a7875aee5492c565c549c037511 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-09 04:56:35.989094) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-09 04:56:35.989375) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-09 04:56:36.002735) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-09-09 04:56:36.003151) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=652eb03db935cfc1c15ebda0000001ad-1504958193.571302-813399221 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:56:36 INFO - MultiFileLogger online at 20170909 04:56:36 in /builds/slave/test 04:56:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:56:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:56:36 INFO - {'append_to_log': False, 04:56:36 INFO - 'base_work_dir': '/builds/slave/test', 04:56:36 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:56:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:56:36 INFO - 'branch': 'Firefox-Non-PGO', 04:56:36 INFO - 'buildbot_json_path': 'buildprops.json', 04:56:36 INFO - 'code_coverage': False, 04:56:36 INFO - 'config_files': ('talos/linux_config.py',), 04:56:36 INFO - 'default_actions': ('clobber', 04:56:36 INFO - 'read-buildbot-config', 04:56:36 INFO - 'download-and-extract', 04:56:36 INFO - 'populate-webroot', 04:56:36 INFO - 'create-virtualenv', 04:56:36 INFO - 'install', 04:56:36 INFO - 'setup-mitmproxy', 04:56:36 INFO - 'run-tests'), 04:56:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:56:36 INFO - 'disable_ccov_upload': False, 04:56:36 INFO - 'disable_stylo': False, 04:56:36 INFO - 'download_minidump_stackwalk': True, 04:56:36 INFO - 'download_symbols': 'ondemand', 04:56:36 INFO - 'enable_stylo': False, 04:56:36 INFO - 'enable_webrender': False, 04:56:36 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 04:56:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:56:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:56:36 INFO - 'gecko_profile': False, 04:56:36 INFO - 'gecko_profile_interval': 0, 04:56:36 INFO - 'installer_path': 'installer.exe', 04:56:36 INFO - 'log_level': 'info', 04:56:36 INFO - 'log_name': 'talos', 04:56:36 INFO - 'log_to_console': True, 04:56:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:56:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:56:36 INFO - 'opt_config_files': (), 04:56:36 INFO - 'pip_index': False, 04:56:36 INFO - 'suite': 'dromaeojs-e10s', 04:56:36 INFO - 'system_bits': '32', 04:56:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:56:36 INFO - 'title': 'talos-linux64-ix-046', 04:56:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:56:36 INFO - 'use_talos_json': True, 04:56:36 INFO - 'verify': 'False', 04:56:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:56:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:56:36 INFO - 'work_dir': 'build'} 04:56:36 INFO - [mozharness: 2017-09-09 11:56:36.325380Z] Running clobber step. 04:56:36 INFO - Running pre-action listener: _resource_record_pre_action 04:56:36 INFO - Running main action method: clobber 04:56:36 INFO - rmtree: /builds/slave/test/build 04:56:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:56:37 INFO - Running post-action listener: _resource_record_post_action 04:56:37 INFO - [mozharness: 2017-09-09 11:56:37.297285Z] Finished clobber step (success) 04:56:37 INFO - [mozharness: 2017-09-09 11:56:37.297449Z] Running read-buildbot-config step. 04:56:37 INFO - Running pre-action listener: _resource_record_pre_action 04:56:37 INFO - Running main action method: read_buildbot_config 04:56:37 INFO - Using buildbot properties: 04:56:37 INFO - { 04:56:37 INFO - "project": "", 04:56:37 INFO - "product": "firefox", 04:56:37 INFO - "who": "archaeopteryx@coole-files.de", 04:56:37 INFO - "installer_path": "public/build/target.tar.bz2", 04:56:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:56:37 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 04:56:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:56:37 INFO - "stage_platform": "linux64", 04:56:37 INFO - "basedir": "/builds/slave/test", 04:56:37 INFO - "buildnumber": 1128, 04:56:37 INFO - "platform": "ubuntu64_hw", 04:56:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:56:37 INFO - "slavebuilddir": "test", 04:56:37 INFO - "taskId": "CBHAYGz-TiuAQNuLyj9yAA", 04:56:37 INFO - "branch": "mozilla-central", 04:56:37 INFO - "script_repo_revision": "production", 04:56:37 INFO - "revision": "2a9cffb19ab58a7875aee5492c565c549c037511", 04:56:37 INFO - "slavename": "talos-linux64-ix-046", 04:56:37 INFO - "repo_path": "mozilla-central" 04:56:37 INFO - } 04:56:37 INFO - Finding installer, test and symbols from parent task. 04:56:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CBHAYGz-TiuAQNuLyj9yAA'}, attempt #1 04:56:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CBHAYGz-TiuAQNuLyj9yAA'}, attempt #1 04:56:38 INFO - Task dependencies: dkh--l4YT16D-V81XBCmig 04:56:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dkh--l4YT16D-V81XBCmig'}, attempt #1 04:56:38 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/dkh--l4YT16D-V81XBCmig/artifacts/public/build/target.tar.bz2 04:56:38 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/dkh--l4YT16D-V81XBCmig/artifacts/public/build/target.test_packages.json 04:56:38 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/dkh--l4YT16D-V81XBCmig/artifacts/public/build/target.crashreporter-symbols.zip 04:56:38 INFO - Running post-action listener: _resource_record_post_action 04:56:38 INFO - [mozharness: 2017-09-09 11:56:38.638082Z] Finished read-buildbot-config step (success) 04:56:38 INFO - [mozharness: 2017-09-09 11:56:38.638299Z] Running download-and-extract step. 04:56:38 INFO - Running pre-action listener: _resource_record_pre_action 04:56:38 INFO - Running main action method: download_and_extract 04:56:38 INFO - mkdir: /builds/slave/test/build/tests 04:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:38 INFO - trying https://queue.taskcluster.net/v1/task/dkh--l4YT16D-V81XBCmig/artifacts/public/build/target.test_packages.json 04:56:38 INFO - Downloading https://queue.taskcluster.net/v1/task/dkh--l4YT16D-V81XBCmig/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:56:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dkh--l4YT16D-V81XBCmig/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:56:39 INFO - Downloaded 989 bytes. 04:56:39 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:56:39 INFO - Using the following test package requirements: 04:56:39 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:56:39 INFO - u'common': [u'target.common.tests.zip'], 04:56:39 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:56:39 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:56:39 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:56:39 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:56:39 INFO - u'mozbase': [u'target.common.tests.zip'], 04:56:39 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:56:39 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:56:39 INFO - u'web-platform': [u'target.common.tests.zip', 04:56:39 INFO - u'target.web-platform.tests.tar.gz'], 04:56:39 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:56:39 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 04:56:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dkh--l4YT16D-V81XBCmig/artifacts/public/build/target.common.tests.zip 04:56:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dkh--l4YT16D-V81XBCmig/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:56:39 INFO - Fetch https://queue.taskcluster.net/v1/task/dkh--l4YT16D-V81XBCmig/artifacts/public/build/target.common.tests.zip into memory 04:56:40 INFO - Content-Length response header: 55024817 04:56:40 INFO - Bytes received: 55024817 04:56:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dkh--l4YT16D-V81XBCmig/artifacts/public/build/target.talos.tests.zip 04:56:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dkh--l4YT16D-V81XBCmig/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:56:52 INFO - Fetch https://queue.taskcluster.net/v1/task/dkh--l4YT16D-V81XBCmig/artifacts/public/build/target.talos.tests.zip into memory 04:56:53 INFO - Content-Length response header: 14497963 04:56:53 INFO - Bytes received: 14497963 04:56: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')]} 04:56:53 INFO - trying https://queue.taskcluster.net/v1/task/dkh--l4YT16D-V81XBCmig/artifacts/public/build/target.tar.bz2 04:56:53 INFO - Downloading https://queue.taskcluster.net/v1/task/dkh--l4YT16D-V81XBCmig/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:56:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dkh--l4YT16D-V81XBCmig/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:56:55 INFO - Downloaded 62941160 bytes. 04:56:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dkh--l4YT16D-V81XBCmig/artifacts/public/build/target.tar.bz2 04:56:55 INFO - mkdir: /builds/slave/test/properties 04:56:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:56:55 INFO - Writing to file /builds/slave/test/properties/build_url 04:56:55 INFO - Contents: 04:56:55 INFO - build_url:https://queue.taskcluster.net/v1/task/dkh--l4YT16D-V81XBCmig/artifacts/public/build/target.tar.bz2 04:56:55 INFO - Running post-action listener: _resource_record_post_action 04:56:55 INFO - Running post-action listener: find_tests_for_verification 04:56:55 INFO - Running post-action listener: set_extra_try_arguments 04:56:55 INFO - [mozharness: 2017-09-09 11:56:55.119455Z] Finished download-and-extract step (success) 04:56:55 INFO - [mozharness: 2017-09-09 11:56:55.119553Z] Running populate-webroot step. 04:56:55 INFO - Running pre-action listener: _resource_record_pre_action 04:56:55 INFO - Running main action method: populate_webroot 04:56:55 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:56:55 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:56:55 INFO - 'tests': ['tresize', 04:56:55 INFO - 'tcanvasmark']}, 04:56:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:56:55 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:56:55 INFO - 'tests': ['dromaeo_css', 04:56:55 INFO - 'kraken']}, 04:56:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:56:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:56:55 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:56:55 INFO - 'talos_options': ['--disable-stylo'], 04:56:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:56:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:56:55 INFO - 'tests': ['damp', 'tps']}, 04:56:55 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:56:55 INFO - 'talos_options': ['--disable-stylo'], 04:56:55 INFO - 'tests': ['damp', 'tps']}, 04:56:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:56:55 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:56:55 INFO - 'tests': ['dromaeo_dom']}, 04:56:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:56:55 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:56:55 INFO - 'tests': ['basic_compositor_video', 04:56:55 INFO - 'glvideo']}, 04:56:55 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 04:56:55 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 04:56:55 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:56:55 INFO - 'talos_options': ['--disable-stylo'], 04:56:55 INFO - 'tests': ['ts_paint_webext', 04:56:55 INFO - 'tp5o_webext']}, 04:56:55 INFO - 'other-e10s': {'tests': ['a11yr', 04:56:55 INFO - 'ts_paint', 04:56:55 INFO - 'tpaint', 04:56:55 INFO - 'sessionrestore', 04:56:55 INFO - 'sessionrestore_many_windows', 04:56:55 INFO - 'sessionrestore_no_auto_restore', 04:56:55 INFO - 'tabpaint']}, 04:56:55 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:56:55 INFO - 'tests': ['a11yr', 04:56:55 INFO - 'ts_paint', 04:56:55 INFO - 'tpaint', 04:56:55 INFO - 'sessionrestore', 04:56:55 INFO - 'sessionrestore_many_windows', 04:56:55 INFO - 'sessionrestore_no_auto_restore', 04:56:55 INFO - 'tabpaint']}, 04:56:55 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 04:56:55 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 04:56:55 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:56:55 INFO - 'tests': ['bloom_basic_singleton']}, 04:56:55 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:56:55 INFO - 'tests': ['bloom_basic']}, 04:56:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:56:55 INFO - 'tsvgr_opacity', 04:56:55 INFO - 'tart', 04:56:55 INFO - 'tscrollx', 04:56:55 INFO - 'tsvg_static']}, 04:56:55 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:56:55 INFO - 'tests': ['tsvgx', 04:56:55 INFO - 'tsvgr_opacity', 04:56:55 INFO - 'tart', 04:56:55 INFO - 'tscrollx', 04:56:55 INFO - 'tsvg_static']}, 04:56:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:56:55 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:56:55 INFO - 'talos_options': ['--disable-stylo'], 04:56:55 INFO - 'tests': ['tp5o']}, 04:56:55 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:56:55 INFO - 'talos_options': ['--mitmproxy', 04:56:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:56:55 INFO - '--firstNonBlankPaint'], 04:56:55 INFO - 'tests': ['tp6_google', 04:56:55 INFO - 'tp6_youtube', 04:56:55 INFO - 'tp6_amazon', 04:56:55 INFO - 'tp6_facebook']}, 04:56:55 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:56:55 INFO - 'talos_options': ['--disable-stylo', 04:56:55 INFO - '--mitmproxy', 04:56:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:56:55 INFO - '--firstNonBlankPaint'], 04:56:55 INFO - 'tests': ['tp6_google', 04:56:55 INFO - 'tp6_youtube', 04:56:55 INFO - 'tp6_amazon', 04:56:55 INFO - 'tp6_facebook']}, 04:56:55 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:56:55 INFO - 'talos_options': ['--stylo-threads=1', 04:56:55 INFO - '--mitmproxy', 04:56:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:56:55 INFO - '--firstNonBlankPaint'], 04:56:55 INFO - 'tests': ['tp6_google', 04:56:55 INFO - 'tp6_youtube', 04:56:55 INFO - 'tp6_amazon', 04:56:55 INFO - 'tp6_facebook']}, 04:56:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:56:55 INFO - 'talos_options': ['--xperf_path', 04:56:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:56:55 INFO - 'tests': ['tp5n']}, 04:56:55 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:56:55 INFO - 'talos_options': ['--disable-stylo', 04:56:55 INFO - '--xperf_path', 04:56:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:56:55 INFO - 'tests': ['tp5n']}}} 04:56:55 INFO - Running post-action listener: _resource_record_post_action 04:56:55 INFO - [mozharness: 2017-09-09 11:56:55.134415Z] Finished populate-webroot step (success) 04:56:55 INFO - [mozharness: 2017-09-09 11:56:55.134504Z] Running create-virtualenv step. 04:56:55 INFO - Running pre-action listener: _resource_record_pre_action 04:56:55 INFO - Running main action method: create_virtualenv 04:56:55 INFO - Creating virtualenv /builds/slave/test/build/venv 04:56:55 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:56:55 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 04:56:55 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 04:56:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:56:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:56:56 INFO - Installing distribute.............................................................................................................................................................................................done. 04:56:57 INFO - Installing pip...............done. 04:56:57 INFO - Return code: 0 04:56:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:56:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:56:57 INFO - Reading from file tmpfile_stdout 04:56:57 INFO - Output received: 04:56:57 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 04:56:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:56:57 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')]} 04:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:57 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')]} 04:56:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:57 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 0x9ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb97a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3e090>, '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 0xd3ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd38f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1504958193.571302-813399221', '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 04:56:57 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 04:56:57 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 04:56:57 INFO - Using env: {'DISPLAY': ':0', 04:56:57 INFO - 'HOME': '/home/cltbld', 04:56:57 INFO - 'LANG': 'en_US.UTF-8', 04:56:57 INFO - 'LANGUAGE': 'en_US:en', 04:56:57 INFO - 'LOGNAME': 'cltbld', 04:56:57 INFO - 'MAIL': '/var/mail/cltbld', 04:56:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:57 INFO - 'MOZ_NO_REMOTE': '1', 04:56:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:56:57 INFO - 'NO_EM_RESTART': '1', 04:56:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:56:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:57 INFO - 'PWD': '/builds/slave/test', 04:56:57 INFO - 'SHELL': '/bin/bash', 04:56:57 INFO - 'SHLVL': '1', 04:56:57 INFO - 'TERM': 'linux', 04:56:57 INFO - 'TMOUT': '86400', 04:56:57 INFO - 'USER': 'cltbld', 04:56:57 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1504958193.571302-813399221', 04:56:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:57 INFO - '_': '/tools/buildbot/bin/python'} 04:56:58 INFO - Ignoring indexes: http://pypi.python.org/simple/ 04:56:58 INFO - Downloading/unpacking pip>=1.5 04:56:58 INFO - Running setup.py egg_info for package pip 04:56:58 INFO - warning: no files found matching 'pip/cacert.pem' 04:56:58 INFO - warning: no files found matching '*.html' under directory 'docs' 04:56:58 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:56:58 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:56:58 INFO - Installing collected packages: pip 04:56:58 INFO - Found existing installation: pip 1.1 04:56:58 INFO - Uninstalling pip: 04:56:58 INFO - Successfully uninstalled pip 04:56:58 INFO - Running setup.py install for pip 04:56:58 INFO - warning: no files found matching 'pip/cacert.pem' 04:56:58 INFO - warning: no files found matching '*.html' under directory 'docs' 04:56:58 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:56:58 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:56:58 INFO - Installing pip script to /builds/slave/test/build/venv/bin 04:56:58 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 04:56:58 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 04:56:58 INFO - Successfully installed pip 04:56:58 INFO - Cleaning up... 04:56:58 INFO - Return code: 0 04:56:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:56: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')]} 04:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56: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')]} 04:56:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56: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', '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 0x9ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb97a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3e090>, '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 0xd3ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd38f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1504958193.571302-813399221', '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 04:56: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', 'psutil>=3.1.1'] in /builds/slave/test/build 04:56: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 psutil>=3.1.1 04:56:58 INFO - Using env: {'DISPLAY': ':0', 04:56:58 INFO - 'HOME': '/home/cltbld', 04:56:58 INFO - 'LANG': 'en_US.UTF-8', 04:56:58 INFO - 'LANGUAGE': 'en_US:en', 04:56:58 INFO - 'LOGNAME': 'cltbld', 04:56:58 INFO - 'MAIL': '/var/mail/cltbld', 04:56:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:58 INFO - 'MOZ_NO_REMOTE': '1', 04:56:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:56:58 INFO - 'NO_EM_RESTART': '1', 04:56:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:56:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:58 INFO - 'PWD': '/builds/slave/test', 04:56:58 INFO - 'SHELL': '/bin/bash', 04:56:58 INFO - 'SHLVL': '1', 04:56:58 INFO - 'TERM': 'linux', 04:56:58 INFO - 'TMOUT': '86400', 04:56:58 INFO - 'USER': 'cltbld', 04:56:58 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1504958193.571302-813399221', 04:56:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:58 INFO - '_': '/tools/buildbot/bin/python'} 04:56:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:58 INFO - Downloading/unpacking psutil>=3.1.1 04:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:57:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:57:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:57:00 INFO - Installing collected packages: psutil 04:57:00 INFO - Running setup.py install for psutil 04:57:00 INFO - building 'psutil._psutil_linux' extension 04:57:00 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 04:57:01 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 04:57:01 INFO - building 'psutil._psutil_posix' extension 04:57:01 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 04:57:01 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 04:57:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:57:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:57:02 INFO - Successfully installed psutil 04:57:02 INFO - Cleaning up... 04:57:02 INFO - Return code: 0 04:57:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:02 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 0x9ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb97a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3e090>, '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 0xd3ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd38f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1504958193.571302-813399221', '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 04:57:02 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 04:57:02 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 04:57:02 INFO - Using env: {'DISPLAY': ':0', 04:57:02 INFO - 'HOME': '/home/cltbld', 04:57:02 INFO - 'LANG': 'en_US.UTF-8', 04:57:02 INFO - 'LANGUAGE': 'en_US:en', 04:57:02 INFO - 'LOGNAME': 'cltbld', 04:57:02 INFO - 'MAIL': '/var/mail/cltbld', 04:57:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:02 INFO - 'MOZ_NO_REMOTE': '1', 04:57:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:02 INFO - 'NO_EM_RESTART': '1', 04:57:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:02 INFO - 'PWD': '/builds/slave/test', 04:57:02 INFO - 'SHELL': '/bin/bash', 04:57:02 INFO - 'SHLVL': '1', 04:57:02 INFO - 'TERM': 'linux', 04:57:02 INFO - 'TMOUT': '86400', 04:57:02 INFO - 'USER': 'cltbld', 04:57:02 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1504958193.571302-813399221', 04:57:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:02 INFO - '_': '/tools/buildbot/bin/python'} 04:57:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:57:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:57:03 INFO - Installing collected packages: mozsystemmonitor 04:57:03 INFO - Running setup.py install for mozsystemmonitor 04:57:03 INFO - Successfully installed mozsystemmonitor 04:57:03 INFO - Cleaning up... 04:57:03 INFO - Return code: 0 04:57:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:57:03 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')]} 04:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:03 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')]} 04:57:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:03 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 0x9ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb97a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3e090>, '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 0xd3ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd38f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1504958193.571302-813399221', '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 04:57:03 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 04:57:03 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 04:57:03 INFO - Using env: {'DISPLAY': ':0', 04:57:03 INFO - 'HOME': '/home/cltbld', 04:57:03 INFO - 'LANG': 'en_US.UTF-8', 04:57:03 INFO - 'LANGUAGE': 'en_US:en', 04:57:03 INFO - 'LOGNAME': 'cltbld', 04:57:03 INFO - 'MAIL': '/var/mail/cltbld', 04:57:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:03 INFO - 'MOZ_NO_REMOTE': '1', 04:57:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:03 INFO - 'NO_EM_RESTART': '1', 04:57:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:03 INFO - 'PWD': '/builds/slave/test', 04:57:03 INFO - 'SHELL': '/bin/bash', 04:57:03 INFO - 'SHLVL': '1', 04:57:03 INFO - 'TERM': 'linux', 04:57:03 INFO - 'TMOUT': '86400', 04:57:03 INFO - 'USER': 'cltbld', 04:57:03 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1504958193.571302-813399221', 04:57:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:03 INFO - '_': '/tools/buildbot/bin/python'} 04:57:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:04 INFO - Downloading/unpacking jsonschema==2.5.1 04:57:04 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 04:57:04 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 04:57:04 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 04:57:04 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 04:57:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:57:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:05 INFO - Downloading functools32-3.2.3-2.tar.gz 04:57:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:57:05 INFO - warning: no files found matching '*.txt' 04:57:05 INFO - no previously-included directories found matching 'build' 04:57:05 INFO - no previously-included directories found matching 'dist' 04:57:05 INFO - no previously-included directories found matching '.git*' 04:57:05 INFO - Installing collected packages: jsonschema, functools32 04:57:05 INFO - Running setup.py install for functools32 04:57:05 INFO - warning: no files found matching '*.txt' 04:57:05 INFO - no previously-included directories found matching 'build' 04:57:05 INFO - no previously-included directories found matching 'dist' 04:57:05 INFO - no previously-included directories found matching '.git*' 04:57:05 INFO - Successfully installed jsonschema functools32 04:57:05 INFO - Cleaning up... 04:57:05 INFO - Return code: 0 04:57:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:57:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:05 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 0x9ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb97a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3e090>, '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 0xd3ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd38f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1504958193.571302-813399221', '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 04:57:05 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 04:57:05 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 04:57:05 INFO - Using env: {'DISPLAY': ':0', 04:57:05 INFO - 'HOME': '/home/cltbld', 04:57:05 INFO - 'LANG': 'en_US.UTF-8', 04:57:05 INFO - 'LANGUAGE': 'en_US:en', 04:57:05 INFO - 'LOGNAME': 'cltbld', 04:57:05 INFO - 'MAIL': '/var/mail/cltbld', 04:57:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:05 INFO - 'MOZ_NO_REMOTE': '1', 04:57:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:05 INFO - 'NO_EM_RESTART': '1', 04:57:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:05 INFO - 'PWD': '/builds/slave/test', 04:57:05 INFO - 'SHELL': '/bin/bash', 04:57:05 INFO - 'SHLVL': '1', 04:57:05 INFO - 'TERM': 'linux', 04:57:05 INFO - 'TMOUT': '86400', 04:57:05 INFO - 'USER': 'cltbld', 04:57:05 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1504958193.571302-813399221', 04:57:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:05 INFO - '_': '/tools/buildbot/bin/python'} 04:57:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:57:05 INFO - Cleaning up... 04:57:05 INFO - Return code: 0 04:57:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:57:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:05 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 0x9ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb97a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3e090>, '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 0xd3ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd38f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1504958193.571302-813399221', '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 04:57:05 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 04:57:05 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 04:57:05 INFO - Using env: {'DISPLAY': ':0', 04:57:05 INFO - 'HOME': '/home/cltbld', 04:57:05 INFO - 'LANG': 'en_US.UTF-8', 04:57:05 INFO - 'LANGUAGE': 'en_US:en', 04:57:05 INFO - 'LOGNAME': 'cltbld', 04:57:05 INFO - 'MAIL': '/var/mail/cltbld', 04:57:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:05 INFO - 'MOZ_NO_REMOTE': '1', 04:57:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:05 INFO - 'NO_EM_RESTART': '1', 04:57:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:05 INFO - 'PWD': '/builds/slave/test', 04:57:05 INFO - 'SHELL': '/bin/bash', 04:57:05 INFO - 'SHLVL': '1', 04:57:05 INFO - 'TERM': 'linux', 04:57:05 INFO - 'TMOUT': '86400', 04:57:05 INFO - 'USER': 'cltbld', 04:57:05 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1504958193.571302-813399221', 04:57:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:05 INFO - '_': '/tools/buildbot/bin/python'} 04:57:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:06 INFO - Downloading/unpacking blobuploader==1.2.4 04:57:06 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 04:57:06 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 04:57:06 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 04:57:06 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 04:57:07 INFO - Downloading blobuploader-1.2.4.tar.gz 04:57:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:57:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:57:07 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 04:57:07 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 04:57:07 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 04:57:07 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 04:57:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:57:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:57:08 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 04:57:08 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 04:57:08 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 04:57:08 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 04:57:08 INFO - Downloading docopt-0.6.1.tar.gz 04:57:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:57:08 INFO - Installing collected packages: blobuploader, requests, docopt 04:57:08 INFO - Running setup.py install for blobuploader 04:57:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:57:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:57:08 INFO - Running setup.py install for requests 04:57:08 INFO - Running setup.py install for docopt 04:57:09 INFO - Successfully installed blobuploader requests docopt 04:57:09 INFO - Cleaning up... 04:57:09 INFO - Return code: 0 04:57:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:57:09 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')]} 04:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:09 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')]} 04:57:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:09 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 0x9ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb97a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3e090>, '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 0xd3ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd38f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1504958193.571302-813399221', '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 04:57:09 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 04:57:09 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 04:57:09 INFO - Using env: {'DISPLAY': ':0', 04:57:09 INFO - 'HOME': '/home/cltbld', 04:57:09 INFO - 'LANG': 'en_US.UTF-8', 04:57:09 INFO - 'LANGUAGE': 'en_US:en', 04:57:09 INFO - 'LOGNAME': 'cltbld', 04:57:09 INFO - 'MAIL': '/var/mail/cltbld', 04:57:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:09 INFO - 'MOZ_NO_REMOTE': '1', 04:57:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:09 INFO - 'NO_EM_RESTART': '1', 04:57:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:09 INFO - 'PWD': '/builds/slave/test', 04:57:09 INFO - 'SHELL': '/bin/bash', 04:57:09 INFO - 'SHLVL': '1', 04:57:09 INFO - 'TERM': 'linux', 04:57:09 INFO - 'TMOUT': '86400', 04:57:09 INFO - 'USER': 'cltbld', 04:57:09 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1504958193.571302-813399221', 04:57:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:09 INFO - '_': '/tools/buildbot/bin/python'} 04:57:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:57:09 INFO - Running setup.py (path:/tmp/pip-Q6N20E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:57:09 INFO - Running setup.py (path:/tmp/pip-hrEKh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:57:09 INFO - Running setup.py (path:/tmp/pip-LJdM3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:57:09 INFO - Running setup.py (path:/tmp/pip-erQUZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:57:09 INFO - Running setup.py (path:/tmp/pip-WzbbiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:57:09 INFO - Running setup.py (path:/tmp/pip-QmX9gA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:57:09 INFO - Running setup.py (path:/tmp/pip-bHACjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:57:09 INFO - Running setup.py (path:/tmp/pip-GIvtFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:57:10 INFO - Running setup.py (path:/tmp/pip-aP1Jit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:57:10 INFO - Running setup.py (path:/tmp/pip-SMkjEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:57:10 INFO - Running setup.py (path:/tmp/pip-_YMm37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:57:10 INFO - Running setup.py (path:/tmp/pip-8cfMS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:57:10 INFO - Running setup.py (path:/tmp/pip-xmpDK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:57:10 INFO - Running setup.py (path:/tmp/pip-BNwsuh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:57:10 INFO - Running setup.py (path:/tmp/pip-PTUcJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:57:10 INFO - Running setup.py (path:/tmp/pip-20LsQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:57:10 INFO - Running setup.py (path:/tmp/pip-h4S20e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:57:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:57:10 INFO - Running setup.py install for manifestparser 04:57:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:57:10 INFO - Running setup.py install for mozcrash 04:57:10 INFO - Running setup.py install for mozdebug 04:57:10 INFO - Running setup.py install for mozdevice 04:57:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:57:10 INFO - Running setup.py install for mozfile 04:57:11 INFO - Running setup.py install for mozhttpd 04:57:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:57:11 INFO - Running setup.py install for mozinfo 04:57:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:57:11 INFO - Running setup.py install for mozInstall 04:57:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:57:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:57:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:57:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:57:11 INFO - Running setup.py install for mozleak 04:57:11 INFO - Running setup.py install for mozlog 04:57:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:57:11 INFO - Running setup.py install for moznetwork 04:57:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:57:11 INFO - Running setup.py install for mozprocess 04:57:11 INFO - Running setup.py install for mozprofile 04:57:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:57:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:57:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:57:11 INFO - Running setup.py install for mozrunner 04:57:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:57:11 INFO - Running setup.py install for mozscreenshot 04:57:12 INFO - Running setup.py install for moztest 04:57:12 INFO - Running setup.py install for mozversion 04:57:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:57:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:57:12 INFO - Cleaning up... 04:57:12 INFO - Return code: 0 04:57:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:57:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:12 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 0x9ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb97a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3e090>, '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 0xd3ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd38f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1504958193.571302-813399221', '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 04:57:12 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 04:57:12 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 04:57:12 INFO - Using env: {'DISPLAY': ':0', 04:57:12 INFO - 'HOME': '/home/cltbld', 04:57:12 INFO - 'LANG': 'en_US.UTF-8', 04:57:12 INFO - 'LANGUAGE': 'en_US:en', 04:57:12 INFO - 'LOGNAME': 'cltbld', 04:57:12 INFO - 'MAIL': '/var/mail/cltbld', 04:57:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:12 INFO - 'MOZ_NO_REMOTE': '1', 04:57:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:12 INFO - 'NO_EM_RESTART': '1', 04:57:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:12 INFO - 'PWD': '/builds/slave/test', 04:57:12 INFO - 'SHELL': '/bin/bash', 04:57:12 INFO - 'SHLVL': '1', 04:57:12 INFO - 'TERM': 'linux', 04:57:12 INFO - 'TMOUT': '86400', 04:57:12 INFO - 'USER': 'cltbld', 04:57:12 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1504958193.571302-813399221', 04:57:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:12 INFO - '_': '/tools/buildbot/bin/python'} 04:57:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:57:12 INFO - Running setup.py (path:/tmp/pip-0RFnca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:57:12 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)) 04:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:57:12 INFO - Running setup.py (path:/tmp/pip-MMRRYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:57:12 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)) 04:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:57:12 INFO - Running setup.py (path:/tmp/pip-d76BMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:57:12 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)) 04:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:57:12 INFO - Running setup.py (path:/tmp/pip-gOj6MZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:57:12 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)) 04:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:57:12 INFO - Running setup.py (path:/tmp/pip-ifrxBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:57:12 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)) 04:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:57:12 INFO - Running setup.py (path:/tmp/pip-QlkJSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:57:12 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)) 04:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:57:12 INFO - Running setup.py (path:/tmp/pip-fsySzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:57:12 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)) 04:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:57:12 INFO - Running setup.py (path:/tmp/pip-r2YYtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:57:13 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)) 04:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:57:13 INFO - Running setup.py (path:/tmp/pip-eyCffV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:57:13 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)) 04:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:57:13 INFO - Running setup.py (path:/tmp/pip-_m5F27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:57:13 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)) 04:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:57:13 INFO - Running setup.py (path:/tmp/pip-wlMwre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:57:13 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)) 04:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:57:13 INFO - Running setup.py (path:/tmp/pip-QMzRDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:57:13 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)) 04:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:57:13 INFO - Running setup.py (path:/tmp/pip-GY6Za2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:57:13 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)) 04:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:57:13 INFO - Running setup.py (path:/tmp/pip-isaxrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:57:13 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)) 04:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:57:13 INFO - Running setup.py (path:/tmp/pip-RJatOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:57:13 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)) 04:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:57:13 INFO - Running setup.py (path:/tmp/pip-rHHIv6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:57:13 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)) 04:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:57:13 INFO - Running setup.py (path:/tmp/pip-tolU3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:57:13 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)) 04:57:13 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)) 04:57:13 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)) 04:57:13 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)) 04:57:13 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)) 04:57:13 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)) 04:57:13 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)) 04:57:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:57:13 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 04:57:13 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 04:57:13 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 04:57:13 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 04:57:14 INFO - Downloading blessings-1.6.tar.gz 04:57:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:57:14 INFO - Installing collected packages: blessings 04:57:14 INFO - Running setup.py install for blessings 04:57:15 INFO - Successfully installed blessings 04:57:15 INFO - Cleaning up... 04:57:15 INFO - Return code: 0 04:57:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:57:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:57:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:57:15 INFO - Reading from file tmpfile_stdout 04:57:15 INFO - Current package versions: 04:57:15 INFO - argparse == 1.2.1 04:57:15 INFO - blessings == 1.6 04:57:15 INFO - blobuploader == 1.2.4 04:57:15 INFO - docopt == 0.6.1 04:57:15 INFO - functools32 == 3.2.3-2 04:57:15 INFO - jsonschema == 2.5.1 04:57:15 INFO - manifestparser == 1.1 04:57:15 INFO - mozInstall == 1.13 04:57:15 INFO - mozcrash == 1.0 04:57:15 INFO - mozdebug == 0.1 04:57:15 INFO - mozdevice == 0.51 04:57:15 INFO - mozfile == 1.2 04:57:15 INFO - mozhttpd == 0.7 04:57:15 INFO - mozinfo == 0.10 04:57:15 INFO - mozleak == 0.1 04:57:15 INFO - mozlog == 3.5 04:57:15 INFO - moznetwork == 0.27 04:57:15 INFO - mozprocess == 0.25 04:57:15 INFO - mozprofile == 0.28 04:57:15 INFO - mozrunner == 6.13 04:57:15 INFO - mozscreenshot == 0.1 04:57:15 INFO - mozsystemmonitor == 0.3 04:57:15 INFO - moztest == 0.8 04:57:15 INFO - mozversion == 1.4 04:57:15 INFO - psutil == 3.1.1 04:57:15 INFO - requests == 1.2.3 04:57:15 INFO - wsgiref == 0.1.2 04:57:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:57:15 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')]} 04:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:15 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')]} 04:57:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:15 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 0x9ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb97a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3e090>, '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 0xd3ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd38f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1504958193.571302-813399221', '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 04:57:15 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 04:57:15 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 04:57:15 INFO - Using env: {'DISPLAY': ':0', 04:57:15 INFO - 'HOME': '/home/cltbld', 04:57:15 INFO - 'LANG': 'en_US.UTF-8', 04:57:15 INFO - 'LANGUAGE': 'en_US:en', 04:57:15 INFO - 'LOGNAME': 'cltbld', 04:57:15 INFO - 'MAIL': '/var/mail/cltbld', 04:57:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:15 INFO - 'MOZ_NO_REMOTE': '1', 04:57:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:15 INFO - 'NO_EM_RESTART': '1', 04:57:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:15 INFO - 'PWD': '/builds/slave/test', 04:57:15 INFO - 'SHELL': '/bin/bash', 04:57:15 INFO - 'SHLVL': '1', 04:57:15 INFO - 'TERM': 'linux', 04:57:15 INFO - 'TMOUT': '86400', 04:57:15 INFO - 'USER': 'cltbld', 04:57:15 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1504958193.571302-813399221', 04:57:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:15 INFO - '_': '/tools/buildbot/bin/python'} 04:57:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:15 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)) 04:57:15 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)) 04:57:15 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)) 04:57:15 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)) 04:57:15 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)) 04:57:15 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)) 04:57:15 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)) 04:57:15 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)) 04:57:15 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)) 04:57:15 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:57:15 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 04:57:15 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 04:57:15 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 04:57:15 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 04:57:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 04:57:16 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)) 04:57:16 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)) 04:57:16 INFO - Installing collected packages: simplejson 04:57:16 INFO - Running setup.py install for simplejson 04:57:16 INFO - building 'simplejson._speedups' extension 04:57:16 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 04:57:17 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 04:57:17 INFO - Successfully installed simplejson 04:57:17 INFO - Cleaning up... 04:57:17 INFO - Return code: 0 04:57:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:57:17 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')]} 04:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:17 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')]} 04:57:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:17 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 0x9ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb97a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3e090>, '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 0xd3ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd38f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1504958193.571302-813399221', '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 04:57:17 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 04:57:17 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 04:57:17 INFO - Using env: {'DISPLAY': ':0', 04:57:17 INFO - 'HOME': '/home/cltbld', 04:57:17 INFO - 'LANG': 'en_US.UTF-8', 04:57:17 INFO - 'LANGUAGE': 'en_US:en', 04:57:17 INFO - 'LOGNAME': 'cltbld', 04:57:17 INFO - 'MAIL': '/var/mail/cltbld', 04:57:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:17 INFO - 'MOZ_NO_REMOTE': '1', 04:57:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:17 INFO - 'NO_EM_RESTART': '1', 04:57:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:17 INFO - 'PWD': '/builds/slave/test', 04:57:17 INFO - 'SHELL': '/bin/bash', 04:57:17 INFO - 'SHLVL': '1', 04:57:17 INFO - 'TERM': 'linux', 04:57:17 INFO - 'TMOUT': '86400', 04:57:17 INFO - 'USER': 'cltbld', 04:57:17 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1504958193.571302-813399221', 04:57:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:17 INFO - '_': '/tools/buildbot/bin/python'} 04:57:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:57:18 INFO - Cleaning up... 04:57:18 INFO - Return code: 0 04:57:18 INFO - Running post-action listener: _resource_record_post_action 04:57:18 INFO - Running post-action listener: _start_resource_monitoring 04:57:18 INFO - Starting resource monitoring. 04:57:18 INFO - [mozharness: 2017-09-09 11:57:18.055175Z] Finished create-virtualenv step (success) 04:57:18 INFO - [mozharness: 2017-09-09 11:57:18.056157Z] Running install step. 04:57:18 INFO - Running pre-action listener: _resource_record_pre_action 04:57:18 INFO - Running main action method: install 04:57:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:57:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:57:18 INFO - Reading from file tmpfile_stdout 04:57:18 INFO - Detecting whether we're running mozinstall >=1.0... 04:57:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:57:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:57:18 INFO - Reading from file tmpfile_stdout 04:57:18 INFO - Output received: 04:57:18 INFO - Usage: mozinstall [options] installer 04:57:18 INFO - Options: 04:57:18 INFO - -h, --help show this help message and exit 04:57:18 INFO - -d DEST, --destination=DEST 04:57:18 INFO - Directory to install application into. [default: 04:57:18 INFO - "/builds/slave/test"] 04:57:18 INFO - --app=APP Application being installed. [default: firefox] 04:57:18 INFO - mkdir: /builds/slave/test/build/application 04:57:18 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'] 04:57:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:57:34 INFO - Reading from file tmpfile_stdout 04:57:34 INFO - Output received: 04:57:34 INFO - /builds/slave/test/build/application/firefox/firefox 04:57:34 INFO - Running post-action listener: _resource_record_post_action 04:57:34 INFO - [mozharness: 2017-09-09 11:57:34.971239Z] Finished install step (success) 04:57:34 INFO - [mozharness: 2017-09-09 11:57:34.971489Z] Running setup-mitmproxy step. 04:57:34 INFO - Running pre-action listener: _resource_record_pre_action 04:57:34 INFO - Running main action method: setup_mitmproxy 04:57:34 INFO - Skipping: mitmproxy is not required 04:57:34 INFO - Running post-action listener: _resource_record_post_action 04:57:34 INFO - [mozharness: 2017-09-09 11:57:34.972620Z] Finished setup-mitmproxy step (success) 04:57:34 INFO - [mozharness: 2017-09-09 11:57:34.972841Z] Running run-tests step. 04:57:34 INFO - Running pre-action listener: _resource_record_pre_action 04:57:34 INFO - Running pre-action listener: _set_gcov_prefix 04:57:34 INFO - Running main action method: run_tests 04:57:34 WARNING - Try message not found. 04:57:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:57:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:57:34 INFO - Python 2.7.3 04:57:34 INFO - Return code: 0 04:57:34 INFO - grabbing minidump binary from tooltool 04:57:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:34 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 0xd3e090>, '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 0xd3ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd38f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:57:34 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 04:57:34 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 04:57:34 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 04:57:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:57:35 INFO - Return code: 0 04:57:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:57:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:57:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:57:35 INFO - ENV: RUST_BACKTRACE is now full 04:57:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:57:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:57:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dkh--l4YT16D-V81XBCmig/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 04:57:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dkh--l4YT16D-V81XBCmig/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 04:57:35 INFO - Using env: {'DISPLAY': ':0', 04:57:35 INFO - 'HOME': '/home/cltbld', 04:57:35 INFO - 'LANG': 'en_US.UTF-8', 04:57:35 INFO - 'LANGUAGE': 'en_US:en', 04:57:35 INFO - 'LOGNAME': 'cltbld', 04:57:35 INFO - 'MAIL': '/var/mail/cltbld', 04:57:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:57:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:57:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:35 INFO - 'MOZ_NO_REMOTE': '1', 04:57:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:57:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:35 INFO - 'NO_EM_RESTART': '1', 04:57:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:35 INFO - 'PWD': '/builds/slave/test', 04:57:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:57:35 INFO - 'RUST_BACKTRACE': 'full', 04:57:35 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:57:35 INFO - 'SHELL': '/bin/bash', 04:57:35 INFO - 'SHLVL': '1', 04:57:35 INFO - 'TERM': 'linux', 04:57:35 INFO - 'TMOUT': '86400', 04:57:35 INFO - 'USER': 'cltbld', 04:57:35 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1504958193.571302-813399221', 04:57:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:35 INFO - '_': '/tools/buildbot/bin/python'} 04:57:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dkh--l4YT16D-V81XBCmig/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 04:57:35 INFO - mozversion application_buildid: 20170909110058 04:57:35 INFO - mozversion application_changeset: 2a9cffb19ab58a7875aee5492c565c549c037511 04:57:35 INFO - mozversion application_display_name: Nightly 04:57:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:57:35 INFO - mozversion application_name: Firefox 04:57:35 INFO - mozversion application_remotingname: firefox 04:57:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:57:35 INFO - mozversion application_vendor: Mozilla 04:57:35 INFO - mozversion application_version: 57.0a1 04:57:35 INFO - mozversion platform_buildid: 20170909110058 04:57:35 INFO - mozversion platform_changeset: 2a9cffb19ab58a7875aee5492c565c549c037511 04:57:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:57:35 INFO - mozversion platform_version: 57.0a1 04:57:35 INFO - using testdate: 1504958255 04:57:35 INFO - actual date: 1504958255 04:57:35 INFO - starting webserver on 'localhost:45344' 04:57:35 INFO - SUITE-START | Running 2 tests 04:57:35 INFO - TEST-START | dromaeo_css 04:57:35 INFO - Initialising browser for dromaeo_css test... 04:57:35 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45344/getInfo.html -profile /tmp/tmpWCjHeF/profile 04:57:35 INFO - TEST-INFO | started process 3525 (/builds/slave/test/build/application/firefox/firefox http://localhost:45344/getInfo.html) 04:57:43 INFO - TEST-INFO | 3525: exit 0 04:57:43 INFO - Browser initialized. 04:57:43 INFO - Running cycle 1/1 for dromaeo_css test... 04:57:43 INFO - Using env: {'DISPLAY': ':0', 04:57:43 INFO - 'HOME': '/home/cltbld', 04:57:43 INFO - 'JSGC_DISABLE_POISONING': '1', 04:57:43 INFO - 'LANG': 'en_US.UTF-8', 04:57:43 INFO - 'LANGUAGE': 'en_US:en', 04:57:43 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:57:43 INFO - 'LOGNAME': 'cltbld', 04:57:43 INFO - 'MAIL': '/var/mail/cltbld', 04:57:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:57:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:57:43 INFO - 'MOZ_CRASHREPORTER': '1', 04:57:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:43 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:57:43 INFO - 'MOZ_NO_REMOTE': '1', 04:57:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:57:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:43 INFO - 'NO_EM_RESTART': '1', 04:57:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:43 INFO - 'PWD': '/builds/slave/test', 04:57:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:57:43 INFO - 'RUST_BACKTRACE': 'full', 04:57:43 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:57:43 INFO - 'SHELL': '/bin/bash', 04:57:43 INFO - 'SHLVL': '1', 04:57:43 INFO - 'TERM': 'linux', 04:57:43 INFO - 'TMOUT': '86400', 04:57:43 INFO - 'USER': 'cltbld', 04:57:43 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1504958193.571302-813399221', 04:57:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:43 INFO - '_': '/tools/buildbot/bin/python'} 04:57:43 INFO - TEST-INFO | started process 3720 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWCjHeF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:57:44 INFO - PID 3720 | 04:57:44 INFO - PID 3720 | (/builds/slave/test/build/application/firefox/firefox:3771): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:57:44 INFO - PID 3720 | 04:57:54 INFO - PID 3720 | RSS: Main: 173608960 04:57:54 INFO - PID 3720 | 05:00:51 INFO - PID 3720 | Cycle 1(1): loaded http://localhost:45344/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45344/tests/dromaeo/cssquery-ext.html) 05:00:52 INFO - PID 3720 | RSS: Main: 175620096 05:00:52 INFO - PID 3720 | 05:03:54 INFO - PID 3720 | Cycle 1(1): loaded http://localhost:45344/tests/dromaeo/cssquery-ext.html (next: http://localhost:45344/tests/dromaeo/cssquery-jquery.html) 05:03:55 INFO - PID 3720 | RSS: Main: 172302336 05:03:55 INFO - PID 3720 | 05:06:56 INFO - PID 3720 | Cycle 1(1): loaded http://localhost:45344/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45344/tests/dromaeo/cssquery-mootools.html) 05:06:57 INFO - PID 3720 | RSS: Main: 174985216 05:06:57 INFO - PID 3720 | 05:09:59 INFO - PID 3720 | Cycle 1(1): loaded http://localhost:45344/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45344/tests/dromaeo/cssquery-prototype.html) 05:09:59 INFO - PID 3720 | RSS: Main: 171048960 05:09:59 INFO - PID 3720 | 05:13:02 INFO - PID 3720 | Cycle 1(1): loaded http://localhost:45344/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45344/tests/dromaeo/cssquery-yui.html) 05:13:03 INFO - PID 3720 | RSS: Main: 174985216 05:13:03 INFO - PID 3720 | 05:16:05 INFO - PID 3720 | Cycle 1(1): loaded http://localhost:45344/tests/dromaeo/cssquery-yui.html (next: http://localhost:45344/tests/dromaeo/cssquery-dojo.html) 05:16:05 INFO - PID 3720 | RSS: Main: 176832512 05:16:05 INFO - PID 3720 | 05:16:05 INFO - PID 3720 | __start_tp_report 05:16:05 INFO - PID 3720 | _x_x_mozilla_page_load 05:16:05 INFO - PID 3720 | _x_x_mozilla_page_load_details 05:16:05 INFO - PID 3720 | |i|pagename|runs| 05:16:05 INFO - PID 3720 | |0;dojo.html;3116.4234616595922;3127.6403213630438;3138.3880143372053;3140.262038420971;3141.795783274087;6166.136740856273;6193.194884664998;6240.251169859617;6313.116163737075;6395.29651738309;6247.937520624792;6270.561060725751;6270.5924114932495;6317.147185130006;6318.5892916960365;5774.913376299338;5830.4169583041785;5834.854128646796;5839.240898683165;5891.05743081105;45.65620019813064;5800.564957628174;5858.502027327682;5894.3810899855325;5899.675517846516;5425.37608175059;5714.685692286944;5725.971370143144;5843.3864444233595;5864.853378665525;5740.08158694611;5762.798302059449;5819.592628516006;5848.5321174305955;5854.443827836349;5755.539556835443;5755.539556835443;5840;5846.912296315559;5852.12218167274;6214.906776398358;6288.685565721741;6309;6372.107904893319;6399.77600783975;6547.738090476375;6638.4689224861895;6650.900236496456;6807.659617019179;6817.5909445433435;6861.828454288683;6876.828079298008;6878.037074809531;6913.5506192097855;6935.618540980244;6139.815805525796;6203.720832562545;6292.056191571255;6300.653464059475;6377;7018.543794653382;7048.295170482911;7072.0099186113985;7074.22183559808;7088.0431141796225;6684.2647308795995;6690;6709.959956206796;6738.59568425896;6758.087658166183;6700.430463410567;6739.359760822714;6741.898871516931;6778.084958530634;6843.657817109125;6738.427233685094;6743;6752.797416077526;6759.053732477457;6770.898436523456;6679.56582822115;6694.263631000586;6717.059611654372;6719.025741267489;6793.048973143764;5257.710825904535;5267.868303292448;5320.893582128413;5320.973395133077;5333.280007199056;4610.677252592353;4624.606908412756;4655.906881862344;4670.136024835417;4703.811847526129;5617.466340697627;5693.800716974886;5814.9709251454315;5815.302163740378;5863.912041319383;6840.281770414134;6841.62371069586;6846.657667116624;6848.280930502325;6868.7252509900045;5825.98045342072;5852.063669812895;5923.437273459014;5928.377520360386;5931.851703707355;5812.796552120655;5859.648421094748;5917.201177841022;5926.61477004002;5928.584999050025;6422.42198202164;6512.120863683437;6574.704138313788;6641.435477984425;6657.46740260778;6770.52606317553;6795;6888.448924085961;6889.414399775975;6893.517453778188;6442.581232219891;6537.771178008747;6603.306652801387;6609.041688955171;6620.966895165493;6492.772752953624;6617.272100069084;6621.5364924454825;6686.1642294713165;6769.323067693192;6753.459723222032;6789.626570538668;6790.015447760146;6793.966030169818;6852.486063545353;6331.145295385249;6511.674416279262;6633.900491492728;6674.8998765017595;6678.933210668026;6469.159009328757;6559.836004099936;6565.868682626226;6580.736770529125;6585.242697089704;6441.227052753699;6452.516061295328;6502.479801615765;6541.116949211795;6578.8355291118105;6411.711472983634;6433.163688720437;6551.934480655323;6579.407853293035;6674.232463266592;6319.58922670025;6332.208473940757;6332.30344662096;6335.303116657072;6359.395857393541 05:16:05 INFO - PID 3720 | |1;ext.html;846.4413487098516;865.7532603208087;868.0581568997637;872.9650813967442;873.4759144513291;40319.79840100799;40450.190996180136;41103.17793644125;41177.79411102944;41197;37129.814350928275;37473.81263093681;37476.812615936884;37495.43756843643;37497.81251093741;6911.89632155518;7026.297370262959;7029.08621879155;7032.8945065824055;7046.85906281874;6888.621125838077;6997.055397521321;7004.089468369105;7033.683484243195;7035.29647035295;7023.789286321418;7754.030746156731;7943.046834379854;7943.443958922878;7945.880811787828;7820.1788812174755;7880.054393472791;7881.6059197040495;7887.290143887078;7891.1714270001685;7579.393648508106;7737.342325902305;7759.844803103906;7764.456488045839;7827.373810095179;37540.43689344635;37845.62154378449;37853;37922;37957;3550.9644903551152;3604.42329227325;3605.5312809334882;3605.8557657693923;3606.4770608261656;30135;30135.69864301373;30172.54741178884;30214.395712085636;30244;5133.794648214067;5179.04187725272;5196.58427325813;5229.11105112128;5234.057869583474;169379;169475;171130;171568;171655.99999999875;39507.802460987514;39956.80021599874;44729;44824.3276350855;44900;46867.531324687;46920.5307946923;46921;46998.060038799034;47005.5299447008;13995.86004139966;14146.22195779242;14153.929230353782;14164.64588385278;14167.78748318776;11285.943570282096;11407.885921140849;11424.485898134604;11461.484233209525;11465;12758;12797.29614871191;12802;12813.167144135601;12885.22688638666;5205.869853253699;5344.572434205332;5426.484483974016;5451.890962180734;5476.507114359727;989.1641562879355;997.3168379659811;1001.8528784541659;1003.914667253277;1029.0429900192892;21922.123115075217;22036.11855525761;22046;22153.113875445124;22192.667109993363;1090.547422819521;1103.178132291432;1104.1395249005452;1110.0841805510486;1119.7088756923258;11670.824937625943;11680.532778688927;11681.707957301136;11697.356645384585;11764.764704705858;207730;207733;208960;208988;209247;49656;50308.49691503038;54078.72960635171;54196.729016354664;54316;1420.6235347632885;1440.2222799688261;1447.1895738386327;1450.2241300903966;1452.1867754057762;26591.867040664674;26680.32991752062;26755.732442675326;26786;27182.320441989108;36675.633243668286;36701.63298366982;36865.44701829421;36916.44625330569;36952.63047369492;190089;191019;191176;191668;191851;32655.34689306153;33456.33087338288;34954.47568286528;35000.29999400049;35057;43087.56912430836;43402.782986084865;43634;43883.78058109689;44032.779836101894;32323.838380807945;32391.19022024374;32550.83724581362;32587.83706081549;33360.1659958503;32049;32080.35839283248;32138.517922231655;32297.677023230408;32502;36265;36281.274374511835;36336;36531.452028219064;36646.63353366539;31287.84356078205;31387.215319617193;31507.842460788466;31585.684143158272;31654;23208.3037508875;23247;23328.883355583115;23810.523789524457;24054.639180412658 05:16:05 INFO - PID 3720 | |2;jquery.html;565.217174213714;565.9320881494222;568.8464114689032;573.4552175433339;573.7790950484064;21593.4601634959;22378.216762413318;22385.3284401468;22455.775442245573;22487.100515979382;23241.48930319528;24130.155444559445;24174;24550.263492095222;24559.38601534958;6373.9362606373925;6441.838954026163;6530.673466326689;6536.313687062861;6538.509611779112;6088.178095957033;6399.8400039998905;6490.3509649035195;6494.285628580852;6517.902231466508;6293.4650554702675;6317.399847014526;6325.715342809584;6327;6329.113924050636;6285.214348206497;6311.715972781236;6315.684215789215;6319.0837328587095;6319.4312511873695;5712.857178570527;5914.5268378530045;5926.8814623707285;5932;5956.731947062349;27565.448691026068;28117.57823632647;28122.859385703145;28125.859370703016;28137.29656758577;2013.9326157136595;2018.4651067466987;2018.798120187984;2021.7877122902178;2027.9797202028085;18353.3576324828;18874.90562547192;19096.236150553963;19152.425427237205;19154.712679309683;2358.952820943589;2413.686220791286;2414.9034038638433;2416.818738594595;2425.4542727886083;108350.45824770904;114589;114836;119816.40091799572;127198.36400818029;13818.65453363674;14061.578152655233;14271.57185284443;14341.498047568284;14427;22281.66577501339;22399;22400.55198896013;22408.55182896333;22424;9379.859302110473;9495.715128546155;9649.469279189712;9711.9028809711;9713.514324283757;8768.254698350584;8871.157240062184;8892.644294228288;8928.910710892807;8992.46045237288;8542.615582298811;8616.827663446697;8909.287257019423;9008.828852249297;9051.456912585267;2542.2373288013523;2606.2181345596623;2641.168032069892;2671.879765410561;2690.892364305406;926.5969303353063;950.95720692569;952.9475878826593;957.8132264208551;975.9902400976041;18379.448616541526;18462.907685461756;18876.528086797938;19050.333238336592;19082.04589770506;1005.7385079879284;1009.7021378693303;1013.9898601014042;1014.9644762433279;1020.4693559349246;10381.532831022621;10487.318324308895;10539.63111291101;10552.208584356204;10655.041046305869;426560;444990;446018;447744;450731;104683;105445;106389.46805265924;106960.46519767352;108296;1022.3712416863575;1115.642994241851;1143.9656810295705;1164.574930150506;1170.631251155883;19617.509562261057;19651.70522442136;19717.70423443621;19782.40652780419;20238.19047238094;52066.73966630142;53266.73366633142;53383.199252012026;53814.46185538094;54656.72671636617;62986.37013629988;65081.67459162674;66124.66937665474;66552;66848;13966.58100256994;14010.929945350208;14170.858291417366;14277;14277.071990320595;22006;22117.77882221157;22580.887095564416;22674.886625566767;22891.54216915619;17743;17853.642927141645;17938.730919035963;17950.730739038663;18215;15291.158986255417;15516;16003.359865605711;16219.51341459758;16579.336826526804;18337.449876503728;18523.44429667112;18712.81287187111;18776.812231877506;18798.436046918614;13959.302034898417;14048.859511404755;14084.507042253472;14085.577432677037;14100.435982560582;17577.648447031243;17713;17789.822101778816;17800.91099544494;17815.376461823773 05:16:05 INFO - PID 3720 | |3;mootools.html;1325.854156042835;1372.972540549189;1400.7548678981175;1401.0542883553599;1401.3903951780974;14362.994590378677;14939.327730252138;14992.850071499282;14999.700005999886;15017.474388396407;14605.488807891727;14641.853581464182;14795.482158124469;14796.260186990661;14802.925985370084;2699.0688212566633;2712.22701530064;2769.82282529925;2771.2240572639694;2777.986110069447;2727.549954257555;2754.394033312668;2765.3363192833676;2768.0311890838248;2772.0575004498464;2627.2118364490575;2669.9733002670014;2794.4411117776426;2795.580662900571;2795.664520257572;2665.1071890916564;2666.6799984001946;2687.9731202687917;2703.175531462903;2707.1472486166795;2607.256931774435;2644.074573899139;2655.8672066396603;2691.1388355726176;2697.865106744655;14896.255187240704;15018.249087545688;15018.924905375403;15022.24888755558;15022.549323520312;7328.596927169004;7546.132194797614;7550.73572424968;7560.092788865371;7579.583122928237;5120.743962801882;5296.3379577552805;5347.3423238796095;5359;5373.543248823855;1922.5482011727233;1946.6690662587393;1976.901154942247;2005.1778770704086;2005.8696184747944;25817.612735808976;26027.479450410887;26061.73938260612;26235.868820655774;26249.868750656125;6385.329540398191;6624.138861947916;6710.261871194165;6766.69549870257;6776.525643204928;16969.321227151024;16998.490045298662;17048.65902681964;17056;17061.829381706273;7213.422926165894;7390.704371825174;7396.926030739732;7402.185759566443;7410.11078670563;6724.125863637696;6755.898661520081;6829.487788415889;6845.452363810883;6870.965645171742;5089.440161582223;5192.350956130484;5306.548943339782;5326.893462130735;5362.812301569426;1504.0674781635455;1507.6758496923214;1517.4385477373442;1523.1242035829443;1539.5766164304905;842.8187939593017;878.9208971192495;890.6392910870978;890.7105190813012;901.9188273055456;7191.173015103225;7260.96369518149;7296.635168241567;7314.341709246087;7321.560706357635;704.8097013806346;708.624429052603;722.0649259209337;722.7687140115113;728.2826415980255;4562.84030058953;4576.06190730906;4632.166210082218;4721.622270218374;4872.853814385574;20809.06359213839;21053;21569.78430215678;21601.891990539945;21767.129314827547;20812.47968800792;21481.57036859254;21697.783022169893;21774.45563860916;21804.23685171043;10623.681289561326;10918.07196388316;10933.56265749377;10963.122950163968;10996.945015275032;7885.842283154419;7947.682092716458;8025.357971362394;8027.919720802951;8061.113277539584;17608.38370657021;18071.638567228845;18080.276788928295;18425.907870460564;18628.348007819663;18941.14764835558;18951.336703215322;19047.14287857022;19226.230950761812;19290.903545482182;10949.781004380027;11161.274517156358;11164.106871450102;11172.441377931233;11174.49714762854;13722.245276509888;13828.170309781446;13901.72196556043;13904;13968.30158492051;10757.193210509087;10872.510737016695;11015.889841101487;11141.108711303239;11194.496247669038;10451.529681164518;10716.785664286515;10862.94568527184;10911.127109831354;11010.449477526252;9527.428354298765;9651;9717.611295548382;9751.658691945748;9769.413835169913;6768.849295619658;6922.826929326807;6989.266127056586;7002.3697867192195;7025.648717564203;7043.190033146254;7118.5017048806085;7155.391791697556;7160.427165826617;7209.35115839577 05:16:05 INFO - PID 3720 | |4;prototype.html;489.49337435754;525.4614020628854;529.4308618235398;530.3874025500546;531.619891777379;6488.091667166595;6494.415502604765;6503.049085274422;6511.674416279191;6524.249711283204;6375.139356186914;6379;6390.201224846895;6410.134631824702;6420.839479013027;5205.713685747282;5217.139172036609;5233;5257.447967963366;5269;4983.352164218664;5091.414487333948;5213.165893457048;5218.243354713564;5226.8693282667855;5058.570021548173;5060.772265248054;5069.822556210534;5105.617078719092;5127.564157046637;5059.569936555397;5071.18860982241;5087.262346959707;5087.974560127194;5090.414602320743;4445.666575006855;4541.909161816779;4550.68145229834;4552.567506086916;4574.405327307429;6166.136740856284;6299.118123462719;6307.96846015767;6313.242410910674;6327.430531252209;5724.513416359573;5734.225879506255;5763.135529670583;5791.797287094932;5835.5915085944;6716.884181482817;6732.158480189976;6755;6788.456923446161;6806.196357965143;4975.776090075955;4987.576056035241;4987.600991920638;4991.001799640087;5004.874878128039;6495.935040649628;6725;6915.792526224222;6922.861542769167;6965.825854353631;5011.574016208663;5029.597632189416;5064.366954130734;5076.644634875597;5080.399674102646;5101.413337466165;5101.974490127525;5129.281900533928;5134.717590532482;5148.588112950955;5738.512226460714;5754.971225143931;5783.681897495594;5844.649321040666;5848.941510584839;6759.662016899136;6793.660316984131;6803.387695107464;6805.625690587065;6813.454923606099;1768.814274501159;1784.598465345287;1797.5416268851359;1807.548112971757;1811.6105037416755;1182.2197349749297;1207.710149564116;1226.1539537718945;1227.8035514317667;1229.846269216348;5688.516476099578;5742.885142297131;5762.4525670061275;5773.278340207474;5804.158397032406;6883.346082122191;6914.9308506915295;6915.550489218285;6923.723051078001;6924.169099708067;5633.183188437653;5762.971185144047;5768.596198266165;5796.82609521715;5805.055306472379;3617.385044542434;3641.7450778445254;3648.4709717090873;3660.5058317127377;3671.6879065279218;6562.179727534059;6638.103855979478;6643.202815662152;6652.634105124168;6693.364130407604;6513.413792758674;6871.4502839772695;7010.193827709879;7099.680514376865;7136.537009912955;6533.379328963741;6543.574667646588;6551.21385433751;6558.409743123142;6653.866922661519;6759.594424334556;6780.779459697302;6826.620822692799;6862;6864.656767161722;6735.831604209934;6769.255381908085;6826;6827.89758153638;6875.965620171867;6575.63833989116;6598.27418983921;6610.867782644416;6637.1703537057865;6648.642435570199;5067;5082.771275292546;5101.38783345986;5102.464241254764;5117.488251174853;6587.571807832475;6601.702923368364;6630.370114839083;6879.828004299932;6911.447084233349;6661.533692641468;6661.700223489857;6662.136640252739;6667.233268174222;6677.532572719863;6656.900146497903;6660.766873159416;6676.532642715158;6685.364890335411;6719.865602688016;6543.443807276435;6584.604923704593;6643.734250630114;6647.833804154935;6652.800415987528;6715.966420168063;6794.966025169842;6807.591544507345;6820.522563420513;6834.965825170842;6488.318726533646;6515.706793194223;6544.770933017512;6594.406503414716;6608.852123060121 05:16:05 INFO - PID 3720 | |5;yui.html;882.8146089321242;884.9336299777518;900.1538553759464;902.9683961061364;913.7806926337681;18312.26750929963;19116.713249301272;19126.42620721377;19133.139008744605;19163.808361916395;18002.63994720105;18160.4551863444;18169.727454088166;18231.453056408296;18251.452456426294;953.4231789767196;954.3415043619898;954.6658669465701;954.71358592422;957.4877440569297;960.7550074730934;960.9429627409863;961.0149596663441;961.538461538462;963.6290028339105;998.7752755629998;1000.7648202672366;1027.7379268286613;1034.260503739826;1040.47976011994;1020.882598501167;1023.8208313545138;1025.5897640943608;1025.6615316945426;1026.091908660833;724.1852915470096;741.1846968334843;745.2956955676888;745.4930647159983;749.6064566102785;18982.43052708407;19113.61772764537;19156.61686766271;19158.904205479022;19175.232990680357;20964.685529717066;20985.370438886857;21721.13115475379;21888.233911813168;21907.780922190734;13187.868121318856;13382.330883455885;13639.386227619781;13754.93122534381;13756.312184390841;3556.28874225156;3564.7148228141946;3572.392693242155;3572.517710109128;3573.446115852021;102585.48707256417;119865.40067299608;130508;134528.32735836357;136271;16020.839791602168;16403.753943690856;16445.25996330168;16529.421470248482;16530.504084877473;30035.249118772204;30915.0725478236;30994.22514437112;31258.531122033186;31276;8017.358611311081;8026.117127116129;8027.518348899085;8043.356531477468;8067.757967260992;4156.25187466259;4218.303979843292;4240.300350442142;4250.23495770758;4300.89247768802;4992.2511623256805;5078.619103567247;5081.28861959326;5127.333446651986;5133.614978876599;1073.1736562846565;1101.730076131353;1105.5688281570194;1108.8225883858545;1109.778044391125;584.0946532874028;596.2189531713469;598.0968737206849;610.2707264818499;615.827568280882;10811.945940270249;10827.512761925733;10941.781164376827;10950.726231844108;11067;626.9122322874802;630.9053641953652;635.1425575473074;635.8060791458649;647.5402464250341;5265.763040663102;5267.130923397596;5360.410354860962;5389.083855744533;5391.757370918318;114311;117415;118137;118835;121335;103481.48259258656;105144;105730.47134764431;106808;109850;90036.54981725049;90742.09257907468;91713.08286917179;92659.53670231605;94160;9970.55132519024;9992.900070999487;10021.39871607706;10072.294939354175;10166.593336266762;42264.366034508894;43015.56984430116;43664;43707.78146109249;44010.33984490299;55502;56312.43687563236;57078.429215707314;57894.4210557889;58396;14917;14995.700085998436;15085.24573771329;15100.320485577955;15184.240787960778;15909.52271431859;15919.68160636804;16048;16140.95083819548;16182.757258640895;14640.70718585601;14755.262236887898;14796;14987.475438359605;14992.775108373602;13582.11716238481;13711.382987765774;13799.79300310476;13928.164310141019;13933.164010159422;13048.934755326163;13276.800847987095;13281.601551953458;13298.202107873558;13502.32488375597;10360.637377691744;10406.427646479213;10545.841812372668;10594.788104238027;10811.945940270563;10851.45742712877;10882.347059176474;11032;11075.501602427748;11169.72075698114 05:16:05 INFO - PID 3720 | __end_tp_report 05:16:05 INFO - PID 3720 | __start_cc_report 05:16:05 INFO - PID 3720 | _x_x_mozilla_cycle_collect,381 05:16:05 INFO - PID 3720 | __end_cc_report 05:16:05 INFO - PID 3720 | __startTimestamp1504959365414__endTimestamp 05:16:05 INFO - PID 3720 | 05:16:05 INFO - PID 3720 | ------- Summary: start ------- 05:16:05 INFO - PID 3720 | Number of tests: 6 05:16:05 INFO - PID 3720 | 05:16:05 INFO - PID 3720 | [#0] dojo.html Cycles:165 Average:6180.49 Median:6422.42 stddev:894.39 (13.9%) stddev-sans-first:864.23 05:16:05 INFO - PID 3720 | Values: 3116.4 3127.6 3138.4 3140.3 3141.8 6166.1 6193.2 6240.3 6313.1 6395.3 6247.9 6270.6 6270.6 6317.1 6318.6 5774.9 5830.4 5834.9 5839.2 5891.1 45.7 5800.6 5858.5 5894.4 5899.7 5425.4 5714.7 5726.0 5843.4 5864.9 5740.1 5762.8 5819.6 5848.5 5854.4 5755.5 5755.5 5840.0 5846.9 5852.1 6214.9 6288.7 6309.0 6372.1 6399.8 6547.7 6638.5 6650.9 6807.7 6817.6 6861.8 6876.8 6878.0 6913.6 6935.6 6139.8 6203.7 6292.1 6300.7 6377.0 7018.5 7048.3 7072.0 7074.2 7088.0 6684.3 6690.0 6710.0 6738.6 6758.1 6700.4 6739.4 6741.9 6778.1 6843.7 6738.4 6743.0 6752.8 6759.1 6770.9 6679.6 6694.3 6717.1 6719.0 6793.0 5257.7 5267.9 5320.9 5321.0 5333.3 4610.7 4624.6 4655.9 4670.1 4703.8 5617.5 5693.8 5815.0 5815.3 5863.9 6840.3 6841.6 6846.7 6848.3 6868.7 5826.0 5852.1 5923.4 5928.4 5931.9 5812.8 5859.6 5917.2 5926.6 5928.6 6422.4 6512.1 6574.7 6641.4 6657.5 6770.5 6795.0 6888.4 6889.4 6893.5 6442.6 6537.8 6603.3 6609.0 6621.0 6492.8 6617.3 6621.5 6686.2 6769.3 6753.5 6789.6 6790.0 6794.0 6852.5 6331.1 6511.7 6633.9 6674.9 6678.9 6469.2 6559.8 6565.9 6580.7 6585.2 6441.2 6452.5 6502.5 6541.1 6578.8 6411.7 6433.2 6551.9 6579.4 6674.2 6319.6 6332.2 6332.3 6335.3 6359.4 05:16:05 INFO - PID 3720 | 05:16:05 INFO - PID 3720 | [#1] ext.html Cycles:180 Average:35683.55 Median:3605.69 stddev:49329.28 (1368.1%) stddev-sans-first:49398.30 05:16:05 INFO - PID 3720 | Values: 846.4 865.8 868.1 873.0 873.5 40319.8 40450.2 41103.2 41177.8 41197.0 37129.8 37473.8 37476.8 37495.4 37497.8 6911.9 7026.3 7029.1 7032.9 7046.9 6888.6 6997.1 7004.1 7033.7 7035.3 7023.8 7754.0 7943.0 7943.4 7945.9 7820.2 7880.1 7881.6 7887.3 7891.2 7579.4 7737.3 7759.8 7764.5 7827.4 37540.4 37845.6 37853.0 37922.0 37957.0 3551.0 3604.4 3605.5 3605.9 3606.5 30135.0 30135.7 30172.5 30214.4 30244.0 5133.8 5179.0 5196.6 5229.1 5234.1 169379.0 169475.0 171130.0 171568.0 171656.0 39507.8 39956.8 44729.0 44824.3 44900.0 46867.5 46920.5 46921.0 46998.1 47005.5 13995.9 14146.2 14153.9 14164.6 14167.8 11285.9 11407.9 11424.5 11461.5 11465.0 12758.0 12797.3 12802.0 12813.2 12885.2 5205.9 5344.6 5426.5 5451.9 5476.5 989.2 997.3 1001.9 1003.9 1029.0 21922.1 22036.1 22046.0 22153.1 22192.7 1090.5 1103.2 1104.1 1110.1 1119.7 11670.8 11680.5 11681.7 11697.4 11764.8 207730.0 207733.0 208960.0 208988.0 209247.0 49656.0 50308.5 54078.7 54196.7 54316.0 1420.6 1440.2 1447.2 1450.2 1452.2 26591.9 26680.3 26755.7 26786.0 27182.3 36675.6 36701.6 36865.4 36916.4 36952.6 190089.0 191019.0 191176.0 191668.0 191851.0 32655.3 33456.3 34954.5 35000.3 35057.0 43087.6 43402.8 43634.0 43883.8 44032.8 32323.8 32391.2 32550.8 32587.8 33360.2 32049.0 32080.4 32138.5 32297.7 32502.0 36265.0 36281.3 36336.0 36531.5 36646.6 31287.8 31387.2 31507.8 31585.7 31654.0 23208.3 23247.0 23328.9 23810.5 24054.6 05:16:05 INFO - PID 3720 | 05:16:05 INFO - PID 3720 | [#2] jquery.html Cycles:180 Average:32077.05 Median:22471.44 stddev:74374.94 (331.0%) stddev-sans-first:74545.95 05:16:05 INFO - PID 3720 | Values: 565.2 565.9 568.8 573.5 573.8 21593.5 22378.2 22385.3 22455.8 22487.1 23241.5 24130.2 24174.0 24550.3 24559.4 6373.9 6441.8 6530.7 6536.3 6538.5 6088.2 6399.8 6490.4 6494.3 6517.9 6293.5 6317.4 6325.7 6327.0 6329.1 6285.2 6311.7 6315.7 6319.1 6319.4 5712.9 5914.5 5926.9 5932.0 5956.7 27565.4 28117.6 28122.9 28125.9 28137.3 2013.9 2018.5 2018.8 2021.8 2028.0 18353.4 18874.9 19096.2 19152.4 19154.7 2359.0 2413.7 2414.9 2416.8 2425.5 108350.5 114589.0 114836.0 119816.4 127198.4 13818.7 14061.6 14271.6 14341.5 14427.0 22281.7 22399.0 22400.6 22408.6 22424.0 9379.9 9495.7 9649.5 9711.9 9713.5 8768.3 8871.2 8892.6 8928.9 8992.5 8542.6 8616.8 8909.3 9008.8 9051.5 2542.2 2606.2 2641.2 2671.9 2690.9 926.6 951.0 952.9 957.8 976.0 18379.4 18462.9 18876.5 19050.3 19082.0 1005.7 1009.7 1014.0 1015.0 1020.5 10381.5 10487.3 10539.6 10552.2 10655.0 426560.0 444990.0 446018.0 447744.0 450731.0 104683.0 105445.0 106389.5 106960.5 108296.0 1022.4 1115.6 1144.0 1164.6 1170.6 19617.5 19651.7 19717.7 19782.4 20238.2 52066.7 53266.7 53383.2 53814.5 54656.7 62986.4 65081.7 66124.7 66552.0 66848.0 13966.6 14010.9 14170.9 14277.0 14277.1 22006.0 22117.8 22580.9 22674.9 22891.5 17743.0 17853.6 17938.7 17950.7 18215.0 15291.2 15516.0 16003.4 16219.5 16579.3 18337.4 18523.4 18712.8 18776.8 18798.4 13959.3 14048.9 14084.5 14085.6 14100.4 17577.6 17713.0 17789.8 17800.9 17815.4 05:16:05 INFO - PID 3720 | 05:16:05 INFO - PID 3720 | [#3] mootools.html Cycles:180 Average:9114.67 Median:2668.33 stddev:6606.96 (247.6%) stddev-sans-first:6599.58 05:16:05 INFO - PID 3720 | Values: 1325.9 1373.0 1400.8 1401.1 1401.4 14363.0 14939.3 14992.9 14999.7 15017.5 14605.5 14641.9 14795.5 14796.3 14802.9 2699.1 2712.2 2769.8 2771.2 2778.0 2727.5 2754.4 2765.3 2768.0 2772.1 2627.2 2670.0 2794.4 2795.6 2795.7 2665.1 2666.7 2688.0 2703.2 2707.1 2607.3 2644.1 2655.9 2691.1 2697.9 14896.3 15018.2 15018.9 15022.2 15022.5 7328.6 7546.1 7550.7 7560.1 7579.6 5120.7 5296.3 5347.3 5359.0 5373.5 1922.5 1946.7 1976.9 2005.2 2005.9 25817.6 26027.5 26061.7 26235.9 26249.9 6385.3 6624.1 6710.3 6766.7 6776.5 16969.3 16998.5 17048.7 17056.0 17061.8 7213.4 7390.7 7396.9 7402.2 7410.1 6724.1 6755.9 6829.5 6845.5 6871.0 5089.4 5192.4 5306.5 5326.9 5362.8 1504.1 1507.7 1517.4 1523.1 1539.6 842.8 878.9 890.6 890.7 901.9 7191.2 7261.0 7296.6 7314.3 7321.6 704.8 708.6 722.1 722.8 728.3 4562.8 4576.1 4632.2 4721.6 4872.9 20809.1 21053.0 21569.8 21601.9 21767.1 20812.5 21481.6 21697.8 21774.5 21804.2 10623.7 10918.1 10933.6 10963.1 10996.9 7885.8 7947.7 8025.4 8027.9 8061.1 17608.4 18071.6 18080.3 18425.9 18628.3 18941.1 18951.3 19047.1 19226.2 19290.9 10949.8 11161.3 11164.1 11172.4 11174.5 13722.2 13828.2 13901.7 13904.0 13968.3 10757.2 10872.5 11015.9 11141.1 11194.5 10451.5 10716.8 10862.9 10911.1 11010.4 9527.4 9651.0 9717.6 9751.7 9769.4 6768.8 6922.8 6989.3 7002.4 7025.6 7043.2 7118.5 7155.4 7160.4 7209.4 05:16:05 INFO - PID 3720 | 05:16:05 INFO - PID 3720 | [#4] prototype.html Cycles:180 Average:5623.42 Median:6377.07 stddev:1579.01 (24.8%) stddev-sans-first:1535.70 05:16:05 INFO - PID 3720 | Values: 489.5 525.5 529.4 530.4 531.6 6488.1 6494.4 6503.0 6511.7 6524.2 6375.1 6379.0 6390.2 6410.1 6420.8 5205.7 5217.1 5233.0 5257.4 5269.0 4983.4 5091.4 5213.2 5218.2 5226.9 5058.6 5060.8 5069.8 5105.6 5127.6 5059.6 5071.2 5087.3 5088.0 5090.4 4445.7 4541.9 4550.7 4552.6 4574.4 6166.1 6299.1 6308.0 6313.2 6327.4 5724.5 5734.2 5763.1 5791.8 5835.6 6716.9 6732.2 6755.0 6788.5 6806.2 4975.8 4987.6 4987.6 4991.0 5004.9 6495.9 6725.0 6915.8 6922.9 6965.8 5011.6 5029.6 5064.4 5076.6 5080.4 5101.4 5102.0 5129.3 5134.7 5148.6 5738.5 5755.0 5783.7 5844.6 5848.9 6759.7 6793.7 6803.4 6805.6 6813.5 1768.8 1784.6 1797.5 1807.5 1811.6 1182.2 1207.7 1226.2 1227.8 1229.8 5688.5 5742.9 5762.5 5773.3 5804.2 6883.3 6914.9 6915.6 6923.7 6924.2 5633.2 5763.0 5768.6 5796.8 5805.1 3617.4 3641.7 3648.5 3660.5 3671.7 6562.2 6638.1 6643.2 6652.6 6693.4 6513.4 6871.5 7010.2 7099.7 7136.5 6533.4 6543.6 6551.2 6558.4 6653.9 6759.6 6780.8 6826.6 6862.0 6864.7 6735.8 6769.3 6826.0 6827.9 6876.0 6575.6 6598.3 6610.9 6637.2 6648.6 5067.0 5082.8 5101.4 5102.5 5117.5 6587.6 6601.7 6630.4 6879.8 6911.4 6661.5 6661.7 6662.1 6667.2 6677.5 6656.9 6660.8 6676.5 6685.4 6719.9 6543.4 6584.6 6643.7 6647.8 6652.8 6716.0 6795.0 6807.6 6820.5 6835.0 6488.3 6515.7 6544.8 6594.4 6608.9 05:16:05 INFO - PID 3720 | 05:16:05 INFO - PID 3720 | [#5] yui.html Cycles:180 Average:23040.76 Median:19121.57 stddev:33425.62 (174.8%) stddev-sans-first:33477.98 05:16:05 INFO - PID 3720 | Values: 882.8 884.9 900.2 903.0 913.8 18312.3 19116.7 19126.4 19133.1 19163.8 18002.6 18160.5 18169.7 18231.5 18251.5 953.4 954.3 954.7 954.7 957.5 960.8 960.9 961.0 961.5 963.6 998.8 1000.8 1027.7 1034.3 1040.5 1020.9 1023.8 1025.6 1025.7 1026.1 724.2 741.2 745.3 745.5 749.6 18982.4 19113.6 19156.6 19158.9 19175.2 20964.7 20985.4 21721.1 21888.2 21907.8 13187.9 13382.3 13639.4 13754.9 13756.3 3556.3 3564.7 3572.4 3572.5 3573.4 102585.5 119865.4 130508.0 134528.3 136271.0 16020.8 16403.8 16445.3 16529.4 16530.5 30035.2 30915.1 30994.2 31258.5 31276.0 8017.4 8026.1 8027.5 8043.4 8067.8 4156.3 4218.3 4240.3 4250.2 4300.9 4992.3 5078.6 5081.3 5127.3 5133.6 1073.2 1101.7 1105.6 1108.8 1109.8 584.1 596.2 598.1 610.3 615.8 10811.9 10827.5 10941.8 10950.7 11067.0 626.9 630.9 635.1 635.8 647.5 5265.8 5267.1 5360.4 5389.1 5391.8 114311.0 117415.0 118137.0 118835.0 121335.0 103481.5 105144.0 105730.5 106808.0 109850.0 90036.5 90742.1 91713.1 92659.5 94160.0 9970.6 9992.9 10021.4 10072.3 10166.6 42264.4 43015.6 43664.0 43707.8 44010.3 55502.0 56312.4 57078.4 57894.4 58396.0 14917.0 14995.7 15085.2 15100.3 15184.2 15909.5 15919.7 16048.0 16141.0 16182.8 14640.7 14755.3 14796.0 14987.5 14992.8 13582.1 13711.4 13799.8 13928.2 13933.2 13048.9 13276.8 13281.6 13298.2 13502.3 10360.6 10406.4 10545.8 10594.8 10811.9 10851.5 10882.3 11032.0 11075.5 11169.7 05:16:05 INFO - PID 3720 | -------- Summary: end -------- 05:16:05 INFO - PID 3720 | 05:16:06 INFO - TEST-INFO | 3720: exit 0 05:16:06 INFO - TEST-OK | dromaeo_css | took 1110805ms 05:16:06 INFO - TEST-START | kraken 05:16:06 INFO - Initialising browser for kraken test... 05:16:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45344/getInfo.html -profile /tmp/tmpVj2SEO/profile 05:16:06 INFO - TEST-INFO | started process 4093 (/builds/slave/test/build/application/firefox/firefox http://localhost:45344/getInfo.html) 05:16:11 INFO - TEST-INFO | 4093: exit 0 05:16:11 INFO - Browser initialized. 05:16:11 INFO - Running cycle 1/1 for kraken test... 05:16:11 INFO - Using env: {'DISPLAY': ':0', 05:16:11 INFO - 'HOME': '/home/cltbld', 05:16:11 INFO - 'JSGC_DISABLE_POISONING': '1', 05:16:11 INFO - 'LANG': 'en_US.UTF-8', 05:16:11 INFO - 'LANGUAGE': 'en_US:en', 05:16:11 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 05:16:11 INFO - 'LOGNAME': 'cltbld', 05:16:11 INFO - 'MAIL': '/var/mail/cltbld', 05:16:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:16:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:16:11 INFO - 'MOZ_CRASHREPORTER': '1', 05:16:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:11 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 05:16:11 INFO - 'MOZ_NO_REMOTE': '1', 05:16:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:16:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:11 INFO - 'NO_EM_RESTART': '1', 05:16:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:11 INFO - 'PWD': '/builds/slave/test', 05:16:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:16:11 INFO - 'RUST_BACKTRACE': 'full', 05:16:11 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:16:11 INFO - 'SHELL': '/bin/bash', 05:16:11 INFO - 'SHLVL': '1', 05:16:11 INFO - 'TERM': 'linux', 05:16:11 INFO - 'TMOUT': '86400', 05:16:11 INFO - 'USER': 'cltbld', 05:16:11 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1504958193.571302-813399221', 05:16:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:11 INFO - '_': '/tools/buildbot/bin/python'} 05:16:11 INFO - TEST-INFO | started process 4289 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVj2SEO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:16:12 INFO - PID 4289 | 05:16:12 INFO - PID 4289 | (/builds/slave/test/build/application/firefox/firefox:4339): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:16:12 INFO - PID 4289 | 05:16:22 INFO - PID 4289 | RSS: Main: 173002752 05:16:22 INFO - PID 4289 | 05:16:25 INFO - PID 4289 | Cycle 1(1): loaded http://localhost:45344/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45344/tests/kraken/driver.html?testName=audio-beat-detection) 05:16:26 INFO - PID 4289 | RSS: Main: 178180096 05:16:26 INFO - PID 4289 | 05:16:29 INFO - PID 4289 | Cycle 1(1): loaded http://localhost:45344/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45344/tests/kraken/driver.html?testName=audio-dft) 05:16:29 INFO - PID 4289 | RSS: Main: 178778112 05:16:29 INFO - PID 4289 | 05:16:32 INFO - PID 4289 | Cycle 1(1): loaded http://localhost:45344/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45344/tests/kraken/driver.html?testName=audio-fft) 05:16:33 INFO - PID 4289 | RSS: Main: 174432256 05:16:33 INFO - PID 4289 | 05:16:35 INFO - PID 4289 | Cycle 1(1): loaded http://localhost:45344/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45344/tests/kraken/driver.html?testName=audio-oscillator) 05:16:36 INFO - PID 4289 | RSS: Main: 175194112 05:16:36 INFO - PID 4289 | 05:16:38 INFO - PID 4289 | Cycle 1(1): loaded http://localhost:45344/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45344/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:16:38 INFO - PID 4289 | RSS: Main: 175456256 05:16:38 INFO - PID 4289 | 05:16:41 INFO - PID 4289 | Cycle 1(1): loaded http://localhost:45344/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45344/tests/kraken/driver.html?testName=imaging-darkroom) 05:16:42 INFO - PID 4289 | RSS: Main: 177758208 05:16:42 INFO - PID 4289 | 05:16:46 INFO - PID 4289 | Cycle 1(1): loaded http://localhost:45344/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45344/tests/kraken/driver.html?testName=imaging-desaturate) 05:16:46 INFO - PID 4289 | RSS: Main: 177520640 05:16:46 INFO - PID 4289 | 05:16:49 INFO - PID 4289 | Cycle 1(1): loaded http://localhost:45344/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45344/tests/kraken/driver.html?testName=json-parse-financial) 05:16:50 INFO - PID 4289 | RSS: Main: 178429952 05:16:50 INFO - PID 4289 | 05:16:51 INFO - PID 4289 | Cycle 1(1): loaded http://localhost:45344/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45344/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:16:52 INFO - PID 4289 | RSS: Main: 177958912 05:16:52 INFO - PID 4289 | 05:16:54 INFO - PID 4289 | Cycle 1(1): loaded http://localhost:45344/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45344/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:16:54 INFO - PID 4289 | RSS: Main: 177893376 05:16:54 INFO - PID 4289 | 05:16:56 INFO - PID 4289 | Cycle 1(1): loaded http://localhost:45344/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45344/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:16:57 INFO - PID 4289 | RSS: Main: 174891008 05:16:57 INFO - PID 4289 | 05:17:00 INFO - PID 4289 | Cycle 1(1): loaded http://localhost:45344/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45344/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:17:00 INFO - PID 4289 | RSS: Main: 175366144 05:17:00 INFO - PID 4289 | 05:17:03 INFO - PID 4289 | Cycle 1(1): loaded http://localhost:45344/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45344/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:17:04 INFO - PID 4289 | RSS: Main: 175386624 05:17:04 INFO - PID 4289 | 05:17:06 INFO - PID 4289 | Cycle 1(1): loaded http://localhost:45344/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45344/tests/kraken/driver.html?testName=ai-astar) 05:17:06 INFO - PID 4289 | RSS: Main: 177168384 05:17:06 INFO - PID 4289 | 05:17:06 INFO - PID 4289 | __start_tp_report 05:17:06 INFO - PID 4289 | _x_x_mozilla_page_load 05:17:06 INFO - PID 4289 | _x_x_mozilla_page_load_details 05:17:06 INFO - PID 4289 | |i|pagename|runs| 05:17:06 INFO - PID 4289 | |0;ai-astar;108;108;110;108;106;109;110;109;108;108 05:17:06 INFO - PID 4289 | |1;audio-beat-detection;117;116;116;118;116;119;116;119;119;122 05:17:06 INFO - PID 4289 | |2;audio-dft;163;162;164;164;161;162;167;166;167;163 05:17:06 INFO - PID 4289 | |3;audio-fft;72;74;77;73;73;73;74;74;74;74 05:17:06 INFO - PID 4289 | |4;audio-oscillator;81;81;80;79;80;79;79;80;79;79 05:17:06 INFO - PID 4289 | |5;imaging-gaussian-blur;116;113;111;114;113;115;114;114;114;114 05:17:06 INFO - PID 4289 | |6;imaging-darkroom;147;147;148;147;147;146;147;147;149;148 05:17:06 INFO - PID 4289 | |7;imaging-desaturate;94;93;94;94;94;95;94;95;100;99 05:17:06 INFO - PID 4289 | |8;json-parse-financial;58;54;55;55;54;58;55;56;54;52 05:17:06 INFO - PID 4289 | |9;json-stringify-tinderbox;37;38;37;37;38;37;37;37;37;37 05:17:06 INFO - PID 4289 | |10;stanford-crypto-aes;74;80;73;79;78;75;77;76;75;75 05:17:06 INFO - PID 4289 | |11;stanford-crypto-ccm;126;121;134;123;120;123;116;133;124;131 05:17:06 INFO - PID 4289 | |12;stanford-crypto-pbkdf2;172;173;181;173;181;178;173;174;176;171 05:17:06 INFO - PID 4289 | |13;stanford-crypto-sha256-iterative;67;63;63;62;71;64;66;67;63;63 05:17:06 INFO - PID 4289 | __end_tp_report 05:17:06 INFO - PID 4289 | __start_cc_report 05:17:06 INFO - PID 4289 | _x_x_mozilla_cycle_collect,948 05:17:06 INFO - PID 4289 | __end_cc_report 05:17:06 INFO - PID 4289 | __startTimestamp1504959426524__endTimestamp 05:17:06 INFO - PID 4289 | 05:17:06 INFO - PID 4289 | ------- Summary: start ------- 05:17:06 INFO - PID 4289 | Number of tests: 14 05:17:06 INFO - PID 4289 | 05:17:06 INFO - PID 4289 | [#0] ai-astar Cycles:10 Average:108.40 Median:108.50 stddev:1.17 (1.1%) stddev-sans-first:1.24 05:17:06 INFO - PID 4289 | Values: 108.0 108.0 110.0 108.0 106.0 109.0 110.0 109.0 108.0 108.0 05:17:06 INFO - PID 4289 | 05:17:06 INFO - PID 4289 | [#1] audio-beat-detection Cycles:10 Average:117.80 Median:118.50 stddev:1.99 (1.7%) stddev-sans-first:2.09 05:17:06 INFO - PID 4289 | Values: 117.0 116.0 116.0 118.0 116.0 119.0 116.0 119.0 119.0 122.0 05:17:06 INFO - PID 4289 | 05:17:06 INFO - PID 4289 | [#2] audio-dft Cycles:10 Average:163.90 Median:164.00 stddev:2.13 (1.3%) stddev-sans-first:2.24 05:17:06 INFO - PID 4289 | Values: 163.0 162.0 164.0 164.0 161.0 162.0 167.0 166.0 167.0 163.0 05:17:06 INFO - PID 4289 | 05:17:06 INFO - PID 4289 | [#3] audio-fft Cycles:10 Average:73.80 Median:74.00 stddev:1.32 (1.8%) stddev-sans-first:1.22 05:17:06 INFO - PID 4289 | Values: 72.0 74.0 77.0 73.0 73.0 73.0 74.0 74.0 74.0 74.0 05:17:06 INFO - PID 4289 | 05:17:06 INFO - PID 4289 | [#4] audio-oscillator Cycles:10 Average:79.70 Median:80.00 stddev:0.82 (1.0%) stddev-sans-first:0.73 05:17:06 INFO - PID 4289 | Values: 81.0 81.0 80.0 79.0 80.0 79.0 79.0 80.0 79.0 79.0 05:17:06 INFO - PID 4289 | 05:17:06 INFO - PID 4289 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:1.32 (1.2%) stddev-sans-first:1.13 05:17:06 INFO - PID 4289 | Values: 116.0 113.0 111.0 114.0 113.0 115.0 114.0 114.0 114.0 114.0 05:17:06 INFO - PID 4289 | 05:17:06 INFO - PID 4289 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 05:17:06 INFO - PID 4289 | Values: 147.0 147.0 148.0 147.0 147.0 146.0 147.0 147.0 149.0 148.0 05:17:06 INFO - PID 4289 | 05:17:06 INFO - PID 4289 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:94.00 stddev:2.35 (2.5%) stddev-sans-first:2.45 05:17:06 INFO - PID 4289 | Values: 94.0 93.0 94.0 94.0 94.0 95.0 94.0 95.0 100.0 99.0 05:17:06 INFO - PID 4289 | 05:17:06 INFO - PID 4289 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.00 stddev:1.85 (3.4%) stddev-sans-first:1.64 05:17:06 INFO - PID 4289 | Values: 58.0 54.0 55.0 55.0 54.0 58.0 55.0 56.0 54.0 52.0 05:17:06 INFO - PID 4289 | 05:17:06 INFO - PID 4289 | [#9] json-stringify-tinderbox Cycles:10 Average:37.20 Median:37.00 stddev:0.42 (1.1%) stddev-sans-first:0.44 05:17:06 INFO - PID 4289 | Values: 37.0 38.0 37.0 37.0 38.0 37.0 37.0 37.0 37.0 37.0 05:17:06 INFO - PID 4289 | 05:17:06 INFO - PID 4289 | [#10] stanford-crypto-aes Cycles:10 Average:76.20 Median:76.50 stddev:2.25 (2.9%) stddev-sans-first:2.24 05:17:06 INFO - PID 4289 | Values: 74.0 80.0 73.0 79.0 78.0 75.0 77.0 76.0 75.0 75.0 05:17:06 INFO - PID 4289 | 05:17:06 INFO - PID 4289 | [#11] stanford-crypto-ccm Cycles:10 Average:125.10 Median:125.00 stddev:5.90 (4.7%) stddev-sans-first:6.24 05:17:06 INFO - PID 4289 | Values: 126.0 121.0 134.0 123.0 120.0 123.0 116.0 133.0 124.0 131.0 05:17:06 INFO - PID 4289 | 05:17:06 INFO - PID 4289 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.20 Median:175.00 stddev:3.65 (2.1%) stddev-sans-first:3.68 05:17:06 INFO - PID 4289 | Values: 172.0 173.0 181.0 173.0 181.0 178.0 173.0 174.0 176.0 171.0 05:17:06 INFO - PID 4289 | 05:17:06 INFO - PID 4289 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:2.81 (4.3%) stddev-sans-first:2.87 05:17:06 INFO - PID 4289 | Values: 67.0 63.0 63.0 62.0 71.0 64.0 66.0 67.0 63.0 63.0 05:17:06 INFO - PID 4289 | -------- Summary: end -------- 05:17:06 INFO - PID 4289 | 05:17:06 INFO - PID 4289 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 05:17:07 INFO - TEST-INFO | 4289: exit 0 05:17:07 INFO - TEST-OK | kraken | took 61070ms 05:17:07 INFO - SUITE-END | took 1171s 05:17:07 INFO - Completed test suite (00:19:32) 05:17:07 INFO - javascript benchmark 05:17:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8320.722732051046, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3116.4234616595922, 3127.6403213630438, 3138.3880143372053, 3140.262038420971, 3141.795783274087, 6166.136740856273, 6193.194884664998, 6240.251169859617, 6313.116163737075, 6395.29651738309, 6247.937520624792, 6270.561060725751, 6270.5924114932495, 6317.147185130006, 6318.5892916960365, 5774.913376299338, 5830.4169583041785, 5834.854128646796, 5839.240898683165, 5891.05743081105, 45.65620019813064, 5800.564957628174, 5858.502027327682, 5894.3810899855325, 5899.675517846516, 5425.37608175059, 5714.685692286944, 5725.971370143144, 5843.3864444233595, 5864.853378665525, 5740.08158694611, 5762.798302059449, 5819.592628516006, 5848.5321174305955, 5854.443827836349, 5755.539556835443, 5755.539556835443, 5840.0, 5846.912296315559, 5852.12218167274, 6214.906776398358, 6288.685565721741, 6309.0, 6372.107904893319, 6399.77600783975, 6547.738090476375, 6638.4689224861895, 6650.900236496456, 6807.659617019179, 6817.5909445433435, 6861.828454288683, 6876.828079298008, 6878.037074809531, 6913.5506192097855, 6935.618540980244, 6139.815805525796, 6203.720832562545, 6292.056191571255, 6300.653464059475, 6377.0, 7018.543794653382, 7048.295170482911, 7072.0099186113985, 7074.22183559808, 7088.0431141796225, 6684.2647308795995, 6690.0, 6709.959956206796, 6738.59568425896, 6758.087658166183, 6700.430463410567, 6739.359760822714, 6741.898871516931, 6778.084958530634, 6843.657817109125, 6738.427233685094, 6743.0, 6752.797416077526, 6759.053732477457, 6770.898436523456, 6679.56582822115, 6694.263631000586, 6717.059611654372, 6719.025741267489, 6793.048973143764, 5257.710825904535, 5267.868303292448, 5320.893582128413, 5320.973395133077, 5333.280007199056, 4610.677252592353, 4624.606908412756, 4655.906881862344, 4670.136024835417, 4703.811847526129, 5617.466340697627, 5693.800716974886, 5814.9709251454315, 5815.302163740378, 5863.912041319383, 6840.281770414134, 6841.62371069586, 6846.657667116624, 6848.280930502325, 6868.7252509900045, 5825.98045342072, 5852.063669812895, 5923.437273459014, 5928.377520360386, 5931.851703707355, 5812.796552120655, 5859.648421094748, 5917.201177841022, 5926.61477004002, 5928.584999050025, 6422.42198202164, 6512.120863683437, 6574.704138313788, 6641.435477984425, 6657.46740260778, 6770.52606317553, 6795.0, 6888.448924085961, 6889.414399775975, 6893.517453778188, 6442.581232219891, 6537.771178008747, 6603.306652801387, 6609.041688955171, 6620.966895165493, 6492.772752953624, 6617.272100069084, 6621.5364924454825, 6686.1642294713165, 6769.323067693192, 6753.459723222032, 6789.626570538668, 6790.015447760146, 6793.966030169818, 6852.486063545353, 6331.145295385249, 6511.674416279262, 6633.900491492728, 6674.8998765017595, 6678.933210668026, 6469.159009328757, 6559.836004099936, 6565.868682626226, 6580.736770529125, 6585.242697089704, 6441.227052753699, 6452.516061295328, 6502.479801615765, 6541.116949211795, 6578.8355291118105, 6411.711472983634, 6433.163688720437, 6551.934480655323, 6579.407853293035, 6674.232463266592, 6319.58922670025, 6332.208473940757, 6332.30344662096, 6335.303116657072, 6359.395857393541], "value": 6116.244241089228, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [846.4413487098516, 865.7532603208087, 868.0581568997637, 872.9650813967442, 873.4759144513291, 40319.79840100799, 40450.190996180136, 41103.17793644125, 41177.79411102944, 41197.0, 37129.814350928275, 37473.81263093681, 37476.812615936884, 37495.43756843643, 37497.81251093741, 6911.89632155518, 7026.297370262959, 7029.08621879155, 7032.8945065824055, 7046.85906281874, 6888.621125838077, 6997.055397521321, 7004.089468369105, 7033.683484243195, 7035.29647035295, 7023.789286321418, 7754.030746156731, 7943.046834379854, 7943.443958922878, 7945.880811787828, 7820.1788812174755, 7880.054393472791, 7881.6059197040495, 7887.290143887078, 7891.1714270001685, 7579.393648508106, 7737.342325902305, 7759.844803103906, 7764.456488045839, 7827.373810095179, 37540.43689344635, 37845.62154378449, 37853.0, 37922.0, 37957.0, 3550.9644903551152, 3604.42329227325, 3605.5312809334882, 3605.8557657693923, 3606.4770608261656, 30135.0, 30135.69864301373, 30172.54741178884, 30214.395712085636, 30244.0, 5133.794648214067, 5179.04187725272, 5196.58427325813, 5229.11105112128, 5234.057869583474, 169379.0, 169475.0, 171130.0, 171568.0, 171655.99999999875, 39507.802460987514, 39956.80021599874, 44729.0, 44824.3276350855, 44900.0, 46867.531324687, 46920.5307946923, 46921.0, 46998.060038799034, 47005.5299447008, 13995.86004139966, 14146.22195779242, 14153.929230353782, 14164.64588385278, 14167.78748318776, 11285.943570282096, 11407.885921140849, 11424.485898134604, 11461.484233209525, 11465.0, 12758.0, 12797.29614871191, 12802.0, 12813.167144135601, 12885.22688638666, 5205.869853253699, 5344.572434205332, 5426.484483974016, 5451.890962180734, 5476.507114359727, 989.1641562879355, 997.3168379659811, 1001.8528784541659, 1003.914667253277, 1029.0429900192892, 21922.123115075217, 22036.11855525761, 22046.0, 22153.113875445124, 22192.667109993363, 1090.547422819521, 1103.178132291432, 1104.1395249005452, 1110.0841805510486, 1119.7088756923258, 11670.824937625943, 11680.532778688927, 11681.707957301136, 11697.356645384585, 11764.764704705858, 207730.0, 207733.0, 208960.0, 208988.0, 209247.0, 49656.0, 50308.49691503038, 54078.72960635171, 54196.729016354664, 54316.0, 1420.6235347632885, 1440.2222799688261, 1447.1895738386327, 1450.2241300903966, 1452.1867754057762, 26591.867040664674, 26680.32991752062, 26755.732442675326, 26786.0, 27182.320441989108, 36675.633243668286, 36701.63298366982, 36865.44701829421, 36916.44625330569, 36952.63047369492, 190089.0, 191019.0, 191176.0, 191668.0, 191851.0, 32655.34689306153, 33456.33087338288, 34954.47568286528, 35000.29999400049, 35057.0, 43087.56912430836, 43402.782986084865, 43634.0, 43883.78058109689, 44032.779836101894, 32323.838380807945, 32391.19022024374, 32550.83724581362, 32587.83706081549, 33360.1659958503, 32049.0, 32080.35839283248, 32138.517922231655, 32297.677023230408, 32502.0, 36265.0, 36281.274374511835, 36336.0, 36531.452028219064, 36646.63353366539, 31287.84356078205, 31387.215319617193, 31507.842460788466, 31585.684143158272, 31654.0, 23208.3037508875, 23247.0, 23328.883355583115, 23810.523789524457, 24054.639180412658], "value": 16630.892157275313, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.217174213714, 565.9320881494222, 568.8464114689032, 573.4552175433339, 573.7790950484064, 21593.4601634959, 22378.216762413318, 22385.3284401468, 22455.775442245573, 22487.100515979382, 23241.48930319528, 24130.155444559445, 24174.0, 24550.263492095222, 24559.38601534958, 6373.9362606373925, 6441.838954026163, 6530.673466326689, 6536.313687062861, 6538.509611779112, 6088.178095957033, 6399.8400039998905, 6490.3509649035195, 6494.285628580852, 6517.902231466508, 6293.4650554702675, 6317.399847014526, 6325.715342809584, 6327.0, 6329.113924050636, 6285.214348206497, 6311.715972781236, 6315.684215789215, 6319.0837328587095, 6319.4312511873695, 5712.857178570527, 5914.5268378530045, 5926.8814623707285, 5932.0, 5956.731947062349, 27565.448691026068, 28117.57823632647, 28122.859385703145, 28125.859370703016, 28137.29656758577, 2013.9326157136595, 2018.4651067466987, 2018.798120187984, 2021.7877122902178, 2027.9797202028085, 18353.3576324828, 18874.90562547192, 19096.236150553963, 19152.425427237205, 19154.712679309683, 2358.952820943589, 2413.686220791286, 2414.9034038638433, 2416.818738594595, 2425.4542727886083, 108350.45824770904, 114589.0, 114836.0, 119816.40091799572, 127198.36400818029, 13818.65453363674, 14061.578152655233, 14271.57185284443, 14341.498047568284, 14427.0, 22281.66577501339, 22399.0, 22400.55198896013, 22408.55182896333, 22424.0, 9379.859302110473, 9495.715128546155, 9649.469279189712, 9711.9028809711, 9713.514324283757, 8768.254698350584, 8871.157240062184, 8892.644294228288, 8928.910710892807, 8992.46045237288, 8542.615582298811, 8616.827663446697, 8909.287257019423, 9008.828852249297, 9051.456912585267, 2542.2373288013523, 2606.2181345596623, 2641.168032069892, 2671.879765410561, 2690.892364305406, 926.5969303353063, 950.95720692569, 952.9475878826593, 957.8132264208551, 975.9902400976041, 18379.448616541526, 18462.907685461756, 18876.528086797938, 19050.333238336592, 19082.04589770506, 1005.7385079879284, 1009.7021378693303, 1013.9898601014042, 1014.9644762433279, 1020.4693559349246, 10381.532831022621, 10487.318324308895, 10539.63111291101, 10552.208584356204, 10655.041046305869, 426560.0, 444990.0, 446018.0, 447744.0, 450731.0, 104683.0, 105445.0, 106389.46805265924, 106960.46519767352, 108296.0, 1022.3712416863575, 1115.642994241851, 1143.9656810295705, 1164.574930150506, 1170.631251155883, 19617.509562261057, 19651.70522442136, 19717.70423443621, 19782.40652780419, 20238.19047238094, 52066.73966630142, 53266.73366633142, 53383.199252012026, 53814.46185538094, 54656.72671636617, 62986.37013629988, 65081.67459162674, 66124.66937665474, 66552.0, 66848.0, 13966.58100256994, 14010.929945350208, 14170.858291417366, 14277.0, 14277.071990320595, 22006.0, 22117.77882221157, 22580.887095564416, 22674.886625566767, 22891.54216915619, 17743.0, 17853.642927141645, 17938.730919035963, 17950.730739038663, 18215.0, 15291.158986255417, 15516.0, 16003.359865605711, 16219.51341459758, 16579.336826526804, 18337.449876503728, 18523.44429667112, 18712.81287187111, 18776.812231877506, 18798.436046918614, 13959.302034898417, 14048.859511404755, 14084.507042253472, 14085.577432677037, 14100.435982560582, 17577.648447031243, 17713.0, 17789.822101778816, 17800.91099544494, 17815.376461823773], "value": 11528.147464639791, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1325.854156042835, 1372.972540549189, 1400.7548678981175, 1401.0542883553599, 1401.3903951780974, 14362.994590378677, 14939.327730252138, 14992.850071499282, 14999.700005999886, 15017.474388396407, 14605.488807891727, 14641.853581464182, 14795.482158124469, 14796.260186990661, 14802.925985370084, 2699.0688212566633, 2712.22701530064, 2769.82282529925, 2771.2240572639694, 2777.986110069447, 2727.549954257555, 2754.394033312668, 2765.3363192833676, 2768.0311890838248, 2772.0575004498464, 2627.2118364490575, 2669.9733002670014, 2794.4411117776426, 2795.580662900571, 2795.664520257572, 2665.1071890916564, 2666.6799984001946, 2687.9731202687917, 2703.175531462903, 2707.1472486166795, 2607.256931774435, 2644.074573899139, 2655.8672066396603, 2691.1388355726176, 2697.865106744655, 14896.255187240704, 15018.249087545688, 15018.924905375403, 15022.24888755558, 15022.549323520312, 7328.596927169004, 7546.132194797614, 7550.73572424968, 7560.092788865371, 7579.583122928237, 5120.743962801882, 5296.3379577552805, 5347.3423238796095, 5359.0, 5373.543248823855, 1922.5482011727233, 1946.6690662587393, 1976.901154942247, 2005.1778770704086, 2005.8696184747944, 25817.612735808976, 26027.479450410887, 26061.73938260612, 26235.868820655774, 26249.868750656125, 6385.329540398191, 6624.138861947916, 6710.261871194165, 6766.69549870257, 6776.525643204928, 16969.321227151024, 16998.490045298662, 17048.65902681964, 17056.0, 17061.829381706273, 7213.422926165894, 7390.704371825174, 7396.926030739732, 7402.185759566443, 7410.11078670563, 6724.125863637696, 6755.898661520081, 6829.487788415889, 6845.452363810883, 6870.965645171742, 5089.440161582223, 5192.350956130484, 5306.548943339782, 5326.893462130735, 5362.812301569426, 1504.0674781635455, 1507.6758496923214, 1517.4385477373442, 1523.1242035829443, 1539.5766164304905, 842.8187939593017, 878.9208971192495, 890.6392910870978, 890.7105190813012, 901.9188273055456, 7191.173015103225, 7260.96369518149, 7296.635168241567, 7314.341709246087, 7321.560706357635, 704.8097013806346, 708.624429052603, 722.0649259209337, 722.7687140115113, 728.2826415980255, 4562.84030058953, 4576.06190730906, 4632.166210082218, 4721.622270218374, 4872.853814385574, 20809.06359213839, 21053.0, 21569.78430215678, 21601.891990539945, 21767.129314827547, 20812.47968800792, 21481.57036859254, 21697.783022169893, 21774.45563860916, 21804.23685171043, 10623.681289561326, 10918.07196388316, 10933.56265749377, 10963.122950163968, 10996.945015275032, 7885.842283154419, 7947.682092716458, 8025.357971362394, 8027.919720802951, 8061.113277539584, 17608.38370657021, 18071.638567228845, 18080.276788928295, 18425.907870460564, 18628.348007819663, 18941.14764835558, 18951.336703215322, 19047.14287857022, 19226.230950761812, 19290.903545482182, 10949.781004380027, 11161.274517156358, 11164.106871450102, 11172.441377931233, 11174.49714762854, 13722.245276509888, 13828.170309781446, 13901.72196556043, 13904.0, 13968.30158492051, 10757.193210509087, 10872.510737016695, 11015.889841101487, 11141.108711303239, 11194.496247669038, 10451.529681164518, 10716.785664286515, 10862.94568527184, 10911.127109831354, 11010.449477526252, 9527.428354298765, 9651.0, 9717.611295548382, 9751.658691945748, 9769.413835169913, 6768.849295619658, 6922.826929326807, 6989.266127056586, 7002.3697867192195, 7025.648717564203, 7043.190033146254, 7118.5017048806085, 7155.391791697556, 7160.427165826617, 7209.35115839577], "value": 6478.327903469472, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [489.49337435754, 525.4614020628854, 529.4308618235398, 530.3874025500546, 531.619891777379, 6488.091667166595, 6494.415502604765, 6503.049085274422, 6511.674416279191, 6524.249711283204, 6375.139356186914, 6379.0, 6390.201224846895, 6410.134631824702, 6420.839479013027, 5205.713685747282, 5217.139172036609, 5233.0, 5257.447967963366, 5269.0, 4983.352164218664, 5091.414487333948, 5213.165893457048, 5218.243354713564, 5226.8693282667855, 5058.570021548173, 5060.772265248054, 5069.822556210534, 5105.617078719092, 5127.564157046637, 5059.569936555397, 5071.18860982241, 5087.262346959707, 5087.974560127194, 5090.414602320743, 4445.666575006855, 4541.909161816779, 4550.68145229834, 4552.567506086916, 4574.405327307429, 6166.136740856284, 6299.118123462719, 6307.96846015767, 6313.242410910674, 6327.430531252209, 5724.513416359573, 5734.225879506255, 5763.135529670583, 5791.797287094932, 5835.5915085944, 6716.884181482817, 6732.158480189976, 6755.0, 6788.456923446161, 6806.196357965143, 4975.776090075955, 4987.576056035241, 4987.600991920638, 4991.001799640087, 5004.874878128039, 6495.935040649628, 6725.0, 6915.792526224222, 6922.861542769167, 6965.825854353631, 5011.574016208663, 5029.597632189416, 5064.366954130734, 5076.644634875597, 5080.399674102646, 5101.413337466165, 5101.974490127525, 5129.281900533928, 5134.717590532482, 5148.588112950955, 5738.512226460714, 5754.971225143931, 5783.681897495594, 5844.649321040666, 5848.941510584839, 6759.662016899136, 6793.660316984131, 6803.387695107464, 6805.625690587065, 6813.454923606099, 1768.814274501159, 1784.598465345287, 1797.5416268851359, 1807.548112971757, 1811.6105037416755, 1182.2197349749297, 1207.710149564116, 1226.1539537718945, 1227.8035514317667, 1229.846269216348, 5688.516476099578, 5742.885142297131, 5762.4525670061275, 5773.278340207474, 5804.158397032406, 6883.346082122191, 6914.9308506915295, 6915.550489218285, 6923.723051078001, 6924.169099708067, 5633.183188437653, 5762.971185144047, 5768.596198266165, 5796.82609521715, 5805.055306472379, 3617.385044542434, 3641.7450778445254, 3648.4709717090873, 3660.5058317127377, 3671.6879065279218, 6562.179727534059, 6638.103855979478, 6643.202815662152, 6652.634105124168, 6693.364130407604, 6513.413792758674, 6871.4502839772695, 7010.193827709879, 7099.680514376865, 7136.537009912955, 6533.379328963741, 6543.574667646588, 6551.21385433751, 6558.409743123142, 6653.866922661519, 6759.594424334556, 6780.779459697302, 6826.620822692799, 6862.0, 6864.656767161722, 6735.831604209934, 6769.255381908085, 6826.0, 6827.89758153638, 6875.965620171867, 6575.63833989116, 6598.27418983921, 6610.867782644416, 6637.1703537057865, 6648.642435570199, 5067.0, 5082.771275292546, 5101.38783345986, 5102.464241254764, 5117.488251174853, 6587.571807832475, 6601.702923368364, 6630.370114839083, 6879.828004299932, 6911.447084233349, 6661.533692641468, 6661.700223489857, 6662.136640252739, 6667.233268174222, 6677.532572719863, 6656.900146497903, 6660.766873159416, 6676.532642715158, 6685.364890335411, 6719.865602688016, 6543.443807276435, 6584.604923704593, 6643.734250630114, 6647.833804154935, 6652.800415987528, 6715.966420168063, 6794.966025169842, 6807.591544507345, 6820.522563420513, 6834.965825170842, 6488.318726533646, 6515.706793194223, 6544.770933017512, 6594.406503414716, 6608.852123060121], "value": 5156.067868019701, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [882.8146089321242, 884.9336299777518, 900.1538553759464, 902.9683961061364, 913.7806926337681, 18312.26750929963, 19116.713249301272, 19126.42620721377, 19133.139008744605, 19163.808361916395, 18002.63994720105, 18160.4551863444, 18169.727454088166, 18231.453056408296, 18251.452456426294, 953.4231789767196, 954.3415043619898, 954.6658669465701, 954.71358592422, 957.4877440569297, 960.7550074730934, 960.9429627409863, 961.0149596663441, 961.538461538462, 963.6290028339105, 998.7752755629998, 1000.7648202672366, 1027.7379268286613, 1034.260503739826, 1040.47976011994, 1020.882598501167, 1023.8208313545138, 1025.5897640943608, 1025.6615316945426, 1026.091908660833, 724.1852915470096, 741.1846968334843, 745.2956955676888, 745.4930647159983, 749.6064566102785, 18982.43052708407, 19113.61772764537, 19156.61686766271, 19158.904205479022, 19175.232990680357, 20964.685529717066, 20985.370438886857, 21721.13115475379, 21888.233911813168, 21907.780922190734, 13187.868121318856, 13382.330883455885, 13639.386227619781, 13754.93122534381, 13756.312184390841, 3556.28874225156, 3564.7148228141946, 3572.392693242155, 3572.517710109128, 3573.446115852021, 102585.48707256417, 119865.40067299608, 130508.0, 134528.32735836357, 136271.0, 16020.839791602168, 16403.753943690856, 16445.25996330168, 16529.421470248482, 16530.504084877473, 30035.249118772204, 30915.0725478236, 30994.22514437112, 31258.531122033186, 31276.0, 8017.358611311081, 8026.117127116129, 8027.518348899085, 8043.356531477468, 8067.757967260992, 4156.25187466259, 4218.303979843292, 4240.300350442142, 4250.23495770758, 4300.89247768802, 4992.2511623256805, 5078.619103567247, 5081.28861959326, 5127.333446651986, 5133.614978876599, 1073.1736562846565, 1101.730076131353, 1105.5688281570194, 1108.8225883858545, 1109.778044391125, 584.0946532874028, 596.2189531713469, 598.0968737206849, 610.2707264818499, 615.827568280882, 10811.945940270249, 10827.512761925733, 10941.781164376827, 10950.726231844108, 11067.0, 626.9122322874802, 630.9053641953652, 635.1425575473074, 635.8060791458649, 647.5402464250341, 5265.763040663102, 5267.130923397596, 5360.410354860962, 5389.083855744533, 5391.757370918318, 114311.0, 117415.0, 118137.0, 118835.0, 121335.0, 103481.48259258656, 105144.0, 105730.47134764431, 106808.0, 109850.0, 90036.54981725049, 90742.09257907468, 91713.08286917179, 92659.53670231605, 94160.0, 9970.55132519024, 9992.900070999487, 10021.39871607706, 10072.294939354175, 10166.593336266762, 42264.366034508894, 43015.56984430116, 43664.0, 43707.78146109249, 44010.33984490299, 55502.0, 56312.43687563236, 57078.429215707314, 57894.4210557889, 58396.0, 14917.0, 14995.700085998436, 15085.24573771329, 15100.320485577955, 15184.240787960778, 15909.52271431859, 15919.68160636804, 16048.0, 16140.95083819548, 16182.757258640895, 14640.70718585601, 14755.262236887898, 14796.0, 14987.475438359605, 14992.775108373602, 13582.11716238481, 13711.382987765774, 13799.79300310476, 13928.164310141019, 13933.164010159422, 13048.934755326163, 13276.800847987095, 13281.601551953458, 13298.202107873558, 13502.32488375597, 10360.637377691744, 10406.427646479213, 10545.841812372668, 10594.788104238027, 10811.945940270563, 10851.45742712877, 10882.347059176474, 11032.0, 11075.501602427748, 11169.72075698114], "value": 8472.288012058163, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1433.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 108.0, 110.0, 108.0, 106.0, 109.0, 110.0, 109.0, 108.0, 108.0], "value": 108.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 118.0, 116.0, 119.0, 116.0, 119.0, 119.0, 122.0], "value": 117.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 164.0, 164.0, 161.0, 162.0, 167.0, 166.0, 167.0, 163.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 77.0, 73.0, 73.0, 73.0, 74.0, 74.0, 74.0, 74.0], "value": 73.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 80.0, 79.0, 80.0, 79.0, 79.0, 80.0, 79.0, 79.0], "value": 79.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 113.0, 111.0, 114.0, 113.0, 115.0, 114.0, 114.0, 114.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 147.0, 147.0, 146.0, 147.0, 147.0, 149.0, 148.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 94.0, 94.0, 95.0, 94.0, 95.0, 100.0, 99.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 54.0, 55.0, 55.0, 54.0, 58.0, 55.0, 56.0, 54.0, 52.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 38.0, 37.0, 37.0, 38.0, 37.0, 37.0, 37.0, 37.0, 37.0], "value": 37.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 80.0, 73.0, 79.0, 78.0, 75.0, 77.0, 76.0, 75.0, 75.0], "value": 76.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 121.0, 134.0, 123.0, 120.0, 123.0, 116.0, 133.0, 124.0, 131.0], "value": 125.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 173.0, 181.0, 173.0, 181.0, 178.0, 173.0, 174.0, 176.0, 171.0], "value": 175.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 63.0, 63.0, 62.0, 71.0, 64.0, 66.0, 67.0, 63.0, 63.0], "value": 64.9, "unit": "score"}]}]} 05:17:07 INFO - Return code: 0 05:17:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:17:07 INFO - # TBPL SUCCESS # 05:17:07 INFO - Running post-action listener: _package_coverage_data 05:17:07 INFO - Running post-action listener: _resource_record_post_action 05:17:07 INFO - [mozharness: 2017-09-09 12:17:07.817562Z] Finished run-tests step (success) 05:17:07 INFO - Running post-run listener: _resource_record_post_run 05:17:07 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 8888320; Write bytes: 424812544; Read time: 2484; Write time: 365632 05:17:07 INFO - TinderboxPrint: CPU usage
13.1% 05:17:07 INFO - TinderboxPrint: I/O read bytes / time
8,888,320 / 2,484 05:17:07 INFO - TinderboxPrint: I/O write bytes / time
424,812,544 / 365,632 05:17:07 INFO - TinderboxPrint: CPU idle
8,235.1 (86.9%) 05:17:07 INFO - TinderboxPrint: CPU user
1,190.5 (12.6%) 05:17:07 INFO - TinderboxPrint: Swap in / out
0 / 0 05:17:07 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 12980224; Read time: 0; Write time: 1684 05:17:07 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:17:07 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 7143424; Write bytes: 411832320; Read time: 2440; Write time: 363948 05:17:08 INFO - Running post-run listener: _upload_blobber_files 05:17:08 INFO - Blob upload gear active. 05:17:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:17:08 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 05:17:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:17:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:17:08 INFO - (blobuploader) - INFO - Open directory for files ... 05:17:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:17:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:17:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:17:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:17:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:17:09 INFO - (blobuploader) - INFO - Done attempting. 05:17:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:17:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:17:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:17:10 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:17:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:17:10 INFO - (blobuploader) - INFO - Done attempting. 05:17:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:17:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:17:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:17:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:17:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:17:11 INFO - (blobuploader) - INFO - Done attempting. 05:17:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:17:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:17:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:17:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:17:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:17:19 INFO - (blobuploader) - INFO - Done attempting. 05:17:19 INFO - (blobuploader) - INFO - Iteration through files over. 05:17:19 INFO - Return code: 0 05:17:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:17:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:17:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a237136118b4d469afe44d17bce285dedcb6e02b215e05361792770770c8b37863ce71070a8e589345335c7a2f007875203edce1f6d4a249442faa75894cec72", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e3156f00d6a150b04ae315da0706cf827d4c9d376eabe587e7d788fb44f877c3bf4ef56ff559bb9ef690a102af1ae31d053f800169acf0d0f0dd416f411500e4", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f78f6f1ed544cb4b3d8e201238d2e6760c543dcbf74aaa311673b4030266ce64b8f1273d33436fc172e5293f34bbd4aa1ebca2ea3b7550336b5606af67dea079", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1fa86f00c626adb492afd5c59492a680b1adfd282e279a540b43f05be801f89c3c78ae6d8a3ea92a785d0f50f6f210b00270c87f679605e771519f08c04ba4c4"} 05:17:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:17:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:17:19 INFO - Contents: 05:17:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a237136118b4d469afe44d17bce285dedcb6e02b215e05361792770770c8b37863ce71070a8e589345335c7a2f007875203edce1f6d4a249442faa75894cec72", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e3156f00d6a150b04ae315da0706cf827d4c9d376eabe587e7d788fb44f877c3bf4ef56ff559bb9ef690a102af1ae31d053f800169acf0d0f0dd416f411500e4", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f78f6f1ed544cb4b3d8e201238d2e6760c543dcbf74aaa311673b4030266ce64b8f1273d33436fc172e5293f34bbd4aa1ebca2ea3b7550336b5606af67dea079", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1fa86f00c626adb492afd5c59492a680b1adfd282e279a540b43f05be801f89c3c78ae6d8a3ea92a785d0f50f6f210b00270c87f679605e771519f08c04ba4c4"} 05:17:19 INFO - Running post-run listener: copy_logs_to_upload_dir 05:17:19 INFO - Copying logs to upload dir... 05:17:19 INFO - mkdir: /builds/slave/test/build/upload/logs 05:17:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.210022 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-09-09 05:17:19.280266) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-09 05:17:19.283574) ========= 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=652eb03db935cfc1c15ebda0000001ad-1504958193.571302-813399221 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/Firefox-Non-PGO/sha512/a237136118b4d469afe44d17bce285dedcb6e02b215e05361792770770c8b37863ce71070a8e589345335c7a2f007875203edce1f6d4a249442faa75894cec72", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e3156f00d6a150b04ae315da0706cf827d4c9d376eabe587e7d788fb44f877c3bf4ef56ff559bb9ef690a102af1ae31d053f800169acf0d0f0dd416f411500e4", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f78f6f1ed544cb4b3d8e201238d2e6760c543dcbf74aaa311673b4030266ce64b8f1273d33436fc172e5293f34bbd4aa1ebca2ea3b7550336b5606af67dea079", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1fa86f00c626adb492afd5c59492a680b1adfd282e279a540b43f05be801f89c3c78ae6d8a3ea92a785d0f50f6f210b00270c87f679605e771519f08c04ba4c4"} build_url:https://queue.taskcluster.net/v1/task/dkh--l4YT16D-V81XBCmig/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011149 build_url: 'https://queue.taskcluster.net/v1/task/dkh--l4YT16D-V81XBCmig/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a237136118b4d469afe44d17bce285dedcb6e02b215e05361792770770c8b37863ce71070a8e589345335c7a2f007875203edce1f6d4a249442faa75894cec72", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e3156f00d6a150b04ae315da0706cf827d4c9d376eabe587e7d788fb44f877c3bf4ef56ff559bb9ef690a102af1ae31d053f800169acf0d0f0dd416f411500e4", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f78f6f1ed544cb4b3d8e201238d2e6760c543dcbf74aaa311673b4030266ce64b8f1273d33436fc172e5293f34bbd4aa1ebca2ea3b7550336b5606af67dea079", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1fa86f00c626adb492afd5c59492a680b1adfd282e279a540b43f05be801f89c3c78ae6d8a3ea92a785d0f50f6f210b00270c87f679605e771519f08c04ba4c4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-09 05:17:19.312191) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 05:17:19.312558) ========= 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=652eb03db935cfc1c15ebda0000001ad-1504958193.571302-813399221 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004451 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 05:17:19.394354) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-09 05:17:19.394673) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-09 05:17:19.395003) ========= ========= Total master_lag: 0.23 =========