builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-055 starttime: 1501485620.46 results: success (0) revision: a6c502679d442596b8b4410d6413cd310ac46408 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-31 00:20:20.463199) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-31 00:20:20.463649) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-31 00:20:20.463922) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-31 00:20:20.479847) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 00:20:20.480175) ========= 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=bb9b54edd4a927dc735d112f000001d9-1501477576.126492-1966430490 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-31 00:20:20-- 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% 42.4M=0s 2017-07-31 00:20:20 (42.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.129348 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 00:20:20.622538) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 00:20:20.622825) ========= 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=bb9b54edd4a927dc735d112f000001d9-1501477576.126492-1966430490 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020619 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 00:20:20.672729) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-31 00:20:20.673082) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a6c502679d442596b8b4410d6413cd310ac46408 --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 a6c502679d442596b8b4410d6413cd310ac46408 --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=bb9b54edd4a927dc735d112f000001d9-1501477576.126492-1966430490 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-31 00:20:20,880 truncating revision to first 12 chars 2017-07-31 00:20:20,881 Setting DEBUG logging. 2017-07-31 00:20:20,881 attempt 1/10 2017-07-31 00:20:20,881 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a6c502679d44?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-31 00:20:22,352 unpacking tar archive at: mozilla-central-a6c502679d44/testing/mozharness/ program finished with exit code 0 elapsedTime=1.782118 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-31 00:20:22.472714) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-31 00:20:22.473000) ========= script_repo_revision: a6c502679d442596b8b4410d6413cd310ac46408 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-31 00:20:22.473425) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-31 00:20:22.474000) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-31 00:20:22.482664) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-07-31 00:20:22.483063) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=bb9b54edd4a927dc735d112f000001d9-1501477576.126492-1966430490 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:20:22 INFO - MultiFileLogger online at 20170731 00:20:22 in /builds/slave/test 00:20:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 00:20:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:20:22 INFO - {'append_to_log': False, 00:20:22 INFO - 'base_work_dir': '/builds/slave/test', 00:20:22 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 00:20:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:20:22 INFO - 'branch': 'Firefox-Non-PGO', 00:20:22 INFO - 'buildbot_json_path': 'buildprops.json', 00:20:22 INFO - 'code_coverage': False, 00:20:22 INFO - 'config_files': ('talos/linux_config.py',), 00:20:22 INFO - 'default_actions': ('clobber', 00:20:22 INFO - 'read-buildbot-config', 00:20:22 INFO - 'download-and-extract', 00:20:22 INFO - 'populate-webroot', 00:20:22 INFO - 'create-virtualenv', 00:20:22 INFO - 'install', 00:20:22 INFO - 'setup-mitmproxy', 00:20:22 INFO - 'run-tests'), 00:20:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:20:22 INFO - 'disable_ccov_upload': False, 00:20:22 INFO - 'download_minidump_stackwalk': True, 00:20:22 INFO - 'download_symbols': 'ondemand', 00:20:22 INFO - 'enable_stylo': False, 00:20:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:20:22 INFO - 'tooltool.py': '/tools/tooltool.py', 00:20:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:20:22 INFO - '/tools/misc-python/virtualenv.py')}, 00:20:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:20:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:20:22 INFO - 'gecko_profile': False, 00:20:22 INFO - 'gecko_profile_interval': 0, 00:20:22 INFO - 'installer_path': 'installer.exe', 00:20:22 INFO - 'log_level': 'info', 00:20:22 INFO - 'log_name': 'talos', 00:20:22 INFO - 'log_to_console': True, 00:20:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:20:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:20:22 INFO - 'opt_config_files': (), 00:20:22 INFO - 'pip_index': False, 00:20:22 INFO - 'suite': 'dromaeojs-e10s', 00:20:22 INFO - 'system_bits': '32', 00:20:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:20:22 INFO - 'title': 'talos-linux64-ix-055', 00:20:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:20:22 INFO - 'use_talos_json': True, 00:20:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:20:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:20:22 INFO - 'work_dir': 'build'} 00:20:22 INFO - [mozharness: 2017-07-31 07:20:22.794452Z] Running clobber step. 00:20:22 INFO - Running pre-action listener: _resource_record_pre_action 00:20:22 INFO - Running main action method: clobber 00:20:22 INFO - rmtree: /builds/slave/test/build 00:20:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:20:24 INFO - Running post-action listener: _resource_record_post_action 00:20:24 INFO - [mozharness: 2017-07-31 07:20:24.327321Z] Finished clobber step (success) 00:20:24 INFO - [mozharness: 2017-07-31 07:20:24.327423Z] Running read-buildbot-config step. 00:20:24 INFO - Running pre-action listener: _resource_record_pre_action 00:20:24 INFO - Running main action method: read_buildbot_config 00:20:24 INFO - Using buildbot properties: 00:20:24 INFO - { 00:20:24 INFO - "project": "", 00:20:24 INFO - "product": "firefox", 00:20:24 INFO - "who": "rstrong@mozilla.com", 00:20:24 INFO - "installer_path": "public/build/target.tar.bz2", 00:20:24 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 00:20:24 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 00:20:24 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 00:20:24 INFO - "stage_platform": "linux64", 00:20:24 INFO - "basedir": "/builds/slave/test", 00:20:24 INFO - "buildnumber": 1046, 00:20:24 INFO - "platform": "ubuntu64_hw", 00:20:24 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 00:20:24 INFO - "slavebuilddir": "test", 00:20:24 INFO - "taskId": "LhvKVwUFQBe621R58416yA", 00:20:24 INFO - "branch": "mozilla-central", 00:20:24 INFO - "script_repo_revision": "production", 00:20:24 INFO - "revision": "a6c502679d442596b8b4410d6413cd310ac46408", 00:20:24 INFO - "slavename": "talos-linux64-ix-055", 00:20:24 INFO - "repo_path": "mozilla-central" 00:20:24 INFO - } 00:20:24 INFO - Finding installer, test and symbols from parent task. 00:20:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LhvKVwUFQBe621R58416yA'}, attempt #1 00:20:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LhvKVwUFQBe621R58416yA'}, attempt #1 00:20:25 INFO - Task dependencies: JacXY8NJTua8V_2O70iG6g 00:20:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JacXY8NJTua8V_2O70iG6g'}, attempt #1 00:20:25 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/JacXY8NJTua8V_2O70iG6g/artifacts/public/build/target.tar.bz2 00:20:25 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/JacXY8NJTua8V_2O70iG6g/artifacts/public/build/target.test_packages.json 00:20:25 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/JacXY8NJTua8V_2O70iG6g/artifacts/public/build/target.crashreporter-symbols.zip 00:20:25 INFO - Running post-action listener: _resource_record_post_action 00:20:25 INFO - [mozharness: 2017-07-31 07:20:25.717987Z] Finished read-buildbot-config step (success) 00:20:25 INFO - [mozharness: 2017-07-31 07:20:25.718299Z] Running download-and-extract step. 00:20:25 INFO - Running pre-action listener: _resource_record_pre_action 00:20:25 INFO - Running main action method: download_and_extract 00:20:25 INFO - mkdir: /builds/slave/test/build/tests 00:20:25 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')]} 00:20:25 INFO - trying https://queue.taskcluster.net/v1/task/JacXY8NJTua8V_2O70iG6g/artifacts/public/build/target.test_packages.json 00:20:25 INFO - Downloading https://queue.taskcluster.net/v1/task/JacXY8NJTua8V_2O70iG6g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 00:20:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JacXY8NJTua8V_2O70iG6g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 00:20:26 INFO - Downloaded 989 bytes. 00:20:26 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 00:20:26 INFO - Using the following test package requirements: 00:20:26 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 00:20:26 INFO - u'common': [u'target.common.tests.zip'], 00:20:26 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 00:20:26 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 00:20:26 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 00:20:26 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 00:20:26 INFO - u'mozbase': [u'target.common.tests.zip'], 00:20:26 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 00:20:26 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 00:20:26 INFO - u'web-platform': [u'target.common.tests.zip', 00:20:26 INFO - u'target.web-platform.tests.tar.gz'], 00:20:26 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 00:20:26 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 00:20:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JacXY8NJTua8V_2O70iG6g/artifacts/public/build/target.common.tests.zip 00:20:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JacXY8NJTua8V_2O70iG6g/artifacts/public/build/target.common.tests.zip'}, attempt #1 00:20:26 INFO - Fetch https://queue.taskcluster.net/v1/task/JacXY8NJTua8V_2O70iG6g/artifacts/public/build/target.common.tests.zip into memory 00:20:28 INFO - Content-Length response header: 72592484 00:20:28 INFO - Bytes received: 72592484 00:20:39 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 00:20:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JacXY8NJTua8V_2O70iG6g/artifacts/public/build/target.common.tests.zip 00:20:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JacXY8NJTua8V_2O70iG6g/artifacts/public/build/target.common.tests.zip'}, attempt #1 00:20:39 INFO - Fetch https://queue.taskcluster.net/v1/task/JacXY8NJTua8V_2O70iG6g/artifacts/public/build/target.common.tests.zip into memory 00:20:41 INFO - Content-Length response header: 72592484 00:20:41 INFO - Bytes received: 72592484 00:20:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JacXY8NJTua8V_2O70iG6g/artifacts/public/build/target.talos.tests.zip 00:20:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JacXY8NJTua8V_2O70iG6g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 00:20:55 INFO - Fetch https://queue.taskcluster.net/v1/task/JacXY8NJTua8V_2O70iG6g/artifacts/public/build/target.talos.tests.zip into memory 00:20:56 INFO - Content-Length response header: 14496686 00:20:56 INFO - Bytes received: 14496686 00:20: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')]} 00:20:56 INFO - trying https://queue.taskcluster.net/v1/task/JacXY8NJTua8V_2O70iG6g/artifacts/public/build/target.tar.bz2 00:20:56 INFO - Downloading https://queue.taskcluster.net/v1/task/JacXY8NJTua8V_2O70iG6g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 00:20:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JacXY8NJTua8V_2O70iG6g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 00:20:57 INFO - Downloaded 62196477 bytes. 00:20:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JacXY8NJTua8V_2O70iG6g/artifacts/public/build/target.tar.bz2 00:20:57 INFO - mkdir: /builds/slave/test/properties 00:20:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:20:57 INFO - Writing to file /builds/slave/test/properties/build_url 00:20:57 INFO - Contents: 00:20:57 INFO - build_url:https://queue.taskcluster.net/v1/task/JacXY8NJTua8V_2O70iG6g/artifacts/public/build/target.tar.bz2 00:20:57 INFO - Running post-action listener: _resource_record_post_action 00:20:57 INFO - Running post-action listener: set_extra_try_arguments 00:20:57 INFO - [mozharness: 2017-07-31 07:20:57.905962Z] Finished download-and-extract step (success) 00:20:57 INFO - [mozharness: 2017-07-31 07:20:57.906060Z] Running populate-webroot step. 00:20:57 INFO - Running pre-action listener: _resource_record_pre_action 00:20:57 INFO - Running main action method: populate_webroot 00:20:57 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:20:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:20:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 00:20:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:20:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 00:20:57 INFO - 'tests': ['damp', 'tps']}, 00:20:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:20:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 00:20:57 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 00:20:57 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 00:20:57 INFO - 'other-e10s': {'tests': ['a11yr', 00:20:57 INFO - 'ts_paint', 00:20:57 INFO - 'tpaint', 00:20:57 INFO - 'sessionrestore', 00:20:57 INFO - 'sessionrestore_many_windows', 00:20:57 INFO - 'sessionrestore_no_auto_restore', 00:20:57 INFO - 'tabpaint']}, 00:20:57 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 00:20:57 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 00:20:57 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 00:20:57 INFO - 'talos_options': ['--mitmproxy', 00:20:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 00:20:57 INFO - '--firstNonBlankPaint'], 00:20:57 INFO - 'tests': ['quantum_pageload_google', 00:20:57 INFO - 'quantum_pageload_youtube', 00:20:57 INFO - 'quantum_pageload_amazon', 00:20:57 INFO - 'quantum_pageload_facebook']}, 00:20:57 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 00:20:57 INFO - 'talos_options': ['--stylo', 00:20:57 INFO - '--mitmproxy', 00:20:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 00:20:57 INFO - '--firstNonBlankPaint'], 00:20:57 INFO - 'tests': ['quantum_pageload_google', 00:20:57 INFO - 'quantum_pageload_youtube', 00:20:57 INFO - 'quantum_pageload_amazon', 00:20:57 INFO - 'quantum_pageload_facebook']}, 00:20:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:20:57 INFO - 'tsvgr_opacity', 00:20:57 INFO - 'tart', 00:20:57 INFO - 'tscrollx', 00:20:57 INFO - 'cart', 00:20:57 INFO - 'tsvg_static']}, 00:20:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 00:20:57 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 00:20:57 INFO - 'talos_options': ['--stylo', 00:20:57 INFO - '--stylo-threads=1', 00:20:57 INFO - '--mitmproxy', 00:20:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 00:20:57 INFO - '--firstNonBlankPaint'], 00:20:57 INFO - 'tests': ['tp6_google', 00:20:57 INFO - 'tp6_youtube', 00:20:57 INFO - 'tp6_amazon', 00:20:57 INFO - 'tp6_facebook']}, 00:20:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 00:20:57 INFO - 'talos_options': ['--xperf_path', 00:20:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:20:57 INFO - 'tests': ['tp5n']}}} 00:20:57 INFO - Running post-action listener: _resource_record_post_action 00:20:57 INFO - [mozharness: 2017-07-31 07:20:57.914760Z] Finished populate-webroot step (success) 00:20:57 INFO - [mozharness: 2017-07-31 07:20:57.914851Z] Running create-virtualenv step. 00:20:57 INFO - Running pre-action listener: _resource_record_pre_action 00:20:57 INFO - Running main action method: create_virtualenv 00:20:57 INFO - Creating virtualenv /builds/slave/test/build/venv 00:20:57 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 00:20:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:20:57 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 00:20:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:20:58 INFO - Using real prefix '/usr' 00:20:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:20:58 INFO - Installing distribute.............................................................................................................................................................................................done. 00:21:00 INFO - Installing pip.................done. 00:21:00 INFO - Return code: 0 00:21:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:21:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:21:00 INFO - Reading from file tmpfile_stdout 00:21:00 INFO - Output received: 00:21:00 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 00:21:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:21: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')]} 00:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:21: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')]} 00:21:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:21: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217ceb0>, '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 0x217ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217e240>, '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': 'bb9b54edd4a927dc735d112f000001d9-1501477576.126492-1966430490', '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 00:21: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', 'pip>=1.5'] in /builds/slave/test/build 00:21: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 pip>=1.5 00:21:00 INFO - Using env: {'DISPLAY': ':0', 00:21:00 INFO - 'HOME': '/home/cltbld', 00:21:00 INFO - 'LANG': 'en_US.UTF-8', 00:21:00 INFO - 'LANGUAGE': 'en_US:en', 00:21:00 INFO - 'LOGNAME': 'cltbld', 00:21:00 INFO - 'MAIL': '/var/mail/cltbld', 00:21:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:21:00 INFO - 'MOZ_NO_REMOTE': '1', 00:21:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:21:00 INFO - 'NO_EM_RESTART': '1', 00:21:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:21:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:21:00 INFO - 'PWD': '/builds/slave/test', 00:21:00 INFO - 'SHELL': '/bin/bash', 00:21:00 INFO - 'SHLVL': '1', 00:21:00 INFO - 'TERM': 'linux', 00:21:00 INFO - 'TMOUT': '86400', 00:21:00 INFO - 'USER': 'cltbld', 00:21:00 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1501477576.126492-1966430490', 00:21:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:21:00 INFO - '_': '/tools/buildbot/bin/python'} 00:21:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 00:21:00 INFO - Cleaning up... 00:21:00 INFO - Return code: 0 00:21:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:21: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')]} 00:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:21: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')]} 00:21:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:21: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', '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 0x1e0f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217ceb0>, '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 0x217ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217e240>, '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': 'bb9b54edd4a927dc735d112f000001d9-1501477576.126492-1966430490', '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 00:21: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', 'psutil>=3.1.1'] in /builds/slave/test/build 00:21: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 psutil>=3.1.1 00:21:00 INFO - Using env: {'DISPLAY': ':0', 00:21:00 INFO - 'HOME': '/home/cltbld', 00:21:00 INFO - 'LANG': 'en_US.UTF-8', 00:21:00 INFO - 'LANGUAGE': 'en_US:en', 00:21:00 INFO - 'LOGNAME': 'cltbld', 00:21:00 INFO - 'MAIL': '/var/mail/cltbld', 00:21:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:21:00 INFO - 'MOZ_NO_REMOTE': '1', 00:21:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:21:00 INFO - 'NO_EM_RESTART': '1', 00:21:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:21:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:21:00 INFO - 'PWD': '/builds/slave/test', 00:21:00 INFO - 'SHELL': '/bin/bash', 00:21:00 INFO - 'SHLVL': '1', 00:21:00 INFO - 'TERM': 'linux', 00:21:00 INFO - 'TMOUT': '86400', 00:21:00 INFO - 'USER': 'cltbld', 00:21:00 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1501477576.126492-1966430490', 00:21:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:21:00 INFO - '_': '/tools/buildbot/bin/python'} 00:21:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:21:01 INFO - Downloading/unpacking psutil>=3.1.1 00:21:01 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 00:21:01 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 00:21:01 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 00:21:01 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 00:21:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:21:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:21:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:21:02 INFO - Installing collected packages: psutil 00:21:02 INFO - Running setup.py install for psutil 00:21:02 INFO - building 'psutil._psutil_linux' extension 00:21:02 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 00:21:02 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 00:21:02 INFO - building 'psutil._psutil_posix' extension 00:21:02 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 00:21:02 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 00:21:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:21:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:21:02 INFO - Successfully installed psutil 00:21:02 INFO - Cleaning up... 00:21:02 INFO - Return code: 0 00:21:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:21: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')]} 00:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:21: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')]} 00:21:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:21:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217ceb0>, '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 0x217ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217e240>, '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': 'bb9b54edd4a927dc735d112f000001d9-1501477576.126492-1966430490', '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 00:21:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 00:21:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 00:21:02 INFO - Using env: {'DISPLAY': ':0', 00:21:02 INFO - 'HOME': '/home/cltbld', 00:21:02 INFO - 'LANG': 'en_US.UTF-8', 00:21:02 INFO - 'LANGUAGE': 'en_US:en', 00:21:02 INFO - 'LOGNAME': 'cltbld', 00:21:02 INFO - 'MAIL': '/var/mail/cltbld', 00:21:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:21:02 INFO - 'MOZ_NO_REMOTE': '1', 00:21:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:21:02 INFO - 'NO_EM_RESTART': '1', 00:21:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:21:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:21:02 INFO - 'PWD': '/builds/slave/test', 00:21:02 INFO - 'SHELL': '/bin/bash', 00:21:02 INFO - 'SHLVL': '1', 00:21:02 INFO - 'TERM': 'linux', 00:21:02 INFO - 'TMOUT': '86400', 00:21:02 INFO - 'USER': 'cltbld', 00:21:02 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1501477576.126492-1966430490', 00:21:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:21:02 INFO - '_': '/tools/buildbot/bin/python'} 00:21:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:21:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:21:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:21:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:21:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:21:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:21:04 INFO - Installing collected packages: mozsystemmonitor 00:21:04 INFO - Running setup.py install for mozsystemmonitor 00:21:04 INFO - Successfully installed mozsystemmonitor 00:21:04 INFO - Cleaning up... 00:21:04 INFO - Return code: 0 00:21:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:21:04 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')]} 00:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:21:04 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')]} 00:21:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:21:04 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 0x1e0f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217ceb0>, '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 0x217ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217e240>, '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': 'bb9b54edd4a927dc735d112f000001d9-1501477576.126492-1966430490', '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 00:21:04 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 00:21:04 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 00:21:04 INFO - Using env: {'DISPLAY': ':0', 00:21:04 INFO - 'HOME': '/home/cltbld', 00:21:04 INFO - 'LANG': 'en_US.UTF-8', 00:21:04 INFO - 'LANGUAGE': 'en_US:en', 00:21:04 INFO - 'LOGNAME': 'cltbld', 00:21:04 INFO - 'MAIL': '/var/mail/cltbld', 00:21:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:21:04 INFO - 'MOZ_NO_REMOTE': '1', 00:21:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:21:04 INFO - 'NO_EM_RESTART': '1', 00:21:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:21:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:21:04 INFO - 'PWD': '/builds/slave/test', 00:21:04 INFO - 'SHELL': '/bin/bash', 00:21:04 INFO - 'SHLVL': '1', 00:21:04 INFO - 'TERM': 'linux', 00:21:04 INFO - 'TMOUT': '86400', 00:21:04 INFO - 'USER': 'cltbld', 00:21:04 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1501477576.126492-1966430490', 00:21:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:21:04 INFO - '_': '/tools/buildbot/bin/python'} 00:21:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:21:04 INFO - Downloading/unpacking jsonschema==2.5.1 00:21: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 00:21: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 00:21: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 00:21: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 00:21:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:21:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:21:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:21:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:21:05 INFO - Downloading functools32-3.2.3-2.tar.gz 00:21:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:21:05 INFO - warning: no files found matching '*.txt' 00:21:05 INFO - no previously-included directories found matching 'build' 00:21:05 INFO - no previously-included directories found matching 'dist' 00:21:05 INFO - no previously-included directories found matching '.git*' 00:21:05 INFO - Installing collected packages: jsonschema, functools32 00:21:05 INFO - Running setup.py install for functools32 00:21:05 INFO - warning: no files found matching '*.txt' 00:21:05 INFO - no previously-included directories found matching 'build' 00:21:05 INFO - no previously-included directories found matching 'dist' 00:21:05 INFO - no previously-included directories found matching '.git*' 00:21:05 INFO - Successfully installed jsonschema functools32 00:21:05 INFO - Cleaning up... 00:21:06 INFO - Return code: 0 00:21:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:21: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')]} 00:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:21: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')]} 00:21:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:21: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 0x1e0f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217ceb0>, '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 0x217ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217e240>, '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': 'bb9b54edd4a927dc735d112f000001d9-1501477576.126492-1966430490', '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 00:21: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 00:21: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 00:21:06 INFO - Using env: {'DISPLAY': ':0', 00:21:06 INFO - 'HOME': '/home/cltbld', 00:21:06 INFO - 'LANG': 'en_US.UTF-8', 00:21:06 INFO - 'LANGUAGE': 'en_US:en', 00:21:06 INFO - 'LOGNAME': 'cltbld', 00:21:06 INFO - 'MAIL': '/var/mail/cltbld', 00:21:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:21:06 INFO - 'MOZ_NO_REMOTE': '1', 00:21:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:21:06 INFO - 'NO_EM_RESTART': '1', 00:21:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:21:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:21:06 INFO - 'PWD': '/builds/slave/test', 00:21:06 INFO - 'SHELL': '/bin/bash', 00:21:06 INFO - 'SHLVL': '1', 00:21:06 INFO - 'TERM': 'linux', 00:21:06 INFO - 'TMOUT': '86400', 00:21:06 INFO - 'USER': 'cltbld', 00:21:06 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1501477576.126492-1966430490', 00:21:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:21:06 INFO - '_': '/tools/buildbot/bin/python'} 00:21:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:21:06 INFO - Cleaning up... 00:21:06 INFO - Return code: 0 00:21:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:21: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')]} 00:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:21: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')]} 00:21:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:21: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', '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 0x1e0f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217ceb0>, '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 0x217ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217e240>, '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': 'bb9b54edd4a927dc735d112f000001d9-1501477576.126492-1966430490', '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 00:21: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:21: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 blobuploader==1.2.4 00:21:06 INFO - Using env: {'DISPLAY': ':0', 00:21:06 INFO - 'HOME': '/home/cltbld', 00:21:06 INFO - 'LANG': 'en_US.UTF-8', 00:21:06 INFO - 'LANGUAGE': 'en_US:en', 00:21:06 INFO - 'LOGNAME': 'cltbld', 00:21:06 INFO - 'MAIL': '/var/mail/cltbld', 00:21:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:21:06 INFO - 'MOZ_NO_REMOTE': '1', 00:21:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:21:06 INFO - 'NO_EM_RESTART': '1', 00:21:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:21:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:21:06 INFO - 'PWD': '/builds/slave/test', 00:21:06 INFO - 'SHELL': '/bin/bash', 00:21:06 INFO - 'SHLVL': '1', 00:21:06 INFO - 'TERM': 'linux', 00:21:06 INFO - 'TMOUT': '86400', 00:21:06 INFO - 'USER': 'cltbld', 00:21:06 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1501477576.126492-1966430490', 00:21:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:21:06 INFO - '_': '/tools/buildbot/bin/python'} 00:21:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:21:06 INFO - Downloading/unpacking blobuploader==1.2.4 00:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:21:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:21:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:21:07 INFO - Downloading blobuploader-1.2.4.tar.gz 00:21:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:21:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:21: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 00:21: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 00:21: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 00:21: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 00:21:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:21:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:21: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 00:21: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 00:21: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 00:21: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 00:21:08 INFO - Downloading docopt-0.6.1.tar.gz 00:21:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:21:08 INFO - Installing collected packages: blobuploader, requests, docopt 00:21:08 INFO - Running setup.py install for blobuploader 00:21:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:21:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:21:08 INFO - Running setup.py install for requests 00:21:08 INFO - Running setup.py install for docopt 00:21:08 INFO - Successfully installed blobuploader requests docopt 00:21:08 INFO - Cleaning up... 00:21:08 INFO - Return code: 0 00:21:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:21:08 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')]} 00:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:21:08 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')]} 00:21:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:21:08 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 0x1e0f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217ceb0>, '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 0x217ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217e240>, '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': 'bb9b54edd4a927dc735d112f000001d9-1501477576.126492-1966430490', '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 00:21:08 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 00:21:08 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 00:21:08 INFO - Using env: {'DISPLAY': ':0', 00:21:08 INFO - 'HOME': '/home/cltbld', 00:21:08 INFO - 'LANG': 'en_US.UTF-8', 00:21:08 INFO - 'LANGUAGE': 'en_US:en', 00:21:08 INFO - 'LOGNAME': 'cltbld', 00:21:08 INFO - 'MAIL': '/var/mail/cltbld', 00:21:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:21:08 INFO - 'MOZ_NO_REMOTE': '1', 00:21:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:21:08 INFO - 'NO_EM_RESTART': '1', 00:21:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:21:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:21:08 INFO - 'PWD': '/builds/slave/test', 00:21:08 INFO - 'SHELL': '/bin/bash', 00:21:08 INFO - 'SHLVL': '1', 00:21:08 INFO - 'TERM': 'linux', 00:21:08 INFO - 'TMOUT': '86400', 00:21:08 INFO - 'USER': 'cltbld', 00:21:08 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1501477576.126492-1966430490', 00:21:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:21:08 INFO - '_': '/tools/buildbot/bin/python'} 00:21:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:21:08 INFO - Running setup.py (path:/tmp/pip-oKFvjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:21:09 INFO - Running setup.py (path:/tmp/pip-4GjSTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:21:09 INFO - Running setup.py (path:/tmp/pip-8lh_Ss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:21:09 INFO - Running setup.py (path:/tmp/pip-mU_neh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:21:09 INFO - Running setup.py (path:/tmp/pip-2fYd0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:21:09 INFO - Running setup.py (path:/tmp/pip-xXACCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:21:09 INFO - Running setup.py (path:/tmp/pip-iyThsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:21:09 INFO - Running setup.py (path:/tmp/pip-KAtV1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:21:09 INFO - Running setup.py (path:/tmp/pip-ugdWsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:21:09 INFO - Running setup.py (path:/tmp/pip-wljN2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:21:09 INFO - Running setup.py (path:/tmp/pip-Us4DfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:21:09 INFO - Running setup.py (path:/tmp/pip-QisDo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:21:09 INFO - Running setup.py (path:/tmp/pip-L7uh1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:21:09 INFO - Running setup.py (path:/tmp/pip-TWzIQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:21:09 INFO - Running setup.py (path:/tmp/pip-RHofio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:21:10 INFO - Running setup.py (path:/tmp/pip-EM_rNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:21:10 INFO - Running setup.py (path:/tmp/pip-SEKEDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:21:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:21:10 INFO - Running setup.py install for manifestparser 00:21:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:21:10 INFO - Running setup.py install for mozcrash 00:21:10 INFO - Running setup.py install for mozdebug 00:21:10 INFO - Running setup.py install for mozdevice 00:21:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:21:10 INFO - Running setup.py install for mozfile 00:21:10 INFO - Running setup.py install for mozhttpd 00:21:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:21:10 INFO - Running setup.py install for mozinfo 00:21:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:21:10 INFO - Running setup.py install for mozInstall 00:21:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:21:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:21:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:21:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:21:10 INFO - Running setup.py install for mozleak 00:21:11 INFO - Running setup.py install for mozlog 00:21:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:21:11 INFO - Running setup.py install for moznetwork 00:21:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:21:11 INFO - Running setup.py install for mozprocess 00:21:11 INFO - Running setup.py install for mozprofile 00:21:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:21:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:21:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:21:11 INFO - Running setup.py install for mozrunner 00:21:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:21:11 INFO - Running setup.py install for mozscreenshot 00:21:11 INFO - Running setup.py install for moztest 00:21:11 INFO - Running setup.py install for mozversion 00:21:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:21:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:21:11 INFO - Cleaning up... 00:21:11 INFO - Return code: 0 00:21:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:21:11 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')]} 00:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:21:11 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')]} 00:21:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:21:11 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 0x1e0f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217ceb0>, '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 0x217ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217e240>, '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': 'bb9b54edd4a927dc735d112f000001d9-1501477576.126492-1966430490', '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 00:21:11 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 00:21:11 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 00:21:11 INFO - Using env: {'DISPLAY': ':0', 00:21:11 INFO - 'HOME': '/home/cltbld', 00:21:11 INFO - 'LANG': 'en_US.UTF-8', 00:21:11 INFO - 'LANGUAGE': 'en_US:en', 00:21:11 INFO - 'LOGNAME': 'cltbld', 00:21:11 INFO - 'MAIL': '/var/mail/cltbld', 00:21:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:21:11 INFO - 'MOZ_NO_REMOTE': '1', 00:21:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:21:11 INFO - 'NO_EM_RESTART': '1', 00:21:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:21:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:21:11 INFO - 'PWD': '/builds/slave/test', 00:21:11 INFO - 'SHELL': '/bin/bash', 00:21:11 INFO - 'SHLVL': '1', 00:21:11 INFO - 'TERM': 'linux', 00:21:11 INFO - 'TMOUT': '86400', 00:21:11 INFO - 'USER': 'cltbld', 00:21:11 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1501477576.126492-1966430490', 00:21:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:21:11 INFO - '_': '/tools/buildbot/bin/python'} 00:21:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:21:12 INFO - Running setup.py (path:/tmp/pip-Y9AmS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 00:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:21:12 INFO - Running setup.py (path:/tmp/pip-vsja6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:21:12 INFO - Running setup.py (path:/tmp/pip-0qE0Hs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 00:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:21:12 INFO - Running setup.py (path:/tmp/pip-Ic28o5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:21:12 INFO - Running setup.py (path:/tmp/pip-6XNfwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 00:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:21:12 INFO - Running setup.py (path:/tmp/pip-FdVjKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 00:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:21:12 INFO - Running setup.py (path:/tmp/pip-r3G69W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 00:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:21:12 INFO - Running setup.py (path:/tmp/pip-HtofV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:21:12 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)) 00:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:21:12 INFO - Running setup.py (path:/tmp/pip-LSEksS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:21:12 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)) 00:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:21:12 INFO - Running setup.py (path:/tmp/pip-Xn3N_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:21:12 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)) 00:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:21:12 INFO - Running setup.py (path:/tmp/pip-MloWrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:21:12 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)) 00:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:21:12 INFO - Running setup.py (path:/tmp/pip-RDP2rT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:21: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)) 00:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:21:13 INFO - Running setup.py (path:/tmp/pip-VAlvnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:21: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)) 00:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:21:13 INFO - Running setup.py (path:/tmp/pip-8_l5Ty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 00:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:21:13 INFO - Running setup.py (path:/tmp/pip-P38X1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 00:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:21:13 INFO - Running setup.py (path:/tmp/pip-ED_ers-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 00:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:21:13 INFO - Running setup.py (path:/tmp/pip-2BLSQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 00:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 00:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 00:21:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:21:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:21:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:21:14 INFO - Downloading blessings-1.6.tar.gz 00:21:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:21:14 INFO - Installing collected packages: blessings 00:21:14 INFO - Running setup.py install for blessings 00:21:14 INFO - Successfully installed blessings 00:21:14 INFO - Cleaning up... 00:21:14 INFO - Return code: 0 00:21:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:21:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:21:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:21:14 INFO - Reading from file tmpfile_stdout 00:21:14 INFO - Current package versions: 00:21:14 INFO - argparse == 1.2.1 00:21:14 INFO - blessings == 1.6 00:21:14 INFO - blobuploader == 1.2.4 00:21:14 INFO - docopt == 0.6.1 00:21:14 INFO - functools32 == 3.2.3-2 00:21:14 INFO - jsonschema == 2.5.1 00:21:14 INFO - manifestparser == 1.1 00:21:14 INFO - mozInstall == 1.13 00:21:14 INFO - mozcrash == 1.0 00:21:14 INFO - mozdebug == 0.1 00:21:14 INFO - mozdevice == 0.51 00:21:14 INFO - mozfile == 1.2 00:21:14 INFO - mozhttpd == 0.7 00:21:14 INFO - mozinfo == 0.10 00:21:14 INFO - mozleak == 0.1 00:21:14 INFO - mozlog == 3.5 00:21:14 INFO - moznetwork == 0.27 00:21:14 INFO - mozprocess == 0.25 00:21:14 INFO - mozprofile == 0.28 00:21:14 INFO - mozrunner == 6.13 00:21:14 INFO - mozscreenshot == 0.1 00:21:14 INFO - mozsystemmonitor == 0.3 00:21:14 INFO - moztest == 0.8 00:21:14 INFO - mozversion == 1.4 00:21:14 INFO - psutil == 3.1.1 00:21:14 INFO - requests == 1.2.3 00:21:14 INFO - wsgiref == 0.1.2 00:21:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:21:14 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')]} 00:21:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:21:14 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')]} 00:21:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:21:14 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 0x1e0f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217ceb0>, '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 0x217ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217e240>, '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': 'bb9b54edd4a927dc735d112f000001d9-1501477576.126492-1966430490', '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 00:21:14 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 00:21:14 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 00:21:14 INFO - Using env: {'DISPLAY': ':0', 00:21:14 INFO - 'HOME': '/home/cltbld', 00:21:14 INFO - 'LANG': 'en_US.UTF-8', 00:21:14 INFO - 'LANGUAGE': 'en_US:en', 00:21:14 INFO - 'LOGNAME': 'cltbld', 00:21:14 INFO - 'MAIL': '/var/mail/cltbld', 00:21:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:21:14 INFO - 'MOZ_NO_REMOTE': '1', 00:21:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:21:14 INFO - 'NO_EM_RESTART': '1', 00:21:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:21:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:21:14 INFO - 'PWD': '/builds/slave/test', 00:21:14 INFO - 'SHELL': '/bin/bash', 00:21:14 INFO - 'SHLVL': '1', 00:21:14 INFO - 'TERM': 'linux', 00:21:14 INFO - 'TMOUT': '86400', 00:21:14 INFO - 'USER': 'cltbld', 00:21:14 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1501477576.126492-1966430490', 00:21:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:21:14 INFO - '_': '/tools/buildbot/bin/python'} 00:21:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:21:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 00:21:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 00:21:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 00:21:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 00:21:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 00:21:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 00:21:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 00:21:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 00:21:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 00:21:15 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 00:21:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:21:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:21:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:21:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:21:16 INFO - Downloading marionette_driver-1.4.0.tar.gz 00:21:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 00:21:16 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 00:21: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 00:21: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 00:21: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 00:21: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 00:21:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 00:21:16 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 00:21:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 00:21:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 00:21:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 00:21:16 INFO - Installing collected packages: marionette-driver, simplejson 00:21:16 INFO - Running setup.py install for marionette-driver 00:21:16 INFO - Running setup.py install for simplejson 00:21:16 INFO - building 'simplejson._speedups' extension 00:21:16 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 00:21:17 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 00:21:17 INFO - Successfully installed marionette-driver simplejson 00:21:17 INFO - Cleaning up... 00:21:17 INFO - Return code: 0 00:21:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:21:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:21:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:21:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:21:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:21:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217ceb0>, '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 0x217ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217e240>, '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': 'bb9b54edd4a927dc735d112f000001d9-1501477576.126492-1966430490', '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 00:21:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 00:21:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:21:17 INFO - Using env: {'DISPLAY': ':0', 00:21:17 INFO - 'HOME': '/home/cltbld', 00:21:17 INFO - 'LANG': 'en_US.UTF-8', 00:21:17 INFO - 'LANGUAGE': 'en_US:en', 00:21:17 INFO - 'LOGNAME': 'cltbld', 00:21:17 INFO - 'MAIL': '/var/mail/cltbld', 00:21:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:21:17 INFO - 'MOZ_NO_REMOTE': '1', 00:21:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:21:17 INFO - 'NO_EM_RESTART': '1', 00:21:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:21:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:21:17 INFO - 'PWD': '/builds/slave/test', 00:21:17 INFO - 'SHELL': '/bin/bash', 00:21:17 INFO - 'SHLVL': '1', 00:21:17 INFO - 'TERM': 'linux', 00:21:17 INFO - 'TMOUT': '86400', 00:21:17 INFO - 'USER': 'cltbld', 00:21:17 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1501477576.126492-1966430490', 00:21:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:21:17 INFO - '_': '/tools/buildbot/bin/python'} 00:21:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:21:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:21:17 INFO - Cleaning up... 00:21:17 INFO - Return code: 0 00:21:17 INFO - Running post-action listener: _resource_record_post_action 00:21:17 INFO - Running post-action listener: _start_resource_monitoring 00:21:17 INFO - Starting resource monitoring. 00:21:17 INFO - [mozharness: 2017-07-31 07:21:17.978317Z] Finished create-virtualenv step (success) 00:21:17 INFO - [mozharness: 2017-07-31 07:21:17.978832Z] Running install step. 00:21:17 INFO - Running pre-action listener: _resource_record_pre_action 00:21:17 INFO - Running main action method: install 00:21:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:21:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:21:18 INFO - Reading from file tmpfile_stdout 00:21:18 INFO - Detecting whether we're running mozinstall >=1.0... 00:21:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:21:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:21:18 INFO - Reading from file tmpfile_stdout 00:21:18 INFO - Output received: 00:21:18 INFO - Usage: mozinstall [options] installer 00:21:18 INFO - Options: 00:21:18 INFO - -h, --help show this help message and exit 00:21:18 INFO - -d DEST, --destination=DEST 00:21:18 INFO - Directory to install application into. [default: 00:21:18 INFO - "/builds/slave/test"] 00:21:18 INFO - --app=APP Application being installed. [default: firefox] 00:21:18 INFO - mkdir: /builds/slave/test/build/application 00:21: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'] 00:21:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 00:21:36 INFO - Reading from file tmpfile_stdout 00:21:36 INFO - Output received: 00:21:36 INFO - /builds/slave/test/build/application/firefox/firefox 00:21:36 INFO - Running post-action listener: _resource_record_post_action 00:21:36 INFO - [mozharness: 2017-07-31 07:21:36.392254Z] Finished install step (success) 00:21:36 INFO - [mozharness: 2017-07-31 07:21:36.392506Z] Running setup-mitmproxy step. 00:21:36 INFO - Running pre-action listener: _resource_record_pre_action 00:21:36 INFO - Running main action method: setup_mitmproxy 00:21:36 INFO - Skipping: mitmproxy is not required 00:21:36 INFO - Running post-action listener: _resource_record_post_action 00:21:36 INFO - [mozharness: 2017-07-31 07:21:36.393723Z] Finished setup-mitmproxy step (success) 00:21:36 INFO - [mozharness: 2017-07-31 07:21:36.393943Z] Running run-tests step. 00:21:36 INFO - Running pre-action listener: _resource_record_pre_action 00:21:36 INFO - Running pre-action listener: _set_gcov_prefix 00:21:36 INFO - Running main action method: run_tests 00:21:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:21:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:21:36 INFO - Python 2.7.3 00:21:36 INFO - Return code: 0 00:21:36 INFO - grabbing minidump binary from tooltool 00:21: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')]} 00:21:36 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 0x217ceb0>, '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 0x217ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217e240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:21:36 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 00:21:36 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 00:21:36 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 00:21:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:21:36 INFO - Return code: 0 00:21:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:21:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:21:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:21:36 INFO - ENV: RUST_BACKTRACE is now 1 00:21:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:21:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:21:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JacXY8NJTua8V_2O70iG6g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 00:21:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JacXY8NJTua8V_2O70iG6g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-055 --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 00:21:36 INFO - Using env: {'DISPLAY': ':0', 00:21:36 INFO - 'HOME': '/home/cltbld', 00:21:36 INFO - 'LANG': 'en_US.UTF-8', 00:21:36 INFO - 'LANGUAGE': 'en_US:en', 00:21:36 INFO - 'LOGNAME': 'cltbld', 00:21:36 INFO - 'MAIL': '/var/mail/cltbld', 00:21:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:21:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:21:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:21:36 INFO - 'MOZ_NO_REMOTE': '1', 00:21:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:21:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:21:36 INFO - 'NO_EM_RESTART': '1', 00:21:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:21:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:21:36 INFO - 'PWD': '/builds/slave/test', 00:21:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:21:36 INFO - 'RUST_BACKTRACE': '1', 00:21:36 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 00:21:36 INFO - 'SHELL': '/bin/bash', 00:21:36 INFO - 'SHLVL': '1', 00:21:36 INFO - 'TERM': 'linux', 00:21:36 INFO - 'TMOUT': '86400', 00:21:36 INFO - 'USER': 'cltbld', 00:21:36 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1501477576.126492-1966430490', 00:21:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:21:36 INFO - '_': '/tools/buildbot/bin/python'} 00:21:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JacXY8NJTua8V_2O70iG6g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 00:21:36 INFO - mozversion application_buildid: 20170731062808 00:21:36 INFO - mozversion application_changeset: a6c502679d442596b8b4410d6413cd310ac46408 00:21:36 INFO - mozversion application_display_name: Nightly 00:21:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:21:36 INFO - mozversion application_name: Firefox 00:21:36 INFO - mozversion application_remotingname: firefox 00:21:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 00:21:36 INFO - mozversion application_vendor: Mozilla 00:21:36 INFO - mozversion application_version: 56.0a1 00:21:36 INFO - mozversion platform_buildid: 20170731062808 00:21:36 INFO - mozversion platform_changeset: a6c502679d442596b8b4410d6413cd310ac46408 00:21:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 00:21:36 INFO - mozversion platform_version: 56.0a1 00:21:36 INFO - using testdate: 1501485696 00:21:36 INFO - actual date: 1501485696 00:21:36 INFO - starting webserver on 'localhost:45403' 00:21:36 INFO - SUITE-START | Running 2 tests 00:21:36 INFO - TEST-START | dromaeo_css 00:21:36 INFO - Initialising browser for dromaeo_css test... 00:21:36 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45403/getInfo.html -profile /tmp/tmpavc90o/profile 00:21:36 INFO - TEST-INFO | started process 12112 (/builds/slave/test/build/application/firefox/firefox http://localhost:45403/getInfo.html) 00:21:42 INFO - TEST-INFO | 12112: exit 0 00:21:42 INFO - Browser initialized. 00:21:42 INFO - Running cycle 1/1 for dromaeo_css test... 00:21:42 INFO - TEST-INFO | started process 12321 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpavc90o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 00:21:43 INFO - PID 12321 | 00:21:43 INFO - PID 12321 | (/builds/slave/test/build/application/firefox/firefox:12369): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 00:21:43 INFO - PID 12321 | 00:21:53 INFO - PID 12321 | RSS: Main: 171003904 00:21:53 INFO - PID 12321 | 00:24:52 INFO - PID 12321 | Cycle 1(1): loaded http://localhost:45403/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45403/tests/dromaeo/cssquery-ext.html) 00:24:54 INFO - PID 12321 | RSS: Main: 170508288 00:24:54 INFO - PID 12321 | 00:27:56 INFO - PID 12321 | Cycle 1(1): loaded http://localhost:45403/tests/dromaeo/cssquery-ext.html (next: http://localhost:45403/tests/dromaeo/cssquery-jquery.html) 00:27:56 INFO - PID 12321 | RSS: Main: 170455040 00:27:56 INFO - PID 12321 | 00:30:58 INFO - PID 12321 | Cycle 1(1): loaded http://localhost:45403/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45403/tests/dromaeo/cssquery-mootools.html) 00:30:59 INFO - PID 12321 | RSS: Main: 170237952 00:30:59 INFO - PID 12321 | 00:34:00 INFO - PID 12321 | Cycle 1(1): loaded http://localhost:45403/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45403/tests/dromaeo/cssquery-prototype.html) 00:34:01 INFO - PID 12321 | RSS: Main: 171053056 00:34:01 INFO - PID 12321 | 00:37:05 INFO - PID 12321 | Cycle 1(1): loaded http://localhost:45403/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45403/tests/dromaeo/cssquery-yui.html) 00:37:06 INFO - PID 12321 | RSS: Main: 174678016 00:37:06 INFO - PID 12321 | 00:40:07 INFO - PID 12321 | Cycle 1(1): loaded http://localhost:45403/tests/dromaeo/cssquery-yui.html (next: http://localhost:45403/tests/dromaeo/cssquery-dojo.html) 00:40:08 INFO - PID 12321 | RSS: Main: 171675648 00:40:08 INFO - PID 12321 | 00:40:08 INFO - PID 12321 | __start_tp_report 00:40:08 INFO - PID 12321 | _x_x_mozilla_page_load 00:40:08 INFO - PID 12321 | _x_x_mozilla_page_load_details 00:40:08 INFO - PID 12321 | |i|pagename|runs| 00:40:08 INFO - PID 12321 | |0;dojo.html;3077.0768769369183;3154.369126174765;3156.7632427567933;3159.85780639871;3159.905202843914;6081.908771368422;6153.815385538435;6165.136880836675;6246.65643389614;6285.120083188357;6132.632042077478;6156.56904016719;6162.722677479513;6180.536459765513;6181.350958149397;5615.971920140393;5629.155626655994;5637.492625663689;5649.180868774025;5709.229254050712;5675.9432405675825;5718.914216286759;5733.598648094635;5734.942650573504;5764.106563482667;5755.2230448889495;5759.366469688331;5776.624519406246;5794.826155215329;5803.73883175256;5678.772849086032;5680.772769089232;5729.39841316662;5735.1970724098655;5787.189793428924;5592.636478628876;5597.244372009767;5678.488935995739;5685.772569097231;5686.118651609007;6004.939950600526;6020.1872747179;6039.969800150971;6048.637081775108;6086.7565297388055;6574.145361103026;6575.309592492815;6578.868422631568;6682.632455214961;6695.363940425652;6449.226092868886;6604.504662150358;6700.363465470772;6770.086038384804;6815.250322464525;6083.422074902877;6219.564630475868;6219.813405597839;6223.875522489525;6227.377262273736;6842.144731908512;6863.10779598649;6923.826904327432;6924.134483189601;6929.341712537301;6486.481081513468;6521.217453905467;6572.14562106923;6600.108985287021;6612;6442.549021568539;6584.637844918576;6618.503612229102;6627;6729.192496900306;6457.677116144174;6459.644719540471;6534.150560427114;6539.117219175446;6541.771038013647;6544.116544266463;6565.507586930999;6577.144971153815;6648.069270302161;6649.401553860176;5390.407055223922;5393.406725260218;5418.91871621926;5424.701641409761;5437.891242175214;4584.037352156018;4617.8152873884665;4642.419697537808;4646.558576935186;4657.510961349078;5596.748146333425;5696;5701.743421546041;5786.276715410574;5789.797357092481;6616.735330586819;6672.232693240339;6705.966470167716;6746.325367463214;6752.459803215731;5732.512736417368;5761.9135712964335;5764.654120752768;5766.163906233573;5780.768769249183;5819.709014549256;5834.445727655866;5907.675077870673;5919.496842768327;5921.792737254175;6299.716512757029;6402.647854368054;6406.4554512866;6489.351064893567;6507.34926507355;6582.703778329891;6583.506237032146;6583.868322633616;6589;6596.109525214035;6254.249490061222;6323.683815809283;6332.841678958063;6336.334684858208;6342.048692696132;6397.616143031433;6398.104265402941;6413.551051426542;6439.098526206429;6473.838154046187;6527.934720652733;6529.379708927644;6570.080188773671;6573.046908198189;6595.736170553124;6421.839454013687;6427.453666438405;6440.710168042356;6510.381513756186;6526.575772574767;6253.218347706536;6450.709718062604;6535.117759102461;6557.082008518906;6563.671816409256;6281.874362512815;6291.653959032297;6299.905501417391;6300.464460520907;6302.905456418249;6497;6501.609903405811;6549.6070235786;6581.6709164542535;6582.17722784652;6274.937250627435;6303.810885673437;6348.460380867493;6355.300916899045;6360.268569114611 00:40:08 INFO - PID 12321 | |1;ext.html;820;855.8202777416742;878.50803550012;906.533135435251;907.8502047162218;38421.04473806561;39824.20351592974;39833.4024989625;39923.800380998124;39953.2009359813;35991.10022249445;35998.820005899935;36034.63965360346;36090.2781944361;36384.09039774007;6804.591724496534;6851.212110607269;6854.691538880737;6899.37905588497;6933.861322773541;6739.427148692367;6835.418989385908;6852.451803855704;6879.1057162568795;6908.861822763542;6835.350641689057;7028.226895041541;7478.925210747904;7525.924740752577;7528.360089392409;7449.441291903102;7466.66400011998;7469.962650186769;7470.0662417197855;7489.850202995937;7306.671199796022;7336.119665640104;7391.186969433358;7392.815179620498;7393.2606739326175;37755.622443775486;38142.42786358207;38309.61690383089;38328.233435331415;38333;3564.287142571496;3611.331903597843;3633.218857945528;3633.400488919325;3638.945415818765;29919.85040074786;29978.25054373636;30148.24629384283;30186.245343866358;30186.396272074657;4757.690750101232;4781.330613714083;4804.159272127364;4823.469418363977;4884.462709101996;175970;177849;181487;186652;191021;46926.296105558446;47165;47252.29121563179;47267.52732472631;47323;48952.510474895505;49037.26444103341;49069.75465122652;49247;49369.753151234014;15223;15247.923760381127;15301.770473442908;15304.464343748137;15316.923415382851;12407.813882791765;12444.688882777822;12447.75104497905;12466.81299780504;12491.125621206611;14024.228667423185;14091;14145.504907328193;14183.78724319136;14371.281435928162;5675.460831221028;5865.35481097079;5871.823845284648;5881.41185881417;5915.852103697442;963.2582911158369;966.4201479112617;982.9557669904872;994.3288280410839;1011.1354791653177;22315.10739570399;22507.43731406728;22552.323430297118;22696.546069078526;22883.427914302276;1038.672818062308;1061.5918033425437;1090.1224514266091;1108.5953626926114;1113.276370359273;11818;11819.704507387212;11835.526578936746;11916.761664766656;12040.638780836589;219379;220146;220562;220641;220797;48390.54828355155;49112.508874910796;49119.754401227765;49158.75420622945;49222.50777492251;1447.1317209674112;1465.8314293856129;1468.2805425341505;1478.2904205980974;1489.932953017117;21401.67897481508;21608.567828643023;22198.667019995035;22248.332550023526;22328.441788955406;35703.10742231361;35717.46423803593;35751;35763.82118089393;35857.28285434329;179377;180670;181061;181081;181264;32008.83995580007;34185.82907085449;34495.13762155966;34564.65435345614;34580.30839383148;43305.56694433015;44314.556854431044;44357.33463998107;44602.77698611486;45164.32253516265;29022;30148.09555713332;30427.695723042485;31007.534886976264;31571.526427103152;28792.424151516432;31184;31387.529187062668;31507.21231969219;31901.20246993844;34906.825465872505;35365.64634353624;35631;35788.82105589456;35959;30285.242868928453;31766.228270870943;31868.84065579657;32263.51604725884;32315.19212019718;23583.41041473977;23666.45556680319;24002.27993160138;24005.27984160478;24061.759382406653 00:40:08 INFO - PID 12321 | |2;jquery.html;567.8069456384828;571.3572231239855;572.936976932537;576.7721749908787;581.3227589857815;21810.454738631543;22746.090156393744;22780.31659050229;22843.08627654892;22993.4251643709;22928.65607015892;23845.28464146074;24830.875845620747;25000.374990625245;25031.249062528153;6398.264199617034;6566.179227596551;6566.244881838602;6568.441682456997;6570.737170513197;6136.355682653324;6344.3338449462835;6347.809565713036;6400.679966001681;6405.935940640604;6431.549791514596;6438.098666186737;6444.806655800334;6444.838879028015;6466.06242094896;6449.6775161241985;6455.548111632188;6457.612543247374;6458.354164583528;6462.353764623547;6010.2186715726675;6017.277926648786;6022.3676513966275;6027.367126451747;6032.788852390189;27995.300117497227;29496.41007179866;29986.85006574975;30006.249843753863;30462.54306185409;1864.3102052240758;1918.4820098573307;1918.7793403758608;1918.808119188084;1920.3662791278844;19038.61922761537;19575.216991320474;19581.706274405897;19646.214151433924;19651.115699793543;2291.4385975435957;2328.5924963131383;2406.3743426709007;2421.140495124223;2422.2127808462146;135869;137918;142132.28933855367;142306;142431;13791.448342066406;15058.548243552492;15374.461893833663;15395.384184632714;15795.21023948798;23903.52192956131;23941.880290598434;23998;24024.39939001539;24048.759512404653;10126.341787783771;10403.791924161626;10630.255882088335;10636.840447393295;10724.41015744126;9639.18066964316;9664.516774161264;9687.854682179774;9722.319437639297;9768.974257702981;9191.678291259908;9406.43561386319;9641.180499657466;9706.369086009387;9824.263180261509;2909.1418031680705;2927.458420192271;2941.6175897133235;2949.439606474763;2955.8226506409255;927.758782716485;946.4415994563241;967.8834154024031;968.7820240445843;977.0620204603518;19612.313569025016;19844.404667859988;20001.399958001282;20019.899900500404;20363.796362036486;978.1392374710209;1019.612547232062;1039.5581877701945;1039.823230050878;1046.7644779924608;10744.73138171552;10778.353298802096;11344.716382090513;13490.460381584822;14454.915881308943;528129;546063;548264;552994;560637;125329;128582;130644;130720.3463982674;130946.34526827495;1240.1566934484456;1276.3681977421236;1287.1376177960976;1311.1477539599146;1315.4409376015155;19120.52198694988;21124.676285608264;21139.788602113782;21829.235976740736;22589.322320330415;61772.382276176664;62120.37879621146;62484;64000.359996401305;64059;72026.63986680243;72034.27965720276;72053.639731801;72140.63929680319;73075.63462182655;16887.155642217593;19575.314863979693;21123.577528449652;21628.567428651655;21681;24012.51974960526;24127.276181714577;24143.637845431982;24463.38841528905;25011.499770004863;18464.81535184631;19046.430479081428;19140.71288930695;19153.61692766165;19434.514137146685;16597.25312360971;16680.416185433936;16708.49874503767;17523.649527009642;18345.908270458563;19340;19341.613167736847;19499.61000779948;19543.51141221424;20037.599248014667;20227;21550.461238468535;21585.13659453604;21635.350939471842;21779.782202177776;18278.086095695428;18412.26350945947;19015.619687606446;19032.524186894883;19259.90370048141 00:40:08 INFO - PID 12321 | |3;mootools.html;1276.1322300835432;1320.27384938284;1332.347149896551;1334.6529902225418;1347.7978303254508;13785.10396824207;14365;14365.640858978504;14366.425342986282;14380.352884120213;13458.730825383487;14416.423343066292;14417.495387661435;14420.35108420121;14446.133232006086;2665.2270841456;2743.876525556345;2744.217897899099;2745.492083964463;2745.9862700686467;2390.6533552634855;2642.128097727745;2685.7582817546418;2728.290644432452;2738.5207588672;2725.727427257278;2745.6018877262786;2746.4781691478556;2748.2579703480046;2749.780017598597;2602.856842873641;2602.9609555856678;2631.8289311194712;2632.7762140218106;2654.0047482194177;2609.7781688556497;2641.643378143945;2642.1280977277643;2642.6696662917134;2652.641893344393;13991.790123148161;14072.648183795385;14132.293385330795;14147.504837330747;14147.787783183261;7494.325510704063;7780.105287891852;7786.883196752054;7790.220977902221;7796.337311328544;5047.697138171685;5109.926915347782;5163.638545301793;5274.604404669665;5299.49654782795;1694.220658497093;1718.2525601363448;1731.2555601091526;1748.728947013215;1759.9296028158858;22754.431139221488;22973.88513057424;22993.425164371023;23007.309780706604;23017.309480715438;6149.3235744068115;6429.196350456193;6472.9029064564065;6496.967515162394;6525.401276687242;15524.534263972098;15630;15648.374065037498;15649.217539122998;15661;7305.817354566178;7553.886691699519;7574.166841647414;7575.469717119859;7585.544867307979;6621.475963496095;6998.965005174941;7046.1192350956135;7051.435885129177;7061.470389720792;4836.443808961944;4994.1759609663995;5016.799328026838;5027.874303142451;5075.187969924795;1410.5486244401898;1443.2062365698823;1460.4669295707204;1472.6097584139998;1515.4468618954002;743.8809790433505;761.5468796066332;776.7630872583803;786.4887822915036;793.1117148793388;6727.495437842182;7110.92889071113;7133.89299160513;7234.385077268385;7278.1266248049515;901.2519608724742;914.29599208609;921.5898924978454;928.0858354520792;961.1829944547219;4274.1451709658195;4501.167284052461;4522;4584.633229341712;4619.260918253063;18423.26306947707;18610;18679.81320186808;19180.232790688497;19222.03889805504;18342.358017469593;19076.61846763057;19447.3193438229;19629.8037019628;19641.508962276057;9789.36369136018;10340.276180667432;10355.585776568852;10365;10531.94680531956;6733.42765864907;7015.649217539205;7156.928430715834;7202.89195662076;7250.564966102051;16755.078470684228;16896.915515422344;16948.830511695218;17129;17254.741178882075;17265.82734172642;17306.567335816704;17495.912520437316;17499;17529.912350438168;10052.497375131361;10342.844857326996;10398.324108932895;10455.059044686015;10468.476576171313;12770.489180433051;12989.220646761225;12997.935010324887;13004.154729942524;13014;9795.706128815862;10053.145482633765;10178.491075446345;10232.948835255776;10608.151347892304;10015.14871235953;10190.082892539707;10369.792604147724;10406.271560990657;10453.84319235197;8263.834723305621;8567.4002819802;8579.2707619853;8583.969923609207;8588.098249683942;5379.757910894097;5605.635633683797;5659.292588426447;5684.516816070515;5724.8282551523525;6086.7260973255425;6114.602550834182;6222.439980401786;6259.874802504016;6325.905111423241 00:40:08 INFO - PID 12321 | |4;prototype.html;472.56287933661355;499.73763774018624;512.1600575056907;516.1895823557012;527.6491133396291;6219.844503887405;6264.906026409608;6269.435750782434;6333.904991425121;6356.2054743157105;5941.346451890288;6041.546883983697;6061.363556826536;6070.63079990605;6095.878082438348;4818.51814818518;4874.268859671042;4887.780049897763;4946.925796113062;4973.179425394806;4776.880577985544;4903.82836600719;4973.278874563186;4992.750362481861;5041.3194218780545;4871.415430148387;4904.36243288372;4917.950820491803;4920.7785649645675;4942.802287908479;4863.975680121594;4928.97535512322;4984.850454486371;4988.65079444439;4998;4452.554744525554;4459.620932220765;4472.84345047925;4488.573585509372;4511.458624965026;5917.822465326047;6020.96989515054;6025.758969641209;6078.300995385543;6092.055731361602;5703.4011428799795;5771.769129234825;5777.364489906107;5783.913241301342;5796.333421656479;6443.420092191725;6465.515086368541;6467.967660161716;6494.220693516761;6524.608523488606;4809.9038019239415;4887.70673759572;4900.411950565919;4913.732367975292;4918.581920536759;6839.726410943556;6849.965750171217;6912.516123871281;7029.437644988439;7037.964810175968;4954.133026720309;4972.676776009548;4973.651844370932;4984.202527595639;5025.748712564357;5038.5969122470115;5052.711558552545;5079.720615366116;5150.922736158961;5159.355080614923;5707.914381284284;5713.885722285531;5743.4543718346695;5743.530281978789;5770;6440.742370305229;6474.640325531597;6516.185476815398;6529.2817790043055;6558.573692709959;1669.5909502172046;1687.6962146813692;1715.759793628893;1723.5346456456937;1734.6357264974245;1147.2370873369282;1207.0265116534354;1209.9818502722467;1211.0856303490984;1212.902967762577;5517.69652669099;5570.275864137636;5603.719814009365;5642.714700546286;5681.744321505542;6470.967645161744;6540.738370465128;6563.704633291513;6611.173603299588;6672.699728512229;5624.409437009137;5711.914321285184;5742.908847318996;5768.451997060357;5787.5080618147085;3521.9295614087573;3577.2308953575107;3605.3330133925306;3615.493830863681;3617.855285788539;6465.709043093072;6521.739130434825;6557.934420655828;6605.30644282353;6615.206175258903;6845.794626161223;6926.376626103574;6949.339812717783;6958.408535274457;6959.399338152253;6452.77415290472;6462.935370646233;6470.191226096738;6551.525906671056;6619.139511863524;6542.509311801729;6688.264290927897;6707.3628005339415;6754.324567543206;6787.762428314985;6672.698823729326;6726.159230096238;6746.662666866735;6769;6799.830004249933;6481.157449531531;6600.60396376219;6615;6626.5030122741955;6660.800175994728;4883.87790305231;4922.606191504599;4922.630802689741;4930.728809915489;4966.404031516241;6716.462682985251;6717.018479548447;6732.629705366252;6793.898091528532;6798.966005169942;6485.513586481127;6520.510961677798;6521.478281737354;6584.275729669828;6633.9668301658185;6205.541697701127;6394.904076438764;6465.997770345604;6509.251436084722;6564.6389448580785;6152.600080994721;6243.594166379171;6351.396617321347;6361.332060133619;6375.617462952052;6425.518086143465;6445.387688169616;6517.608943463408;6543.76083838503;6611.206655201407;6249.1563638908165;6346.873062538816;6384.6169229846355;6394.968025159845;6405.935940640534 00:40:08 INFO - PID 12321 | |5;yui.html;859.1108203009886;886.2068448738379;898.4968417686092;905.9365844390895;906.5150144672598;17558.82441175588;18577.72133417998;18619.255229790808;18640.440786776417;19314.51713707158;20555.280565180223;21283.787162128374;21320.253791117277;21484.57030859386;21508.462288442795;991.1723710701573;1008.2690049713935;1014;1014.5181039006486;1014.695591322604;1007.6825799873053;1010.0404615615158;1011.1001208924064;1011.7723512209767;1013.4089479517161;1084.7776205877776;1098.1818545183849;1098.203802243375;1098.3355070182545;1099.290957332524;1074.1943542343242;1083.1659622091024;1084.2247792828127;1084.9457527123652;1086.760912599227;802.4182467710921;802.5345299726204;802.5706247157742;802.9116797152309;803.2409373142383;18948.905255473772;18954;19169.616607667907;19191.32830350945;19632.80367196324;20592.27927022547;20669.379918602466;21052.578948421098;21085.8945705272;21332.786672133392;15623.062616243062;15682.686346273125;15769;15891.92054039734;15896.84103158965;3167.31902640931;3168.572242747223;3205.9679403206137;3207.759418043656;3208.0536241808722;118802.40598797037;121647.39176304062;125367.37316313451;125474;127170.3641481796;15723.68552628941;16148.83851161497;16156.676866462605;16174.514764557081;16197.271122799502;29225.7077429223;30244.09267721972;30473.847630761706;30483.08550743481;30528.54207186894;7807.80480487981;8040.437169398086;8165.673373065011;8170.714025009215;8186.181381861886;4135.937960930589;4238.660907127422;4244.957550424518;4250.234957707642;4253.787310634456;5216.295800067019;5222.321098257278;5291.100512912814;5315.495027972336;5334.466553344634;855.1619412975194;884.8363052835246;894.4409743910056;896.2113340260529;897.7845317123844;637.8182218067828;648.45205801098;674.1539368093012;675.9019942108366;687.3641881259815;10539.42033188182;13241.337933103307;13538.526151584647;13670.589882303548;13786.586402407944;660.9008648702637;674.699758607415;684.090160087083;692.6155983429145;696.6586372677453;5170.37955445349;5522.30971128609;5573.637713548606;5613.382527921925;5829.883402332014;100205.49897250468;101809.49095254476;105553.47223263835;106722;108040;84523.15476845276;88641.55679221563;91050.54474727584;91748.54125729328;92058.53970730238;71167;75791.62104189444;75928.24071759322;76700.81151945423;77284;11523.53905843757;11896.76206475883;12774.23354598727;12819.935900320439;12937.223766574036;31815.522767158975;34459.31081378408;34462.655373445945;35089.824550878104;36247.63752362443;63332;67609.3239067603;67704.3229567698;68649.65675171593;70010.29989700038;18490.722639160693;18577.16402761852;18723.531911702317;18874.33939812155;18882.52793680114;20175.899120504302;21083.789162108795;21316.36050918475;21389.46526336854;21421.57156856823;14830.258487075818;14855.554333370017;16742.748858767372;17565.209565569323;17605.559861003065;19227.423177304703;19297.903510482356;19352.516187095436;19569.902150489157;19577.902110489358;17607.911960440117;18002.09989500546;18013.80605588339;18245.08774561293;18246.361377351728;12066.939665301617;12487.12590118683;12524.874751252735;12708.809367859674;12947.158434701714;14044.719105617625;14235.64410889736;14492.202928838593;14712.852871471148;14949.402023918921 00:40:08 INFO - PID 12321 | __end_tp_report 00:40:08 INFO - PID 12321 | __start_cc_report 00:40:08 INFO - PID 12321 | _x_x_mozilla_cycle_collect,382 00:40:08 INFO - PID 12321 | __end_cc_report 00:40:08 INFO - PID 12321 | __startTimestamp1501486808009__endTimestamp 00:40:08 INFO - PID 12321 | 00:40:08 INFO - PID 12321 | ------- Summary: start ------- 00:40:08 INFO - PID 12321 | Number of tests: 6 00:40:08 INFO - PID 12321 | 00:40:08 INFO - PID 12321 | [#0] dojo.html Cycles:165 Average:6097.16 Median:6300.46 stddev:705.53 (11.2%) stddev-sans-first:666.73 00:40:08 INFO - PID 12321 | Values: 3077.1 3154.4 3156.8 3159.9 3159.9 6081.9 6153.8 6165.1 6246.7 6285.1 6132.6 6156.6 6162.7 6180.5 6181.4 5616.0 5629.2 5637.5 5649.2 5709.2 5675.9 5718.9 5733.6 5734.9 5764.1 5755.2 5759.4 5776.6 5794.8 5803.7 5678.8 5680.8 5729.4 5735.2 5787.2 5592.6 5597.2 5678.5 5685.8 5686.1 6004.9 6020.2 6040.0 6048.6 6086.8 6574.1 6575.3 6578.9 6682.6 6695.4 6449.2 6604.5 6700.4 6770.1 6815.3 6083.4 6219.6 6219.8 6223.9 6227.4 6842.1 6863.1 6923.8 6924.1 6929.3 6486.5 6521.2 6572.1 6600.1 6612.0 6442.5 6584.6 6618.5 6627.0 6729.2 6457.7 6459.6 6534.2 6539.1 6541.8 6544.1 6565.5 6577.1 6648.1 6649.4 5390.4 5393.4 5418.9 5424.7 5437.9 4584.0 4617.8 4642.4 4646.6 4657.5 5596.7 5696.0 5701.7 5786.3 5789.8 6616.7 6672.2 6706.0 6746.3 6752.5 5732.5 5761.9 5764.7 5766.2 5780.8 5819.7 5834.4 5907.7 5919.5 5921.8 6299.7 6402.6 6406.5 6489.4 6507.3 6582.7 6583.5 6583.9 6589.0 6596.1 6254.2 6323.7 6332.8 6336.3 6342.0 6397.6 6398.1 6413.6 6439.1 6473.8 6527.9 6529.4 6570.1 6573.0 6595.7 6421.8 6427.5 6440.7 6510.4 6526.6 6253.2 6450.7 6535.1 6557.1 6563.7 6281.9 6291.7 6299.9 6300.5 6302.9 6497.0 6501.6 6549.6 6581.7 6582.2 6274.9 6303.8 6348.5 6355.3 6360.3 00:40:08 INFO - PID 12321 | 00:40:08 INFO - PID 12321 | [#1] ext.html Cycles:180 Average:35895.87 Median:35710.29 stddev:50590.20 (141.7%) stddev-sans-first:50663.56 00:40:08 INFO - PID 12321 | Values: 820.0 855.8 878.5 906.5 907.9 38421.0 39824.2 39833.4 39923.8 39953.2 35991.1 35998.8 36034.6 36090.3 36384.1 6804.6 6851.2 6854.7 6899.4 6933.9 6739.4 6835.4 6852.5 6879.1 6908.9 6835.4 7028.2 7478.9 7525.9 7528.4 7449.4 7466.7 7470.0 7470.1 7489.9 7306.7 7336.1 7391.2 7392.8 7393.3 37755.6 38142.4 38309.6 38328.2 38333.0 3564.3 3611.3 3633.2 3633.4 3638.9 29919.9 29978.3 30148.2 30186.2 30186.4 4757.7 4781.3 4804.2 4823.5 4884.5 175970.0 177849.0 181487.0 186652.0 191021.0 46926.3 47165.0 47252.3 47267.5 47323.0 48952.5 49037.3 49069.8 49247.0 49369.8 15223.0 15247.9 15301.8 15304.5 15316.9 12407.8 12444.7 12447.8 12466.8 12491.1 14024.2 14091.0 14145.5 14183.8 14371.3 5675.5 5865.4 5871.8 5881.4 5915.9 963.3 966.4 983.0 994.3 1011.1 22315.1 22507.4 22552.3 22696.5 22883.4 1038.7 1061.6 1090.1 1108.6 1113.3 11818.0 11819.7 11835.5 11916.8 12040.6 219379.0 220146.0 220562.0 220641.0 220797.0 48390.5 49112.5 49119.8 49158.8 49222.5 1447.1 1465.8 1468.3 1478.3 1489.9 21401.7 21608.6 22198.7 22248.3 22328.4 35703.1 35717.5 35751.0 35763.8 35857.3 179377.0 180670.0 181061.0 181081.0 181264.0 32008.8 34185.8 34495.1 34564.7 34580.3 43305.6 44314.6 44357.3 44602.8 45164.3 29022.0 30148.1 30427.7 31007.5 31571.5 28792.4 31184.0 31387.5 31507.2 31901.2 34906.8 35365.6 35631.0 35788.8 35959.0 30285.2 31766.2 31868.8 32263.5 32315.2 23583.4 23666.5 24002.3 24005.3 24061.8 00:40:08 INFO - PID 12321 | 00:40:08 INFO - PID 12321 | [#2] jquery.html Cycles:180 Average:37589.25 Median:12661.01 stddev:91810.57 (725.1%) stddev-sans-first:92026.04 00:40:08 INFO - PID 12321 | Values: 567.8 571.4 572.9 576.8 581.3 21810.5 22746.1 22780.3 22843.1 22993.4 22928.7 23845.3 24830.9 25000.4 25031.2 6398.3 6566.2 6566.2 6568.4 6570.7 6136.4 6344.3 6347.8 6400.7 6405.9 6431.5 6438.1 6444.8 6444.8 6466.1 6449.7 6455.5 6457.6 6458.4 6462.4 6010.2 6017.3 6022.4 6027.4 6032.8 27995.3 29496.4 29986.9 30006.2 30462.5 1864.3 1918.5 1918.8 1918.8 1920.4 19038.6 19575.2 19581.7 19646.2 19651.1 2291.4 2328.6 2406.4 2421.1 2422.2 135869.0 137918.0 142132.3 142306.0 142431.0 13791.4 15058.5 15374.5 15395.4 15795.2 23903.5 23941.9 23998.0 24024.4 24048.8 10126.3 10403.8 10630.3 10636.8 10724.4 9639.2 9664.5 9687.9 9722.3 9769.0 9191.7 9406.4 9641.2 9706.4 9824.3 2909.1 2927.5 2941.6 2949.4 2955.8 927.8 946.4 967.9 968.8 977.1 19612.3 19844.4 20001.4 20019.9 20363.8 978.1 1019.6 1039.6 1039.8 1046.8 10744.7 10778.4 11344.7 13490.5 14454.9 528129.0 546063.0 548264.0 552994.0 560637.0 125329.0 128582.0 130644.0 130720.3 130946.3 1240.2 1276.4 1287.1 1311.1 1315.4 19120.5 21124.7 21139.8 21829.2 22589.3 61772.4 62120.4 62484.0 64000.4 64059.0 72026.6 72034.3 72053.6 72140.6 73075.6 16887.2 19575.3 21123.6 21628.6 21681.0 24012.5 24127.3 24143.6 24463.4 25011.5 18464.8 19046.4 19140.7 19153.6 19434.5 16597.3 16680.4 16708.5 17523.6 18345.9 19340.0 19341.6 19499.6 19543.5 20037.6 20227.0 21550.5 21585.1 21635.4 21779.8 18278.1 18412.3 19015.6 19032.5 19259.9 00:40:08 INFO - PID 12321 | 00:40:08 INFO - PID 12321 | [#3] mootools.html Cycles:180 Average:8472.96 Median:2642.13 stddev:5938.63 (224.8%) stddev-sans-first:5930.67 00:40:08 INFO - PID 12321 | Values: 1276.1 1320.3 1332.3 1334.7 1347.8 13785.1 14365.0 14365.6 14366.4 14380.4 13458.7 14416.4 14417.5 14420.4 14446.1 2665.2 2743.9 2744.2 2745.5 2746.0 2390.7 2642.1 2685.8 2728.3 2738.5 2725.7 2745.6 2746.5 2748.3 2749.8 2602.9 2603.0 2631.8 2632.8 2654.0 2609.8 2641.6 2642.1 2642.7 2652.6 13991.8 14072.6 14132.3 14147.5 14147.8 7494.3 7780.1 7786.9 7790.2 7796.3 5047.7 5109.9 5163.6 5274.6 5299.5 1694.2 1718.3 1731.3 1748.7 1759.9 22754.4 22973.9 22993.4 23007.3 23017.3 6149.3 6429.2 6472.9 6497.0 6525.4 15524.5 15630.0 15648.4 15649.2 15661.0 7305.8 7553.9 7574.2 7575.5 7585.5 6621.5 6999.0 7046.1 7051.4 7061.5 4836.4 4994.2 5016.8 5027.9 5075.2 1410.5 1443.2 1460.5 1472.6 1515.4 743.9 761.5 776.8 786.5 793.1 6727.5 7110.9 7133.9 7234.4 7278.1 901.3 914.3 921.6 928.1 961.2 4274.1 4501.2 4522.0 4584.6 4619.3 18423.3 18610.0 18679.8 19180.2 19222.0 18342.4 19076.6 19447.3 19629.8 19641.5 9789.4 10340.3 10355.6 10365.0 10531.9 6733.4 7015.6 7156.9 7202.9 7250.6 16755.1 16896.9 16948.8 17129.0 17254.7 17265.8 17306.6 17495.9 17499.0 17529.9 10052.5 10342.8 10398.3 10455.1 10468.5 12770.5 12989.2 12997.9 13004.2 13014.0 9795.7 10053.1 10178.5 10232.9 10608.2 10015.1 10190.1 10369.8 10406.3 10453.8 8263.8 8567.4 8579.3 8584.0 8588.1 5379.8 5605.6 5659.3 5684.5 5724.8 6086.7 6114.6 6222.4 6259.9 6325.9 00:40:08 INFO - PID 12321 | 00:40:08 INFO - PID 12321 | [#4] prototype.html Cycles:180 Average:5490.67 Median:6066.00 stddev:1549.34 (25.5%) stddev-sans-first:1507.21 00:40:08 INFO - PID 12321 | Values: 472.6 499.7 512.2 516.2 527.6 6219.8 6264.9 6269.4 6333.9 6356.2 5941.3 6041.5 6061.4 6070.6 6095.9 4818.5 4874.3 4887.8 4946.9 4973.2 4776.9 4903.8 4973.3 4992.8 5041.3 4871.4 4904.4 4918.0 4920.8 4942.8 4864.0 4929.0 4984.9 4988.7 4998.0 4452.6 4459.6 4472.8 4488.6 4511.5 5917.8 6021.0 6025.8 6078.3 6092.1 5703.4 5771.8 5777.4 5783.9 5796.3 6443.4 6465.5 6468.0 6494.2 6524.6 4809.9 4887.7 4900.4 4913.7 4918.6 6839.7 6850.0 6912.5 7029.4 7038.0 4954.1 4972.7 4973.7 4984.2 5025.7 5038.6 5052.7 5079.7 5150.9 5159.4 5707.9 5713.9 5743.5 5743.5 5770.0 6440.7 6474.6 6516.2 6529.3 6558.6 1669.6 1687.7 1715.8 1723.5 1734.6 1147.2 1207.0 1210.0 1211.1 1212.9 5517.7 5570.3 5603.7 5642.7 5681.7 6471.0 6540.7 6563.7 6611.2 6672.7 5624.4 5711.9 5742.9 5768.5 5787.5 3521.9 3577.2 3605.3 3615.5 3617.9 6465.7 6521.7 6557.9 6605.3 6615.2 6845.8 6926.4 6949.3 6958.4 6959.4 6452.8 6462.9 6470.2 6551.5 6619.1 6542.5 6688.3 6707.4 6754.3 6787.8 6672.7 6726.2 6746.7 6769.0 6799.8 6481.2 6600.6 6615.0 6626.5 6660.8 4883.9 4922.6 4922.6 4930.7 4966.4 6716.5 6717.0 6732.6 6793.9 6799.0 6485.5 6520.5 6521.5 6584.3 6634.0 6205.5 6394.9 6466.0 6509.3 6564.6 6152.6 6243.6 6351.4 6361.3 6375.6 6425.5 6445.4 6517.6 6543.8 6611.2 6249.2 6346.9 6384.6 6395.0 6405.9 00:40:08 INFO - PID 12321 | 00:40:08 INFO - PID 12321 | [#5] yui.html Cycles:180 Average:22702.85 Median:20573.78 stddev:30257.80 (147.1%) stddev-sans-first:30298.22 00:40:08 INFO - PID 12321 | Values: 859.1 886.2 898.5 905.9 906.5 17558.8 18577.7 18619.3 18640.4 19314.5 20555.3 21283.8 21320.3 21484.6 21508.5 991.2 1008.3 1014.0 1014.5 1014.7 1007.7 1010.0 1011.1 1011.8 1013.4 1084.8 1098.2 1098.2 1098.3 1099.3 1074.2 1083.2 1084.2 1084.9 1086.8 802.4 802.5 802.6 802.9 803.2 18948.9 18954.0 19169.6 19191.3 19632.8 20592.3 20669.4 21052.6 21085.9 21332.8 15623.1 15682.7 15769.0 15891.9 15896.8 3167.3 3168.6 3206.0 3207.8 3208.1 118802.4 121647.4 125367.4 125474.0 127170.4 15723.7 16148.8 16156.7 16174.5 16197.3 29225.7 30244.1 30473.8 30483.1 30528.5 7807.8 8040.4 8165.7 8170.7 8186.2 4135.9 4238.7 4245.0 4250.2 4253.8 5216.3 5222.3 5291.1 5315.5 5334.5 855.2 884.8 894.4 896.2 897.8 637.8 648.5 674.2 675.9 687.4 10539.4 13241.3 13538.5 13670.6 13786.6 660.9 674.7 684.1 692.6 696.7 5170.4 5522.3 5573.6 5613.4 5829.9 100205.5 101809.5 105553.5 106722.0 108040.0 84523.2 88641.6 91050.5 91748.5 92058.5 71167.0 75791.6 75928.2 76700.8 77284.0 11523.5 11896.8 12774.2 12819.9 12937.2 31815.5 34459.3 34462.7 35089.8 36247.6 63332.0 67609.3 67704.3 68649.7 70010.3 18490.7 18577.2 18723.5 18874.3 18882.5 20175.9 21083.8 21316.4 21389.5 21421.6 14830.3 14855.6 16742.7 17565.2 17605.6 19227.4 19297.9 19352.5 19569.9 19577.9 17607.9 18002.1 18013.8 18245.1 18246.4 12066.9 12487.1 12524.9 12708.8 12947.2 14044.7 14235.6 14492.2 14712.9 14949.4 00:40:08 INFO - PID 12321 | -------- Summary: end -------- 00:40:08 INFO - PID 12321 | 00:40:08 INFO - TEST-INFO | 12321: exit 0 00:40:08 INFO - TEST-OK | dromaeo_css | took 1112001ms 00:40:08 INFO - TEST-START | kraken 00:40:08 INFO - Initialising browser for kraken test... 00:40:08 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45403/getInfo.html -profile /tmp/tmp51XfqE/profile 00:40:08 INFO - TEST-INFO | started process 12675 (/builds/slave/test/build/application/firefox/firefox http://localhost:45403/getInfo.html) 00:40:14 INFO - TEST-INFO | 12675: exit 0 00:40:14 INFO - Browser initialized. 00:40:14 INFO - Running cycle 1/1 for kraken test... 00:40:14 INFO - TEST-INFO | started process 12879 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp51XfqE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 00:40:15 INFO - PID 12879 | 00:40:15 INFO - PID 12879 | (/builds/slave/test/build/application/firefox/firefox:12928): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 00:40:15 INFO - PID 12879 | 00:40:25 INFO - PID 12879 | RSS: Main: 171311104 00:40:25 INFO - PID 12879 | 00:40:28 INFO - PID 12879 | Cycle 1(1): loaded http://localhost:45403/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45403/tests/kraken/driver.html?testName=audio-beat-detection) 00:40:29 INFO - PID 12879 | RSS: Main: 177221632 00:40:29 INFO - PID 12879 | 00:40:31 INFO - PID 12879 | Cycle 1(1): loaded http://localhost:45403/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45403/tests/kraken/driver.html?testName=audio-dft) 00:40:32 INFO - PID 12879 | RSS: Main: 177426432 00:40:32 INFO - PID 12879 | 00:40:35 INFO - PID 12879 | Cycle 1(1): loaded http://localhost:45403/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45403/tests/kraken/driver.html?testName=audio-fft) 00:40:36 INFO - PID 12879 | RSS: Main: 171249664 00:40:36 INFO - PID 12879 | 00:40:38 INFO - PID 12879 | Cycle 1(1): loaded http://localhost:45403/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45403/tests/kraken/driver.html?testName=audio-oscillator) 00:40:38 INFO - PID 12879 | RSS: Main: 171626496 00:40:38 INFO - PID 12879 | 00:40:41 INFO - PID 12879 | Cycle 1(1): loaded http://localhost:45403/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45403/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:40:41 INFO - PID 12879 | RSS: Main: 171732992 00:40:41 INFO - PID 12879 | 00:40:44 INFO - PID 12879 | Cycle 1(1): loaded http://localhost:45403/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45403/tests/kraken/driver.html?testName=imaging-darkroom) 00:40:45 INFO - PID 12879 | RSS: Main: 174505984 00:40:45 INFO - PID 12879 | 00:40:48 INFO - PID 12879 | Cycle 1(1): loaded http://localhost:45403/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45403/tests/kraken/driver.html?testName=imaging-desaturate) 00:40:49 INFO - PID 12879 | RSS: Main: 174444544 00:40:49 INFO - PID 12879 | 00:40:52 INFO - PID 12879 | Cycle 1(1): loaded http://localhost:45403/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45403/tests/kraken/driver.html?testName=json-parse-financial) 00:40:52 INFO - PID 12879 | RSS: Main: 174514176 00:40:52 INFO - PID 12879 | 00:40:54 INFO - PID 12879 | Cycle 1(1): loaded http://localhost:45403/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45403/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:40:55 INFO - PID 12879 | RSS: Main: 174546944 00:40:55 INFO - PID 12879 | 00:40:56 INFO - PID 12879 | Cycle 1(1): loaded http://localhost:45403/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45403/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:40:57 INFO - PID 12879 | RSS: Main: 174645248 00:40:57 INFO - PID 12879 | 00:40:59 INFO - PID 12879 | Cycle 1(1): loaded http://localhost:45403/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45403/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:41:00 INFO - PID 12879 | RSS: Main: 171241472 00:41:00 INFO - PID 12879 | 00:41:03 INFO - PID 12879 | Cycle 1(1): loaded http://localhost:45403/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45403/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:41:03 INFO - PID 12879 | RSS: Main: 172011520 00:41:03 INFO - PID 12879 | 00:41:07 INFO - PID 12879 | Cycle 1(1): loaded http://localhost:45403/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45403/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:41:07 INFO - PID 12879 | RSS: Main: 172093440 00:41:07 INFO - PID 12879 | 00:41:09 INFO - PID 12879 | Cycle 1(1): loaded http://localhost:45403/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45403/tests/kraken/driver.html?testName=ai-astar) 00:41:09 INFO - PID 12879 | RSS: Main: 174686208 00:41:09 INFO - PID 12879 | 00:41:09 INFO - PID 12879 | __start_tp_report 00:41:09 INFO - PID 12879 | _x_x_mozilla_page_load 00:41:09 INFO - PID 12879 | _x_x_mozilla_page_load_details 00:41:09 INFO - PID 12879 | |i|pagename|runs| 00:41:09 INFO - PID 12879 | |0;ai-astar;101;109;102;108;110;109;108;100;107;107 00:41:09 INFO - PID 12879 | |1;audio-beat-detection;146;118;151;168;120;149;143;119;172;120 00:41:09 INFO - PID 12879 | |2;audio-dft;163;162;163;162;164;162;166;165;167;161 00:41:09 INFO - PID 12879 | |3;audio-fft;75;75;74;165;76;75;76;91;95;74 00:41:09 INFO - PID 12879 | |4;audio-oscillator;78;78;130;78;78;80;132;78;79;123 00:41:09 INFO - PID 12879 | |5;imaging-gaussian-blur;117;117;117;117;117;114;115;114;114;114 00:41:09 INFO - PID 12879 | |6;imaging-darkroom;151;152;150;150;151;151;149;151;151;151 00:41:09 INFO - PID 12879 | |7;imaging-desaturate;99;94;94;94;94;93;94;93;93;94 00:41:09 INFO - PID 12879 | |8;json-parse-financial;57;56;55;56;56;56;56;55;55;56 00:41:09 INFO - PID 12879 | |9;json-stringify-tinderbox;54;54;56;55;54;55;54;54;55;54 00:41:09 INFO - PID 12879 | |10;stanford-crypto-aes;80;80;81;91;90;94;81;99;91;82 00:41:09 INFO - PID 12879 | |11;stanford-crypto-ccm;137;131;133;135;127;134;126;130;128;185 00:41:09 INFO - PID 12879 | |12;stanford-crypto-pbkdf2;177;200;180;177;187;175;175;182;177;177 00:41:09 INFO - PID 12879 | |13;stanford-crypto-sha256-iterative;68;67;69;68;65;68;66;66;66;64 00:41:09 INFO - PID 12879 | __end_tp_report 00:41:09 INFO - PID 12879 | __start_cc_report 00:41:09 INFO - PID 12879 | _x_x_mozilla_cycle_collect,998 00:41:09 INFO - PID 12879 | __end_cc_report 00:41:09 INFO - PID 12879 | __startTimestamp1501486869717__endTimestamp 00:41:09 INFO - PID 12879 | 00:41:09 INFO - PID 12879 | ------- Summary: start ------- 00:41:09 INFO - PID 12879 | Number of tests: 14 00:41:09 INFO - PID 12879 | 00:41:09 INFO - PID 12879 | [#0] ai-astar Cycles:10 Average:106.10 Median:108.00 stddev:3.67 (3.4%) stddev-sans-first:3.39 00:41:09 INFO - PID 12879 | Values: 101.0 109.0 102.0 108.0 110.0 109.0 108.0 100.0 107.0 107.0 00:41:09 INFO - PID 12879 | 00:41:09 INFO - PID 12879 | [#1] audio-beat-detection Cycles:10 Average:140.60 Median:147.50 stddev:20.48 (13.9%) stddev-sans-first:21.63 00:41:09 INFO - PID 12879 | Values: 146.0 118.0 151.0 168.0 120.0 149.0 143.0 119.0 172.0 120.0 00:41:09 INFO - PID 12879 | 00:41:09 INFO - PID 12879 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.50 stddev:1.96 (1.2%) stddev-sans-first:2.07 00:41:09 INFO - PID 12879 | Values: 163.0 162.0 163.0 162.0 164.0 162.0 166.0 165.0 167.0 161.0 00:41:09 INFO - PID 12879 | 00:41:09 INFO - PID 12879 | [#3] audio-fft Cycles:10 Average:87.60 Median:75.50 stddev:28.23 (37.4%) stddev-sans-first:29.57 00:41:09 INFO - PID 12879 | Values: 75.0 75.0 74.0 165.0 76.0 75.0 76.0 91.0 95.0 74.0 00:41:09 INFO - PID 12879 | 00:41:09 INFO - PID 12879 | [#4] audio-oscillator Cycles:10 Average:93.40 Median:78.00 stddev:24.22 (31.0%) stddev-sans-first:25.04 00:41:09 INFO - PID 12879 | Values: 78.0 78.0 130.0 78.0 78.0 80.0 132.0 78.0 79.0 123.0 00:41:09 INFO - PID 12879 | 00:41:09 INFO - PID 12879 | [#5] imaging-gaussian-blur Cycles:10 Average:115.60 Median:117.00 stddev:1.51 (1.3%) stddev-sans-first:1.51 00:41:09 INFO - PID 12879 | Values: 117.0 117.0 117.0 117.0 117.0 114.0 115.0 114.0 114.0 114.0 00:41:09 INFO - PID 12879 | 00:41:09 INFO - PID 12879 | [#6] imaging-darkroom Cycles:10 Average:150.70 Median:151.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 00:41:09 INFO - PID 12879 | Values: 151.0 152.0 150.0 150.0 151.0 151.0 149.0 151.0 151.0 151.0 00:41:09 INFO - PID 12879 | 00:41:09 INFO - PID 12879 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:1.75 (1.9%) stddev-sans-first:0.50 00:41:09 INFO - PID 12879 | Values: 99.0 94.0 94.0 94.0 94.0 93.0 94.0 93.0 93.0 94.0 00:41:09 INFO - PID 12879 | 00:41:09 INFO - PID 12879 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:56.00 stddev:0.63 (1.1%) stddev-sans-first:0.50 00:41:09 INFO - PID 12879 | Values: 57.0 56.0 55.0 56.0 56.0 56.0 56.0 55.0 55.0 56.0 00:41:09 INFO - PID 12879 | 00:41:09 INFO - PID 12879 | [#9] json-stringify-tinderbox Cycles:10 Average:54.50 Median:54.50 stddev:0.71 (1.3%) stddev-sans-first:0.73 00:41:09 INFO - PID 12879 | Values: 54.0 54.0 56.0 55.0 54.0 55.0 54.0 54.0 55.0 54.0 00:41:09 INFO - PID 12879 | 00:41:09 INFO - PID 12879 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:90.50 stddev:6.90 (7.6%) stddev-sans-first:6.86 00:41:09 INFO - PID 12879 | Values: 80.0 80.0 81.0 91.0 90.0 94.0 81.0 99.0 91.0 82.0 00:41:09 INFO - PID 12879 | 00:41:09 INFO - PID 12879 | [#11] stanford-crypto-ccm Cycles:10 Average:136.60 Median:133.50 stddev:17.38 (13.0%) stddev-sans-first:18.43 00:41:09 INFO - PID 12879 | Values: 137.0 131.0 133.0 135.0 127.0 134.0 126.0 130.0 128.0 185.0 00:41:09 INFO - PID 12879 | 00:41:09 INFO - PID 12879 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.70 Median:178.50 stddev:7.70 (4.3%) stddev-sans-first:8.05 00:41:09 INFO - PID 12879 | Values: 177.0 200.0 180.0 177.0 187.0 175.0 175.0 182.0 177.0 177.0 00:41:09 INFO - PID 12879 | 00:41:09 INFO - PID 12879 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.50 stddev:1.57 (2.3%) stddev-sans-first:1.59 00:41:09 INFO - PID 12879 | Values: 68.0 67.0 69.0 68.0 65.0 68.0 66.0 66.0 66.0 64.0 00:41:09 INFO - PID 12879 | -------- Summary: end -------- 00:41:09 INFO - PID 12879 | 00:41:10 INFO - PID 12879 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 00:41:10 INFO - TEST-INFO | 12879: exit 0 00:41:10 INFO - TEST-OK | kraken | took 61832ms 00:41:10 INFO - SUITE-END | took 1173s 00:41:10 INFO - Completed test suite (00:19:34) 00:41:10 INFO - javascript benchmark 00:41:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8379.486132328531, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3077.0768769369183, 3154.369126174765, 3156.7632427567933, 3159.85780639871, 3159.905202843914, 6081.908771368422, 6153.815385538435, 6165.136880836675, 6246.65643389614, 6285.120083188357, 6132.632042077478, 6156.56904016719, 6162.722677479513, 6180.536459765513, 6181.350958149397, 5615.971920140393, 5629.155626655994, 5637.492625663689, 5649.180868774025, 5709.229254050712, 5675.9432405675825, 5718.914216286759, 5733.598648094635, 5734.942650573504, 5764.106563482667, 5755.2230448889495, 5759.366469688331, 5776.624519406246, 5794.826155215329, 5803.73883175256, 5678.772849086032, 5680.772769089232, 5729.39841316662, 5735.1970724098655, 5787.189793428924, 5592.636478628876, 5597.244372009767, 5678.488935995739, 5685.772569097231, 5686.118651609007, 6004.939950600526, 6020.1872747179, 6039.969800150971, 6048.637081775108, 6086.7565297388055, 6574.145361103026, 6575.309592492815, 6578.868422631568, 6682.632455214961, 6695.363940425652, 6449.226092868886, 6604.504662150358, 6700.363465470772, 6770.086038384804, 6815.250322464525, 6083.422074902877, 6219.564630475868, 6219.813405597839, 6223.875522489525, 6227.377262273736, 6842.144731908512, 6863.10779598649, 6923.826904327432, 6924.134483189601, 6929.341712537301, 6486.481081513468, 6521.217453905467, 6572.14562106923, 6600.108985287021, 6612.0, 6442.549021568539, 6584.637844918576, 6618.503612229102, 6627.0, 6729.192496900306, 6457.677116144174, 6459.644719540471, 6534.150560427114, 6539.117219175446, 6541.771038013647, 6544.116544266463, 6565.507586930999, 6577.144971153815, 6648.069270302161, 6649.401553860176, 5390.407055223922, 5393.406725260218, 5418.91871621926, 5424.701641409761, 5437.891242175214, 4584.037352156018, 4617.8152873884665, 4642.419697537808, 4646.558576935186, 4657.510961349078, 5596.748146333425, 5696.0, 5701.743421546041, 5786.276715410574, 5789.797357092481, 6616.735330586819, 6672.232693240339, 6705.966470167716, 6746.325367463214, 6752.459803215731, 5732.512736417368, 5761.9135712964335, 5764.654120752768, 5766.163906233573, 5780.768769249183, 5819.709014549256, 5834.445727655866, 5907.675077870673, 5919.496842768327, 5921.792737254175, 6299.716512757029, 6402.647854368054, 6406.4554512866, 6489.351064893567, 6507.34926507355, 6582.703778329891, 6583.506237032146, 6583.868322633616, 6589.0, 6596.109525214035, 6254.249490061222, 6323.683815809283, 6332.841678958063, 6336.334684858208, 6342.048692696132, 6397.616143031433, 6398.104265402941, 6413.551051426542, 6439.098526206429, 6473.838154046187, 6527.934720652733, 6529.379708927644, 6570.080188773671, 6573.046908198189, 6595.736170553124, 6421.839454013687, 6427.453666438405, 6440.710168042356, 6510.381513756186, 6526.575772574767, 6253.218347706536, 6450.709718062604, 6535.117759102461, 6557.082008518906, 6563.671816409256, 6281.874362512815, 6291.653959032297, 6299.905501417391, 6300.464460520907, 6302.905456418249, 6497.0, 6501.609903405811, 6549.6070235786, 6581.6709164542535, 6582.17722784652, 6274.937250627435, 6303.810885673437, 6348.460380867493, 6355.300916899045, 6360.268569114611], "value": 6045.037055123473, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [820.0, 855.8202777416742, 878.50803550012, 906.533135435251, 907.8502047162218, 38421.04473806561, 39824.20351592974, 39833.4024989625, 39923.800380998124, 39953.2009359813, 35991.10022249445, 35998.820005899935, 36034.63965360346, 36090.2781944361, 36384.09039774007, 6804.591724496534, 6851.212110607269, 6854.691538880737, 6899.37905588497, 6933.861322773541, 6739.427148692367, 6835.418989385908, 6852.451803855704, 6879.1057162568795, 6908.861822763542, 6835.350641689057, 7028.226895041541, 7478.925210747904, 7525.924740752577, 7528.360089392409, 7449.441291903102, 7466.66400011998, 7469.962650186769, 7470.0662417197855, 7489.850202995937, 7306.671199796022, 7336.119665640104, 7391.186969433358, 7392.815179620498, 7393.2606739326175, 37755.622443775486, 38142.42786358207, 38309.61690383089, 38328.233435331415, 38333.0, 3564.287142571496, 3611.331903597843, 3633.218857945528, 3633.400488919325, 3638.945415818765, 29919.85040074786, 29978.25054373636, 30148.24629384283, 30186.245343866358, 30186.396272074657, 4757.690750101232, 4781.330613714083, 4804.159272127364, 4823.469418363977, 4884.462709101996, 175970.0, 177849.0, 181487.0, 186652.0, 191021.0, 46926.296105558446, 47165.0, 47252.29121563179, 47267.52732472631, 47323.0, 48952.510474895505, 49037.26444103341, 49069.75465122652, 49247.0, 49369.753151234014, 15223.0, 15247.923760381127, 15301.770473442908, 15304.464343748137, 15316.923415382851, 12407.813882791765, 12444.688882777822, 12447.75104497905, 12466.81299780504, 12491.125621206611, 14024.228667423185, 14091.0, 14145.504907328193, 14183.78724319136, 14371.281435928162, 5675.460831221028, 5865.35481097079, 5871.823845284648, 5881.41185881417, 5915.852103697442, 963.2582911158369, 966.4201479112617, 982.9557669904872, 994.3288280410839, 1011.1354791653177, 22315.10739570399, 22507.43731406728, 22552.323430297118, 22696.546069078526, 22883.427914302276, 1038.672818062308, 1061.5918033425437, 1090.1224514266091, 1108.5953626926114, 1113.276370359273, 11818.0, 11819.704507387212, 11835.526578936746, 11916.761664766656, 12040.638780836589, 219379.0, 220146.0, 220562.0, 220641.0, 220797.0, 48390.54828355155, 49112.508874910796, 49119.754401227765, 49158.75420622945, 49222.50777492251, 1447.1317209674112, 1465.8314293856129, 1468.2805425341505, 1478.2904205980974, 1489.932953017117, 21401.67897481508, 21608.567828643023, 22198.667019995035, 22248.332550023526, 22328.441788955406, 35703.10742231361, 35717.46423803593, 35751.0, 35763.82118089393, 35857.28285434329, 179377.0, 180670.0, 181061.0, 181081.0, 181264.0, 32008.83995580007, 34185.82907085449, 34495.13762155966, 34564.65435345614, 34580.30839383148, 43305.56694433015, 44314.556854431044, 44357.33463998107, 44602.77698611486, 45164.32253516265, 29022.0, 30148.09555713332, 30427.695723042485, 31007.534886976264, 31571.526427103152, 28792.424151516432, 31184.0, 31387.529187062668, 31507.21231969219, 31901.20246993844, 34906.825465872505, 35365.64634353624, 35631.0, 35788.82105589456, 35959.0, 30285.242868928453, 31766.228270870943, 31868.84065579657, 32263.51604725884, 32315.19212019718, 23583.41041473977, 23666.45556680319, 24002.27993160138, 24005.27984160478, 24061.759382406653], "value": 16560.92554526501, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.8069456384828, 571.3572231239855, 572.936976932537, 576.7721749908787, 581.3227589857815, 21810.454738631543, 22746.090156393744, 22780.31659050229, 22843.08627654892, 22993.4251643709, 22928.65607015892, 23845.28464146074, 24830.875845620747, 25000.374990625245, 25031.249062528153, 6398.264199617034, 6566.179227596551, 6566.244881838602, 6568.441682456997, 6570.737170513197, 6136.355682653324, 6344.3338449462835, 6347.809565713036, 6400.679966001681, 6405.935940640604, 6431.549791514596, 6438.098666186737, 6444.806655800334, 6444.838879028015, 6466.06242094896, 6449.6775161241985, 6455.548111632188, 6457.612543247374, 6458.354164583528, 6462.353764623547, 6010.2186715726675, 6017.277926648786, 6022.3676513966275, 6027.367126451747, 6032.788852390189, 27995.300117497227, 29496.41007179866, 29986.85006574975, 30006.249843753863, 30462.54306185409, 1864.3102052240758, 1918.4820098573307, 1918.7793403758608, 1918.808119188084, 1920.3662791278844, 19038.61922761537, 19575.216991320474, 19581.706274405897, 19646.214151433924, 19651.115699793543, 2291.4385975435957, 2328.5924963131383, 2406.3743426709007, 2421.140495124223, 2422.2127808462146, 135869.0, 137918.0, 142132.28933855367, 142306.0, 142431.0, 13791.448342066406, 15058.548243552492, 15374.461893833663, 15395.384184632714, 15795.21023948798, 23903.52192956131, 23941.880290598434, 23998.0, 24024.39939001539, 24048.759512404653, 10126.341787783771, 10403.791924161626, 10630.255882088335, 10636.840447393295, 10724.41015744126, 9639.18066964316, 9664.516774161264, 9687.854682179774, 9722.319437639297, 9768.974257702981, 9191.678291259908, 9406.43561386319, 9641.180499657466, 9706.369086009387, 9824.263180261509, 2909.1418031680705, 2927.458420192271, 2941.6175897133235, 2949.439606474763, 2955.8226506409255, 927.758782716485, 946.4415994563241, 967.8834154024031, 968.7820240445843, 977.0620204603518, 19612.313569025016, 19844.404667859988, 20001.399958001282, 20019.899900500404, 20363.796362036486, 978.1392374710209, 1019.612547232062, 1039.5581877701945, 1039.823230050878, 1046.7644779924608, 10744.73138171552, 10778.353298802096, 11344.716382090513, 13490.460381584822, 14454.915881308943, 528129.0, 546063.0, 548264.0, 552994.0, 560637.0, 125329.0, 128582.0, 130644.0, 130720.3463982674, 130946.34526827495, 1240.1566934484456, 1276.3681977421236, 1287.1376177960976, 1311.1477539599146, 1315.4409376015155, 19120.52198694988, 21124.676285608264, 21139.788602113782, 21829.235976740736, 22589.322320330415, 61772.382276176664, 62120.37879621146, 62484.0, 64000.359996401305, 64059.0, 72026.63986680243, 72034.27965720276, 72053.639731801, 72140.63929680319, 73075.63462182655, 16887.155642217593, 19575.314863979693, 21123.577528449652, 21628.567428651655, 21681.0, 24012.51974960526, 24127.276181714577, 24143.637845431982, 24463.38841528905, 25011.499770004863, 18464.81535184631, 19046.430479081428, 19140.71288930695, 19153.61692766165, 19434.514137146685, 16597.25312360971, 16680.416185433936, 16708.49874503767, 17523.649527009642, 18345.908270458563, 19340.0, 19341.613167736847, 19499.61000779948, 19543.51141221424, 20037.599248014667, 20227.0, 21550.461238468535, 21585.13659453604, 21635.350939471842, 21779.782202177776, 18278.086095695428, 18412.26350945947, 19015.619687606446, 19032.524186894883, 19259.90370048141], "value": 12521.361721018706, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1276.1322300835432, 1320.27384938284, 1332.347149896551, 1334.6529902225418, 1347.7978303254508, 13785.10396824207, 14365.0, 14365.640858978504, 14366.425342986282, 14380.352884120213, 13458.730825383487, 14416.423343066292, 14417.495387661435, 14420.35108420121, 14446.133232006086, 2665.2270841456, 2743.876525556345, 2744.217897899099, 2745.492083964463, 2745.9862700686467, 2390.6533552634855, 2642.128097727745, 2685.7582817546418, 2728.290644432452, 2738.5207588672, 2725.727427257278, 2745.6018877262786, 2746.4781691478556, 2748.2579703480046, 2749.780017598597, 2602.856842873641, 2602.9609555856678, 2631.8289311194712, 2632.7762140218106, 2654.0047482194177, 2609.7781688556497, 2641.643378143945, 2642.1280977277643, 2642.6696662917134, 2652.641893344393, 13991.790123148161, 14072.648183795385, 14132.293385330795, 14147.504837330747, 14147.787783183261, 7494.325510704063, 7780.105287891852, 7786.883196752054, 7790.220977902221, 7796.337311328544, 5047.697138171685, 5109.926915347782, 5163.638545301793, 5274.604404669665, 5299.49654782795, 1694.220658497093, 1718.2525601363448, 1731.2555601091526, 1748.728947013215, 1759.9296028158858, 22754.431139221488, 22973.88513057424, 22993.425164371023, 23007.309780706604, 23017.309480715438, 6149.3235744068115, 6429.196350456193, 6472.9029064564065, 6496.967515162394, 6525.401276687242, 15524.534263972098, 15630.0, 15648.374065037498, 15649.217539122998, 15661.0, 7305.817354566178, 7553.886691699519, 7574.166841647414, 7575.469717119859, 7585.544867307979, 6621.475963496095, 6998.965005174941, 7046.1192350956135, 7051.435885129177, 7061.470389720792, 4836.443808961944, 4994.1759609663995, 5016.799328026838, 5027.874303142451, 5075.187969924795, 1410.5486244401898, 1443.2062365698823, 1460.4669295707204, 1472.6097584139998, 1515.4468618954002, 743.8809790433505, 761.5468796066332, 776.7630872583803, 786.4887822915036, 793.1117148793388, 6727.495437842182, 7110.92889071113, 7133.89299160513, 7234.385077268385, 7278.1266248049515, 901.2519608724742, 914.29599208609, 921.5898924978454, 928.0858354520792, 961.1829944547219, 4274.1451709658195, 4501.167284052461, 4522.0, 4584.633229341712, 4619.260918253063, 18423.26306947707, 18610.0, 18679.81320186808, 19180.232790688497, 19222.03889805504, 18342.358017469593, 19076.61846763057, 19447.3193438229, 19629.8037019628, 19641.508962276057, 9789.36369136018, 10340.276180667432, 10355.585776568852, 10365.0, 10531.94680531956, 6733.42765864907, 7015.649217539205, 7156.928430715834, 7202.89195662076, 7250.564966102051, 16755.078470684228, 16896.915515422344, 16948.830511695218, 17129.0, 17254.741178882075, 17265.82734172642, 17306.567335816704, 17495.912520437316, 17499.0, 17529.912350438168, 10052.497375131361, 10342.844857326996, 10398.324108932895, 10455.059044686015, 10468.476576171313, 12770.489180433051, 12989.220646761225, 12997.935010324887, 13004.154729942524, 13014.0, 9795.706128815862, 10053.145482633765, 10178.491075446345, 10232.948835255776, 10608.151347892304, 10015.14871235953, 10190.082892539707, 10369.792604147724, 10406.271560990657, 10453.84319235197, 8263.834723305621, 8567.4002819802, 8579.2707619853, 8583.969923609207, 8588.098249683942, 5379.757910894097, 5605.635633683797, 5659.292588426447, 5684.516816070515, 5724.8282551523525, 6086.7260973255425, 6114.602550834182, 6222.439980401786, 6259.874802504016, 6325.905111423241], "value": 6137.0961389840995, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [472.56287933661355, 499.73763774018624, 512.1600575056907, 516.1895823557012, 527.6491133396291, 6219.844503887405, 6264.906026409608, 6269.435750782434, 6333.904991425121, 6356.2054743157105, 5941.346451890288, 6041.546883983697, 6061.363556826536, 6070.63079990605, 6095.878082438348, 4818.51814818518, 4874.268859671042, 4887.780049897763, 4946.925796113062, 4973.179425394806, 4776.880577985544, 4903.82836600719, 4973.278874563186, 4992.750362481861, 5041.3194218780545, 4871.415430148387, 4904.36243288372, 4917.950820491803, 4920.7785649645675, 4942.802287908479, 4863.975680121594, 4928.97535512322, 4984.850454486371, 4988.65079444439, 4998.0, 4452.554744525554, 4459.620932220765, 4472.84345047925, 4488.573585509372, 4511.458624965026, 5917.822465326047, 6020.96989515054, 6025.758969641209, 6078.300995385543, 6092.055731361602, 5703.4011428799795, 5771.769129234825, 5777.364489906107, 5783.913241301342, 5796.333421656479, 6443.420092191725, 6465.515086368541, 6467.967660161716, 6494.220693516761, 6524.608523488606, 4809.9038019239415, 4887.70673759572, 4900.411950565919, 4913.732367975292, 4918.581920536759, 6839.726410943556, 6849.965750171217, 6912.516123871281, 7029.437644988439, 7037.964810175968, 4954.133026720309, 4972.676776009548, 4973.651844370932, 4984.202527595639, 5025.748712564357, 5038.5969122470115, 5052.711558552545, 5079.720615366116, 5150.922736158961, 5159.355080614923, 5707.914381284284, 5713.885722285531, 5743.4543718346695, 5743.530281978789, 5770.0, 6440.742370305229, 6474.640325531597, 6516.185476815398, 6529.2817790043055, 6558.573692709959, 1669.5909502172046, 1687.6962146813692, 1715.759793628893, 1723.5346456456937, 1734.6357264974245, 1147.2370873369282, 1207.0265116534354, 1209.9818502722467, 1211.0856303490984, 1212.902967762577, 5517.69652669099, 5570.275864137636, 5603.719814009365, 5642.714700546286, 5681.744321505542, 6470.967645161744, 6540.738370465128, 6563.704633291513, 6611.173603299588, 6672.699728512229, 5624.409437009137, 5711.914321285184, 5742.908847318996, 5768.451997060357, 5787.5080618147085, 3521.9295614087573, 3577.2308953575107, 3605.3330133925306, 3615.493830863681, 3617.855285788539, 6465.709043093072, 6521.739130434825, 6557.934420655828, 6605.30644282353, 6615.206175258903, 6845.794626161223, 6926.376626103574, 6949.339812717783, 6958.408535274457, 6959.399338152253, 6452.77415290472, 6462.935370646233, 6470.191226096738, 6551.525906671056, 6619.139511863524, 6542.509311801729, 6688.264290927897, 6707.3628005339415, 6754.324567543206, 6787.762428314985, 6672.698823729326, 6726.159230096238, 6746.662666866735, 6769.0, 6799.830004249933, 6481.157449531531, 6600.60396376219, 6615.0, 6626.5030122741955, 6660.800175994728, 4883.87790305231, 4922.606191504599, 4922.630802689741, 4930.728809915489, 4966.404031516241, 6716.462682985251, 6717.018479548447, 6732.629705366252, 6793.898091528532, 6798.966005169942, 6485.513586481127, 6520.510961677798, 6521.478281737354, 6584.275729669828, 6633.9668301658185, 6205.541697701127, 6394.904076438764, 6465.997770345604, 6509.251436084722, 6564.6389448580785, 6152.600080994721, 6243.594166379171, 6351.396617321347, 6361.332060133619, 6375.617462952052, 6425.518086143465, 6445.387688169616, 6517.608943463408, 6543.76083838503, 6611.206655201407, 6249.1563638908165, 6346.873062538816, 6384.6169229846355, 6394.968025159845, 6405.935940640534], "value": 5031.158194653255, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [859.1108203009886, 886.2068448738379, 898.4968417686092, 905.9365844390895, 906.5150144672598, 17558.82441175588, 18577.72133417998, 18619.255229790808, 18640.440786776417, 19314.51713707158, 20555.280565180223, 21283.787162128374, 21320.253791117277, 21484.57030859386, 21508.462288442795, 991.1723710701573, 1008.2690049713935, 1014.0, 1014.5181039006486, 1014.695591322604, 1007.6825799873053, 1010.0404615615158, 1011.1001208924064, 1011.7723512209767, 1013.4089479517161, 1084.7776205877776, 1098.1818545183849, 1098.203802243375, 1098.3355070182545, 1099.290957332524, 1074.1943542343242, 1083.1659622091024, 1084.2247792828127, 1084.9457527123652, 1086.760912599227, 802.4182467710921, 802.5345299726204, 802.5706247157742, 802.9116797152309, 803.2409373142383, 18948.905255473772, 18954.0, 19169.616607667907, 19191.32830350945, 19632.80367196324, 20592.27927022547, 20669.379918602466, 21052.578948421098, 21085.8945705272, 21332.786672133392, 15623.062616243062, 15682.686346273125, 15769.0, 15891.92054039734, 15896.84103158965, 3167.31902640931, 3168.572242747223, 3205.9679403206137, 3207.759418043656, 3208.0536241808722, 118802.40598797037, 121647.39176304062, 125367.37316313451, 125474.0, 127170.3641481796, 15723.68552628941, 16148.83851161497, 16156.676866462605, 16174.514764557081, 16197.271122799502, 29225.7077429223, 30244.09267721972, 30473.847630761706, 30483.08550743481, 30528.54207186894, 7807.80480487981, 8040.437169398086, 8165.673373065011, 8170.714025009215, 8186.181381861886, 4135.937960930589, 4238.660907127422, 4244.957550424518, 4250.234957707642, 4253.787310634456, 5216.295800067019, 5222.321098257278, 5291.100512912814, 5315.495027972336, 5334.466553344634, 855.1619412975194, 884.8363052835246, 894.4409743910056, 896.2113340260529, 897.7845317123844, 637.8182218067828, 648.45205801098, 674.1539368093012, 675.9019942108366, 687.3641881259815, 10539.42033188182, 13241.337933103307, 13538.526151584647, 13670.589882303548, 13786.586402407944, 660.9008648702637, 674.699758607415, 684.090160087083, 692.6155983429145, 696.6586372677453, 5170.37955445349, 5522.30971128609, 5573.637713548606, 5613.382527921925, 5829.883402332014, 100205.49897250468, 101809.49095254476, 105553.47223263835, 106722.0, 108040.0, 84523.15476845276, 88641.55679221563, 91050.54474727584, 91748.54125729328, 92058.53970730238, 71167.0, 75791.62104189444, 75928.24071759322, 76700.81151945423, 77284.0, 11523.53905843757, 11896.76206475883, 12774.23354598727, 12819.935900320439, 12937.223766574036, 31815.522767158975, 34459.31081378408, 34462.655373445945, 35089.824550878104, 36247.63752362443, 63332.0, 67609.3239067603, 67704.3229567698, 68649.65675171593, 70010.29989700038, 18490.722639160693, 18577.16402761852, 18723.531911702317, 18874.33939812155, 18882.52793680114, 20175.899120504302, 21083.789162108795, 21316.36050918475, 21389.46526336854, 21421.57156856823, 14830.258487075818, 14855.554333370017, 16742.748858767372, 17565.209565569323, 17605.559861003065, 19227.423177304703, 19297.903510482356, 19352.516187095436, 19569.902150489157, 19577.902110489358, 17607.911960440117, 18002.09989500546, 18013.80605588339, 18245.08774561293, 18246.361377351728, 12066.939665301617, 12487.12590118683, 12524.874751252735, 12708.809367859674, 12947.158434701714, 14044.719105617625, 14235.64410889736, 14492.202928838593, 14712.852871471148, 14949.402023918921], "value": 8943.569061326081, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1532.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 109.0, 102.0, 108.0, 110.0, 109.0, 108.0, 100.0, 107.0, 107.0], "value": 106.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 118.0, 151.0, 168.0, 120.0, 149.0, 143.0, 119.0, 172.0, 120.0], "value": 140.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 162.0, 164.0, 162.0, 166.0, 165.0, 167.0, 161.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 165.0, 76.0, 75.0, 76.0, 91.0, 95.0, 74.0], "value": 87.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 130.0, 78.0, 78.0, 80.0, 132.0, 78.0, 79.0, 123.0], "value": 93.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 114.0, 115.0, 114.0, 114.0, 114.0], "value": 115.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 152.0, 150.0, 150.0, 151.0, 151.0, 149.0, 151.0, 151.0, 151.0], "value": 150.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 93.0, 93.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 55.0, 56.0, 56.0, 56.0, 56.0, 55.0, 55.0, 56.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 56.0, 55.0, 54.0, 55.0, 54.0, 54.0, 55.0, 54.0], "value": 54.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 81.0, 91.0, 90.0, 94.0, 81.0, 99.0, 91.0, 82.0], "value": 86.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 131.0, 133.0, 135.0, 127.0, 134.0, 126.0, 130.0, 128.0, 185.0], "value": 136.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 200.0, 180.0, 177.0, 187.0, 175.0, 175.0, 182.0, 177.0, 177.0], "value": 180.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 69.0, 68.0, 65.0, 68.0, 66.0, 66.0, 66.0, 64.0], "value": 66.7, "unit": "score"}]}]} 00:41:10 INFO - Return code: 0 00:41:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:41:11 INFO - # TBPL SUCCESS # 00:41:11 INFO - Running post-action listener: _package_coverage_data 00:41:11 INFO - Running post-action listener: _resource_record_post_action 00:41:11 INFO - [mozharness: 2017-07-31 07:41:11.011950Z] Finished run-tests step (success) 00:41:11 INFO - Running post-run listener: _resource_record_post_run 00:41:11 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 12288; Write bytes: 443764736; Read time: 300; Write time: 245344 00:41:11 INFO - TinderboxPrint: CPU usage
13.1% 00:41:11 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 300 00:41:11 INFO - TinderboxPrint: I/O write bytes / time
443,764,736 / 245,344 00:41:11 INFO - TinderboxPrint: CPU idle
8,264.4 (86.9%) 00:41:11 INFO - TinderboxPrint: CPU user
1,201.0 (12.6%) 00:41:11 INFO - TinderboxPrint: Swap in / out
0 / 0 00:41:11 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 116994048; Read time: 152; Write time: 76060 00:41:11 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 00:41:11 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 326770688; Read time: 140; Write time: 169284 00:41:11 INFO - Running post-run listener: _upload_blobber_files 00:41:11 INFO - Blob upload gear active. 00:41:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:41:11 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 00:41:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:41:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:41:12 INFO - (blobuploader) - INFO - Open directory for files ... 00:41:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:41:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:41:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:41:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:41:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:41:12 INFO - (blobuploader) - INFO - Done attempting. 00:41:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:41:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:41:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:41:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:41:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:41:20 INFO - (blobuploader) - INFO - Done attempting. 00:41:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 00:41:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:41:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:41:21 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 00:41:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:41:21 INFO - (blobuploader) - INFO - Done attempting. 00:41:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:41:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:41:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:41:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:41:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:41:21 INFO - (blobuploader) - INFO - Done attempting. 00:41:21 INFO - (blobuploader) - INFO - Iteration through files over. 00:41:21 INFO - Return code: 0 00:41:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:41:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:41:21 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/70b7b2b59666ec0a84e6fcf21a283ee9367181b0b2efaaa2f2b5444f382b376506995837e953df64152ce8fe2bac5d7b85fccf716096aa151aae69b1cf31d2df", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1672f5354507f71e71ff58d2931c151c89e5e76b05021b9a893b3e17aad55772c69c9715f174c57f1c28fe7afe4c0915e3e34e2051b3e1d9be3fdea9b3797f18", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5121dab88444e21bfd3c5d53d106f9a948599d569cd20624f3b0a6c032143a1736c3be31f8ec8ffef53a44665179f7cf7b76a704d30031b92c85417df7fe772e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c2ca246b83d83ff976dc3a1114b2e005ce1fa92cf02810366492cd01384e128400b174c1fc7b0fcd6ceb9383166351170916686097f34d6b314eb6d6aedcd33d"} 00:41:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:41:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:41:21 INFO - Contents: 00:41:21 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/70b7b2b59666ec0a84e6fcf21a283ee9367181b0b2efaaa2f2b5444f382b376506995837e953df64152ce8fe2bac5d7b85fccf716096aa151aae69b1cf31d2df", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1672f5354507f71e71ff58d2931c151c89e5e76b05021b9a893b3e17aad55772c69c9715f174c57f1c28fe7afe4c0915e3e34e2051b3e1d9be3fdea9b3797f18", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5121dab88444e21bfd3c5d53d106f9a948599d569cd20624f3b0a6c032143a1736c3be31f8ec8ffef53a44665179f7cf7b76a704d30031b92c85417df7fe772e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c2ca246b83d83ff976dc3a1114b2e005ce1fa92cf02810366492cd01384e128400b174c1fc7b0fcd6ceb9383166351170916686097f34d6b314eb6d6aedcd33d"} 00:41:21 INFO - Running post-run listener: copy_logs_to_upload_dir 00:41:21 INFO - Copying logs to upload dir... 00:41:21 INFO - mkdir: /builds/slave/test/build/upload/logs 00:41:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.150491 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-07-31 00:41:21.639986) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-31 00:41:21.645564) ========= 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=bb9b54edd4a927dc735d112f000001d9-1501477576.126492-1966430490 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/70b7b2b59666ec0a84e6fcf21a283ee9367181b0b2efaaa2f2b5444f382b376506995837e953df64152ce8fe2bac5d7b85fccf716096aa151aae69b1cf31d2df", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1672f5354507f71e71ff58d2931c151c89e5e76b05021b9a893b3e17aad55772c69c9715f174c57f1c28fe7afe4c0915e3e34e2051b3e1d9be3fdea9b3797f18", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5121dab88444e21bfd3c5d53d106f9a948599d569cd20624f3b0a6c032143a1736c3be31f8ec8ffef53a44665179f7cf7b76a704d30031b92c85417df7fe772e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c2ca246b83d83ff976dc3a1114b2e005ce1fa92cf02810366492cd01384e128400b174c1fc7b0fcd6ceb9383166351170916686097f34d6b314eb6d6aedcd33d"} build_url:https://queue.taskcluster.net/v1/task/JacXY8NJTua8V_2O70iG6g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011406 build_url: 'https://queue.taskcluster.net/v1/task/JacXY8NJTua8V_2O70iG6g/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/70b7b2b59666ec0a84e6fcf21a283ee9367181b0b2efaaa2f2b5444f382b376506995837e953df64152ce8fe2bac5d7b85fccf716096aa151aae69b1cf31d2df", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1672f5354507f71e71ff58d2931c151c89e5e76b05021b9a893b3e17aad55772c69c9715f174c57f1c28fe7afe4c0915e3e34e2051b3e1d9be3fdea9b3797f18", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5121dab88444e21bfd3c5d53d106f9a948599d569cd20624f3b0a6c032143a1736c3be31f8ec8ffef53a44665179f7cf7b76a704d30031b92c85417df7fe772e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c2ca246b83d83ff976dc3a1114b2e005ce1fa92cf02810366492cd01384e128400b174c1fc7b0fcd6ceb9383166351170916686097f34d6b314eb6d6aedcd33d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-31 00:41:21.672607) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 00:41:21.672930) ========= 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=bb9b54edd4a927dc735d112f000001d9-1501477576.126492-1966430490 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004443 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 00:41:21.754044) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-31 00:41:21.754384) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-31 00:41:21.754666) ========= ========= Total master_lag: 0.16 =========