builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-039 starttime: 1505499865.03 results: success (0) revision: 9071a20f3eaa804a439990b7596dbc16d52d1e20 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-15 11:24:25.028076) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-15 11:24:25.030177) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-15 11:24:25.030473) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-15 11:24:25.052493) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 11:24:25.052824) ========= 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=5bd038846534b2fdfa68eeae000001e2-1505493361.299680-1570690761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-15 11:24:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 210M=0s 2017-09-15 11:24:25 (210 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.100318 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 11:24:25.169661) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 11:24:25.169962) ========= 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=5bd038846534b2fdfa68eeae000001e2-1505493361.299680-1570690761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019177 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 11:24:25.263914) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 13 secs) (at 2017-09-15 11:24:25.264248) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9071a20f3eaa804a439990b7596dbc16d52d1e20 --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 9071a20f3eaa804a439990b7596dbc16d52d1e20 --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=5bd038846534b2fdfa68eeae000001e2-1505493361.299680-1570690761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-15 11:24:25,348 truncating revision to first 12 chars 2017-09-15 11:24:25,348 Setting DEBUG logging. 2017-09-15 11:24:25,348 attempt 1/10 2017-09-15 11:24:25,348 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9071a20f3eaa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-15 11:24:26,034 sleeping for 11.00s (attempt 1/10) 2017-09-15 11:24:37,045 attempt 2/10 2017-09-15 11:24:37,045 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9071a20f3eaa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-15 11:24:38,109 unpacking tar archive at: mozilla-central-9071a20f3eaa/testing/mozharness/ program finished with exit code 0 elapsedTime=13.043291 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 13 secs) (at 2017-09-15 11:24:38.328668) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-15 11:24:38.328978) ========= script_repo_revision: 9071a20f3eaa804a439990b7596dbc16d52d1e20 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-15 11:24:38.329342) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-15 11:24:38.329600) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-15 11:24:38.346073) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-09-15 11:24:38.346387) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=5bd038846534b2fdfa68eeae000001e2-1505493361.299680-1570690761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:24:38 INFO - MultiFileLogger online at 20170915 11:24:38 in /builds/slave/test 11:24:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:24:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:24:38 INFO - {'append_to_log': False, 11:24:38 INFO - 'base_work_dir': '/builds/slave/test', 11:24:38 INFO - 'blob_upload_branch': 'Firefox', 11:24:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:24:38 INFO - 'branch': 'Firefox', 11:24:38 INFO - 'buildbot_json_path': 'buildprops.json', 11:24:38 INFO - 'code_coverage': False, 11:24:38 INFO - 'config_files': ('talos/linux_config.py',), 11:24:38 INFO - 'default_actions': ('clobber', 11:24:38 INFO - 'read-buildbot-config', 11:24:38 INFO - 'download-and-extract', 11:24:38 INFO - 'populate-webroot', 11:24:38 INFO - 'create-virtualenv', 11:24:38 INFO - 'install', 11:24:38 INFO - 'setup-mitmproxy', 11:24:38 INFO - 'run-tests'), 11:24:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:24:38 INFO - 'disable_ccov_upload': False, 11:24:38 INFO - 'disable_stylo': False, 11:24:38 INFO - 'download_minidump_stackwalk': True, 11:24:38 INFO - 'download_symbols': 'ondemand', 11:24:38 INFO - 'enable_stylo': False, 11:24:38 INFO - 'enable_webrender': False, 11:24:38 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:24:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:24:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:24:38 INFO - 'gecko_profile': False, 11:24:38 INFO - 'gecko_profile_interval': 0, 11:24:38 INFO - 'installer_path': 'installer.exe', 11:24:38 INFO - 'log_level': 'info', 11:24:38 INFO - 'log_name': 'talos', 11:24:38 INFO - 'log_to_console': True, 11:24:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:24:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:24:38 INFO - 'opt_config_files': (), 11:24:38 INFO - 'pip_index': False, 11:24:38 INFO - 'suite': 'dromaeojs-e10s', 11:24:38 INFO - 'system_bits': '32', 11:24:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:24:38 INFO - 'title': 'talos-linux64-ix-039', 11:24:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:24:38 INFO - 'use_talos_json': True, 11:24:38 INFO - 'verify': 'False', 11:24:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:24:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:24:38 INFO - 'work_dir': 'build'} 11:24:38 INFO - [mozharness: 2017-09-15 18:24:38.567340Z] Running clobber step. 11:24:38 INFO - Running pre-action listener: _resource_record_pre_action 11:24:38 INFO - Running main action method: clobber 11:24:38 INFO - rmtree: /builds/slave/test/build 11:24:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:24:39 INFO - Running post-action listener: _resource_record_post_action 11:24:39 INFO - [mozharness: 2017-09-15 18:24:39.574975Z] Finished clobber step (success) 11:24:39 INFO - [mozharness: 2017-09-15 18:24:39.575071Z] Running read-buildbot-config step. 11:24:39 INFO - Running pre-action listener: _resource_record_pre_action 11:24:39 INFO - Running main action method: read_buildbot_config 11:24:39 INFO - Using buildbot properties: 11:24:39 INFO - { 11:24:39 INFO - "project": "", 11:24:39 INFO - "product": "firefox", 11:24:39 INFO - "who": "ffxbld@noreply.mozilla.org", 11:24:39 INFO - "installer_path": "public/build/target.tar.bz2", 11:24:39 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 11:24:39 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:24:39 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 11:24:39 INFO - "stage_platform": "linux64-qr", 11:24:39 INFO - "basedir": "/builds/slave/test", 11:24:39 INFO - "buildnumber": 59, 11:24:39 INFO - "platform": "ubuntu64_hw_qr", 11:24:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:24:39 INFO - "slavebuilddir": "test", 11:24:39 INFO - "taskId": "Owf1M9DhQxO6L0sm443xZw", 11:24:39 INFO - "branch": "mozilla-central", 11:24:39 INFO - "script_repo_revision": "production", 11:24:39 INFO - "revision": "9071a20f3eaa804a439990b7596dbc16d52d1e20", 11:24:39 INFO - "slavename": "talos-linux64-ix-039", 11:24:39 INFO - "repo_path": "mozilla-central" 11:24:39 INFO - } 11:24:39 INFO - Finding installer, test and symbols from parent task. 11:24:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Owf1M9DhQxO6L0sm443xZw'}, attempt #1 11:24:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Owf1M9DhQxO6L0sm443xZw'}, attempt #1 11:24:40 INFO - Task dependencies: dGTWU5R0RMmqQFwWXFslJA 11:24:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA'}, attempt #1 11:24:40 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.tar.bz2 11:24:40 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.test_packages.json 11:24:40 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.crashreporter-symbols.zip 11:24:40 INFO - Running post-action listener: _resource_record_post_action 11:24:40 INFO - [mozharness: 2017-09-15 18:24:40.956751Z] Finished read-buildbot-config step (success) 11:24:40 INFO - [mozharness: 2017-09-15 18:24:40.956965Z] Running download-and-extract step. 11:24:40 INFO - Running pre-action listener: _resource_record_pre_action 11:24:40 INFO - Running main action method: download_and_extract 11:24:40 INFO - mkdir: /builds/slave/test/build/tests 11:24:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:40 INFO - trying https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.test_packages.json 11:24:40 INFO - Downloading https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:24:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:24:41 INFO - Downloaded 989 bytes. 11:24:41 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:24:41 INFO - Using the following test package requirements: 11:24:41 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:24:41 INFO - u'common': [u'target.common.tests.zip'], 11:24:41 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:24:41 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:24:41 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:24:41 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:24:41 INFO - u'mozbase': [u'target.common.tests.zip'], 11:24:41 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:24:41 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:24:41 INFO - u'web-platform': [u'target.common.tests.zip', 11:24:41 INFO - u'target.web-platform.tests.tar.gz'], 11:24:41 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:24:41 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:24:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.common.tests.zip 11:24:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:24:41 INFO - Fetch https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.common.tests.zip into memory 11:24:42 INFO - Content-Length response header: 54736823 11:24:42 INFO - Bytes received: 54736823 11:24:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.talos.tests.zip 11:24:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:24:53 INFO - Fetch https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.talos.tests.zip into memory 11:24:54 INFO - Content-Length response header: 14502661 11:24:54 INFO - Bytes received: 14502661 11:24:54 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')]} 11:24:54 INFO - trying https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.tar.bz2 11:24:54 INFO - Downloading https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:24:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:24:55 INFO - Downloaded 61395675 bytes. 11:24:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.tar.bz2 11:24:55 INFO - mkdir: /builds/slave/test/properties 11:24:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:24:55 INFO - Writing to file /builds/slave/test/properties/build_url 11:24:55 INFO - Contents: 11:24:55 INFO - build_url:https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.tar.bz2 11:24:55 INFO - Running post-action listener: _resource_record_post_action 11:24:55 INFO - Running post-action listener: find_tests_for_verification 11:24:55 INFO - Running post-action listener: set_extra_try_arguments 11:24:55 INFO - [mozharness: 2017-09-15 18:24:55.769558Z] Finished download-and-extract step (success) 11:24:55 INFO - [mozharness: 2017-09-15 18:24:55.769735Z] Running populate-webroot step. 11:24:55 INFO - Running pre-action listener: _resource_record_pre_action 11:24:55 INFO - Running main action method: populate_webroot 11:24:55 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:24:55 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:55 INFO - 'tests': ['tresize', 11:24:55 INFO - 'tcanvasmark']}, 11:24:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:24:55 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:55 INFO - 'tests': ['dromaeo_css', 11:24:55 INFO - 'kraken']}, 11:24:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:24:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:24:55 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:24:55 INFO - 'talos_options': ['--disable-stylo'], 11:24:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:24:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:24:55 INFO - 'tests': ['damp', 'tps']}, 11:24:55 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:24:55 INFO - 'talos_options': ['--disable-stylo'], 11:24:55 INFO - 'tests': ['damp', 'tps']}, 11:24:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:24:55 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:55 INFO - 'tests': ['dromaeo_dom']}, 11:24:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:24:55 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:55 INFO - 'tests': ['basic_compositor_video', 11:24:55 INFO - 'glvideo']}, 11:24:55 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:24:55 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:24:55 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:24:55 INFO - 'talos_options': ['--disable-stylo'], 11:24:55 INFO - 'tests': ['ts_paint_webext', 11:24:55 INFO - 'tp5o_webext']}, 11:24:55 INFO - 'other-e10s': {'tests': ['a11yr', 11:24:55 INFO - 'ts_paint', 11:24:55 INFO - 'tpaint', 11:24:55 INFO - 'sessionrestore', 11:24:55 INFO - 'sessionrestore_many_windows', 11:24:55 INFO - 'sessionrestore_no_auto_restore', 11:24:55 INFO - 'tabpaint']}, 11:24:55 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:55 INFO - 'tests': ['a11yr', 11:24:55 INFO - 'ts_paint', 11:24:55 INFO - 'tpaint', 11:24:55 INFO - 'sessionrestore', 11:24:55 INFO - 'sessionrestore_many_windows', 11:24:55 INFO - 'sessionrestore_no_auto_restore', 11:24:55 INFO - 'tabpaint']}, 11:24:55 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:24:55 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:24:55 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:55 INFO - 'tests': ['bloom_basic_singleton']}, 11:24:55 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:55 INFO - 'tests': ['bloom_basic']}, 11:24:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:24:55 INFO - 'tsvgr_opacity', 11:24:55 INFO - 'tart', 11:24:55 INFO - 'tscrollx', 11:24:55 INFO - 'tsvg_static']}, 11:24:55 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:55 INFO - 'tests': ['tsvgx', 11:24:55 INFO - 'tsvgr_opacity', 11:24:55 INFO - 'tart', 11:24:55 INFO - 'tscrollx', 11:24:55 INFO - 'tsvg_static']}, 11:24:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:24:55 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:24:55 INFO - 'talos_options': ['--disable-stylo'], 11:24:55 INFO - 'tests': ['tp5o']}, 11:24:55 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:24:55 INFO - 'talos_options': ['--mitmproxy', 11:24:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:24:55 INFO - '--firstNonBlankPaint'], 11:24:55 INFO - 'tests': ['tp6_google', 11:24:55 INFO - 'tp6_youtube', 11:24:55 INFO - 'tp6_amazon', 11:24:55 INFO - 'tp6_facebook']}, 11:24:55 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:24:55 INFO - 'talos_options': ['--disable-stylo', 11:24:55 INFO - '--mitmproxy', 11:24:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:24:55 INFO - '--firstNonBlankPaint'], 11:24:55 INFO - 'tests': ['tp6_google', 11:24:55 INFO - 'tp6_youtube', 11:24:55 INFO - 'tp6_amazon', 11:24:55 INFO - 'tp6_facebook']}, 11:24:55 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:24:55 INFO - 'talos_options': ['--stylo-threads=1', 11:24:55 INFO - '--mitmproxy', 11:24:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:24:55 INFO - '--firstNonBlankPaint'], 11:24:55 INFO - 'tests': ['tp6_google', 11:24:55 INFO - 'tp6_youtube', 11:24:55 INFO - 'tp6_amazon', 11:24:55 INFO - 'tp6_facebook']}, 11:24:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:24:55 INFO - 'talos_options': ['--xperf_path', 11:24:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:24:55 INFO - 'tests': ['tp5n']}, 11:24:55 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:24:55 INFO - 'talos_options': ['--disable-stylo', 11:24:55 INFO - '--xperf_path', 11:24:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:24:55 INFO - 'tests': ['tp5n']}}} 11:24:55 INFO - Running post-action listener: _resource_record_post_action 11:24:55 INFO - [mozharness: 2017-09-15 18:24:55.784753Z] Finished populate-webroot step (success) 11:24:55 INFO - [mozharness: 2017-09-15 18:24:55.784843Z] Running create-virtualenv step. 11:24:55 INFO - Running pre-action listener: _resource_record_pre_action 11:24:55 INFO - Running main action method: create_virtualenv 11:24:55 INFO - Creating virtualenv /builds/slave/test/build/venv 11:24:55 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:24:55 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:24:55 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:24:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:24:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:24:56 INFO - Installing distribute.............................................................................................................................................................................................done. 11:24:56 INFO - Installing pip...............done. 11:24:56 INFO - Return code: 0 11:24:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:24:56 INFO - Reading from file tmpfile_stdout 11:24:56 INFO - Output received: 11:24:56 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:24:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c69a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6d090>, '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 0x2c6dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c67f90>, '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': '5bd038846534b2fdfa68eeae000001e2-1505493361.299680-1570690761', '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 11:24:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:24:56 INFO - Using env: {'DISPLAY': ':0', 11:24:56 INFO - 'HOME': '/home/cltbld', 11:24:56 INFO - 'LANG': 'en_US.UTF-8', 11:24:56 INFO - 'LANGUAGE': 'en_US:en', 11:24:56 INFO - 'LOGNAME': 'cltbld', 11:24:56 INFO - 'MAIL': '/var/mail/cltbld', 11:24:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:56 INFO - 'MOZ_NO_REMOTE': '1', 11:24:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:56 INFO - 'NO_EM_RESTART': '1', 11:24:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:56 INFO - 'PWD': '/builds/slave/test', 11:24:56 INFO - 'SHELL': '/bin/bash', 11:24:56 INFO - 'SHLVL': '1', 11:24:56 INFO - 'TERM': 'linux', 11:24:56 INFO - 'TMOUT': '86400', 11:24:56 INFO - 'USER': 'cltbld', 11:24:56 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1505493361.299680-1570690761', 11:24:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:56 INFO - '_': '/tools/buildbot/bin/python'} 11:24:57 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:24:57 INFO - Downloading/unpacking pip>=1.5 11:24:57 INFO - Running setup.py egg_info for package pip 11:24:57 INFO - warning: no files found matching 'pip/cacert.pem' 11:24:57 INFO - warning: no files found matching '*.html' under directory 'docs' 11:24:57 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:24:57 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:24:57 INFO - Installing collected packages: pip 11:24:57 INFO - Found existing installation: pip 1.1 11:24:57 INFO - Uninstalling pip: 11:24:57 INFO - Successfully uninstalled pip 11:24:57 INFO - Running setup.py install for pip 11:24:57 INFO - warning: no files found matching 'pip/cacert.pem' 11:24:57 INFO - warning: no files found matching '*.html' under directory 'docs' 11:24:57 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:24:57 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:24:57 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:24:57 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:24:57 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:24:57 INFO - Successfully installed pip 11:24:57 INFO - Cleaning up... 11:24:57 INFO - Return code: 0 11:24:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:24: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')]} 11:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24: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')]} 11:24:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24: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 0x28fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c69a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6d090>, '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 0x2c6dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c67f90>, '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': '5bd038846534b2fdfa68eeae000001e2-1505493361.299680-1570690761', '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 11:24: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 11:24: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 11:24:58 INFO - Using env: {'DISPLAY': ':0', 11:24:58 INFO - 'HOME': '/home/cltbld', 11:24:58 INFO - 'LANG': 'en_US.UTF-8', 11:24:58 INFO - 'LANGUAGE': 'en_US:en', 11:24:58 INFO - 'LOGNAME': 'cltbld', 11:24:58 INFO - 'MAIL': '/var/mail/cltbld', 11:24:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:58 INFO - 'MOZ_NO_REMOTE': '1', 11:24:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:58 INFO - 'NO_EM_RESTART': '1', 11:24:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:58 INFO - 'PWD': '/builds/slave/test', 11:24:58 INFO - 'SHELL': '/bin/bash', 11:24:58 INFO - 'SHLVL': '1', 11:24:58 INFO - 'TERM': 'linux', 11:24:58 INFO - 'TMOUT': '86400', 11:24:58 INFO - 'USER': 'cltbld', 11:24:58 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1505493361.299680-1570690761', 11:24:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:58 INFO - '_': '/tools/buildbot/bin/python'} 11:24:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:58 INFO - Downloading/unpacking psutil>=3.1.1 11:24: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 11:24: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 11:24: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 11:24: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 11:24:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:24:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:24:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:24:59 INFO - Installing collected packages: psutil 11:24:59 INFO - Running setup.py install for psutil 11:24:59 INFO - building 'psutil._psutil_linux' extension 11:24:59 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 11:24:59 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 11:24:59 INFO - building 'psutil._psutil_posix' extension 11:24:59 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 11:24:59 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 11:24:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:24:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:24:59 INFO - Successfully installed psutil 11:24:59 INFO - Cleaning up... 11:25:00 INFO - Return code: 0 11:25:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:25:00 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')]} 11:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:00 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')]} 11:25:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:00 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 0x28fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c69a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6d090>, '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 0x2c6dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c67f90>, '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': '5bd038846534b2fdfa68eeae000001e2-1505493361.299680-1570690761', '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 11:25:00 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 11:25:00 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 11:25:00 INFO - Using env: {'DISPLAY': ':0', 11:25:00 INFO - 'HOME': '/home/cltbld', 11:25:00 INFO - 'LANG': 'en_US.UTF-8', 11:25:00 INFO - 'LANGUAGE': 'en_US:en', 11:25:00 INFO - 'LOGNAME': 'cltbld', 11:25:00 INFO - 'MAIL': '/var/mail/cltbld', 11:25:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:00 INFO - 'MOZ_NO_REMOTE': '1', 11:25:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:00 INFO - 'NO_EM_RESTART': '1', 11:25:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:00 INFO - 'PWD': '/builds/slave/test', 11:25:00 INFO - 'SHELL': '/bin/bash', 11:25:00 INFO - 'SHLVL': '1', 11:25:00 INFO - 'TERM': 'linux', 11:25:00 INFO - 'TMOUT': '86400', 11:25:00 INFO - 'USER': 'cltbld', 11:25:00 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1505493361.299680-1570690761', 11:25:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:00 INFO - '_': '/tools/buildbot/bin/python'} 11:25:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:25:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:25:01 INFO - Installing collected packages: mozsystemmonitor 11:25:01 INFO - Running setup.py install for mozsystemmonitor 11:25:01 INFO - Successfully installed mozsystemmonitor 11:25:01 INFO - Cleaning up... 11:25:02 INFO - Return code: 0 11:25:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:25: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')]} 11:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25: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')]} 11:25:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25: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', '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 0x28fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c69a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6d090>, '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 0x2c6dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c67f90>, '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': '5bd038846534b2fdfa68eeae000001e2-1505493361.299680-1570690761', '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 11:25: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:25: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 jsonschema==2.5.1 11:25:02 INFO - Using env: {'DISPLAY': ':0', 11:25:02 INFO - 'HOME': '/home/cltbld', 11:25:02 INFO - 'LANG': 'en_US.UTF-8', 11:25:02 INFO - 'LANGUAGE': 'en_US:en', 11:25:02 INFO - 'LOGNAME': 'cltbld', 11:25:02 INFO - 'MAIL': '/var/mail/cltbld', 11:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:02 INFO - 'MOZ_NO_REMOTE': '1', 11:25:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:02 INFO - 'NO_EM_RESTART': '1', 11:25:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:02 INFO - 'PWD': '/builds/slave/test', 11:25:02 INFO - 'SHELL': '/bin/bash', 11:25:02 INFO - 'SHLVL': '1', 11:25:02 INFO - 'TERM': 'linux', 11:25:02 INFO - 'TMOUT': '86400', 11:25:02 INFO - 'USER': 'cltbld', 11:25:02 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1505493361.299680-1570690761', 11:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:02 INFO - '_': '/tools/buildbot/bin/python'} 11:25:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:02 INFO - Downloading/unpacking jsonschema==2.5.1 11:25: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 11:25: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 11:25: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 11:25: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 11:25:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:25:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:25: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 11:25: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 11:25: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 11:25: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 11:25:04 INFO - Downloading functools32-3.2.3-2.tar.gz 11:25:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:25:04 INFO - warning: no files found matching '*.txt' 11:25:04 INFO - no previously-included directories found matching 'build' 11:25:04 INFO - no previously-included directories found matching 'dist' 11:25:04 INFO - no previously-included directories found matching '.git*' 11:25:04 INFO - Installing collected packages: jsonschema, functools32 11:25:05 INFO - Running setup.py install for functools32 11:25:06 INFO - warning: no files found matching '*.txt' 11:25:06 INFO - no previously-included directories found matching 'build' 11:25:06 INFO - no previously-included directories found matching 'dist' 11:25:06 INFO - no previously-included directories found matching '.git*' 11:25:06 INFO - Successfully installed jsonschema functools32 11:25:06 INFO - Cleaning up... 11:25:06 INFO - Return code: 0 11:25:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:25:06 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')]} 11:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:06 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')]} 11:25:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:06 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 0x28fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c69a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6d090>, '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 0x2c6dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c67f90>, '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': '5bd038846534b2fdfa68eeae000001e2-1505493361.299680-1570690761', '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 11:25:06 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 11:25:06 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 11:25:06 INFO - Using env: {'DISPLAY': ':0', 11:25:06 INFO - 'HOME': '/home/cltbld', 11:25:06 INFO - 'LANG': 'en_US.UTF-8', 11:25:06 INFO - 'LANGUAGE': 'en_US:en', 11:25:06 INFO - 'LOGNAME': 'cltbld', 11:25:06 INFO - 'MAIL': '/var/mail/cltbld', 11:25:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:06 INFO - 'MOZ_NO_REMOTE': '1', 11:25:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:06 INFO - 'NO_EM_RESTART': '1', 11:25:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:06 INFO - 'PWD': '/builds/slave/test', 11:25:06 INFO - 'SHELL': '/bin/bash', 11:25:06 INFO - 'SHLVL': '1', 11:25:06 INFO - 'TERM': 'linux', 11:25:06 INFO - 'TMOUT': '86400', 11:25:06 INFO - 'USER': 'cltbld', 11:25:06 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1505493361.299680-1570690761', 11:25:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:06 INFO - '_': '/tools/buildbot/bin/python'} 11:25:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:25:07 INFO - Cleaning up... 11:25:07 INFO - Return code: 0 11:25:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:25:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x28fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c69a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6d090>, '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 0x2c6dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c67f90>, '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': '5bd038846534b2fdfa68eeae000001e2-1505493361.299680-1570690761', '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 11:25:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:25:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:25:07 INFO - Using env: {'DISPLAY': ':0', 11:25:07 INFO - 'HOME': '/home/cltbld', 11:25:07 INFO - 'LANG': 'en_US.UTF-8', 11:25:07 INFO - 'LANGUAGE': 'en_US:en', 11:25:07 INFO - 'LOGNAME': 'cltbld', 11:25:07 INFO - 'MAIL': '/var/mail/cltbld', 11:25:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:07 INFO - 'MOZ_NO_REMOTE': '1', 11:25:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:07 INFO - 'NO_EM_RESTART': '1', 11:25:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:07 INFO - 'PWD': '/builds/slave/test', 11:25:07 INFO - 'SHELL': '/bin/bash', 11:25:07 INFO - 'SHLVL': '1', 11:25:07 INFO - 'TERM': 'linux', 11:25:07 INFO - 'TMOUT': '86400', 11:25:07 INFO - 'USER': 'cltbld', 11:25:07 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1505493361.299680-1570690761', 11:25:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:07 INFO - '_': '/tools/buildbot/bin/python'} 11:25:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:07 INFO - Downloading/unpacking blobuploader==1.2.4 11:25: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 11:25: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 11:25: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 11:25: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 11:25:08 INFO - Downloading blobuploader-1.2.4.tar.gz 11:25:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:25:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:25: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 11:25: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 11:25: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 11:25: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 11:25:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:25:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:25: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 11:25: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 11:25: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 11:25: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 11:25:08 INFO - Downloading docopt-0.6.1.tar.gz 11:25:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:25:09 INFO - Installing collected packages: blobuploader, requests, docopt 11:25:09 INFO - Running setup.py install for blobuploader 11:25:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:25:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:25:09 INFO - Running setup.py install for requests 11:25:09 INFO - Running setup.py install for docopt 11:25:09 INFO - Successfully installed blobuploader requests docopt 11:25:09 INFO - Cleaning up... 11:25:09 INFO - Return code: 0 11:25:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25: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')]} 11:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25: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')]} 11:25:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25: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 0x28fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c69a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6d090>, '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 0x2c6dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c67f90>, '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': '5bd038846534b2fdfa68eeae000001e2-1505493361.299680-1570690761', '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 11:25: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 11:25: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 11:25:09 INFO - Using env: {'DISPLAY': ':0', 11:25:09 INFO - 'HOME': '/home/cltbld', 11:25:09 INFO - 'LANG': 'en_US.UTF-8', 11:25:09 INFO - 'LANGUAGE': 'en_US:en', 11:25:09 INFO - 'LOGNAME': 'cltbld', 11:25:09 INFO - 'MAIL': '/var/mail/cltbld', 11:25:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:09 INFO - 'MOZ_NO_REMOTE': '1', 11:25:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:09 INFO - 'NO_EM_RESTART': '1', 11:25:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:09 INFO - 'PWD': '/builds/slave/test', 11:25:09 INFO - 'SHELL': '/bin/bash', 11:25:09 INFO - 'SHLVL': '1', 11:25:09 INFO - 'TERM': 'linux', 11:25:09 INFO - 'TMOUT': '86400', 11:25:09 INFO - 'USER': 'cltbld', 11:25:09 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1505493361.299680-1570690761', 11:25:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:09 INFO - '_': '/tools/buildbot/bin/python'} 11:25:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:25:09 INFO - Running setup.py (path:/tmp/pip-MHgX1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:25:09 INFO - Running setup.py (path:/tmp/pip-nw4HIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:25:09 INFO - Running setup.py (path:/tmp/pip-gBYtxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:25:10 INFO - Running setup.py (path:/tmp/pip-l3I9vQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:25:10 INFO - Running setup.py (path:/tmp/pip-ExSzEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:25:10 INFO - Running setup.py (path:/tmp/pip-9bJNhK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:25:10 INFO - Running setup.py (path:/tmp/pip-xFmWIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:25:10 INFO - Running setup.py (path:/tmp/pip-nFJFXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:25:10 INFO - Running setup.py (path:/tmp/pip-VQimB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:25:10 INFO - Running setup.py (path:/tmp/pip-scvMoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:25:10 INFO - Running setup.py (path:/tmp/pip-FBX1Lj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:25:10 INFO - Running setup.py (path:/tmp/pip-ttvjF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:25:10 INFO - Running setup.py (path:/tmp/pip-jei0_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:25:10 INFO - Running setup.py (path:/tmp/pip-nJQPkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:10 INFO - Running setup.py (path:/tmp/pip-doZwFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:25:10 INFO - Running setup.py (path:/tmp/pip-2gnaqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:25:10 INFO - Running setup.py (path:/tmp/pip-hC0QDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:25:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:25:11 INFO - Running setup.py install for manifestparser 11:25:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:25:11 INFO - Running setup.py install for mozcrash 11:25:11 INFO - Running setup.py install for mozdebug 11:25:11 INFO - Running setup.py install for mozdevice 11:25:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:25:11 INFO - Running setup.py install for mozfile 11:25:11 INFO - Running setup.py install for mozhttpd 11:25:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:25:11 INFO - Running setup.py install for mozinfo 11:25:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:25:11 INFO - Running setup.py install for mozInstall 11:25:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:25:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:25:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:25:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:25:11 INFO - Running setup.py install for mozleak 11:25:11 INFO - Running setup.py install for mozlog 11:25:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:25:12 INFO - Running setup.py install for moznetwork 11:25:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:25:12 INFO - Running setup.py install for mozprocess 11:25:12 INFO - Running setup.py install for mozprofile 11:25:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:25:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:25:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:25:12 INFO - Running setup.py install for mozrunner 11:25:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:25:12 INFO - Running setup.py install for mozscreenshot 11:25:12 INFO - Running setup.py install for moztest 11:25:12 INFO - Running setup.py install for mozversion 11:25:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:25:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:25:12 INFO - Cleaning up... 11:25:12 INFO - Return code: 0 11:25:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25: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')]} 11:25:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25: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')]} 11:25:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25: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 0x28fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c69a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6d090>, '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 0x2c6dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c67f90>, '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': '5bd038846534b2fdfa68eeae000001e2-1505493361.299680-1570690761', '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 11:25: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 11:25: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 11:25:12 INFO - Using env: {'DISPLAY': ':0', 11:25:12 INFO - 'HOME': '/home/cltbld', 11:25:12 INFO - 'LANG': 'en_US.UTF-8', 11:25:12 INFO - 'LANGUAGE': 'en_US:en', 11:25:12 INFO - 'LOGNAME': 'cltbld', 11:25:12 INFO - 'MAIL': '/var/mail/cltbld', 11:25:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:12 INFO - 'MOZ_NO_REMOTE': '1', 11:25:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:12 INFO - 'NO_EM_RESTART': '1', 11:25:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:12 INFO - 'PWD': '/builds/slave/test', 11:25:12 INFO - 'SHELL': '/bin/bash', 11:25:12 INFO - 'SHLVL': '1', 11:25:12 INFO - 'TERM': 'linux', 11:25:12 INFO - 'TMOUT': '86400', 11:25:12 INFO - 'USER': 'cltbld', 11:25:12 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1505493361.299680-1570690761', 11:25:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:12 INFO - '_': '/tools/buildbot/bin/python'} 11:25:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:25:13 INFO - Running setup.py (path:/tmp/pip-zY0rgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:25:13 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)) 11:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:25:13 INFO - Running setup.py (path:/tmp/pip-Tpbq9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:25:13 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)) 11:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:25:13 INFO - Running setup.py (path:/tmp/pip-qbGqAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:25:13 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)) 11:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:25:13 INFO - Running setup.py (path:/tmp/pip-3QhrHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:25:13 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)) 11:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:25:13 INFO - Running setup.py (path:/tmp/pip-gRK8jQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:25:13 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)) 11:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:25:13 INFO - Running setup.py (path:/tmp/pip-lIcyCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:25:13 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)) 11:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:25:13 INFO - Running setup.py (path:/tmp/pip-r_JXpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:25:13 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)) 11:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:25:13 INFO - Running setup.py (path:/tmp/pip-4cNi1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:25: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)) 11:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:25:13 INFO - Running setup.py (path:/tmp/pip-4IXkme-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:25: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)) 11:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:25:13 INFO - Running setup.py (path:/tmp/pip-JsSDMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:25: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)) 11:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:25:13 INFO - Running setup.py (path:/tmp/pip-R3UwAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:25: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)) 11:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:25:13 INFO - Running setup.py (path:/tmp/pip-JY6z6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:25: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)) 11:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:25:13 INFO - Running setup.py (path:/tmp/pip-YNshA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:25: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)) 11:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:25:13 INFO - Running setup.py (path:/tmp/pip-sdv_EF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:25:14 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)) 11:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:14 INFO - Running setup.py (path:/tmp/pip-4gT6Lk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:14 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)) 11:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:25:14 INFO - Running setup.py (path:/tmp/pip-_KGepT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:25:14 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)) 11:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:25:14 INFO - Running setup.py (path:/tmp/pip-woTy2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:25:14 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)) 11:25:14 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)) 11:25:14 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)) 11:25:14 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)) 11:25:14 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)) 11:25:14 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)) 11:25:14 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)) 11:25:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:25:14 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 11:25:14 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 11:25:14 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 11:25:14 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 11:25:15 INFO - Downloading blessings-1.6.tar.gz 11:25:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:25:15 INFO - Installing collected packages: blessings 11:25:15 INFO - Running setup.py install for blessings 11:25:15 INFO - Successfully installed blessings 11:25:15 INFO - Cleaning up... 11:25:15 INFO - Return code: 0 11:25:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:25:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:25:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:25:15 INFO - Reading from file tmpfile_stdout 11:25:15 INFO - Current package versions: 11:25:15 INFO - argparse == 1.2.1 11:25:15 INFO - blessings == 1.6 11:25:15 INFO - blobuploader == 1.2.4 11:25:15 INFO - docopt == 0.6.1 11:25:15 INFO - functools32 == 3.2.3-2 11:25:15 INFO - jsonschema == 2.5.1 11:25:15 INFO - manifestparser == 1.1 11:25:15 INFO - mozInstall == 1.13 11:25:15 INFO - mozcrash == 1.0 11:25:15 INFO - mozdebug == 0.1 11:25:15 INFO - mozdevice == 0.51 11:25:15 INFO - mozfile == 1.2 11:25:15 INFO - mozhttpd == 0.7 11:25:15 INFO - mozinfo == 0.10 11:25:15 INFO - mozleak == 0.1 11:25:15 INFO - mozlog == 3.5 11:25:15 INFO - moznetwork == 0.27 11:25:15 INFO - mozprocess == 0.25 11:25:15 INFO - mozprofile == 0.28 11:25:15 INFO - mozrunner == 6.13 11:25:15 INFO - mozscreenshot == 0.1 11:25:15 INFO - mozsystemmonitor == 0.3 11:25:15 INFO - moztest == 0.8 11:25:15 INFO - mozversion == 1.4 11:25:15 INFO - psutil == 3.1.1 11:25:15 INFO - requests == 1.2.3 11:25:15 INFO - wsgiref == 0.1.2 11:25:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25: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')]} 11:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25: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')]} 11:25:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25: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 0x28fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c69a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6d090>, '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 0x2c6dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c67f90>, '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': '5bd038846534b2fdfa68eeae000001e2-1505493361.299680-1570690761', '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 11:25: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 11:25: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 11:25:15 INFO - Using env: {'DISPLAY': ':0', 11:25:15 INFO - 'HOME': '/home/cltbld', 11:25:15 INFO - 'LANG': 'en_US.UTF-8', 11:25:15 INFO - 'LANGUAGE': 'en_US:en', 11:25:15 INFO - 'LOGNAME': 'cltbld', 11:25:15 INFO - 'MAIL': '/var/mail/cltbld', 11:25:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:15 INFO - 'MOZ_NO_REMOTE': '1', 11:25:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:15 INFO - 'NO_EM_RESTART': '1', 11:25:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:15 INFO - 'PWD': '/builds/slave/test', 11:25:15 INFO - 'SHELL': '/bin/bash', 11:25:15 INFO - 'SHLVL': '1', 11:25:15 INFO - 'TERM': 'linux', 11:25:15 INFO - 'TMOUT': '86400', 11:25:15 INFO - 'USER': 'cltbld', 11:25:15 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1505493361.299680-1570690761', 11:25:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:15 INFO - '_': '/tools/buildbot/bin/python'} 11:25:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:16 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)) 11:25:16 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)) 11:25:16 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)) 11:25:16 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)) 11:25:16 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)) 11:25:16 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)) 11:25:16 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)) 11:25:16 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)) 11:25:16 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)) 11:25:16 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:25:16 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 11:25:16 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 11:25:16 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 11:25:16 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 11:25:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:25:17 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)) 11:25:17 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)) 11:25:17 INFO - Installing collected packages: simplejson 11:25:17 INFO - Running setup.py install for simplejson 11:25:17 INFO - building 'simplejson._speedups' extension 11:25:17 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 11:25:18 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 11:25:18 INFO - Successfully installed simplejson 11:25:18 INFO - Cleaning up... 11:25:18 INFO - Return code: 0 11:25:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:25:18 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')]} 11:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:18 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')]} 11:25:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:18 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 0x28fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c69a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6d090>, '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 0x2c6dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c67f90>, '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': '5bd038846534b2fdfa68eeae000001e2-1505493361.299680-1570690761', '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 11:25:18 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 11:25:18 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 11:25:18 INFO - Using env: {'DISPLAY': ':0', 11:25:18 INFO - 'HOME': '/home/cltbld', 11:25:18 INFO - 'LANG': 'en_US.UTF-8', 11:25:18 INFO - 'LANGUAGE': 'en_US:en', 11:25:18 INFO - 'LOGNAME': 'cltbld', 11:25:18 INFO - 'MAIL': '/var/mail/cltbld', 11:25:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:18 INFO - 'MOZ_NO_REMOTE': '1', 11:25:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:18 INFO - 'NO_EM_RESTART': '1', 11:25:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:18 INFO - 'PWD': '/builds/slave/test', 11:25:18 INFO - 'SHELL': '/bin/bash', 11:25:18 INFO - 'SHLVL': '1', 11:25:18 INFO - 'TERM': 'linux', 11:25:18 INFO - 'TMOUT': '86400', 11:25:18 INFO - 'USER': 'cltbld', 11:25:18 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1505493361.299680-1570690761', 11:25:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:18 INFO - '_': '/tools/buildbot/bin/python'} 11:25:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:25:18 INFO - Cleaning up... 11:25:18 INFO - Return code: 0 11:25:18 INFO - Running post-action listener: _resource_record_post_action 11:25:18 INFO - Running post-action listener: _start_resource_monitoring 11:25:18 INFO - Starting resource monitoring. 11:25:18 INFO - [mozharness: 2017-09-15 18:25:18.513696Z] Finished create-virtualenv step (success) 11:25:18 INFO - [mozharness: 2017-09-15 18:25:18.514221Z] Running install step. 11:25:18 INFO - Running pre-action listener: _resource_record_pre_action 11:25:18 INFO - Running main action method: install 11:25:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:25:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:25:18 INFO - Reading from file tmpfile_stdout 11:25:18 INFO - Detecting whether we're running mozinstall >=1.0... 11:25:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:25:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:25:18 INFO - Reading from file tmpfile_stdout 11:25:18 INFO - Output received: 11:25:18 INFO - Usage: mozinstall [options] installer 11:25:18 INFO - Options: 11:25:18 INFO - -h, --help show this help message and exit 11:25:18 INFO - -d DEST, --destination=DEST 11:25:18 INFO - Directory to install application into. [default: 11:25:18 INFO - "/builds/slave/test"] 11:25:18 INFO - --app=APP Application being installed. [default: firefox] 11:25:18 INFO - mkdir: /builds/slave/test/build/application 11:25: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'] 11:25:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:25:36 INFO - Reading from file tmpfile_stdout 11:25:36 INFO - Output received: 11:25:36 INFO - /builds/slave/test/build/application/firefox/firefox 11:25:36 INFO - Running post-action listener: _resource_record_post_action 11:25:36 INFO - [mozharness: 2017-09-15 18:25:36.596772Z] Finished install step (success) 11:25:36 INFO - [mozharness: 2017-09-15 18:25:36.597025Z] Running setup-mitmproxy step. 11:25:36 INFO - Running pre-action listener: _resource_record_pre_action 11:25:36 INFO - Running main action method: setup_mitmproxy 11:25:36 INFO - Skipping: mitmproxy is not required 11:25:36 INFO - Running post-action listener: _resource_record_post_action 11:25:36 INFO - [mozharness: 2017-09-15 18:25:36.598236Z] Finished setup-mitmproxy step (success) 11:25:36 INFO - [mozharness: 2017-09-15 18:25:36.598456Z] Running run-tests step. 11:25:36 INFO - Running pre-action listener: _resource_record_pre_action 11:25:36 INFO - Running pre-action listener: _set_gcov_prefix 11:25:36 INFO - Running main action method: run_tests 11:25:36 WARNING - Try message not found. 11:25:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:25:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:25:36 INFO - Python 2.7.3 11:25:36 INFO - Return code: 0 11:25:36 INFO - grabbing minidump binary from tooltool 11:25:36 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')]} 11:25:36 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 0x2c6d090>, '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 0x2c6dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c67f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:25:36 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 11:25:36 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 11:25:36 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 11:25:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:25:36 INFO - Return code: 0 11:25:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:25:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:25:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:25:36 INFO - ENV: RUST_BACKTRACE is now full 11:25:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:25:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:25:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 11:25:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-039 --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 11:25:36 INFO - Using env: {'DISPLAY': ':0', 11:25:36 INFO - 'HOME': '/home/cltbld', 11:25:36 INFO - 'LANG': 'en_US.UTF-8', 11:25:36 INFO - 'LANGUAGE': 'en_US:en', 11:25:36 INFO - 'LOGNAME': 'cltbld', 11:25:36 INFO - 'MAIL': '/var/mail/cltbld', 11:25:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:25:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:25:36 INFO - 'MOZ_ACCELERATED': '1', 11:25:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:36 INFO - 'MOZ_NO_REMOTE': '1', 11:25:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:25:36 INFO - 'MOZ_WEBRENDER': '1', 11:25:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:36 INFO - 'NO_EM_RESTART': '1', 11:25:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:36 INFO - 'PWD': '/builds/slave/test', 11:25:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:25:36 INFO - 'RUST_BACKTRACE': 'full', 11:25:36 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:25:36 INFO - 'SHELL': '/bin/bash', 11:25:36 INFO - 'SHLVL': '1', 11:25:36 INFO - 'TERM': 'linux', 11:25:36 INFO - 'TMOUT': '86400', 11:25:36 INFO - 'USER': 'cltbld', 11:25:36 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1505493361.299680-1570690761', 11:25:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:36 INFO - '_': '/tools/buildbot/bin/python'} 11:25:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 11:25:36 INFO - mozversion application_buildid: 20170915173306 11:25:36 INFO - mozversion application_changeset: 9071a20f3eaa804a439990b7596dbc16d52d1e20 11:25:36 INFO - mozversion application_display_name: Nightly 11:25:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:25:36 INFO - mozversion application_name: Firefox 11:25:36 INFO - mozversion application_remotingname: firefox 11:25:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:25:36 INFO - mozversion application_vendor: Mozilla 11:25:36 INFO - mozversion application_version: 57.0a1 11:25:36 INFO - mozversion platform_buildid: 20170915173306 11:25:36 INFO - mozversion platform_changeset: 9071a20f3eaa804a439990b7596dbc16d52d1e20 11:25:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:25:36 INFO - mozversion platform_version: 57.0a1 11:25:36 INFO - using testdate: 1505499936 11:25:36 INFO - actual date: 1505499936 11:25:36 INFO - starting webserver on 'localhost:53866' 11:25:36 INFO - SUITE-START | Running 2 tests 11:25:36 INFO - TEST-START | dromaeo_css 11:25:36 INFO - Initialising browser for dromaeo_css test... 11:25:36 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53866/getInfo.html -profile /tmp/tmpUEULmD/profile 11:25:36 INFO - TEST-INFO | started process 28140 (/builds/slave/test/build/application/firefox/firefox http://localhost:53866/getInfo.html) 11:25:44 INFO - TEST-INFO | 28140: exit 0 11:25:44 INFO - Browser initialized. 11:25:44 INFO - Running cycle 1/1 for dromaeo_css test... 11:25:44 INFO - Using env: {'DISPLAY': ':0', 11:25:44 INFO - 'HOME': '/home/cltbld', 11:25:44 INFO - 'JSGC_DISABLE_POISONING': '1', 11:25:44 INFO - 'LANG': 'en_US.UTF-8', 11:25:44 INFO - 'LANGUAGE': 'en_US:en', 11:25:44 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:25:44 INFO - 'LOGNAME': 'cltbld', 11:25:44 INFO - 'MAIL': '/var/mail/cltbld', 11:25:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:25:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:25:44 INFO - 'MOZ_ACCELERATED': '1', 11:25:44 INFO - 'MOZ_CRASHREPORTER': '1', 11:25:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:44 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:25:44 INFO - 'MOZ_NO_REMOTE': '1', 11:25:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:25:44 INFO - 'MOZ_WEBRENDER': '1', 11:25:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:44 INFO - 'NO_EM_RESTART': '1', 11:25:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:44 INFO - 'PWD': '/builds/slave/test', 11:25:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:25:44 INFO - 'RUST_BACKTRACE': 'full', 11:25:44 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:25:44 INFO - 'SHELL': '/bin/bash', 11:25:44 INFO - 'SHLVL': '1', 11:25:44 INFO - 'TERM': 'linux', 11:25:44 INFO - 'TMOUT': '86400', 11:25:44 INFO - 'USER': 'cltbld', 11:25:44 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1505493361.299680-1570690761', 11:25:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:44 INFO - '_': '/tools/buildbot/bin/python'} 11:25:44 INFO - TEST-INFO | started process 28385 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUEULmD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:25:45 INFO - PID 28385 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:25:45 INFO - PID 28385 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:25:45 INFO - PID 28385 | 11:25:45 INFO - PID 28385 | (/builds/slave/test/build/application/firefox/firefox:28444): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:25:45 INFO - PID 28385 | 11:25:55 INFO - PID 28385 | RSS: Main: 198795264 11:25:55 INFO - PID 28385 | 11:28:52 INFO - PID 28385 | Cycle 1(1): loaded http://localhost:53866/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53866/tests/dromaeo/cssquery-ext.html) 11:28:54 INFO - PID 28385 | RSS: Main: 208773120 11:28:54 INFO - PID 28385 | 11:31:56 INFO - PID 28385 | Cycle 1(1): loaded http://localhost:53866/tests/dromaeo/cssquery-ext.html (next: http://localhost:53866/tests/dromaeo/cssquery-jquery.html) 11:31:57 INFO - PID 28385 | RSS: Main: 208850944 11:31:57 INFO - PID 28385 | 11:34:59 INFO - PID 28385 | Cycle 1(1): loaded http://localhost:53866/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53866/tests/dromaeo/cssquery-mootools.html) 11:34:59 INFO - PID 28385 | RSS: Main: 208863232 11:34:59 INFO - PID 28385 | 11:38:02 INFO - PID 28385 | Cycle 1(1): loaded http://localhost:53866/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53866/tests/dromaeo/cssquery-prototype.html) 11:38:02 INFO - PID 28385 | RSS: Main: 206802944 11:38:02 INFO - PID 28385 | 11:41:06 INFO - PID 28385 | Cycle 1(1): loaded http://localhost:53866/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53866/tests/dromaeo/cssquery-yui.html) 11:41:06 INFO - PID 28385 | RSS: Main: 211214336 11:41:06 INFO - PID 28385 | 11:44:08 INFO - PID 28385 | Cycle 1(1): loaded http://localhost:53866/tests/dromaeo/cssquery-yui.html (next: http://localhost:53866/tests/dromaeo/cssquery-dojo.html) 11:44:09 INFO - PID 28385 | RSS: Main: 214335488 11:44:09 INFO - PID 28385 | 11:44:09 INFO - PID 28385 | __start_tp_report 11:44:09 INFO - PID 28385 | _x_x_mozilla_page_load 11:44:09 INFO - PID 28385 | _x_x_mozilla_page_load_details 11:44:09 INFO - PID 28385 | |i|pagename|runs| 11:44:09 INFO - PID 28385 | |0;dojo.html;3138.419392412404;3158.2104473881514;3165.3669266146776;3166.1451408119815;3183.140552050946;6179.289381721103;6260.436560709535;6288.559800813945;6290.59111157775;6380.80857574273;6194.194754681885;6204.28650705169;6218.62688238706;6229.626222426647;6261.7182226799905;5705.372409035002;5773.884522309551;5817.389174136718;5817.796377126801;5832.416758324176;5707.686077265748;5798.420157984189;5801.245838041049;5804.506616937565;5909.084091965752;90.19508915925489;5678.46054624812;5701.600887937846;5824.679642619654;5885.999380105371;5622.971885140548;5682.147677848315;5750.3962083981;5755.0504166812425;5791;5650.3502097258515;5680.636647204682;5747.798827041033;5757.9712101439645;5778.682172480512;6204.906926396107;6217.191765070512;6271;6271.34150914152;6336.619802811846;6646.567973081783;6674.098996635489;6756.594604323756;6767.052612634235;6786.694598743068;6582.275949645536;6694.230163531208;6709.194896612389;6724.495662825308;6783.118194634715;6195.132681424604;6221;6228.750849965996;6249.843753906143;6260.311365749764;6876.381125698711;6894.655267236618;6898.689558969859;6906.827329316707;6909.792706218822;6475.902861457082;6577.506686998494;6688.598684078971;6689.933100669028;6692.063111164441;6689.397954184147;6776.322367763184;6812.795616131524;6844.28135045823;6856.382925536725;6590.7693230736695;6596.73613055482;6693.364130407604;6756.560823546453;6830.21452532965;6567.408933196035;6593.175853018372;6647.501437392215;6652.467802575782;6689.096971908827;5229.47705229474;5230.947690523122;5232.058229518723;5242.344706911636;5272.209168624737;4552.408186935743;4553.6357091433265;4612.377329060601;4656.8137274508645;4667.8599642010795;5756.309242890796;5762.1068734346245;5835.270591176103;5855.970720146372;5859.765609375577;6615;6695.363940425652;6777.593344399352;6781.084553585301;6857.897131543031;5693.658380497183;5720.399358067426;5743.62666426681;5765.423457654285;5769.624974376652;5725.427457254241;5745.68398738065;5813.331466881278;5821.708914554255;5835.095560188178;6403.775867844696;6438.420542151229;6510.576812507172;6562.835929101715;6570.277269500351;6542.640154791532;6631.171103612049;6638.734450622114;6659.6670166491485;6733.091032710718;6463.644499552382;6473.741050358121;6490.772822951363;6540.215174179129;6574.211094668671;6520.836979075561;6525.64108974011;6594.670266486753;6647.601143931186;6709.161354830646;6585.111010013587;6741.561798483083;6772.322767723188;6800.897986530305;6866.210385805496;6470.9676451619325;6488.448481879093;6548.345165483413;6555.80332590023;6580.440662543738;6417.358264173546;6480.546361754632;6482.124913136666;6490;6527.67361631907;6453.193350831146;6473.482121430368;6527.2167339919515;6550.6069635822005;6552.312007239171;6432.710528026344;6436.8390790230615;6494.805155845333;6506.967465162644;6587;6164.4143806338325;6273.905891411724;6305.779297724557;6313.96843015782;6326.936730632635 11:44:09 INFO - PID 28385 | |1;ext.html;724.8043028382336;740.803687022939;742.428330185757;742.8142964258935;747.9252074792521;38204;41638.375424368656;41731.374029389546;41958;42166.57833421665;37720.49118035275;37877.621223787755;37930.620693793055;38044.80977595108;38103.80948095262;7009.719611215545;7070.7525236616475;7161.355478006978;7165.820854478628;7167;7645.3883689305;7787.221277872224;7814;7865.68537258509;7894.092179399357;7788.844223115534;7874.173211812763;7887.684492620317;7889.368850491946;7892.447528672995;7669.386449084116;7759.612019399064;7781.610919454033;7873.094594121692;7885.842283154305;7729.652165652559;7786.831975203708;7809.531428114331;7816.72641457552;7872.252136047066;39256.41115383243;39660.20679586421;39662;39677.80161099176;39741.20517589632;3527.3650742866275;3542.6457354264626;3561.5904171020147;3578.1233597768714;3581.87463438781;32682.836585817156;32912.835435822904;32931.6706832931;32995.340093198;33099;5273.050850846846;5283.471652834724;5290.312259406291;5324.54741346986;5342.91985620216;181308;181683;182554;184034;185476;42962.14075718468;44515.55484445179;49088.75455622699;49330.50669493259;49590.75204623954;46718;53029;53240.733796331544;53908.730456348254;53967.73016134894;16451.91774041122;16570.088645124633;16662.916685416494;16705.248263828158;16709.33162673504;13535.59393218205;13584.456621735217;13603.387847546686;13606.659833504242;13637.045406821428;14190.432382704576;14271.857281427261;14371.640708982359;14489.492867749577;14663.853361466463;5650.576206784508;5712.200291959129;5795.507381872504;5803.970980145073;5866.853328666817;997.2670087485692;1016.5679586175846;1016.8271393863062;1018.9643362482277;1028.2956175020136;22632;22731.431714207276;22867.19964801224;23009.42476438069;23027.078916843475;1105.9723506912392;1108.2519299472824;1112.060309038877;1117.4133579870634;1124.6344937895217;11972.341521216242;11989.700257493458;12047.819282710767;12097.637070887888;12120.75758484843;226909;227886;228839;229006;229161.8541907313;53051.469485305424;53114.46885531172;53204.201936970974;53326.46673533293;53452.19821702677;1420.7513685105273;1422.5021242565226;1456.8615981481742;1484.0798704802876;1484.1540322016347;21986.780132198473;22580.887095564416;22767.544649107258;22879.88560057189;23038.654420184044;36715.63284367122;36798.26403471862;36844.07889802669;37064.25871482501;37212.44181337336;193822;194665;194927;195013;195108;32142.19644508906;32979;32989;33842;35503.11242218965;44408.33387499126;44748.55251447444;44987.32519012152;45592.08815823731;45605;32426.513602295512;32590.34819303648;32660.693572257795;32709.836450817595;32753.34493310168;31845.363092737553;32317.51523727099;32328.676713232566;32417;32572.83713581417;35227.64772352346;36282;36767.26465470622;36836.81581592075;36838.44742328813;31245.843770781;31331;31331.53002705007;31669;32318.19204519906;22982.885085574464;23557.882210588836;23970.76029239755;23985.400364990317;24161.67110808852 11:44:09 INFO - PID 28385 | |2;jquery.html;553.3608681972323;559.2897020783607;561.2759540193149;570.7688386203588;589.4871461828209;21833.781662183374;22677.659835102466;22713.318600442013;22734.658980115313;22781;23570;24031.879840600817;24224.75775242247;25869.482610347783;26343.47313053738;6412.6793660317035;6455.548111632188;6522.576032557892;6528.08606795049;6584.078229047937;6431.485481161496;6539.6730163491875;6543.509236807235;6576.947688369862;6610.834729131762;6400.647964361959;6539.117219175422;6680.699368528428;6691.029800678899;6699.430548403391;6602.768903088393;6651.334866513334;6667.799966001027;6691.096701945248;6714.227863795677;5889.734961926681;6155.507559395282;6198.504119670415;6203.627782333075;6220.564560480768;28776;29181.70818291811;29235.85382073076;29236.122916312546;29252.561211581844;2024.9190032398687;2031.5733695923873;2052.3432501599345;2058.5059585699323;2060.1553363121197;18747.718784218247;18909.243630254772;18970.52573685669;19282.517937051547;19320.516987075294;2401.1235898896775;2422.0502495491123;2449.3141920262356;2465.3220364399754;2469.703635563744;119684.40157799242;124571;131694;133472.3326383362;138866.61133388637;14521.693047625764;14619.75164397296;14623.341949612293;14646.228060558315;14983.40066397332;22993.425164371023;23103.07587696507;23240.65139022916;23284.417889552897;23310.65034024491;9652.27607929408;9777.853332200022;9884.752881178028;9977.900220997697;10144.188464922789;9115.772105697411;9133.725988220363;9158.86261706075;9276.489793061446;9335.393199442015;8832.160944710242;8948.73153805387;9035.102628447969;9132.81734365309;9245.121713437213;2542.7711505964553;2620.4104076582616;2621.973780262173;2670.893164273446;2702.067786613615;919.4437365393974;928.8792456980549;952.4047470331043;956.551631368919;979.9559019844124;19585.510362241057;19650.90174549118;19727.40817775469;19940.177470176157;19973.101210445566;985.0248254228405;1011.8178727829062;1015.0712098429854;1024.1960061351951;1024.3700124423426;10439.582416703399;10884.510197041152;10939.453027348602;11058.834117488244;11155;458806;459015;472226;478882;486835;109120;112767;113444;114943;116049;1140.8117660586076;1155.5839897636677;1157.3634501024403;1160.7388337624136;1168.339887963315;17398.565035874206;17510.299588016336;17625.82374176242;17723;17888.731669025234;54773.72613136909;55620;56934.7153264231;57101.42898570961;57654;68269.65865170643;69135;69618;70752;70883.29116708973;13335.933125349755;14458.204798736171;14547;14610.780838287646;14673.70652586921;22554;23278.3016509505;23311.88344058269;23378.532429350977;23411.531769364858;18504.907475462536;18564.628707426047;18616.16227269803;18661.533461663566;18674.159662815477;15404.38382464689;16208.35166593323;16325.510234692978;16484.093374864497;16523.33906643721;18733.157007934402;18838;18942.810571894104;18959.336423225122;19138.808611913704;14106.224157671426;14253.144811311355;14276.42894284217;14286.071405358618;14355.784663229852;17938.91030544839;18451.90774046121;18505.629887402447;18555.35056273024;18702.345417910852 11:44:09 INFO - PID 28385 | |3;mootools.html;1360.9863901360986;1398.2030242761616;1412.4562043613212;1413.7596608576541;1416.426347329332;14861.628459288524;15592.532224033268;15637.92181039096;15661.765073523891;15684.921575392122;15177.165255910948;15192.088474691527;15407.614809629737;15419.306131224093;15423.460178893742;2755.3524921643498;2765.958510622337;2812.3531587734833;2815.3665425279355;2819.0978886756143;2643.15419065899;2731.0987374166575;2738.370174859783;2764.2812868654096;2780.541210700242;2685.5703087506004;2701.1086341507257;2743.547314693073;2804.9298767530872;2823.8729257183477;2763.0467488716363;2792.8463934483593;2822.3085344090728;2827.802053856231;2828.0950095969297;2751.5735061065566;2799.9440011199663;2807.0456044944613;2807.4946509628257;2811.353388720606;14879.18164500952;15182.392704291815;15229.086254824746;15260.38958441661;15293;8023.31801796848;8265.380096492727;8297.917020829775;8304.086550479442;8349.373796965192;5265.131253343194;5485.753141108659;5487.478689524529;5605.103183490622;5683.801066962677;1980.2178139634907;1987.0958713785194;1990.4227773945538;2015.0730663894626;2017.4351181669156;26278.868605656848;26691.599626005627;26703.19890403291;26722.06472773463;26781;6624.304448032887;6822.906256246212;6831.4534837212905;7055.9294407056295;7061.611611361322;17338.653226935392;17359.56601084983;17364;17482.475525734248;17516.036617986134;7909.6836126555445;8064.717734879251;8116.188381161955;8129.390295727726;8135.959320203479;7345.963270183614;7419.591922444318;7464.066991626047;7505.136909255396;7572.545647261182;5068.138416469135;5201.765920533509;5214.270002199695;5226.529612334832;5270.235815806686;1456.5411895252962;1513.1299502785942;1518.089146512106;1528.2664321125922;1535.5623647260477;767.6161919040479;874.4097734029632;879.8636211387245;889.515214208258;899.0604817965111;8696.608652610648;8727.694530691395;8778.824423511622;8793.38446308765;8857.601407936658;985.4186030242191;994.2046362909643;1000.7598176437602;1007.7128018514835;1012.4380968562518;5051.772670229849;5112.539871411516;5137.101007323703;5259.894802104013;5260.473952604709;21346.573068538542;21784.89107554452;22133.557328853334;22225.222117225818;22254.221102261345;20345.694814577793;21452.356429307147;21726.45683857916;21746.238881639067;21994.120235190414;10508.527116279785;10668.14654827612;10691.35851848907;10728.356298622108;10768.461576921123;7874.1338452769005;8336.916630833613;8489.617967191367;8490.575471226537;8517.318614510948;18728.906355468134;18777.530561736065;18900.432987010412;19039.90480047591;19500.902495488;19103.52241193981;19282.84302941828;19729.60540789205;19877.105530250883;19935;11072.280301780358;11258.7748245033;11341.886581134084;11368.204225704452;11368.261063030877;13965;13998.37007334652;14151.292435378396;14218.502352417616;14240.572782816533;9409.670661526814;9516.666916657883;9665.420074795253;9838.950805245928;10001.1499022581;11171.776564468502;11413;11477.942610286895;11480.598179063692;11595.768084638428;9783.706488805346;9969.651062212788;10080.949595251977;10249.180065594883;10300.484975751033;6984.860302794017;6991.126109236346;7197.640117994184;7234.529755565872;7371.6314184289495;7188.928110719035;7196.352328290479;7416;7437.776866694008;7534.886976695244 11:44:09 INFO - PID 28385 | |4;prototype.html;478.1512814753814;510.9627456263786;521.062088241166;521.8486638874726;523.3928642774382;6311.400416960393;6372.852886480432;6375.968120159404;6384.616922984613;6416.647084410367;6238.84402889928;6250.343713910042;6269.185005949232;6273.309935907047;6277.497800175986;5194.766235519392;5200.959808038408;5218.486638874721;5222.321098257221;5231.816886408977;5233.319668443097;5251.5798736101215;5258.2638430619745;5272.551833094191;5284.630075894689;4784.5693887550115;4975.338194066176;5004.399472063357;5025.472325405816;5138.511841375082;4967.677100988442;4981.701097934136;4982.579964710077;4998.77530005151;5007.599392048627;4413.426254586915;4429.977850110761;4435;4446.822127114944;4473.82104715811;5999.580029397944;6160.4455598995855;6193;6209.9379006210265;6246.593971391845;5678.432156784289;5704.77180912763;5734.512566431858;5759.481646651821;5780.797672081457;6581.255967168656;6622.317961225664;6634.976332218672;6636.502262330345;6687.933120668779;4897.118518666639;4901.362822833044;4908.312836202935;4909.950900490985;4930.359053323081;6668.9666551667415;6669.299723529008;6811.148606424197;6823.863522729517;7022.1924478685605;5013.771625951592;5030.3963524377305;5042.142835717937;5056.873578160576;5067.974660126676;5076.416212135578;5091.66904151229;5094.61790365724;5104.106781313255;5123.590112790967;5609.747561359749;5696.544276457874;5719.599628025998;5728.312602487728;5774.913376299359;6643.800685979429;6669.4330981866115;6671.499637527205;6707.5975441473665;6751.291114433012;1771.5925337172523;1771.6633839570698;1772.7075032619732;1779.6974514332335;1796.1019490254873;1141.366541569437;1195.5038658956435;1213.1265488848014;1225.6935766058486;1230.2618428942742;5666.490015898589;5726.885462290731;5758.136279558016;5779.162021506858;5854.18041474194;6752.62860542665;6773;6786.694598743068;6807.761728339485;6840.555363901331;5675.716214189357;5744.339400968942;5756.280464941882;5781.971090144522;5801.187833703285;3526.68259856609;3536.328097661436;3547.1486843157454;3548.538689970287;3591.2099338145567;6392.616443013434;6412.583182093149;6428.3893030163;6455.548111632234;6517.523341130435;6874.896876546856;6886.758963436356;6923.446124310043;6926.341997510229;6927.168739751262;5912.906112369225;6426.550141490051;6496.902546461807;6516.0877477153235;6542.476601871839;6601.273859875506;6649.434798042221;6657;6724.4620430364475;6733.081071894682;6474.028895665688;6480.189976252968;6641.867162656623;6678.465722742072;6709.798706038827;6404.911165102037;6414.486841052611;6457.806265812033;6511.38141876521;6531.836704082436;4881.678969922801;4994.350734404504;5030.220315851049;5033.773480193473;5088.185890257541;6433;6526.216853977363;6616.445135393083;6656.30108838565;6816.727330906709;6155.35368786271;6471.967640161769;6477.902831457626;6550.410463058348;6635.9004614929845;6492.610443373413;6511.641859697573;6576.112224849775;6599.373059559334;6608;6412.39082287182;6419.261784894797;6440.516961227833;6479.935200647933;6512.967435162794;6506.4469520091325;6506.902396463962;6586.736530538725;6589.934100658932;6636.701348439428;6270.871243176272;6348.936510634834;6454.612723236621;6467.191601049869;6468.514861385321 11:44:09 INFO - PID 28385 | |5;yui.html;886.5301390263163;895.7760559860035;901.5717534171265;925.1581061234274;929.9395539289945;16462.917685411572;17136.48590542284;17150.399736009243;17226.138693065343;17284.30862765491;16064.437744678939;16139.919300403482;16263.918680406581;16358.018518888844;16544.420945266917;952.752284406056;952.9904700952972;963.5037955452947;964.9807003859919;967.405045896772;977.5454413697629;980.103205566909;980.1374790184627;980.2550061952932;980.9901900981006;968.0706521739139;989.6437282578266;997.3268044070223;997.9700608981742;1011.0142610954334;1001.6544292219173;1003.3829195045031;1004.6734811186394;1004.7990401919645;1004.8241557727405;716.9426445884369;731.6159016516318;737.3474475089531;737.8634952533798;738.985220295591;15871.920640396724;16169.676606467805;16213.2704028319;16214.83785162145;16215.675686486322;19878.006099694958;20434.386968390972;20570.5885882283;21136.577268454697;21389.35831925045;17424.564385890455;17637;17788.46634600951;17789.46631601054;18055.819441805677;3702.092987218122;3725.608811074825;3731.328360895038;3732.122951106488;3734.7572407793405;139303;141353;141377;142345.288273559;144046.83929741062;16125.11311877858;16392;16611.91694041522;16764.245608947625;16848.663026739396;30793.538096928565;31267.84366078155;31327.53008704871;31341;31839.363212735614;8326.875096873551;8399.538025408661;8500.27747641445;8504.617292221865;8523.65905363791;4136.420901073852;4186.497620285585;4216.578342165821;4219.156168766259;4221.746695198298;5254.290670759475;5415.296011518478;5443.237946687388;5468.890622187534;5487.451254874561;950.2872845365976;965.6861520006026;979.8138353712772;982.3712823792779;989;649.574528683713;675.8242856857253;676.736072931557;679.2596070283316;685.6194811879454;10558.334122856482;10691.518881650189;10984.340939543654;11104.44477776108;11200.43997800123;673.3603077076797;679.7009315900988;684.4250829303409;685.6434653979902;700.9018737376771;5055.292259083732;5083.72039537829;5115.104856650071;5182.041322355376;5216.58267338612;119009;120800;123639;126097.73902261043;126373;106064;108133;112057.43971280092;112321.43839280751;113091;93911;96443;96668.13327466823;98337.50831245941;99569.50215249023;9540.761480963032;9545.570449329936;9550.474723890253;9558.378705384128;9619.374740641835;43391.04740286758;43757.12485750331;44120.33819492646;44143;44950.77524612356;57468.71265643645;58250;58334.708326458094;58436;58652.70673646775;14284.214368209849;14684.265786710408;14690.55928322152;14704.41182352694;14735.852641473448;15061.924690376478;15097.924510377377;15135.697286054437;15186.696266074396;15469.5359139226;13506.729865402833;13600.251986140856;13777.104488208235;13881.65295867571;14023.36894839755;13378;13474.79787803164;13604.183748975092;13614.387352569356;13798.93100534491;13429.731405372033;13597.796033059314;13642.93178534101;13665.658358541115;13863.584092477242;10987.285826421257;11015.614453494089;11095.611653592085;11209.215354925076;11353.48909299067;10067.647632332833;10080.546375412978;10110.191184705352;10162.74593135148;10166.18670506343 11:44:09 INFO - PID 28385 | __end_tp_report 11:44:09 INFO - PID 28385 | __start_cc_report 11:44:09 INFO - PID 28385 | _x_x_mozilla_cycle_collect,361 11:44:09 INFO - PID 28385 | __end_cc_report 11:44:09 INFO - PID 28385 | __startTimestamp1505501049106__endTimestamp 11:44:09 INFO - PID 28385 | 11:44:09 INFO - PID 28385 | ------- Summary: start ------- 11:44:09 INFO - PID 28385 | Number of tests: 6 11:44:09 INFO - PID 28385 | 11:44:09 INFO - PID 28385 | [#0] dojo.html Cycles:165 Average:6124.80 Median:6436.84 stddev:873.49 (13.6%) stddev-sans-first:844.17 11:44:09 INFO - PID 28385 | Values: 3138.4 3158.2 3165.4 3166.1 3183.1 6179.3 6260.4 6288.6 6290.6 6380.8 6194.2 6204.3 6218.6 6229.6 6261.7 5705.4 5773.9 5817.4 5817.8 5832.4 5707.7 5798.4 5801.2 5804.5 5909.1 90.2 5678.5 5701.6 5824.7 5886.0 5623.0 5682.1 5750.4 5755.1 5791.0 5650.4 5680.6 5747.8 5758.0 5778.7 6204.9 6217.2 6271.0 6271.3 6336.6 6646.6 6674.1 6756.6 6767.1 6786.7 6582.3 6694.2 6709.2 6724.5 6783.1 6195.1 6221.0 6228.8 6249.8 6260.3 6876.4 6894.7 6898.7 6906.8 6909.8 6475.9 6577.5 6688.6 6689.9 6692.1 6689.4 6776.3 6812.8 6844.3 6856.4 6590.8 6596.7 6693.4 6756.6 6830.2 6567.4 6593.2 6647.5 6652.5 6689.1 5229.5 5230.9 5232.1 5242.3 5272.2 4552.4 4553.6 4612.4 4656.8 4667.9 5756.3 5762.1 5835.3 5856.0 5859.8 6615.0 6695.4 6777.6 6781.1 6857.9 5693.7 5720.4 5743.6 5765.4 5769.6 5725.4 5745.7 5813.3 5821.7 5835.1 6403.8 6438.4 6510.6 6562.8 6570.3 6542.6 6631.2 6638.7 6659.7 6733.1 6463.6 6473.7 6490.8 6540.2 6574.2 6520.8 6525.6 6594.7 6647.6 6709.2 6585.1 6741.6 6772.3 6800.9 6866.2 6471.0 6488.4 6548.3 6555.8 6580.4 6417.4 6480.5 6482.1 6490.0 6527.7 6453.2 6473.5 6527.2 6550.6 6552.3 6432.7 6436.8 6494.8 6507.0 6587.0 6164.4 6273.9 6305.8 6314.0 6326.9 11:44:09 INFO - PID 28385 | 11:44:09 INFO - PID 28385 | [#1] ext.html Cycles:180 Average:37271.65 Median:19522.88 stddev:52547.99 (269.2%) stddev-sans-first:52623.75 11:44:09 INFO - PID 28385 | Values: 724.8 740.8 742.4 742.8 747.9 38204.0 41638.4 41731.4 41958.0 42166.6 37720.5 37877.6 37930.6 38044.8 38103.8 7009.7 7070.8 7161.4 7165.8 7167.0 7645.4 7787.2 7814.0 7865.7 7894.1 7788.8 7874.2 7887.7 7889.4 7892.4 7669.4 7759.6 7781.6 7873.1 7885.8 7729.7 7786.8 7809.5 7816.7 7872.3 39256.4 39660.2 39662.0 39677.8 39741.2 3527.4 3542.6 3561.6 3578.1 3581.9 32682.8 32912.8 32931.7 32995.3 33099.0 5273.1 5283.5 5290.3 5324.5 5342.9 181308.0 181683.0 182554.0 184034.0 185476.0 42962.1 44515.6 49088.8 49330.5 49590.8 46718.0 53029.0 53240.7 53908.7 53967.7 16451.9 16570.1 16662.9 16705.2 16709.3 13535.6 13584.5 13603.4 13606.7 13637.0 14190.4 14271.9 14371.6 14489.5 14663.9 5650.6 5712.2 5795.5 5804.0 5866.9 997.3 1016.6 1016.8 1019.0 1028.3 22632.0 22731.4 22867.2 23009.4 23027.1 1106.0 1108.3 1112.1 1117.4 1124.6 11972.3 11989.7 12047.8 12097.6 12120.8 226909.0 227886.0 228839.0 229006.0 229161.9 53051.5 53114.5 53204.2 53326.5 53452.2 1420.8 1422.5 1456.9 1484.1 1484.2 21986.8 22580.9 22767.5 22879.9 23038.7 36715.6 36798.3 36844.1 37064.3 37212.4 193822.0 194665.0 194927.0 195013.0 195108.0 32142.2 32979.0 32989.0 33842.0 35503.1 44408.3 44748.6 44987.3 45592.1 45605.0 32426.5 32590.3 32660.7 32709.8 32753.3 31845.4 32317.5 32328.7 32417.0 32572.8 35227.6 36282.0 36767.3 36836.8 36838.4 31245.8 31331.0 31331.5 31669.0 32318.2 22982.9 23557.9 23970.8 23985.4 24161.7 11:44:09 INFO - PID 28385 | 11:44:09 INFO - PID 28385 | [#2] jquery.html Cycles:180 Average:33811.55 Median:23297.53 stddev:79338.77 (340.5%) stddev-sans-first:79522.04 11:44:09 INFO - PID 28385 | Values: 553.4 559.3 561.3 570.8 589.5 21833.8 22677.7 22713.3 22734.7 22781.0 23570.0 24031.9 24224.8 25869.5 26343.5 6412.7 6455.5 6522.6 6528.1 6584.1 6431.5 6539.7 6543.5 6576.9 6610.8 6400.6 6539.1 6680.7 6691.0 6699.4 6602.8 6651.3 6667.8 6691.1 6714.2 5889.7 6155.5 6198.5 6203.6 6220.6 28776.0 29181.7 29235.9 29236.1 29252.6 2024.9 2031.6 2052.3 2058.5 2060.2 18747.7 18909.2 18970.5 19282.5 19320.5 2401.1 2422.1 2449.3 2465.3 2469.7 119684.4 124571.0 131694.0 133472.3 138866.6 14521.7 14619.8 14623.3 14646.2 14983.4 22993.4 23103.1 23240.7 23284.4 23310.7 9652.3 9777.9 9884.8 9977.9 10144.2 9115.8 9133.7 9158.9 9276.5 9335.4 8832.2 8948.7 9035.1 9132.8 9245.1 2542.8 2620.4 2622.0 2670.9 2702.1 919.4 928.9 952.4 956.6 980.0 19585.5 19650.9 19727.4 19940.2 19973.1 985.0 1011.8 1015.1 1024.2 1024.4 10439.6 10884.5 10939.5 11058.8 11155.0 458806.0 459015.0 472226.0 478882.0 486835.0 109120.0 112767.0 113444.0 114943.0 116049.0 1140.8 1155.6 1157.4 1160.7 1168.3 17398.6 17510.3 17625.8 17723.0 17888.7 54773.7 55620.0 56934.7 57101.4 57654.0 68269.7 69135.0 69618.0 70752.0 70883.3 13335.9 14458.2 14547.0 14610.8 14673.7 22554.0 23278.3 23311.9 23378.5 23411.5 18504.9 18564.6 18616.2 18661.5 18674.2 15404.4 16208.4 16325.5 16484.1 16523.3 18733.2 18838.0 18942.8 18959.3 19138.8 14106.2 14253.1 14276.4 14286.1 14355.8 17938.9 18451.9 18505.6 18555.4 18702.3 11:44:09 INFO - PID 28385 | 11:44:09 INFO - PID 28385 | [#3] mootools.html Cycles:180 Average:9390.69 Median:2734.73 stddev:6720.54 (245.7%) stddev-sans-first:6712.32 11:44:09 INFO - PID 28385 | Values: 1361.0 1398.2 1412.5 1413.8 1416.4 14861.6 15592.5 15637.9 15661.8 15684.9 15177.2 15192.1 15407.6 15419.3 15423.5 2755.4 2766.0 2812.4 2815.4 2819.1 2643.2 2731.1 2738.4 2764.3 2780.5 2685.6 2701.1 2743.5 2804.9 2823.9 2763.0 2792.8 2822.3 2827.8 2828.1 2751.6 2799.9 2807.0 2807.5 2811.4 14879.2 15182.4 15229.1 15260.4 15293.0 8023.3 8265.4 8297.9 8304.1 8349.4 5265.1 5485.8 5487.5 5605.1 5683.8 1980.2 1987.1 1990.4 2015.1 2017.4 26278.9 26691.6 26703.2 26722.1 26781.0 6624.3 6822.9 6831.5 7055.9 7061.6 17338.7 17359.6 17364.0 17482.5 17516.0 7909.7 8064.7 8116.2 8129.4 8136.0 7346.0 7419.6 7464.1 7505.1 7572.5 5068.1 5201.8 5214.3 5226.5 5270.2 1456.5 1513.1 1518.1 1528.3 1535.6 767.6 874.4 879.9 889.5 899.1 8696.6 8727.7 8778.8 8793.4 8857.6 985.4 994.2 1000.8 1007.7 1012.4 5051.8 5112.5 5137.1 5259.9 5260.5 21346.6 21784.9 22133.6 22225.2 22254.2 20345.7 21452.4 21726.5 21746.2 21994.1 10508.5 10668.1 10691.4 10728.4 10768.5 7874.1 8336.9 8489.6 8490.6 8517.3 18728.9 18777.5 18900.4 19039.9 19500.9 19103.5 19282.8 19729.6 19877.1 19935.0 11072.3 11258.8 11341.9 11368.2 11368.3 13965.0 13998.4 14151.3 14218.5 14240.6 9409.7 9516.7 9665.4 9839.0 10001.1 11171.8 11413.0 11477.9 11480.6 11595.8 9783.7 9969.7 10080.9 10249.2 10300.5 6984.9 6991.1 7197.6 7234.5 7371.6 7188.9 7196.4 7416.0 7437.8 7534.9 11:44:09 INFO - PID 28385 | 11:44:09 INFO - PID 28385 | [#4] prototype.html Cycles:180 Average:5531.83 Median:6224.39 stddev:1543.25 (24.8%) stddev-sans-first:1500.24 11:44:09 INFO - PID 28385 | Values: 478.2 511.0 521.1 521.8 523.4 6311.4 6372.9 6376.0 6384.6 6416.6 6238.8 6250.3 6269.2 6273.3 6277.5 5194.8 5201.0 5218.5 5222.3 5231.8 5233.3 5251.6 5258.3 5272.6 5284.6 4784.6 4975.3 5004.4 5025.5 5138.5 4967.7 4981.7 4982.6 4998.8 5007.6 4413.4 4430.0 4435.0 4446.8 4473.8 5999.6 6160.4 6193.0 6209.9 6246.6 5678.4 5704.8 5734.5 5759.5 5780.8 6581.3 6622.3 6635.0 6636.5 6687.9 4897.1 4901.4 4908.3 4910.0 4930.4 6669.0 6669.3 6811.1 6823.9 7022.2 5013.8 5030.4 5042.1 5056.9 5068.0 5076.4 5091.7 5094.6 5104.1 5123.6 5609.7 5696.5 5719.6 5728.3 5774.9 6643.8 6669.4 6671.5 6707.6 6751.3 1771.6 1771.7 1772.7 1779.7 1796.1 1141.4 1195.5 1213.1 1225.7 1230.3 5666.5 5726.9 5758.1 5779.2 5854.2 6752.6 6773.0 6786.7 6807.8 6840.6 5675.7 5744.3 5756.3 5782.0 5801.2 3526.7 3536.3 3547.1 3548.5 3591.2 6392.6 6412.6 6428.4 6455.5 6517.5 6874.9 6886.8 6923.4 6926.3 6927.2 5912.9 6426.6 6496.9 6516.1 6542.5 6601.3 6649.4 6657.0 6724.5 6733.1 6474.0 6480.2 6641.9 6678.5 6709.8 6404.9 6414.5 6457.8 6511.4 6531.8 4881.7 4994.4 5030.2 5033.8 5088.2 6433.0 6526.2 6616.4 6656.3 6816.7 6155.4 6472.0 6477.9 6550.4 6635.9 6492.6 6511.6 6576.1 6599.4 6608.0 6412.4 6419.3 6440.5 6479.9 6513.0 6506.4 6506.9 6586.7 6589.9 6636.7 6270.9 6348.9 6454.6 6467.2 6468.5 11:44:09 INFO - PID 28385 | 11:44:09 INFO - PID 28385 | [#5] yui.html Cycles:180 Average:23821.20 Median:26091.45 stddev:35914.19 (137.6%) stddev-sans-first:35973.65 11:44:09 INFO - PID 28385 | Values: 886.5 895.8 901.6 925.2 929.9 16462.9 17136.5 17150.4 17226.1 17284.3 16064.4 16139.9 16263.9 16358.0 16544.4 952.8 953.0 963.5 965.0 967.4 977.5 980.1 980.1 980.3 981.0 968.1 989.6 997.3 998.0 1011.0 1001.7 1003.4 1004.7 1004.8 1004.8 716.9 731.6 737.3 737.9 739.0 15871.9 16169.7 16213.3 16214.8 16215.7 19878.0 20434.4 20570.6 21136.6 21389.4 17424.6 17637.0 17788.5 17789.5 18055.8 3702.1 3725.6 3731.3 3732.1 3734.8 139303.0 141353.0 141377.0 142345.3 144046.8 16125.1 16392.0 16611.9 16764.2 16848.7 30793.5 31267.8 31327.5 31341.0 31839.4 8326.9 8399.5 8500.3 8504.6 8523.7 4136.4 4186.5 4216.6 4219.2 4221.7 5254.3 5415.3 5443.2 5468.9 5487.5 950.3 965.7 979.8 982.4 989.0 649.6 675.8 676.7 679.3 685.6 10558.3 10691.5 10984.3 11104.4 11200.4 673.4 679.7 684.4 685.6 700.9 5055.3 5083.7 5115.1 5182.0 5216.6 119009.0 120800.0 123639.0 126097.7 126373.0 106064.0 108133.0 112057.4 112321.4 113091.0 93911.0 96443.0 96668.1 98337.5 99569.5 9540.8 9545.6 9550.5 9558.4 9619.4 43391.0 43757.1 44120.3 44143.0 44950.8 57468.7 58250.0 58334.7 58436.0 58652.7 14284.2 14684.3 14690.6 14704.4 14735.9 15061.9 15097.9 15135.7 15186.7 15469.5 13506.7 13600.3 13777.1 13881.7 14023.4 13378.0 13474.8 13604.2 13614.4 13798.9 13429.7 13597.8 13642.9 13665.7 13863.6 10987.3 11015.6 11095.6 11209.2 11353.5 10067.6 10080.5 10110.2 10162.7 10166.2 11:44:09 INFO - PID 28385 | -------- Summary: end -------- 11:44:09 INFO - PID 28385 | 11:44:10 INFO - TEST-INFO | 28385: exit 0 11:44:10 INFO - TEST-OK | dromaeo_css | took 1113215ms 11:44:10 INFO - TEST-START | kraken 11:44:10 INFO - Initialising browser for kraken test... 11:44:10 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53866/getInfo.html -profile /tmp/tmpi8Fh_X/profile 11:44:10 INFO - TEST-INFO | started process 28770 (/builds/slave/test/build/application/firefox/firefox http://localhost:53866/getInfo.html) 11:44:16 INFO - TEST-INFO | 28770: exit 0 11:44:16 INFO - Browser initialized. 11:44:16 INFO - Running cycle 1/1 for kraken test... 11:44:16 INFO - Using env: {'DISPLAY': ':0', 11:44:16 INFO - 'HOME': '/home/cltbld', 11:44:16 INFO - 'JSGC_DISABLE_POISONING': '1', 11:44:16 INFO - 'LANG': 'en_US.UTF-8', 11:44:16 INFO - 'LANGUAGE': 'en_US:en', 11:44:16 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:44:16 INFO - 'LOGNAME': 'cltbld', 11:44:16 INFO - 'MAIL': '/var/mail/cltbld', 11:44:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:44:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:44:16 INFO - 'MOZ_ACCELERATED': '1', 11:44:16 INFO - 'MOZ_CRASHREPORTER': '1', 11:44:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:16 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:44:16 INFO - 'MOZ_NO_REMOTE': '1', 11:44:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:44:16 INFO - 'MOZ_WEBRENDER': '1', 11:44:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:16 INFO - 'NO_EM_RESTART': '1', 11:44:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:16 INFO - 'PWD': '/builds/slave/test', 11:44:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:44:16 INFO - 'RUST_BACKTRACE': 'full', 11:44:16 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:44:16 INFO - 'SHELL': '/bin/bash', 11:44:16 INFO - 'SHLVL': '1', 11:44:16 INFO - 'TERM': 'linux', 11:44:16 INFO - 'TMOUT': '86400', 11:44:16 INFO - 'USER': 'cltbld', 11:44:16 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1505493361.299680-1570690761', 11:44:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:16 INFO - '_': '/tools/buildbot/bin/python'} 11:44:16 INFO - TEST-INFO | started process 29016 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi8Fh_X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:44:17 INFO - PID 29016 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:44:17 INFO - PID 29016 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:44:17 INFO - PID 29016 | 11:44:17 INFO - PID 29016 | (/builds/slave/test/build/application/firefox/firefox:29074): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:44:17 INFO - PID 29016 | 11:44:27 INFO - PID 29016 | RSS: Main: 202784768 11:44:27 INFO - PID 29016 | 11:44:30 INFO - PID 29016 | Cycle 1(1): loaded http://localhost:53866/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53866/tests/kraken/driver.html?testName=audio-beat-detection) 11:44:31 INFO - PID 29016 | RSS: Main: 210137088 11:44:31 INFO - PID 29016 | 11:44:34 INFO - PID 29016 | Cycle 1(1): loaded http://localhost:53866/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53866/tests/kraken/driver.html?testName=audio-dft) 11:44:35 INFO - PID 29016 | RSS: Main: 210612224 11:44:35 INFO - PID 29016 | 11:44:38 INFO - PID 29016 | Cycle 1(1): loaded http://localhost:53866/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53866/tests/kraken/driver.html?testName=audio-fft) 11:44:38 INFO - PID 29016 | RSS: Main: 204427264 11:44:38 INFO - PID 29016 | 11:44:40 INFO - PID 29016 | Cycle 1(1): loaded http://localhost:53866/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53866/tests/kraken/driver.html?testName=audio-oscillator) 11:44:41 INFO - PID 29016 | RSS: Main: 205045760 11:44:41 INFO - PID 29016 | 11:44:43 INFO - PID 29016 | Cycle 1(1): loaded http://localhost:53866/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53866/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:44:44 INFO - PID 29016 | RSS: Main: 205889536 11:44:44 INFO - PID 29016 | 11:44:47 INFO - PID 29016 | Cycle 1(1): loaded http://localhost:53866/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53866/tests/kraken/driver.html?testName=imaging-darkroom) 11:44:48 INFO - PID 29016 | RSS: Main: 208138240 11:44:48 INFO - PID 29016 | 11:44:51 INFO - PID 29016 | Cycle 1(1): loaded http://localhost:53866/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53866/tests/kraken/driver.html?testName=imaging-desaturate) 11:44:52 INFO - PID 29016 | RSS: Main: 207347712 11:44:52 INFO - PID 29016 | 11:44:55 INFO - PID 29016 | Cycle 1(1): loaded http://localhost:53866/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53866/tests/kraken/driver.html?testName=json-parse-financial) 11:44:56 INFO - PID 29016 | RSS: Main: 209129472 11:44:56 INFO - PID 29016 | 11:44:57 INFO - PID 29016 | Cycle 1(1): loaded http://localhost:53866/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53866/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:44:58 INFO - PID 29016 | RSS: Main: 208502784 11:44:58 INFO - PID 29016 | 11:45:00 INFO - PID 29016 | Cycle 1(1): loaded http://localhost:53866/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53866/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:45:00 INFO - PID 29016 | RSS: Main: 204697600 11:45:00 INFO - PID 29016 | 11:45:03 INFO - PID 29016 | Cycle 1(1): loaded http://localhost:53866/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53866/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:45:03 INFO - PID 29016 | RSS: Main: 205099008 11:45:03 INFO - PID 29016 | 11:45:06 INFO - PID 29016 | Cycle 1(1): loaded http://localhost:53866/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53866/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:45:07 INFO - PID 29016 | RSS: Main: 206360576 11:45:07 INFO - PID 29016 | 11:45:10 INFO - PID 29016 | Cycle 1(1): loaded http://localhost:53866/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53866/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:45:10 INFO - PID 29016 | RSS: Main: 205742080 11:45:10 INFO - PID 29016 | 11:45:12 INFO - PID 29016 | Cycle 1(1): loaded http://localhost:53866/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53866/tests/kraken/driver.html?testName=ai-astar) 11:45:12 INFO - PID 29016 | RSS: Main: 207446016 11:45:12 INFO - PID 29016 | 11:45:12 INFO - PID 29016 | __start_tp_report 11:45:12 INFO - PID 29016 | _x_x_mozilla_page_load 11:45:12 INFO - PID 29016 | _x_x_mozilla_page_load_details 11:45:12 INFO - PID 29016 | |i|pagename|runs| 11:45:12 INFO - PID 29016 | |0;ai-astar;115;112;111;111;113;122;108;118;117;119 11:45:12 INFO - PID 29016 | |1;audio-beat-detection;131;115;117;118;119;118;118;118;117;120 11:45:12 INFO - PID 29016 | |2;audio-dft;167;169;171;162;164;179;165;174;166;176 11:45:12 INFO - PID 29016 | |3;audio-fft;74;75;83;76;75;74;74;81;85;79 11:45:12 INFO - PID 29016 | |4;audio-oscillator;85;82;81;80;81;79;79;80;80;86 11:45:12 INFO - PID 29016 | |5;imaging-gaussian-blur;111;114;114;114;111;118;115;117;114;115 11:45:12 INFO - PID 29016 | |6;imaging-darkroom;152;153;152;148;151;149;148;154;149;158 11:45:12 INFO - PID 29016 | |7;imaging-desaturate;98;97;94;103;95;95;97;95;96;96 11:45:12 INFO - PID 29016 | |8;json-parse-financial;56;56;57;53;54;54;56;52;52;60 11:45:12 INFO - PID 29016 | |9;json-stringify-tinderbox;39;46;40;38;38;47;38;44;38;39 11:45:12 INFO - PID 29016 | |10;stanford-crypto-aes;82;82;79;76;75;84;79;78;80;84 11:45:12 INFO - PID 29016 | |11;stanford-crypto-ccm;124;114;116;118;119;128;119;120;118;114 11:45:12 INFO - PID 29016 | |12;stanford-crypto-pbkdf2;173;173;175;179;175;171;175;182;174;179 11:45:12 INFO - PID 29016 | |13;stanford-crypto-sha256-iterative;68;76;67;66;70;72;72;69;70;66 11:45:12 INFO - PID 29016 | __end_tp_report 11:45:12 INFO - PID 29016 | __start_cc_report 11:45:12 INFO - PID 29016 | _x_x_mozilla_cycle_collect,923 11:45:12 INFO - PID 29016 | __end_cc_report 11:45:12 INFO - PID 29016 | __startTimestamp1505501112933__endTimestamp 11:45:12 INFO - PID 29016 | 11:45:12 INFO - PID 29016 | ------- Summary: start ------- 11:45:12 INFO - PID 29016 | Number of tests: 14 11:45:12 INFO - PID 29016 | 11:45:12 INFO - PID 29016 | [#0] ai-astar Cycles:10 Average:114.60 Median:116.00 stddev:4.35 (3.8%) stddev-sans-first:4.61 11:45:12 INFO - PID 29016 | Values: 115.0 112.0 111.0 111.0 113.0 122.0 108.0 118.0 117.0 119.0 11:45:12 INFO - PID 29016 | 11:45:12 INFO - PID 29016 | [#1] audio-beat-detection Cycles:10 Average:119.10 Median:118.00 stddev:4.38 (3.7%) stddev-sans-first:1.39 11:45:12 INFO - PID 29016 | Values: 131.0 115.0 117.0 118.0 119.0 118.0 118.0 118.0 117.0 120.0 11:45:12 INFO - PID 29016 | 11:45:12 INFO - PID 29016 | [#2] audio-dft Cycles:10 Average:169.30 Median:170.00 stddev:5.58 (3.3%) stddev-sans-first:5.85 11:45:12 INFO - PID 29016 | Values: 167.0 169.0 171.0 162.0 164.0 179.0 165.0 174.0 166.0 176.0 11:45:12 INFO - PID 29016 | 11:45:12 INFO - PID 29016 | [#3] audio-fft Cycles:10 Average:77.60 Median:77.50 stddev:4.12 (5.3%) stddev-sans-first:4.15 11:45:12 INFO - PID 29016 | Values: 74.0 75.0 83.0 76.0 75.0 74.0 74.0 81.0 85.0 79.0 11:45:12 INFO - PID 29016 | 11:45:12 INFO - PID 29016 | [#4] audio-oscillator Cycles:10 Average:81.30 Median:81.00 stddev:2.41 (3.0%) stddev-sans-first:2.15 11:45:12 INFO - PID 29016 | Values: 85.0 82.0 81.0 80.0 81.0 79.0 79.0 80.0 80.0 86.0 11:45:12 INFO - PID 29016 | 11:45:12 INFO - PID 29016 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.50 stddev:2.21 (1.9%) stddev-sans-first:2.00 11:45:12 INFO - PID 29016 | Values: 111.0 114.0 114.0 114.0 111.0 118.0 115.0 117.0 114.0 115.0 11:45:12 INFO - PID 29016 | 11:45:12 INFO - PID 29016 | [#6] imaging-darkroom Cycles:10 Average:151.40 Median:152.00 stddev:3.13 (2.1%) stddev-sans-first:3.32 11:45:12 INFO - PID 29016 | Values: 152.0 153.0 152.0 148.0 151.0 149.0 148.0 154.0 149.0 158.0 11:45:12 INFO - PID 29016 | 11:45:12 INFO - PID 29016 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:96.00 stddev:2.55 (2.7%) stddev-sans-first:2.65 11:45:12 INFO - PID 29016 | Values: 98.0 97.0 94.0 103.0 95.0 95.0 97.0 95.0 96.0 96.0 11:45:12 INFO - PID 29016 | 11:45:12 INFO - PID 29016 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:56.00 stddev:2.49 (4.5%) stddev-sans-first:2.62 11:45:12 INFO - PID 29016 | Values: 56.0 56.0 57.0 53.0 54.0 54.0 56.0 52.0 52.0 60.0 11:45:12 INFO - PID 29016 | 11:45:12 INFO - PID 29016 | [#9] json-stringify-tinderbox Cycles:10 Average:40.70 Median:39.50 stddev:3.56 (9.0%) stddev-sans-first:3.72 11:45:12 INFO - PID 29016 | Values: 39.0 46.0 40.0 38.0 38.0 47.0 38.0 44.0 38.0 39.0 11:45:12 INFO - PID 29016 | 11:45:12 INFO - PID 29016 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:81.00 stddev:3.11 (3.8%) stddev-sans-first:3.20 11:45:12 INFO - PID 29016 | Values: 82.0 82.0 79.0 76.0 75.0 84.0 79.0 78.0 80.0 84.0 11:45:12 INFO - PID 29016 | 11:45:12 INFO - PID 29016 | [#11] stanford-crypto-ccm Cycles:10 Average:119.00 Median:119.00 stddev:4.32 (3.6%) stddev-sans-first:4.19 11:45:12 INFO - PID 29016 | Values: 124.0 114.0 116.0 118.0 119.0 128.0 119.0 120.0 118.0 114.0 11:45:12 INFO - PID 29016 | 11:45:12 INFO - PID 29016 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.60 Median:175.00 stddev:3.37 (1.9%) stddev-sans-first:3.44 11:45:12 INFO - PID 29016 | Values: 173.0 173.0 175.0 179.0 175.0 171.0 175.0 182.0 174.0 179.0 11:45:12 INFO - PID 29016 | 11:45:12 INFO - PID 29016 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:70.00 stddev:3.13 (4.5%) stddev-sans-first:3.27 11:45:12 INFO - PID 29016 | Values: 68.0 76.0 67.0 66.0 70.0 72.0 72.0 69.0 70.0 66.0 11:45:12 INFO - PID 29016 | -------- Summary: end -------- 11:45:12 INFO - PID 29016 | 11:45:13 INFO - PID 29016 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:45:13 INFO - TEST-INFO | 29016: exit 0 11:45:13 INFO - TEST-OK | kraken | took 63681ms 11:45:13 INFO - SUITE-END | took 1176s 11:45:14 INFO - Completed test suite (00:19:37) 11:45:14 INFO - javascript benchmark 11:45:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8419.16774350297, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3138.419392412404, 3158.2104473881514, 3165.3669266146776, 3166.1451408119815, 3183.140552050946, 6179.289381721103, 6260.436560709535, 6288.559800813945, 6290.59111157775, 6380.80857574273, 6194.194754681885, 6204.28650705169, 6218.62688238706, 6229.626222426647, 6261.7182226799905, 5705.372409035002, 5773.884522309551, 5817.389174136718, 5817.796377126801, 5832.416758324176, 5707.686077265748, 5798.420157984189, 5801.245838041049, 5804.506616937565, 5909.084091965752, 90.19508915925489, 5678.46054624812, 5701.600887937846, 5824.679642619654, 5885.999380105371, 5622.971885140548, 5682.147677848315, 5750.3962083981, 5755.0504166812425, 5791.0, 5650.3502097258515, 5680.636647204682, 5747.798827041033, 5757.9712101439645, 5778.682172480512, 6204.906926396107, 6217.191765070512, 6271.0, 6271.34150914152, 6336.619802811846, 6646.567973081783, 6674.098996635489, 6756.594604323756, 6767.052612634235, 6786.694598743068, 6582.275949645536, 6694.230163531208, 6709.194896612389, 6724.495662825308, 6783.118194634715, 6195.132681424604, 6221.0, 6228.750849965996, 6249.843753906143, 6260.311365749764, 6876.381125698711, 6894.655267236618, 6898.689558969859, 6906.827329316707, 6909.792706218822, 6475.902861457082, 6577.506686998494, 6688.598684078971, 6689.933100669028, 6692.063111164441, 6689.397954184147, 6776.322367763184, 6812.795616131524, 6844.28135045823, 6856.382925536725, 6590.7693230736695, 6596.73613055482, 6693.364130407604, 6756.560823546453, 6830.21452532965, 6567.408933196035, 6593.175853018372, 6647.501437392215, 6652.467802575782, 6689.096971908827, 5229.47705229474, 5230.947690523122, 5232.058229518723, 5242.344706911636, 5272.209168624737, 4552.408186935743, 4553.6357091433265, 4612.377329060601, 4656.8137274508645, 4667.8599642010795, 5756.309242890796, 5762.1068734346245, 5835.270591176103, 5855.970720146372, 5859.765609375577, 6615.0, 6695.363940425652, 6777.593344399352, 6781.084553585301, 6857.897131543031, 5693.658380497183, 5720.399358067426, 5743.62666426681, 5765.423457654285, 5769.624974376652, 5725.427457254241, 5745.68398738065, 5813.331466881278, 5821.708914554255, 5835.095560188178, 6403.775867844696, 6438.420542151229, 6510.576812507172, 6562.835929101715, 6570.277269500351, 6542.640154791532, 6631.171103612049, 6638.734450622114, 6659.6670166491485, 6733.091032710718, 6463.644499552382, 6473.741050358121, 6490.772822951363, 6540.215174179129, 6574.211094668671, 6520.836979075561, 6525.64108974011, 6594.670266486753, 6647.601143931186, 6709.161354830646, 6585.111010013587, 6741.561798483083, 6772.322767723188, 6800.897986530305, 6866.210385805496, 6470.9676451619325, 6488.448481879093, 6548.345165483413, 6555.80332590023, 6580.440662543738, 6417.358264173546, 6480.546361754632, 6482.124913136666, 6490.0, 6527.67361631907, 6453.193350831146, 6473.482121430368, 6527.2167339919515, 6550.6069635822005, 6552.312007239171, 6432.710528026344, 6436.8390790230615, 6494.805155845333, 6506.967465162644, 6587.0, 6164.4143806338325, 6273.905891411724, 6305.779297724557, 6313.96843015782, 6326.936730632635], "value": 6063.1774939016195, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [724.8043028382336, 740.803687022939, 742.428330185757, 742.8142964258935, 747.9252074792521, 38204.0, 41638.375424368656, 41731.374029389546, 41958.0, 42166.57833421665, 37720.49118035275, 37877.621223787755, 37930.620693793055, 38044.80977595108, 38103.80948095262, 7009.719611215545, 7070.7525236616475, 7161.355478006978, 7165.820854478628, 7167.0, 7645.3883689305, 7787.221277872224, 7814.0, 7865.68537258509, 7894.092179399357, 7788.844223115534, 7874.173211812763, 7887.684492620317, 7889.368850491946, 7892.447528672995, 7669.386449084116, 7759.612019399064, 7781.610919454033, 7873.094594121692, 7885.842283154305, 7729.652165652559, 7786.831975203708, 7809.531428114331, 7816.72641457552, 7872.252136047066, 39256.41115383243, 39660.20679586421, 39662.0, 39677.80161099176, 39741.20517589632, 3527.3650742866275, 3542.6457354264626, 3561.5904171020147, 3578.1233597768714, 3581.87463438781, 32682.836585817156, 32912.835435822904, 32931.6706832931, 32995.340093198, 33099.0, 5273.050850846846, 5283.471652834724, 5290.312259406291, 5324.54741346986, 5342.91985620216, 181308.0, 181683.0, 182554.0, 184034.0, 185476.0, 42962.14075718468, 44515.55484445179, 49088.75455622699, 49330.50669493259, 49590.75204623954, 46718.0, 53029.0, 53240.733796331544, 53908.730456348254, 53967.73016134894, 16451.91774041122, 16570.088645124633, 16662.916685416494, 16705.248263828158, 16709.33162673504, 13535.59393218205, 13584.456621735217, 13603.387847546686, 13606.659833504242, 13637.045406821428, 14190.432382704576, 14271.857281427261, 14371.640708982359, 14489.492867749577, 14663.853361466463, 5650.576206784508, 5712.200291959129, 5795.507381872504, 5803.970980145073, 5866.853328666817, 997.2670087485692, 1016.5679586175846, 1016.8271393863062, 1018.9643362482277, 1028.2956175020136, 22632.0, 22731.431714207276, 22867.19964801224, 23009.42476438069, 23027.078916843475, 1105.9723506912392, 1108.2519299472824, 1112.060309038877, 1117.4133579870634, 1124.6344937895217, 11972.341521216242, 11989.700257493458, 12047.819282710767, 12097.637070887888, 12120.75758484843, 226909.0, 227886.0, 228839.0, 229006.0, 229161.8541907313, 53051.469485305424, 53114.46885531172, 53204.201936970974, 53326.46673533293, 53452.19821702677, 1420.7513685105273, 1422.5021242565226, 1456.8615981481742, 1484.0798704802876, 1484.1540322016347, 21986.780132198473, 22580.887095564416, 22767.544649107258, 22879.88560057189, 23038.654420184044, 36715.63284367122, 36798.26403471862, 36844.07889802669, 37064.25871482501, 37212.44181337336, 193822.0, 194665.0, 194927.0, 195013.0, 195108.0, 32142.19644508906, 32979.0, 32989.0, 33842.0, 35503.11242218965, 44408.33387499126, 44748.55251447444, 44987.32519012152, 45592.08815823731, 45605.0, 32426.513602295512, 32590.34819303648, 32660.693572257795, 32709.836450817595, 32753.34493310168, 31845.363092737553, 32317.51523727099, 32328.676713232566, 32417.0, 32572.83713581417, 35227.64772352346, 36282.0, 36767.26465470622, 36836.81581592075, 36838.44742328813, 31245.843770781, 31331.0, 31331.53002705007, 31669.0, 32318.19204519906, 22982.885085574464, 23557.882210588836, 23970.76029239755, 23985.400364990317, 24161.67110808852], "value": 17107.564890319754, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.3608681972323, 559.2897020783607, 561.2759540193149, 570.7688386203588, 589.4871461828209, 21833.781662183374, 22677.659835102466, 22713.318600442013, 22734.658980115313, 22781.0, 23570.0, 24031.879840600817, 24224.75775242247, 25869.482610347783, 26343.47313053738, 6412.6793660317035, 6455.548111632188, 6522.576032557892, 6528.08606795049, 6584.078229047937, 6431.485481161496, 6539.6730163491875, 6543.509236807235, 6576.947688369862, 6610.834729131762, 6400.647964361959, 6539.117219175422, 6680.699368528428, 6691.029800678899, 6699.430548403391, 6602.768903088393, 6651.334866513334, 6667.799966001027, 6691.096701945248, 6714.227863795677, 5889.734961926681, 6155.507559395282, 6198.504119670415, 6203.627782333075, 6220.564560480768, 28776.0, 29181.70818291811, 29235.85382073076, 29236.122916312546, 29252.561211581844, 2024.9190032398687, 2031.5733695923873, 2052.3432501599345, 2058.5059585699323, 2060.1553363121197, 18747.718784218247, 18909.243630254772, 18970.52573685669, 19282.517937051547, 19320.516987075294, 2401.1235898896775, 2422.0502495491123, 2449.3141920262356, 2465.3220364399754, 2469.703635563744, 119684.40157799242, 124571.0, 131694.0, 133472.3326383362, 138866.61133388637, 14521.693047625764, 14619.75164397296, 14623.341949612293, 14646.228060558315, 14983.40066397332, 22993.425164371023, 23103.07587696507, 23240.65139022916, 23284.417889552897, 23310.65034024491, 9652.27607929408, 9777.853332200022, 9884.752881178028, 9977.900220997697, 10144.188464922789, 9115.772105697411, 9133.725988220363, 9158.86261706075, 9276.489793061446, 9335.393199442015, 8832.160944710242, 8948.73153805387, 9035.102628447969, 9132.81734365309, 9245.121713437213, 2542.7711505964553, 2620.4104076582616, 2621.973780262173, 2670.893164273446, 2702.067786613615, 919.4437365393974, 928.8792456980549, 952.4047470331043, 956.551631368919, 979.9559019844124, 19585.510362241057, 19650.90174549118, 19727.40817775469, 19940.177470176157, 19973.101210445566, 985.0248254228405, 1011.8178727829062, 1015.0712098429854, 1024.1960061351951, 1024.3700124423426, 10439.582416703399, 10884.510197041152, 10939.453027348602, 11058.834117488244, 11155.0, 458806.0, 459015.0, 472226.0, 478882.0, 486835.0, 109120.0, 112767.0, 113444.0, 114943.0, 116049.0, 1140.8117660586076, 1155.5839897636677, 1157.3634501024403, 1160.7388337624136, 1168.339887963315, 17398.565035874206, 17510.299588016336, 17625.82374176242, 17723.0, 17888.731669025234, 54773.72613136909, 55620.0, 56934.7153264231, 57101.42898570961, 57654.0, 68269.65865170643, 69135.0, 69618.0, 70752.0, 70883.29116708973, 13335.933125349755, 14458.204798736171, 14547.0, 14610.780838287646, 14673.70652586921, 22554.0, 23278.3016509505, 23311.88344058269, 23378.532429350977, 23411.531769364858, 18504.907475462536, 18564.628707426047, 18616.16227269803, 18661.533461663566, 18674.159662815477, 15404.38382464689, 16208.35166593323, 16325.510234692978, 16484.093374864497, 16523.33906643721, 18733.157007934402, 18838.0, 18942.810571894104, 18959.336423225122, 19138.808611913704, 14106.224157671426, 14253.144811311355, 14276.42894284217, 14286.071405358618, 14355.784663229852, 17938.91030544839, 18451.90774046121, 18505.629887402447, 18555.35056273024, 18702.345417910852], "value": 11831.357452577051, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1360.9863901360986, 1398.2030242761616, 1412.4562043613212, 1413.7596608576541, 1416.426347329332, 14861.628459288524, 15592.532224033268, 15637.92181039096, 15661.765073523891, 15684.921575392122, 15177.165255910948, 15192.088474691527, 15407.614809629737, 15419.306131224093, 15423.460178893742, 2755.3524921643498, 2765.958510622337, 2812.3531587734833, 2815.3665425279355, 2819.0978886756143, 2643.15419065899, 2731.0987374166575, 2738.370174859783, 2764.2812868654096, 2780.541210700242, 2685.5703087506004, 2701.1086341507257, 2743.547314693073, 2804.9298767530872, 2823.8729257183477, 2763.0467488716363, 2792.8463934483593, 2822.3085344090728, 2827.802053856231, 2828.0950095969297, 2751.5735061065566, 2799.9440011199663, 2807.0456044944613, 2807.4946509628257, 2811.353388720606, 14879.18164500952, 15182.392704291815, 15229.086254824746, 15260.38958441661, 15293.0, 8023.31801796848, 8265.380096492727, 8297.917020829775, 8304.086550479442, 8349.373796965192, 5265.131253343194, 5485.753141108659, 5487.478689524529, 5605.103183490622, 5683.801066962677, 1980.2178139634907, 1987.0958713785194, 1990.4227773945538, 2015.0730663894626, 2017.4351181669156, 26278.868605656848, 26691.599626005627, 26703.19890403291, 26722.06472773463, 26781.0, 6624.304448032887, 6822.906256246212, 6831.4534837212905, 7055.9294407056295, 7061.611611361322, 17338.653226935392, 17359.56601084983, 17364.0, 17482.475525734248, 17516.036617986134, 7909.6836126555445, 8064.717734879251, 8116.188381161955, 8129.390295727726, 8135.959320203479, 7345.963270183614, 7419.591922444318, 7464.066991626047, 7505.136909255396, 7572.545647261182, 5068.138416469135, 5201.765920533509, 5214.270002199695, 5226.529612334832, 5270.235815806686, 1456.5411895252962, 1513.1299502785942, 1518.089146512106, 1528.2664321125922, 1535.5623647260477, 767.6161919040479, 874.4097734029632, 879.8636211387245, 889.515214208258, 899.0604817965111, 8696.608652610648, 8727.694530691395, 8778.824423511622, 8793.38446308765, 8857.601407936658, 985.4186030242191, 994.2046362909643, 1000.7598176437602, 1007.7128018514835, 1012.4380968562518, 5051.772670229849, 5112.539871411516, 5137.101007323703, 5259.894802104013, 5260.473952604709, 21346.573068538542, 21784.89107554452, 22133.557328853334, 22225.222117225818, 22254.221102261345, 20345.694814577793, 21452.356429307147, 21726.45683857916, 21746.238881639067, 21994.120235190414, 10508.527116279785, 10668.14654827612, 10691.35851848907, 10728.356298622108, 10768.461576921123, 7874.1338452769005, 8336.916630833613, 8489.617967191367, 8490.575471226537, 8517.318614510948, 18728.906355468134, 18777.530561736065, 18900.432987010412, 19039.90480047591, 19500.902495488, 19103.52241193981, 19282.84302941828, 19729.60540789205, 19877.105530250883, 19935.0, 11072.280301780358, 11258.7748245033, 11341.886581134084, 11368.204225704452, 11368.261063030877, 13965.0, 13998.37007334652, 14151.292435378396, 14218.502352417616, 14240.572782816533, 9409.670661526814, 9516.666916657883, 9665.420074795253, 9838.950805245928, 10001.1499022581, 11171.776564468502, 11413.0, 11477.942610286895, 11480.598179063692, 11595.768084638428, 9783.706488805346, 9969.651062212788, 10080.949595251977, 10249.180065594883, 10300.484975751033, 6984.860302794017, 6991.126109236346, 7197.640117994184, 7234.529755565872, 7371.6314184289495, 7188.928110719035, 7196.352328290479, 7416.0, 7437.776866694008, 7534.886976695244], "value": 6731.560183037692, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [478.1512814753814, 510.9627456263786, 521.062088241166, 521.8486638874726, 523.3928642774382, 6311.400416960393, 6372.852886480432, 6375.968120159404, 6384.616922984613, 6416.647084410367, 6238.84402889928, 6250.343713910042, 6269.185005949232, 6273.309935907047, 6277.497800175986, 5194.766235519392, 5200.959808038408, 5218.486638874721, 5222.321098257221, 5231.816886408977, 5233.319668443097, 5251.5798736101215, 5258.2638430619745, 5272.551833094191, 5284.630075894689, 4784.5693887550115, 4975.338194066176, 5004.399472063357, 5025.472325405816, 5138.511841375082, 4967.677100988442, 4981.701097934136, 4982.579964710077, 4998.77530005151, 5007.599392048627, 4413.426254586915, 4429.977850110761, 4435.0, 4446.822127114944, 4473.82104715811, 5999.580029397944, 6160.4455598995855, 6193.0, 6209.9379006210265, 6246.593971391845, 5678.432156784289, 5704.77180912763, 5734.512566431858, 5759.481646651821, 5780.797672081457, 6581.255967168656, 6622.317961225664, 6634.976332218672, 6636.502262330345, 6687.933120668779, 4897.118518666639, 4901.362822833044, 4908.312836202935, 4909.950900490985, 4930.359053323081, 6668.9666551667415, 6669.299723529008, 6811.148606424197, 6823.863522729517, 7022.1924478685605, 5013.771625951592, 5030.3963524377305, 5042.142835717937, 5056.873578160576, 5067.974660126676, 5076.416212135578, 5091.66904151229, 5094.61790365724, 5104.106781313255, 5123.590112790967, 5609.747561359749, 5696.544276457874, 5719.599628025998, 5728.312602487728, 5774.913376299359, 6643.800685979429, 6669.4330981866115, 6671.499637527205, 6707.5975441473665, 6751.291114433012, 1771.5925337172523, 1771.6633839570698, 1772.7075032619732, 1779.6974514332335, 1796.1019490254873, 1141.366541569437, 1195.5038658956435, 1213.1265488848014, 1225.6935766058486, 1230.2618428942742, 5666.490015898589, 5726.885462290731, 5758.136279558016, 5779.162021506858, 5854.18041474194, 6752.62860542665, 6773.0, 6786.694598743068, 6807.761728339485, 6840.555363901331, 5675.716214189357, 5744.339400968942, 5756.280464941882, 5781.971090144522, 5801.187833703285, 3526.68259856609, 3536.328097661436, 3547.1486843157454, 3548.538689970287, 3591.2099338145567, 6392.616443013434, 6412.583182093149, 6428.3893030163, 6455.548111632234, 6517.523341130435, 6874.896876546856, 6886.758963436356, 6923.446124310043, 6926.341997510229, 6927.168739751262, 5912.906112369225, 6426.550141490051, 6496.902546461807, 6516.0877477153235, 6542.476601871839, 6601.273859875506, 6649.434798042221, 6657.0, 6724.4620430364475, 6733.081071894682, 6474.028895665688, 6480.189976252968, 6641.867162656623, 6678.465722742072, 6709.798706038827, 6404.911165102037, 6414.486841052611, 6457.806265812033, 6511.38141876521, 6531.836704082436, 4881.678969922801, 4994.350734404504, 5030.220315851049, 5033.773480193473, 5088.185890257541, 6433.0, 6526.216853977363, 6616.445135393083, 6656.30108838565, 6816.727330906709, 6155.35368786271, 6471.967640161769, 6477.902831457626, 6550.410463058348, 6635.9004614929845, 6492.610443373413, 6511.641859697573, 6576.112224849775, 6599.373059559334, 6608.0, 6412.39082287182, 6419.261784894797, 6440.516961227833, 6479.935200647933, 6512.967435162794, 6506.4469520091325, 6506.902396463962, 6586.736530538725, 6589.934100658932, 6636.701348439428, 6270.871243176272, 6348.936510634834, 6454.612723236621, 6467.191601049869, 6468.514861385321], "value": 5074.852346513213, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [886.5301390263163, 895.7760559860035, 901.5717534171265, 925.1581061234274, 929.9395539289945, 16462.917685411572, 17136.48590542284, 17150.399736009243, 17226.138693065343, 17284.30862765491, 16064.437744678939, 16139.919300403482, 16263.918680406581, 16358.018518888844, 16544.420945266917, 952.752284406056, 952.9904700952972, 963.5037955452947, 964.9807003859919, 967.405045896772, 977.5454413697629, 980.103205566909, 980.1374790184627, 980.2550061952932, 980.9901900981006, 968.0706521739139, 989.6437282578266, 997.3268044070223, 997.9700608981742, 1011.0142610954334, 1001.6544292219173, 1003.3829195045031, 1004.6734811186394, 1004.7990401919645, 1004.8241557727405, 716.9426445884369, 731.6159016516318, 737.3474475089531, 737.8634952533798, 738.985220295591, 15871.920640396724, 16169.676606467805, 16213.2704028319, 16214.83785162145, 16215.675686486322, 19878.006099694958, 20434.386968390972, 20570.5885882283, 21136.577268454697, 21389.35831925045, 17424.564385890455, 17637.0, 17788.46634600951, 17789.46631601054, 18055.819441805677, 3702.092987218122, 3725.608811074825, 3731.328360895038, 3732.122951106488, 3734.7572407793405, 139303.0, 141353.0, 141377.0, 142345.288273559, 144046.83929741062, 16125.11311877858, 16392.0, 16611.91694041522, 16764.245608947625, 16848.663026739396, 30793.538096928565, 31267.84366078155, 31327.53008704871, 31341.0, 31839.363212735614, 8326.875096873551, 8399.538025408661, 8500.27747641445, 8504.617292221865, 8523.65905363791, 4136.420901073852, 4186.497620285585, 4216.578342165821, 4219.156168766259, 4221.746695198298, 5254.290670759475, 5415.296011518478, 5443.237946687388, 5468.890622187534, 5487.451254874561, 950.2872845365976, 965.6861520006026, 979.8138353712772, 982.3712823792779, 989.0, 649.574528683713, 675.8242856857253, 676.736072931557, 679.2596070283316, 685.6194811879454, 10558.334122856482, 10691.518881650189, 10984.340939543654, 11104.44477776108, 11200.43997800123, 673.3603077076797, 679.7009315900988, 684.4250829303409, 685.6434653979902, 700.9018737376771, 5055.292259083732, 5083.72039537829, 5115.104856650071, 5182.041322355376, 5216.58267338612, 119009.0, 120800.0, 123639.0, 126097.73902261043, 126373.0, 106064.0, 108133.0, 112057.43971280092, 112321.43839280751, 113091.0, 93911.0, 96443.0, 96668.13327466823, 98337.50831245941, 99569.50215249023, 9540.761480963032, 9545.570449329936, 9550.474723890253, 9558.378705384128, 9619.374740641835, 43391.04740286758, 43757.12485750331, 44120.33819492646, 44143.0, 44950.77524612356, 57468.71265643645, 58250.0, 58334.708326458094, 58436.0, 58652.70673646775, 14284.214368209849, 14684.265786710408, 14690.55928322152, 14704.41182352694, 14735.852641473448, 15061.924690376478, 15097.924510377377, 15135.697286054437, 15186.696266074396, 15469.5359139226, 13506.729865402833, 13600.251986140856, 13777.104488208235, 13881.65295867571, 14023.36894839755, 13378.0, 13474.79787803164, 13604.183748975092, 13614.387352569356, 13798.93100534491, 13429.731405372033, 13597.796033059314, 13642.93178534101, 13665.658358541115, 13863.584092477242, 10987.285826421257, 11015.614453494089, 11095.611653592085, 11209.215354925076, 11353.48909299067, 10067.647632332833, 10080.546375412978, 10110.191184705352, 10162.74593135148, 10166.18670506343], "value": 8494.29509722824, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1463.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 112.0, 111.0, 111.0, 113.0, 122.0, 108.0, 118.0, 117.0, 119.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 115.0, 117.0, 118.0, 119.0, 118.0, 118.0, 118.0, 117.0, 120.0], "value": 119.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 169.0, 171.0, 162.0, 164.0, 179.0, 165.0, 174.0, 166.0, 176.0], "value": 169.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 83.0, 76.0, 75.0, 74.0, 74.0, 81.0, 85.0, 79.0], "value": 77.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 81.0, 80.0, 81.0, 79.0, 79.0, 80.0, 80.0, 86.0], "value": 81.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 114.0, 114.0, 111.0, 118.0, 115.0, 117.0, 114.0, 115.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 153.0, 152.0, 148.0, 151.0, 149.0, 148.0, 154.0, 149.0, 158.0], "value": 151.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 97.0, 94.0, 103.0, 95.0, 95.0, 97.0, 95.0, 96.0, 96.0], "value": 96.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 53.0, 54.0, 54.0, 56.0, 52.0, 52.0, 60.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 46.0, 40.0, 38.0, 38.0, 47.0, 38.0, 44.0, 38.0, 39.0], "value": 40.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 79.0, 76.0, 75.0, 84.0, 79.0, 78.0, 80.0, 84.0], "value": 79.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 114.0, 116.0, 118.0, 119.0, 128.0, 119.0, 120.0, 118.0, 114.0], "value": 119.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 173.0, 175.0, 179.0, 175.0, 171.0, 175.0, 182.0, 174.0, 179.0], "value": 175.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 76.0, 67.0, 66.0, 70.0, 72.0, 72.0, 69.0, 70.0, 66.0], "value": 69.6, "unit": "score"}]}]} 11:45:14 INFO - Return code: 0 11:45:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:45:14 INFO - # TBPL SUCCESS # 11:45:14 INFO - Running post-action listener: _package_coverage_data 11:45:14 INFO - Running post-action listener: _resource_record_post_action 11:45:14 INFO - [mozharness: 2017-09-15 18:45:14.230693Z] Finished run-tests step (success) 11:45:14 INFO - Running post-run listener: _resource_record_post_run 11:45:14 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 294912; Write bytes: 332787712; Read time: 236; Write time: 390792 11:45:14 INFO - TinderboxPrint: CPU usage
13.3% 11:45:14 INFO - TinderboxPrint: I/O read bytes / time
294,912 / 236 11:45:14 INFO - TinderboxPrint: I/O write bytes / time
332,787,712 / 390,792 11:45:14 INFO - TinderboxPrint: CPU idle
8,254.4 (86.7%) 11:45:14 INFO - TinderboxPrint: CPU user
1,203.6 (12.6%) 11:45:14 INFO - TinderboxPrint: Swap in / out
0 / 0 11:45:14 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 10412032; Read time: 0; Write time: 1988 11:45:14 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:45:14 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 290816; Write bytes: 322375680; Read time: 220; Write time: 388804 11:45:14 INFO - Running post-run listener: _upload_blobber_files 11:45:14 INFO - Blob upload gear active. 11:45:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:45:14 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 11:45:14 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:45:14 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:45:15 INFO - (blobuploader) - INFO - Open directory for files ... 11:45:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:45:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:16 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:45:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:16 INFO - (blobuploader) - INFO - Done attempting. 11:45:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:45:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:45:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:23 INFO - (blobuploader) - INFO - Done attempting. 11:45:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:45:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:45:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:24 INFO - (blobuploader) - INFO - Done attempting. 11:45:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:45:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:45:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:25 INFO - (blobuploader) - INFO - Done attempting. 11:45:25 INFO - (blobuploader) - INFO - Iteration through files over. 11:45:25 INFO - Return code: 0 11:45:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:45:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:45:25 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4dc9c0357a39cf2b080201ac73c8bd3f67c4c4ea3fa9291c36d30f510447da0a752366dfef2167203ef00633b8cb717d7f20841ac99d4ce1c8552584af56489f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b588dd65a1573a203dbd59385fc3b52db56c6416ed5bca4dd3e3cca2303d3818d8c558ffb3be3738f7a3c33eb1acefb2e95e2967a0bbce01883c112f847314b9", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e146e258e20e3bed960a0893c5ca57848961b68288b4bd69f7eed69efd8aadd4e98a4ac83f9fd51f40cb936825d217796d5dc61c65a87c926e8d75ca6f590e4", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68dae7ee7584e1b3edbdcadee7b8fe2768739c48565d1e000d8f54746e25945137a6931a313c627c28eeae8848ef265790506fdb2291e9b49c69e01bec9adc40"} 11:45:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:45:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:45:25 INFO - Contents: 11:45:25 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4dc9c0357a39cf2b080201ac73c8bd3f67c4c4ea3fa9291c36d30f510447da0a752366dfef2167203ef00633b8cb717d7f20841ac99d4ce1c8552584af56489f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b588dd65a1573a203dbd59385fc3b52db56c6416ed5bca4dd3e3cca2303d3818d8c558ffb3be3738f7a3c33eb1acefb2e95e2967a0bbce01883c112f847314b9", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e146e258e20e3bed960a0893c5ca57848961b68288b4bd69f7eed69efd8aadd4e98a4ac83f9fd51f40cb936825d217796d5dc61c65a87c926e8d75ca6f590e4", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68dae7ee7584e1b3edbdcadee7b8fe2768739c48565d1e000d8f54746e25945137a6931a313c627c28eeae8848ef265790506fdb2291e9b49c69e01bec9adc40"} 11:45:25 INFO - Running post-run listener: copy_logs_to_upload_dir 11:45:25 INFO - Copying logs to upload dir... 11:45:25 INFO - mkdir: /builds/slave/test/build/upload/logs 11:45:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.572628 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-09-15 11:45:25.977948) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-15 11:45:25.986147) ========= 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=5bd038846534b2fdfa68eeae000001e2-1505493361.299680-1570690761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4dc9c0357a39cf2b080201ac73c8bd3f67c4c4ea3fa9291c36d30f510447da0a752366dfef2167203ef00633b8cb717d7f20841ac99d4ce1c8552584af56489f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b588dd65a1573a203dbd59385fc3b52db56c6416ed5bca4dd3e3cca2303d3818d8c558ffb3be3738f7a3c33eb1acefb2e95e2967a0bbce01883c112f847314b9", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e146e258e20e3bed960a0893c5ca57848961b68288b4bd69f7eed69efd8aadd4e98a4ac83f9fd51f40cb936825d217796d5dc61c65a87c926e8d75ca6f590e4", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68dae7ee7584e1b3edbdcadee7b8fe2768739c48565d1e000d8f54746e25945137a6931a313c627c28eeae8848ef265790506fdb2291e9b49c69e01bec9adc40"} build_url:https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011355 build_url: 'https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4dc9c0357a39cf2b080201ac73c8bd3f67c4c4ea3fa9291c36d30f510447da0a752366dfef2167203ef00633b8cb717d7f20841ac99d4ce1c8552584af56489f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b588dd65a1573a203dbd59385fc3b52db56c6416ed5bca4dd3e3cca2303d3818d8c558ffb3be3738f7a3c33eb1acefb2e95e2967a0bbce01883c112f847314b9", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e146e258e20e3bed960a0893c5ca57848961b68288b4bd69f7eed69efd8aadd4e98a4ac83f9fd51f40cb936825d217796d5dc61c65a87c926e8d75ca6f590e4", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68dae7ee7584e1b3edbdcadee7b8fe2768739c48565d1e000d8f54746e25945137a6931a313c627c28eeae8848ef265790506fdb2291e9b49c69e01bec9adc40"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-15 11:45:26.016333) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 11:45:26.016643) ========= 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=5bd038846534b2fdfa68eeae000001e2-1505493361.299680-1570690761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004502 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 11:45:26.101199) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-15 11:45:26.101506) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-15 11:45:26.101808) ========= ========= Total master_lag: 0.27 =========