builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-072 starttime: 1505348784.09 results: success (0) revision: c15e2f280729b6503f9455cd4448ab2852eb5806 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-13 17:26:24.087993) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-13 17:26:24.088496) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-13 17:26:24.088807) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-13 17:26:24.103516) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 17:26:24.103822) ========= 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=199fb4c72b90437b990b419b000001c5-1505348783.246139-355573265 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-13 17:26:24-- 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% 46.7M=0s 2017-09-13 17:26:24 (46.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122171 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 17:26:24.242181) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 17:26:24.242544) ========= 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=199fb4c72b90437b990b419b000001c5-1505348783.246139-355573265 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021056 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 17:26:24.292283) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-13 17:26:24.292655) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c15e2f280729b6503f9455cd4448ab2852eb5806 --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 c15e2f280729b6503f9455cd4448ab2852eb5806 --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=199fb4c72b90437b990b419b000001c5-1505348783.246139-355573265 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-13 17:26:24,348 truncating revision to first 12 chars 2017-09-13 17:26:24,348 Setting DEBUG logging. 2017-09-13 17:26:24,348 attempt 1/10 2017-09-13 17:26:24,348 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c15e2f280729?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-13 17:26:25,308 unpacking tar archive at: mozilla-central-c15e2f280729/testing/mozharness/ program finished with exit code 0 elapsedTime=1.317080 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-13 17:26:25.626830) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-13 17:26:25.627237) ========= script_repo_revision: c15e2f280729b6503f9455cd4448ab2852eb5806 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-13 17:26:25.627678) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-13 17:26:25.627982) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-13 17:26:25.642217) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-13 17:26:25.642647) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-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-stylo-disabled-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=199fb4c72b90437b990b419b000001c5-1505348783.246139-355573265 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:26:25 INFO - MultiFileLogger online at 20170913 17:26:25 in /builds/slave/test 17:26:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-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 17:26:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:26:25 INFO - {'append_to_log': False, 17:26:25 INFO - 'base_work_dir': '/builds/slave/test', 17:26:25 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:26:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:26:25 INFO - 'branch': 'Firefox-Non-PGO', 17:26:25 INFO - 'buildbot_json_path': 'buildprops.json', 17:26:25 INFO - 'code_coverage': False, 17:26:25 INFO - 'config_files': ('talos/linux_config.py',), 17:26:25 INFO - 'default_actions': ('clobber', 17:26:25 INFO - 'read-buildbot-config', 17:26:25 INFO - 'download-and-extract', 17:26:25 INFO - 'populate-webroot', 17:26:25 INFO - 'create-virtualenv', 17:26:25 INFO - 'install', 17:26:25 INFO - 'setup-mitmproxy', 17:26:25 INFO - 'run-tests'), 17:26:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:26:25 INFO - 'disable_ccov_upload': False, 17:26:25 INFO - 'disable_stylo': False, 17:26:25 INFO - 'download_minidump_stackwalk': True, 17:26:25 INFO - 'download_symbols': 'ondemand', 17:26:25 INFO - 'enable_stylo': False, 17:26:25 INFO - 'enable_webrender': False, 17:26:25 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 17:26:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:26:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:26:25 INFO - 'gecko_profile': False, 17:26:25 INFO - 'gecko_profile_interval': 0, 17:26:25 INFO - 'installer_path': 'installer.exe', 17:26:25 INFO - 'log_level': 'info', 17:26:25 INFO - 'log_name': 'talos', 17:26:25 INFO - 'log_to_console': True, 17:26:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:26:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:26:25 INFO - 'opt_config_files': (), 17:26:25 INFO - 'pip_index': False, 17:26:25 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 17:26:25 INFO - 'system_bits': '32', 17:26:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:26:25 INFO - 'title': 'talos-linux64-ix-072', 17:26:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:26:25 INFO - 'use_talos_json': True, 17:26:25 INFO - 'verify': 'False', 17:26:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:26:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:26:25 INFO - 'work_dir': 'build'} 17:26:25 INFO - [mozharness: 2017-09-14 00:26:25.841612Z] Running clobber step. 17:26:25 INFO - Running pre-action listener: _resource_record_pre_action 17:26:25 INFO - Running main action method: clobber 17:26:25 INFO - rmtree: /builds/slave/test/build 17:26:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:26:26 INFO - Running post-action listener: _resource_record_post_action 17:26:26 INFO - [mozharness: 2017-09-14 00:26:26.908905Z] Finished clobber step (success) 17:26:26 INFO - [mozharness: 2017-09-14 00:26:26.909013Z] Running read-buildbot-config step. 17:26:26 INFO - Running pre-action listener: _resource_record_pre_action 17:26:26 INFO - Running main action method: read_buildbot_config 17:26:26 INFO - Using buildbot properties: 17:26:26 INFO - { 17:26:26 INFO - "project": "", 17:26:26 INFO - "product": "firefox", 17:26:26 INFO - "who": "ryanvm@gmail.com", 17:26:26 INFO - "installer_path": "public/build/target.tar.bz2", 17:26:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 17:26:26 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:26:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 17:26:26 INFO - "stage_platform": "linux64", 17:26:26 INFO - "basedir": "/builds/slave/test", 17:26:26 INFO - "buildnumber": 19, 17:26:26 INFO - "platform": "ubuntu64_hw", 17:26:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:26:26 INFO - "slavebuilddir": "test", 17:26:26 INFO - "taskId": "OiZbskkuTqCvbQbwHHr64g", 17:26:26 INFO - "branch": "mozilla-central", 17:26:26 INFO - "script_repo_revision": "production", 17:26:26 INFO - "revision": "c15e2f280729b6503f9455cd4448ab2852eb5806", 17:26:26 INFO - "slavename": "talos-linux64-ix-072", 17:26:26 INFO - "repo_path": "mozilla-central" 17:26:26 INFO - } 17:26:26 INFO - Finding installer, test and symbols from parent task. 17:26:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OiZbskkuTqCvbQbwHHr64g'}, attempt #1 17:26:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OiZbskkuTqCvbQbwHHr64g'}, attempt #1 17:26:27 INFO - Task dependencies: GhKihdsTQkWhAO3N2_oAlA 17:26:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA'}, attempt #1 17:26:28 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA/artifacts/public/build/target.tar.bz2 17:26:28 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA/artifacts/public/build/target.test_packages.json 17:26:28 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA/artifacts/public/build/target.crashreporter-symbols.zip 17:26:28 INFO - Running post-action listener: _resource_record_post_action 17:26:28 INFO - [mozharness: 2017-09-14 00:26:28.252822Z] Finished read-buildbot-config step (success) 17:26:28 INFO - [mozharness: 2017-09-14 00:26:28.253083Z] Running download-and-extract step. 17:26:28 INFO - Running pre-action listener: _resource_record_pre_action 17:26:28 INFO - Running main action method: download_and_extract 17:26:28 INFO - mkdir: /builds/slave/test/build/tests 17:26:28 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')]} 17:26:28 INFO - trying https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA/artifacts/public/build/target.test_packages.json 17:26:28 INFO - Downloading https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:26:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:26:28 INFO - Downloaded 989 bytes. 17:26:28 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:26:28 INFO - Using the following test package requirements: 17:26:28 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:26:28 INFO - u'common': [u'target.common.tests.zip'], 17:26:28 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:26:28 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:26:28 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:26:28 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:26:28 INFO - u'mozbase': [u'target.common.tests.zip'], 17:26:28 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:26:28 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:26:28 INFO - u'web-platform': [u'target.common.tests.zip', 17:26:28 INFO - u'target.web-platform.tests.tar.gz'], 17:26:28 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:26:28 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 17:26:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA/artifacts/public/build/target.common.tests.zip 17:26:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:26:28 INFO - Fetch https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA/artifacts/public/build/target.common.tests.zip into memory 17:26:29 INFO - Content-Length response header: 54572603 17:26:29 INFO - Bytes received: 54572603 17:26:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA/artifacts/public/build/target.talos.tests.zip 17:26:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:26:40 INFO - Fetch https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA/artifacts/public/build/target.talos.tests.zip into memory 17:26:41 INFO - Content-Length response header: 14500356 17:26:41 INFO - Bytes received: 14500356 17:26:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:26:41 INFO - trying https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA/artifacts/public/build/target.tar.bz2 17:26:41 INFO - Downloading https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:26:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:26:43 INFO - Downloaded 61426292 bytes. 17:26:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA/artifacts/public/build/target.tar.bz2 17:26:43 INFO - mkdir: /builds/slave/test/properties 17:26:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:26:43 INFO - Writing to file /builds/slave/test/properties/build_url 17:26:43 INFO - Contents: 17:26:43 INFO - build_url:https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA/artifacts/public/build/target.tar.bz2 17:26:43 INFO - Running post-action listener: _resource_record_post_action 17:26:43 INFO - Running post-action listener: find_tests_for_verification 17:26:43 INFO - Running post-action listener: set_extra_try_arguments 17:26:43 INFO - [mozharness: 2017-09-14 00:26:43.093550Z] Finished download-and-extract step (success) 17:26:43 INFO - [mozharness: 2017-09-14 00:26:43.093648Z] Running populate-webroot step. 17:26:43 INFO - Running pre-action listener: _resource_record_pre_action 17:26:43 INFO - Running main action method: populate_webroot 17:26:43 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:26:43 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:26:43 INFO - 'tests': ['tresize', 17:26:43 INFO - 'tcanvasmark']}, 17:26:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:26:43 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:26:43 INFO - 'tests': ['dromaeo_css', 17:26:43 INFO - 'kraken']}, 17:26:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:26:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:26:43 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:26:43 INFO - 'talos_options': ['--disable-stylo'], 17:26:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:26:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:26:43 INFO - 'tests': ['damp', 'tps']}, 17:26:43 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:26:43 INFO - 'talos_options': ['--disable-stylo'], 17:26:43 INFO - 'tests': ['damp', 'tps']}, 17:26:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:26:43 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:26:43 INFO - 'tests': ['dromaeo_dom']}, 17:26:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:26:43 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:26:43 INFO - 'tests': ['basic_compositor_video', 17:26:43 INFO - 'glvideo']}, 17:26:43 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:26:43 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:26:43 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:26:43 INFO - 'talos_options': ['--disable-stylo'], 17:26:43 INFO - 'tests': ['ts_paint_webext', 17:26:43 INFO - 'tp5o_webext']}, 17:26:43 INFO - 'other-e10s': {'tests': ['a11yr', 17:26:43 INFO - 'ts_paint', 17:26:43 INFO - 'tpaint', 17:26:43 INFO - 'sessionrestore', 17:26:43 INFO - 'sessionrestore_many_windows', 17:26:43 INFO - 'sessionrestore_no_auto_restore', 17:26:43 INFO - 'tabpaint']}, 17:26:43 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:26:43 INFO - 'tests': ['a11yr', 17:26:43 INFO - 'ts_paint', 17:26:43 INFO - 'tpaint', 17:26:43 INFO - 'sessionrestore', 17:26:43 INFO - 'sessionrestore_many_windows', 17:26:43 INFO - 'sessionrestore_no_auto_restore', 17:26:43 INFO - 'tabpaint']}, 17:26:43 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 17:26:43 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 17:26:43 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:26:43 INFO - 'tests': ['bloom_basic_singleton']}, 17:26:43 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:26:43 INFO - 'tests': ['bloom_basic']}, 17:26:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:26:43 INFO - 'tsvgr_opacity', 17:26:43 INFO - 'tart', 17:26:43 INFO - 'tscrollx', 17:26:43 INFO - 'tsvg_static']}, 17:26:43 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:26:43 INFO - 'tests': ['tsvgx', 17:26:43 INFO - 'tsvgr_opacity', 17:26:43 INFO - 'tart', 17:26:43 INFO - 'tscrollx', 17:26:43 INFO - 'tsvg_static']}, 17:26:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:26:43 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:26:43 INFO - 'talos_options': ['--disable-stylo'], 17:26:43 INFO - 'tests': ['tp5o']}, 17:26:43 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:26:43 INFO - 'talos_options': ['--mitmproxy', 17:26:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:26:43 INFO - '--firstNonBlankPaint'], 17:26:43 INFO - 'tests': ['tp6_google', 17:26:43 INFO - 'tp6_youtube', 17:26:43 INFO - 'tp6_amazon', 17:26:43 INFO - 'tp6_facebook']}, 17:26:43 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:26:43 INFO - 'talos_options': ['--disable-stylo', 17:26:43 INFO - '--mitmproxy', 17:26:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:26:43 INFO - '--firstNonBlankPaint'], 17:26:43 INFO - 'tests': ['tp6_google', 17:26:43 INFO - 'tp6_youtube', 17:26:43 INFO - 'tp6_amazon', 17:26:43 INFO - 'tp6_facebook']}, 17:26:43 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:26:43 INFO - 'talos_options': ['--stylo-threads=1', 17:26:43 INFO - '--mitmproxy', 17:26:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:26:43 INFO - '--firstNonBlankPaint'], 17:26:43 INFO - 'tests': ['tp6_google', 17:26:43 INFO - 'tp6_youtube', 17:26:43 INFO - 'tp6_amazon', 17:26:43 INFO - 'tp6_facebook']}, 17:26:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:26:43 INFO - 'talos_options': ['--xperf_path', 17:26:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:26:43 INFO - 'tests': ['tp5n']}, 17:26:43 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:26:43 INFO - 'talos_options': ['--disable-stylo', 17:26:43 INFO - '--xperf_path', 17:26:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:26:43 INFO - 'tests': ['tp5n']}}} 17:26:43 INFO - Running post-action listener: _resource_record_post_action 17:26:43 INFO - [mozharness: 2017-09-14 00:26:43.108549Z] Finished populate-webroot step (success) 17:26:43 INFO - [mozharness: 2017-09-14 00:26:43.108639Z] Running create-virtualenv step. 17:26:43 INFO - Running pre-action listener: _resource_record_pre_action 17:26:43 INFO - Running main action method: create_virtualenv 17:26:43 INFO - Creating virtualenv /builds/slave/test/build/venv 17:26:43 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:26:43 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 17:26:43 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:26:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:26:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:26:44 INFO - Installing distribute.............................................................................................................................................................................................done. 17:26:44 INFO - Installing pip...............done. 17:26:44 INFO - Return code: 0 17:26:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:26:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:26:44 INFO - Reading from file tmpfile_stdout 17:26:44 INFO - Output received: 17:26:44 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 17:26:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:26:44 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')]} 17:26:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:44 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')]} 17:26:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:44 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 0xa0f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbd8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7f090>, '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 0xd7fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd79f90>, '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': '199fb4c72b90437b990b419b000001c5-1505348783.246139-355573265', '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 17:26:44 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 17:26:44 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 17:26:44 INFO - Using env: {'DISPLAY': ':0', 17:26:44 INFO - 'HOME': '/home/cltbld', 17:26:44 INFO - 'LANG': 'en_US.UTF-8', 17:26:44 INFO - 'LANGUAGE': 'en_US:en', 17:26:44 INFO - 'LOGNAME': 'cltbld', 17:26:44 INFO - 'MAIL': '/var/mail/cltbld', 17:26:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:44 INFO - 'MOZ_NO_REMOTE': '1', 17:26:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:44 INFO - 'NO_EM_RESTART': '1', 17:26:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:44 INFO - 'PWD': '/builds/slave/test', 17:26:44 INFO - 'SHELL': '/bin/bash', 17:26:44 INFO - 'SHLVL': '1', 17:26:44 INFO - 'TERM': 'linux', 17:26:44 INFO - 'TMOUT': '86400', 17:26:44 INFO - 'USER': 'cltbld', 17:26:44 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1505348783.246139-355573265', 17:26:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:44 INFO - '_': '/tools/buildbot/bin/python'} 17:26:45 INFO - Ignoring indexes: http://pypi.python.org/simple/ 17:26:45 INFO - Downloading/unpacking pip>=1.5 17:26:45 INFO - Running setup.py egg_info for package pip 17:26:45 INFO - warning: no files found matching 'pip/cacert.pem' 17:26:45 INFO - warning: no files found matching '*.html' under directory 'docs' 17:26:45 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:26:45 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:26:45 INFO - Installing collected packages: pip 17:26:45 INFO - Found existing installation: pip 1.1 17:26:45 INFO - Uninstalling pip: 17:26:45 INFO - Successfully uninstalled pip 17:26:45 INFO - Running setup.py install for pip 17:26:45 INFO - warning: no files found matching 'pip/cacert.pem' 17:26:45 INFO - warning: no files found matching '*.html' under directory 'docs' 17:26:45 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:26:45 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:26:45 INFO - Installing pip script to /builds/slave/test/build/venv/bin 17:26:45 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 17:26:45 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 17:26:45 INFO - Successfully installed pip 17:26:45 INFO - Cleaning up... 17:26:45 INFO - Return code: 0 17:26:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:26:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:26:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:26:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xa0f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbd8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7f090>, '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 0xd7fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd79f90>, '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': '199fb4c72b90437b990b419b000001c5-1505348783.246139-355573265', '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 17:26:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:26:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:26:45 INFO - Using env: {'DISPLAY': ':0', 17:26:45 INFO - 'HOME': '/home/cltbld', 17:26:45 INFO - 'LANG': 'en_US.UTF-8', 17:26:45 INFO - 'LANGUAGE': 'en_US:en', 17:26:45 INFO - 'LOGNAME': 'cltbld', 17:26:45 INFO - 'MAIL': '/var/mail/cltbld', 17:26:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:45 INFO - 'MOZ_NO_REMOTE': '1', 17:26:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:45 INFO - 'NO_EM_RESTART': '1', 17:26:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:45 INFO - 'PWD': '/builds/slave/test', 17:26:45 INFO - 'SHELL': '/bin/bash', 17:26:45 INFO - 'SHLVL': '1', 17:26:45 INFO - 'TERM': 'linux', 17:26:45 INFO - 'TMOUT': '86400', 17:26:45 INFO - 'USER': 'cltbld', 17:26:45 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1505348783.246139-355573265', 17:26:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:45 INFO - '_': '/tools/buildbot/bin/python'} 17:26:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:45 INFO - Downloading/unpacking psutil>=3.1.1 17:26:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:26:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:26:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:26:47 INFO - Installing collected packages: psutil 17:26:47 INFO - Running setup.py install for psutil 17:26:47 INFO - building 'psutil._psutil_linux' extension 17:26:47 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 17:26:47 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 17:26:47 INFO - building 'psutil._psutil_posix' extension 17:26:47 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 17:26:47 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 17:26:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:26:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:26:47 INFO - Successfully installed psutil 17:26:47 INFO - Cleaning up... 17:26:47 INFO - Return code: 0 17:26:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:26:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:26:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xa0f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbd8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7f090>, '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 0xd7fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd79f90>, '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': '199fb4c72b90437b990b419b000001c5-1505348783.246139-355573265', '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 17:26:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:26:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:26:47 INFO - Using env: {'DISPLAY': ':0', 17:26:47 INFO - 'HOME': '/home/cltbld', 17:26:47 INFO - 'LANG': 'en_US.UTF-8', 17:26:47 INFO - 'LANGUAGE': 'en_US:en', 17:26:47 INFO - 'LOGNAME': 'cltbld', 17:26:47 INFO - 'MAIL': '/var/mail/cltbld', 17:26:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:47 INFO - 'MOZ_NO_REMOTE': '1', 17:26:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:47 INFO - 'NO_EM_RESTART': '1', 17:26:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:47 INFO - 'PWD': '/builds/slave/test', 17:26:47 INFO - 'SHELL': '/bin/bash', 17:26:47 INFO - 'SHLVL': '1', 17:26:47 INFO - 'TERM': 'linux', 17:26:47 INFO - 'TMOUT': '86400', 17:26:47 INFO - 'USER': 'cltbld', 17:26:47 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1505348783.246139-355573265', 17:26:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:47 INFO - '_': '/tools/buildbot/bin/python'} 17:26:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:26:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:26:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:26:49 INFO - Installing collected packages: mozsystemmonitor 17:26:49 INFO - Running setup.py install for mozsystemmonitor 17:26:49 INFO - Successfully installed mozsystemmonitor 17:26:49 INFO - Cleaning up... 17:26:49 INFO - Return code: 0 17:26:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:26:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:26:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xa0f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbd8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7f090>, '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 0xd7fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd79f90>, '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': '199fb4c72b90437b990b419b000001c5-1505348783.246139-355573265', '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 17:26:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:26:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:26:49 INFO - Using env: {'DISPLAY': ':0', 17:26:49 INFO - 'HOME': '/home/cltbld', 17:26:49 INFO - 'LANG': 'en_US.UTF-8', 17:26:49 INFO - 'LANGUAGE': 'en_US:en', 17:26:49 INFO - 'LOGNAME': 'cltbld', 17:26:49 INFO - 'MAIL': '/var/mail/cltbld', 17:26:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:49 INFO - 'MOZ_NO_REMOTE': '1', 17:26:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:49 INFO - 'NO_EM_RESTART': '1', 17:26:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:49 INFO - 'PWD': '/builds/slave/test', 17:26:49 INFO - 'SHELL': '/bin/bash', 17:26:49 INFO - 'SHLVL': '1', 17:26:49 INFO - 'TERM': 'linux', 17:26:49 INFO - 'TMOUT': '86400', 17:26:49 INFO - 'USER': 'cltbld', 17:26:49 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1505348783.246139-355573265', 17:26:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:49 INFO - '_': '/tools/buildbot/bin/python'} 17:26:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:50 INFO - Downloading/unpacking jsonschema==2.5.1 17:26:50 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 17:26:50 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 17:26:50 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 17:26:50 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 17:26:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:26:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:26:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:51 INFO - Downloading functools32-3.2.3-2.tar.gz 17:26:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:26:51 INFO - warning: no files found matching '*.txt' 17:26:51 INFO - no previously-included directories found matching 'build' 17:26:51 INFO - no previously-included directories found matching 'dist' 17:26:51 INFO - no previously-included directories found matching '.git*' 17:26:51 INFO - Installing collected packages: jsonschema, functools32 17:26:52 INFO - Running setup.py install for functools32 17:26:52 INFO - warning: no files found matching '*.txt' 17:26:52 INFO - no previously-included directories found matching 'build' 17:26:52 INFO - no previously-included directories found matching 'dist' 17:26:52 INFO - no previously-included directories found matching '.git*' 17:26:52 INFO - Successfully installed jsonschema functools32 17:26:52 INFO - Cleaning up... 17:26:52 INFO - Return code: 0 17:26:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:26:52 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')]} 17:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:52 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')]} 17:26:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:52 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 0xa0f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbd8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7f090>, '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 0xd7fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd79f90>, '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': '199fb4c72b90437b990b419b000001c5-1505348783.246139-355573265', '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 17:26:52 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 17:26:52 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 17:26:52 INFO - Using env: {'DISPLAY': ':0', 17:26:52 INFO - 'HOME': '/home/cltbld', 17:26:52 INFO - 'LANG': 'en_US.UTF-8', 17:26:52 INFO - 'LANGUAGE': 'en_US:en', 17:26:52 INFO - 'LOGNAME': 'cltbld', 17:26:52 INFO - 'MAIL': '/var/mail/cltbld', 17:26:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:52 INFO - 'MOZ_NO_REMOTE': '1', 17:26:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:52 INFO - 'NO_EM_RESTART': '1', 17:26:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:52 INFO - 'PWD': '/builds/slave/test', 17:26:52 INFO - 'SHELL': '/bin/bash', 17:26:52 INFO - 'SHLVL': '1', 17:26:52 INFO - 'TERM': 'linux', 17:26:52 INFO - 'TMOUT': '86400', 17:26:52 INFO - 'USER': 'cltbld', 17:26:52 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1505348783.246139-355573265', 17:26:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:52 INFO - '_': '/tools/buildbot/bin/python'} 17:26:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:26:52 INFO - Cleaning up... 17:26:52 INFO - Return code: 0 17:26:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:26:52 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')]} 17:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:52 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')]} 17:26:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:52 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 0xa0f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbd8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7f090>, '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 0xd7fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd79f90>, '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': '199fb4c72b90437b990b419b000001c5-1505348783.246139-355573265', '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 17:26:52 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 17:26:52 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 17:26:52 INFO - Using env: {'DISPLAY': ':0', 17:26:52 INFO - 'HOME': '/home/cltbld', 17:26:52 INFO - 'LANG': 'en_US.UTF-8', 17:26:52 INFO - 'LANGUAGE': 'en_US:en', 17:26:52 INFO - 'LOGNAME': 'cltbld', 17:26:52 INFO - 'MAIL': '/var/mail/cltbld', 17:26:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:52 INFO - 'MOZ_NO_REMOTE': '1', 17:26:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:52 INFO - 'NO_EM_RESTART': '1', 17:26:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:52 INFO - 'PWD': '/builds/slave/test', 17:26:52 INFO - 'SHELL': '/bin/bash', 17:26:52 INFO - 'SHLVL': '1', 17:26:52 INFO - 'TERM': 'linux', 17:26:52 INFO - 'TMOUT': '86400', 17:26:52 INFO - 'USER': 'cltbld', 17:26:52 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1505348783.246139-355573265', 17:26:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:52 INFO - '_': '/tools/buildbot/bin/python'} 17:26:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:52 INFO - Downloading/unpacking blobuploader==1.2.4 17:26:52 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 17:26:52 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 17:26:52 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 17:26:52 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 17:26:53 INFO - Downloading blobuploader-1.2.4.tar.gz 17:26:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:26:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:26:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:54 INFO - Downloading docopt-0.6.1.tar.gz 17:26:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:26:54 INFO - Installing collected packages: blobuploader, requests, docopt 17:26:54 INFO - Running setup.py install for blobuploader 17:26:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:26:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:26:54 INFO - Running setup.py install for requests 17:26:54 INFO - Running setup.py install for docopt 17:26:54 INFO - Successfully installed blobuploader requests docopt 17:26:54 INFO - Cleaning up... 17:26:54 INFO - Return code: 0 17:26:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:26:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:54 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 0xa0f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbd8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7f090>, '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 0xd7fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd79f90>, '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': '199fb4c72b90437b990b419b000001c5-1505348783.246139-355573265', '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 17:26:54 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 17:26:54 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 17:26:54 INFO - Using env: {'DISPLAY': ':0', 17:26:54 INFO - 'HOME': '/home/cltbld', 17:26:54 INFO - 'LANG': 'en_US.UTF-8', 17:26:54 INFO - 'LANGUAGE': 'en_US:en', 17:26:54 INFO - 'LOGNAME': 'cltbld', 17:26:54 INFO - 'MAIL': '/var/mail/cltbld', 17:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:54 INFO - 'MOZ_NO_REMOTE': '1', 17:26:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:54 INFO - 'NO_EM_RESTART': '1', 17:26:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:54 INFO - 'PWD': '/builds/slave/test', 17:26:54 INFO - 'SHELL': '/bin/bash', 17:26:54 INFO - 'SHLVL': '1', 17:26:54 INFO - 'TERM': 'linux', 17:26:54 INFO - 'TMOUT': '86400', 17:26:54 INFO - 'USER': 'cltbld', 17:26:54 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1505348783.246139-355573265', 17:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:54 INFO - '_': '/tools/buildbot/bin/python'} 17:26:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:26:55 INFO - Running setup.py (path:/tmp/pip-4NxvEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:26:55 INFO - Running setup.py (path:/tmp/pip-Nmmtqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:26:55 INFO - Running setup.py (path:/tmp/pip-dyoVZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:26:55 INFO - Running setup.py (path:/tmp/pip-V_nw_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:26:55 INFO - Running setup.py (path:/tmp/pip-BO0WHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:26:55 INFO - Running setup.py (path:/tmp/pip-g_Q5uh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:26:55 INFO - Running setup.py (path:/tmp/pip-VR4i9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:26:55 INFO - Running setup.py (path:/tmp/pip-9uw1Mv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:26:55 INFO - Running setup.py (path:/tmp/pip-OjTAdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:26:55 INFO - Running setup.py (path:/tmp/pip-eVe48K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:26:55 INFO - Running setup.py (path:/tmp/pip-9Vwhtq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:26:55 INFO - Running setup.py (path:/tmp/pip-NWJp0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:26:55 INFO - Running setup.py (path:/tmp/pip-_qKuA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:26:56 INFO - Running setup.py (path:/tmp/pip-GnNqia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:26:56 INFO - Running setup.py (path:/tmp/pip-CQT22l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:26:56 INFO - Running setup.py (path:/tmp/pip-qPx4Dl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:26:56 INFO - Running setup.py (path:/tmp/pip-RIFSxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:26:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:26:56 INFO - Running setup.py install for manifestparser 17:26:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:26:56 INFO - Running setup.py install for mozcrash 17:26:56 INFO - Running setup.py install for mozdebug 17:26:56 INFO - Running setup.py install for mozdevice 17:26:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:26:56 INFO - Running setup.py install for mozfile 17:26:56 INFO - Running setup.py install for mozhttpd 17:26:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:26:56 INFO - Running setup.py install for mozinfo 17:26:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:26:57 INFO - Running setup.py install for mozInstall 17:26:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:26:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:26:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:26:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:26:57 INFO - Running setup.py install for mozleak 17:26:57 INFO - Running setup.py install for mozlog 17:26:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:26:57 INFO - Running setup.py install for moznetwork 17:26:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:26:57 INFO - Running setup.py install for mozprocess 17:26:57 INFO - Running setup.py install for mozprofile 17:26:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:26:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:26:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:26:57 INFO - Running setup.py install for mozrunner 17:26:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:26:57 INFO - Running setup.py install for mozscreenshot 17:26:57 INFO - Running setup.py install for moztest 17:26:57 INFO - Running setup.py install for mozversion 17:26:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:26:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:26:58 INFO - Cleaning up... 17:26:58 INFO - Return code: 0 17:26:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:26:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:26:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:58 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 0xa0f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbd8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7f090>, '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 0xd7fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd79f90>, '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': '199fb4c72b90437b990b419b000001c5-1505348783.246139-355573265', '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 17:26:58 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 17:26:58 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 17:26:58 INFO - Using env: {'DISPLAY': ':0', 17:26:58 INFO - 'HOME': '/home/cltbld', 17:26:58 INFO - 'LANG': 'en_US.UTF-8', 17:26:58 INFO - 'LANGUAGE': 'en_US:en', 17:26:58 INFO - 'LOGNAME': 'cltbld', 17:26:58 INFO - 'MAIL': '/var/mail/cltbld', 17:26:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:58 INFO - 'MOZ_NO_REMOTE': '1', 17:26:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:58 INFO - 'NO_EM_RESTART': '1', 17:26:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:58 INFO - 'PWD': '/builds/slave/test', 17:26:58 INFO - 'SHELL': '/bin/bash', 17:26:58 INFO - 'SHLVL': '1', 17:26:58 INFO - 'TERM': 'linux', 17:26:58 INFO - 'TMOUT': '86400', 17:26:58 INFO - 'USER': 'cltbld', 17:26:58 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1505348783.246139-355573265', 17:26:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:58 INFO - '_': '/tools/buildbot/bin/python'} 17:26:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:26:58 INFO - Running setup.py (path:/tmp/pip-XUzpzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:26:58 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)) 17:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:26:58 INFO - Running setup.py (path:/tmp/pip-eUC_M1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:26:58 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)) 17:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:26:58 INFO - Running setup.py (path:/tmp/pip-eJGYUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:26:58 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)) 17:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:26:58 INFO - Running setup.py (path:/tmp/pip-MXHrN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:26:58 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)) 17:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:26:58 INFO - Running setup.py (path:/tmp/pip-gJbIYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:26:58 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)) 17:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:26:58 INFO - Running setup.py (path:/tmp/pip-hHP_vu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:26:58 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)) 17:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:26:58 INFO - Running setup.py (path:/tmp/pip-AK83Hx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:26:58 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)) 17:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:26:58 INFO - Running setup.py (path:/tmp/pip-ANK4uH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:26:58 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)) 17:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:26:58 INFO - Running setup.py (path:/tmp/pip-Ivg9XD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:26:58 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)) 17:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:26:58 INFO - Running setup.py (path:/tmp/pip-0Cbocz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:26:59 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)) 17:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:26:59 INFO - Running setup.py (path:/tmp/pip-_jafLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:26:59 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)) 17:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:26:59 INFO - Running setup.py (path:/tmp/pip-oyzvTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:26:59 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)) 17:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:26:59 INFO - Running setup.py (path:/tmp/pip-QjHfKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:26:59 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)) 17:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:26:59 INFO - Running setup.py (path:/tmp/pip-KyC5zq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:26:59 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)) 17:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:26:59 INFO - Running setup.py (path:/tmp/pip-mTsjlM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:26:59 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)) 17:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:26:59 INFO - Running setup.py (path:/tmp/pip-QlAC3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:26:59 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)) 17:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:26:59 INFO - Running setup.py (path:/tmp/pip-EeStLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:26:59 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)) 17:26:59 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)) 17:26:59 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)) 17:26:59 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)) 17:26:59 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)) 17:26:59 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)) 17:26:59 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)) 17:26:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:26:59 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 17:26:59 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 17:26:59 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 17:26:59 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 17:27:00 INFO - Downloading blessings-1.6.tar.gz 17:27:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:27:00 INFO - Installing collected packages: blessings 17:27:00 INFO - Running setup.py install for blessings 17:27:00 INFO - Successfully installed blessings 17:27:00 INFO - Cleaning up... 17:27:00 INFO - Return code: 0 17:27:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:27:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:27:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:27:01 INFO - Reading from file tmpfile_stdout 17:27:01 INFO - Current package versions: 17:27:01 INFO - argparse == 1.2.1 17:27:01 INFO - blessings == 1.6 17:27:01 INFO - blobuploader == 1.2.4 17:27:01 INFO - docopt == 0.6.1 17:27:01 INFO - functools32 == 3.2.3-2 17:27:01 INFO - jsonschema == 2.5.1 17:27:01 INFO - manifestparser == 1.1 17:27:01 INFO - mozInstall == 1.13 17:27:01 INFO - mozcrash == 1.0 17:27:01 INFO - mozdebug == 0.1 17:27:01 INFO - mozdevice == 0.51 17:27:01 INFO - mozfile == 1.2 17:27:01 INFO - mozhttpd == 0.7 17:27:01 INFO - mozinfo == 0.10 17:27:01 INFO - mozleak == 0.1 17:27:01 INFO - mozlog == 3.5 17:27:01 INFO - moznetwork == 0.27 17:27:01 INFO - mozprocess == 0.25 17:27:01 INFO - mozprofile == 0.28 17:27:01 INFO - mozrunner == 6.13 17:27:01 INFO - mozscreenshot == 0.1 17:27:01 INFO - mozsystemmonitor == 0.3 17:27:01 INFO - moztest == 0.8 17:27:01 INFO - mozversion == 1.4 17:27:01 INFO - psutil == 3.1.1 17:27:01 INFO - requests == 1.2.3 17:27:01 INFO - wsgiref == 0.1.2 17:27:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:27:01 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')]} 17:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27:01 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')]} 17:27:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:01 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 0xa0f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbd8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7f090>, '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 0xd7fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd79f90>, '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': '199fb4c72b90437b990b419b000001c5-1505348783.246139-355573265', '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 17:27:01 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 17:27:01 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 17:27:01 INFO - Using env: {'DISPLAY': ':0', 17:27:01 INFO - 'HOME': '/home/cltbld', 17:27:01 INFO - 'LANG': 'en_US.UTF-8', 17:27:01 INFO - 'LANGUAGE': 'en_US:en', 17:27:01 INFO - 'LOGNAME': 'cltbld', 17:27:01 INFO - 'MAIL': '/var/mail/cltbld', 17:27:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:01 INFO - 'MOZ_NO_REMOTE': '1', 17:27:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:01 INFO - 'NO_EM_RESTART': '1', 17:27:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:01 INFO - 'PWD': '/builds/slave/test', 17:27:01 INFO - 'SHELL': '/bin/bash', 17:27:01 INFO - 'SHLVL': '1', 17:27:01 INFO - 'TERM': 'linux', 17:27:01 INFO - 'TMOUT': '86400', 17:27:01 INFO - 'USER': 'cltbld', 17:27:01 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1505348783.246139-355573265', 17:27:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:01 INFO - '_': '/tools/buildbot/bin/python'} 17:27:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:01 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)) 17:27:01 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)) 17:27:01 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)) 17:27:01 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)) 17:27:01 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)) 17:27:01 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)) 17:27:01 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)) 17:27:01 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)) 17:27:01 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)) 17:27:01 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:27: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 17:27: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 17:27: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 17:27: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 17:27:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:27:02 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)) 17:27:02 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)) 17:27:02 INFO - Installing collected packages: simplejson 17:27:02 INFO - Running setup.py install for simplejson 17:27:02 INFO - building 'simplejson._speedups' extension 17:27:02 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 17:27:03 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 17:27:03 INFO - Successfully installed simplejson 17:27:03 INFO - Cleaning up... 17:27:03 INFO - Return code: 0 17:27:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:27:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:27:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xa0f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbd8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7f090>, '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 0xd7fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd79f90>, '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': '199fb4c72b90437b990b419b000001c5-1505348783.246139-355573265', '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 17:27:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:27:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:27:03 INFO - Using env: {'DISPLAY': ':0', 17:27:03 INFO - 'HOME': '/home/cltbld', 17:27:03 INFO - 'LANG': 'en_US.UTF-8', 17:27:03 INFO - 'LANGUAGE': 'en_US:en', 17:27:03 INFO - 'LOGNAME': 'cltbld', 17:27:03 INFO - 'MAIL': '/var/mail/cltbld', 17:27:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:03 INFO - 'MOZ_NO_REMOTE': '1', 17:27:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:03 INFO - 'NO_EM_RESTART': '1', 17:27:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:03 INFO - 'PWD': '/builds/slave/test', 17:27:03 INFO - 'SHELL': '/bin/bash', 17:27:03 INFO - 'SHLVL': '1', 17:27:03 INFO - 'TERM': 'linux', 17:27:03 INFO - 'TMOUT': '86400', 17:27:03 INFO - 'USER': 'cltbld', 17:27:03 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1505348783.246139-355573265', 17:27:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:03 INFO - '_': '/tools/buildbot/bin/python'} 17:27:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:27:03 INFO - Cleaning up... 17:27:03 INFO - Return code: 0 17:27:03 INFO - Running post-action listener: _resource_record_post_action 17:27:03 INFO - Running post-action listener: _start_resource_monitoring 17:27:03 INFO - Starting resource monitoring. 17:27:03 INFO - [mozharness: 2017-09-14 00:27:03.942950Z] Finished create-virtualenv step (success) 17:27:03 INFO - [mozharness: 2017-09-14 00:27:03.943418Z] Running install step. 17:27:03 INFO - Running pre-action listener: _resource_record_pre_action 17:27:03 INFO - Running main action method: install 17:27:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:27:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:27:04 INFO - Reading from file tmpfile_stdout 17:27:04 INFO - Detecting whether we're running mozinstall >=1.0... 17:27:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:27:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:27:04 INFO - Reading from file tmpfile_stdout 17:27:04 INFO - Output received: 17:27:04 INFO - Usage: mozinstall [options] installer 17:27:04 INFO - Options: 17:27:04 INFO - -h, --help show this help message and exit 17:27:04 INFO - -d DEST, --destination=DEST 17:27:04 INFO - Directory to install application into. [default: 17:27:04 INFO - "/builds/slave/test"] 17:27:04 INFO - --app=APP Application being installed. [default: firefox] 17:27:04 INFO - mkdir: /builds/slave/test/build/application 17:27:04 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'] 17:27:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:27:22 INFO - Reading from file tmpfile_stdout 17:27:22 INFO - Output received: 17:27:22 INFO - /builds/slave/test/build/application/firefox/firefox 17:27:22 INFO - Running post-action listener: _resource_record_post_action 17:27:22 INFO - [mozharness: 2017-09-14 00:27:22.039755Z] Finished install step (success) 17:27:22 INFO - [mozharness: 2017-09-14 00:27:22.040006Z] Running setup-mitmproxy step. 17:27:22 INFO - Running pre-action listener: _resource_record_pre_action 17:27:22 INFO - Running main action method: setup_mitmproxy 17:27:22 INFO - Skipping: mitmproxy is not required 17:27:22 INFO - Running post-action listener: _resource_record_post_action 17:27:22 INFO - [mozharness: 2017-09-14 00:27:22.041185Z] Finished setup-mitmproxy step (success) 17:27:22 INFO - [mozharness: 2017-09-14 00:27:22.041406Z] Running run-tests step. 17:27:22 INFO - Running pre-action listener: _resource_record_pre_action 17:27:22 INFO - Running pre-action listener: _set_gcov_prefix 17:27:22 INFO - Running main action method: run_tests 17:27:22 WARNING - Try message not found. 17:27:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:27:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:27:22 INFO - Python 2.7.3 17:27:22 INFO - Return code: 0 17:27:22 INFO - grabbing minidump binary from tooltool 17:27:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:27:22 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7f090>, '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 0xd7fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd79f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:27:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:27:22 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:27:22 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:27:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:27:22 INFO - Return code: 0 17:27:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:27:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:27:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:27:22 INFO - ENV: RUST_BACKTRACE is now full 17:27:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:27:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:27:22 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-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-072', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 17:27:22 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-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-072 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 17:27:22 INFO - Using env: {'DISPLAY': ':0', 17:27:22 INFO - 'HOME': '/home/cltbld', 17:27:22 INFO - 'LANG': 'en_US.UTF-8', 17:27:22 INFO - 'LANGUAGE': 'en_US:en', 17:27:22 INFO - 'LOGNAME': 'cltbld', 17:27:22 INFO - 'MAIL': '/var/mail/cltbld', 17:27:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:27:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:27:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:22 INFO - 'MOZ_NO_REMOTE': '1', 17:27:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:27:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:22 INFO - 'NO_EM_RESTART': '1', 17:27:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:22 INFO - 'PWD': '/builds/slave/test', 17:27:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:27:22 INFO - 'RUST_BACKTRACE': 'full', 17:27:22 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:27:22 INFO - 'SHELL': '/bin/bash', 17:27:22 INFO - 'SHLVL': '1', 17:27:22 INFO - 'TERM': 'linux', 17:27:22 INFO - 'TMOUT': '86400', 17:27:22 INFO - 'USER': 'cltbld', 17:27:22 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1505348783.246139-355573265', 17:27:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:22 INFO - '_': '/tools/buildbot/bin/python'} 17:27:22 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-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-072', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 17:27:22 INFO - mozversion application_buildid: 20170913233914 17:27:22 INFO - mozversion application_changeset: c15e2f280729b6503f9455cd4448ab2852eb5806 17:27:22 INFO - mozversion application_display_name: Nightly 17:27:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:27:22 INFO - mozversion application_name: Firefox 17:27:22 INFO - mozversion application_remotingname: firefox 17:27:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:27:22 INFO - mozversion application_vendor: Mozilla 17:27:22 INFO - mozversion application_version: 57.0a1 17:27:22 INFO - mozversion platform_buildid: 20170913233914 17:27:22 INFO - mozversion platform_changeset: c15e2f280729b6503f9455cd4448ab2852eb5806 17:27:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:27:22 INFO - mozversion platform_version: 57.0a1 17:27:22 INFO - using testdate: 1505348842 17:27:22 INFO - actual date: 1505348842 17:27:22 INFO - starting webserver on 'localhost:43812' 17:27:22 INFO - SUITE-START | Running 2 tests 17:27:22 INFO - TEST-START | dromaeo_css 17:27:22 INFO - Initialising browser for dromaeo_css test... 17:27:22 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43812/getInfo.html -profile /tmp/tmprjLtLo/profile 17:27:22 INFO - TEST-INFO | started process 13260 (/builds/slave/test/build/application/firefox/firefox http://localhost:43812/getInfo.html) 17:27:28 INFO - TEST-INFO | 13260: exit 0 17:27:28 INFO - Browser initialized. 17:27:28 INFO - Running cycle 1/1 for dromaeo_css test... 17:27:28 INFO - Using env: {'DISPLAY': ':0', 17:27:28 INFO - 'HOME': '/home/cltbld', 17:27:28 INFO - 'JSGC_DISABLE_POISONING': '1', 17:27:28 INFO - 'LANG': 'en_US.UTF-8', 17:27:28 INFO - 'LANGUAGE': 'en_US:en', 17:27:28 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:27:28 INFO - 'LOGNAME': 'cltbld', 17:27:28 INFO - 'MAIL': '/var/mail/cltbld', 17:27:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:27:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:27:28 INFO - 'MOZ_CRASHREPORTER': '1', 17:27:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:28 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:27:28 INFO - 'MOZ_NO_REMOTE': '1', 17:27:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:27:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:28 INFO - 'NO_EM_RESTART': '1', 17:27:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:28 INFO - 'PWD': '/builds/slave/test', 17:27:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:27:28 INFO - 'RUST_BACKTRACE': 'full', 17:27:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:27:28 INFO - 'SHELL': '/bin/bash', 17:27:28 INFO - 'SHLVL': '1', 17:27:28 INFO - 'STYLO_FORCE_DISABLED': '1', 17:27:28 INFO - 'TERM': 'linux', 17:27:28 INFO - 'TMOUT': '86400', 17:27:28 INFO - 'USER': 'cltbld', 17:27:28 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1505348783.246139-355573265', 17:27:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:28 INFO - '_': '/tools/buildbot/bin/python'} 17:27:28 INFO - TEST-INFO | started process 13488 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprjLtLo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:27:29 INFO - PID 13488 | 17:27:29 INFO - PID 13488 | (/builds/slave/test/build/application/firefox/firefox:13537): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:27:29 INFO - PID 13488 | 17:27:39 INFO - PID 13488 | RSS: Main: 173498368 17:27:39 INFO - PID 13488 | 17:30:36 INFO - PID 13488 | Cycle 1(1): loaded http://localhost:43812/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43812/tests/dromaeo/cssquery-ext.html) 17:30:38 INFO - PID 13488 | RSS: Main: 176377856 17:30:38 INFO - PID 13488 | 17:33:40 INFO - PID 13488 | Cycle 1(1): loaded http://localhost:43812/tests/dromaeo/cssquery-ext.html (next: http://localhost:43812/tests/dromaeo/cssquery-jquery.html) 17:33:40 INFO - PID 13488 | RSS: Main: 171446272 17:33:40 INFO - PID 13488 | 17:36:42 INFO - PID 13488 | Cycle 1(1): loaded http://localhost:43812/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43812/tests/dromaeo/cssquery-mootools.html) 17:36:43 INFO - PID 13488 | RSS: Main: 174792704 17:36:43 INFO - PID 13488 | 17:39:44 INFO - PID 13488 | Cycle 1(1): loaded http://localhost:43812/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43812/tests/dromaeo/cssquery-prototype.html) 17:39:45 INFO - PID 13488 | RSS: Main: 173215744 17:39:45 INFO - PID 13488 | 17:42:48 INFO - PID 13488 | Cycle 1(1): loaded http://localhost:43812/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43812/tests/dromaeo/cssquery-yui.html) 17:42:49 INFO - PID 13488 | RSS: Main: 172724224 17:42:49 INFO - PID 13488 | 17:45:50 INFO - PID 13488 | Cycle 1(1): loaded http://localhost:43812/tests/dromaeo/cssquery-yui.html (next: http://localhost:43812/tests/dromaeo/cssquery-dojo.html) 17:45:50 INFO - PID 13488 | RSS: Main: 177074176 17:45:50 INFO - PID 13488 | 17:45:50 INFO - PID 13488 | __start_tp_report 17:45:50 INFO - PID 13488 | _x_x_mozilla_page_load 17:45:50 INFO - PID 13488 | _x_x_mozilla_page_load_details 17:45:50 INFO - PID 13488 | |i|pagename|runs| 17:45:50 INFO - PID 13488 | |0;dojo.html;3128.1553980425283;3151.6848315168477;3190.5692731481245;3196.5684632574594;3204.9038528844144;6192.628442293454;6324;6339.841503962403;6342.5243106767;6413.102165696806;6209.099680546329;6258.217722784652;6325.746970121201;6465.903011454832;6480.319566445526;5701.372848986619;5792.68140252286;5852.473277405033;5862.765489380441;5940.702964851762;1292.7448520822293;5740.1102829061565;5799.565032622549;5911.704414779266;5947.464728174464;5836.267737163745;5839.416058394169;5901.4688678018965;5923.022701254288;5925.377835327272;5848.941510584882;5855.531557475391;5927.970360148215;5928.79249226275;5938.020226662596;5799.449052340021;5820.882115160024;5883.264591926009;5891.764329426818;5906.3207731110615;6370.904436433457;6386;6393.296737358934;6430.61416315018;6465.806025819233;6672.366125218096;6776.220734615533;6848.965755171242;6876.415504682108;6956.930430695729;6836.521443498957;6855.383015528626;6862.313768623148;6865.5537390069485;6869.484788640872;6339.0808332791485;6347.206599175103;6458.418742313167;6464.062710906939;6468.3208263132165;7084.716611335592;7102.538335008208;7178.533395329391;7187.676554554953;7203.675834587456;6559.672016399161;6690.899636505359;6747.156605424322;6785.321467853274;6855;6769.830754231184;6809.250982391933;6895.482838787111;6904.344087311697;6906.102206713095;6705.4970877184405;6758.695858686371;6819.24988251292;6820.181578210547;6827.590344579242;6734.225564060098;6743.123393958754;6824.112865327475;6857.7256909723055;6862.313768623198;5277.551408130275;5301.5493683037375;5343.839684809462;5359.410464848864;5361.169018802092;4622.722636641813;4661.86014419568;4706.129366067288;4720.598749106296;4743.786529606176;5779.653220806765;5856.033754430471;5865.67738774363;5878.353381128072;5921;6797.5921444712485;6822.079019332326;6893.414059804973;6973.093497845248;6982.546134501241;5684.204211410406;5794.710264486759;5823.854403639943;5883.2057672213705;5899.380565040695;5757.769689212469;5764.625299355528;5775.33583637887;5778.479936805707;5782.2483077199695;6440.452561532322;6488.643124628096;6512.153420055362;6513.381228783258;6546.378094081055;6729.798106056826;6928.1339832520935;6932.965335173292;6933.064036355027;6972.51192416526;6616.073749675145;6645.734170633121;6694.29709880475;6709.698063587052;6716.361945615159;6520.543561950618;6711.161104861892;6722.058911752456;6787.966060169668;6825.522213445011;6780.830479238059;6786.3892249697765;6831.6242606657115;6831.9316806833285;6835.7949261522235;6577.671116444254;6603.174603174603;6687.465002799861;6690.59856408617;6694.397504224643;6596.208454985433;6677.699503522256;6687.297833727584;6698.296678848846;6708.530402871752;6525.902111468236;6570.981497867838;6625.768098116543;6634.933650663432;6652.7006284716335;6544.705488252945;6641.833954151185;6693.096431981815;6754.12196414463;6771.119754431892;6522.119513865568;6539.444147247347;6545.312742162005;6576.44100251484;6585.242697089704 17:45:50 INFO - PID 13488 | |1;ext.html;718.4324383736845;781.8709912864377;790.5098838719995;795.4471642208665;797.1271457753758;39831.402528962055;40687.796561017225;40752.184956300895;40784.79607601965;40992;36656.08359791007;36975.445368319495;36985.44521832174;37018.44472332911;37031.81484092583;6977.79066628002;7088.326608972139;7120.50156489046;7128;7131.7503887363955;6989.161300643905;6994.68523916425;6995.720171193147;7007.789766307019;7009.08881845362;7065.858682826341;7068.469864760138;7070.363667269945;7088.4683648726295;7781.144074151839;7862.764117076496;7920.32677222431;7926.128125906146;7932.444728868982;7933.404994625397;7556.206598307153;7741.187175346564;7783.182765809565;7865.921340786576;7872.76381708544;36981.26037479236;37328.253434931146;37370.43944340837;37382.43926341107;37477;3537.9292414151832;3575.0883524701294;3582.695470884978;3583.2475180212186;3586.4620306953907;30638.84680576605;30714;30770.38459230825;30809;30868.53697194544;5096.719680417576;5102.540771330561;5144.485551444863;5146.408163061258;5146.7683954221775;183958;184376;185532;186336;186863;45888;45906.54093459023;45959;46047.539524604326;46173.30740038902;49241.75379123153;49258.507414926105;49303;49346;49393;15579.766303505456;15784.36862525509;15784.684306314039;15785;15846.841531584536;12822.551210707581;12833.679158021125;12834.935825320814;12841.93579032099;12966.546170884163;14048.227347495986;14151.433942642385;14173.716525669635;14186.503472378417;14337.283135843167;5818.796342128006;5870.3249126350165;5881.411858814085;5932.911006334908;5947.5539334550085;1010.8635334229932;1012.1851909213007;1013.9340942838692;1018.1040684197859;1019.3476175247847;22079;22295;22348.664770028463;22381.104755809913;22412.439689007904;1098.357460885391;1101.8402331661864;1116.508736156105;1118.2563595209094;1128.306091753582;11880.940595297141;11891.464884080237;11901.940490297493;12019.87980120205;12042.939785301018;225952;227297;227572;227859;228019;50562.49437505578;51700.22449663258;52837.735811320694;55288;55464;1417.2134465371612;1460.832004319517;1464.7143806957754;1467.4350375105662;1478.6894752101964;26122.738772612032;26456.867715661298;26612.334691632863;26906.32734181661;27183.320416989733;36391.818040909624;36470;36499;36522.452163218106;36534.817325914264;192700;193763;193822;193902;194931;31853.044408667778;31863.203419914687;31977.200569985005;32040;32176;38784;39963.40054899121;40480.1903961925;40670;40719.796401017804;30447.695523044487;30478.542821857245;30660.693393065783;30846.383072338875;32008.51987220147;30102.3443710598;30219.69780302169;30408.847955760964;30871.536926945664;31571.842140789147;33755.493667594514;33856.66143338535;34459.4831077529;34534.654653453144;34553;29815;29850.552241715955;30013.5497967535;30087.097387078422;30206.84896575503;22674.43313917165;22781.31656050321;23127.88436057809;23247.41881452977;23358.532829343658 17:45:50 INFO - PID 13488 | |2;jquery.html;553.5267346418809;556.3324011186575;563.9238702775124;565.2087078090675;569.7977267964595;22004.88997555014;22746.203882864123;22754.31737047887;22767.316980490592;22779.658305125435;23418.648720269208;24191.879040604817;24502.509949800995;24550.631740523906;24590.877045614747;6388.329225431333;6535;6575.572587781803;6576.243731970837;6576.539642225046;6468.417842394184;6550.344965503459;6562.8687426251445;6565.638889861056;6568.1789776277965;6194.101855230989;6420.293767685551;6439.130717353144;6460.515461340395;6533.509986750989;6360.745570177188;6407.455366293871;6413.583117097373;6433.3566643335525;6439.259485159197;5771.88456230873;5904.7342869570975;5955.076963070731;5957.553183511254;5973.7311820967725;27676.861615691992;28376.432471350457;28503.287417814514;28510.28724281889;28567;2004.3385682724665;2021.9797802022085;2058.361907808584;2060.484878780305;2071.109422948132;18492.53768655781;18703.62592748151;19139.234430622757;19188.040597970186;19295;2427.8179136564827;2448.2410452759523;2503.198976327576;2505.749425057498;2516.169664010872;121172;128519;129604.35197824045;136978;137051.31474342765;13935.58193254204;14442.566722998326;14449.20401508864;14580.924279277433;14757.631059223606;22020.33938981833;22024.229151979605;22050.44873878166;22125.336239912827;22154.556908861734;10113.949430252802;10382.169426446017;10383.325083869524;10418.531166097544;10453.372797632166;9680.709578712509;9692.612295508241;9710.863610005787;9797.118259356692;9802.411855288705;8935.151160639858;9026.909730902738;9077.863832042525;9139.223166030828;9153.359264851397;2684.637573927495;2685.1273336165823;2706.742859428351;2707.2555047362134;2761.337279053053;951.0917074194266;966.9033096690415;973.8295798235281;982.2387649571497;982.8427451607708;18455.53861153455;18583.53541161482;18991.1453984571;19010.144543495575;19045.14296856617;1010.4897027001317;1015.5683834370363;1026.9127124194379;1034.2088302448633;1037.9636712715019;10278;10320;10419.94790026045;10442.530086146142;10551.050405463391;482367;483763;484514;490957;492290;107922.46038769756;109195;112139;113027;113827;1038.4651904269308;1080.060347497682;1136.8181091025397;1139.27655938478;1191.2852288626927;19218.711719323943;19252.90373548123;19515.219391224193;19577;19584.412467625425;54423.45576544184;54548.454515455924;54577.72711136419;56398;56648.433515664314;71624;71956;72054.27945720476;72086.63956680182;72772;13725.725485490433;13851.16892986424;13877.79183312231;13889.930550347184;13894.374753135931;21485.14059437605;21771.455713606654;21900.342989709698;21913.890430547744;21929.561408771417;17659.911700441415;17672.469825905242;17966.101694915462;18046.5488362792;18116.81883181204;15602.297896594908;15613.297401617181;15637.452689155825;15754.763678544601;15856.682866342839;17766.84515506488;18067.728984065514;18080.09599520045;18175.727364089285;18192.72710909311;13572.79640805369;13625.931870340584;13765.793513097511;13839;13843.307834608027;17529.211185496937;17535.736963945295;17746.37887673925;17856.46430607084;17886.642267154322 17:45:50 INFO - PID 13488 | |3;mootools.html;1306.758249723801;1384.9169049857005;1405.9859401405995;1407.8169837921068;1417.7660685986818;15257.847421525781;15724.371025158995;15733.292001859914;15742.763858542132;15755.133467659274;15358.46245381409;15366.462173823918;15370.385184592604;15512.612184695388;15550.84449155508;2698.1500827239356;2703.9324016899636;2759.8206116602455;2761.903333383332;2764.8894044238205;2678.3973605938704;2691.165738621024;2706.404590989979;2706.905258315959;2708.1063249127837;2578.7034491033583;2674.61218123372;2695.649565556475;2695.689995650496;2696.406790506095;2762.323230808455;2773.653293338333;2781.5410457274625;2787.916362509128;2789.7628701560393;2733.139061195717;2745.3960128771637;2746.533089374811;2766.336079340964;2770.7229277072133;14751;15094.245287735679;15097.24513774307;15101.773473397909;15112.471063512725;7852.136265010844;8041.3968952328805;8043.758687239392;8048;8104.959475202645;5046.999061508414;5156.793728250866;5180.300659410969;5240.9213861792105;5250.737463126867;1995.7605087389607;2005.5688027074102;2008.8192062714427;2041.9795802041938;2055.1779288284656;26732.732672673414;26791.062312818958;26993.730062699316;26997;26997.325066873484;6567.737290508422;6685.161580565384;6739.494537909676;6866.793996180123;6914.239433662293;17498.91250543739;17505.474835754947;17520.824791752173;17523.211455484532;17543;7691.384689224848;7949.324307433817;8078.757637270891;8265.545395003333;8311.709090181814;7280.817979550554;7324.560526368328;7356.816079598053;7373.88939165913;7402.407807375397;5141.177411614124;5318.680879147263;5329.493698098674;5371.838844834661;5396.32713858705;1471.7865909443071;1487.7991471151256;1595.6649103688123;1613.2659639863834;1623.2127418202163;876.6887754847065;900.4192295969063;900.6622516556291;916.7891384981358;920.9685152628964;8330.083690794008;8453.492790432594;8527.914720852712;8531.74404767858;8550.529720865288;722.2849379114639;726.7819654103748;726.8764310067302;728.9343959043712;804.9114597394282;5160.509751573594;5204.323437953042;5250.291210686585;5369.40936496985;5503.367112782002;21086.894565527073;21178.576428471653;21434.678479822815;21544.56910861774;22260.55478890413;20321.288754893507;20822.79177208239;20942.37172884816;21066.78933210679;21337;10346.430946297874;10463.319884207502;10571.788564228673;10602.469876506144;10645.78708425827;7961.522308661499;8137.715179968673;8299.543525106177;8395.454295470774;8443.662253510036;18124.093795309916;18167.909160454114;18197.909010454863;18329.175187116878;18464.35374761877;18702;18832.717509237646;18891.811081889005;18942.147603358157;19079.71380429267;10683.30558513694;10767.246292759432;10889.673309800719;10894.891051089387;10899.945500272448;13611.86388136106;13894.166350019032;13901.37443815051;13946.79079813824;13955.790663139858;11269.830952535554;11289.71775705614;11371.715707107389;11514.712132196762;11619.302841829518;11042.282251653616;11231.38227397501;11331.32012079278;11450;11629.825552616887;9452.480113593818;9739.9026009739;9741.707748767549;9747.122758951728;9747.9025209747;6961.37347638715;6968.79093627192;6971.51199416036;6976.5465244758925;7058.258882817436;6738.59568425896;6851;6893.517453778188;6918.238993710587;6958.443324534126 17:45:50 INFO - PID 13488 | |4;prototype.html;480.30355983823466;504.8334049763578;515.1397166731558;518.9948100518993;525.4115390762347;6263.557212687056;6311.873762524747;6336.778212762554;6347.777827776029;6387.329330420309;6144.6006009609455;6150.938490615093;6153.384661533844;6179.660118693481;6282.811515654537;4877.780499877514;4917.82787602434;5156.3296771419755;5161.4322424533275;5183.818566350178;4945.159322915095;4984.725840078794;5000.224965130411;5000.449950505442;5038.445770965191;4909.656324057318;4941.975290123544;4976.701397916118;4990.201567749161;4990.900181996358;4985.152524070917;4987.730582584952;5028.145215313405;5048.829003528482;5053.216751403502;4508.639308855284;4543.182227199103;4545.977270113628;4548.999220171557;4563.383943167663;6147;6172.29018662855;6193.3496982816605;6198.287196972361;6330.335314791927;5674.602777805555;5739.827805165852;5751.309842818847;5766.769329226868;5778.855528611776;6700.93299067008;6702.396784289389;6703.463722902156;6722.563033402862;6727.562708423986;4905.730184839832;4908.01839632075;4913.656044076916;4918.434380046305;4943.406791185081;6698.564593301468;6762.188537375498;6867.587944723333;6886.724531018754;6963.651817409109;5001.799928002912;5011.749412529359;5059.392872855281;5061.164907790173;5063.721495317719;5078.669886457368;5091.8981620367385;5093.363329583802;5096.847094587169;5147.176451767774;5715.599908006399;5733.913991290134;5738.426157384228;5741.034005585138;5804.158397032491;6682.3317668232785;6707.899381509281;6721.327867213239;6737.652469506118;6767.2066902270935;1755.6225411536582;1759.5513144148417;1764.3207365164503;1776.9111544422726;1782.0466050662833;1154.5266440759249;1196.9401529923468;1207.8309036734863;1216.4282787090053;1235.2218102595307;5728.828135155952;5756.798512052058;5766.538676905838;5789.363170051291;5815.94184058154;6764.594124352555;6836.6923488443135;6853.732059568995;6855.4172895304455;6873.931260687429;5791.362950075489;5805.970970145122;5808.564357673192;5819.679917604488;5827.388124246978;3602.8470889315167;3610.1588190023276;3630.854765809338;3632.8183590820354;3636.7090632749846;6489.318621544764;6523.836904077436;6537.280899101095;6605.603663780189;6687.899681504781;6867.175938887365;6904.551204171713;6908.171019477594;6925.549839260432;6961.503276795514;6157.291911430243;6485.643289618927;6527.967360163168;6565.8358541035905;6594.1865986854;6576.342365763386;6699.29657385987;6703.296153903965;6759.391654751096;6761.966190169018;6628.5691430056895;6757.86484270302;6854.520183587101;6882.797504798416;6910;6518.511111666549;6595;6693.230278518033;6695.928651415945;6697.899531506934;5007.1487847065355;5012.699238045729;5036.960031187375;5047.621428392812;5360.437154098763;6424.775132870514;6514.250861151028;6670.831979606744;6960.269171737097;6961.79114626562;6493.396165128399;6526.184226971629;6534.607923524603;6682.63245521501;6688.163979502562;6488.188976377953;6534.523851161969;6588.308227636221;6625.867482650224;6714.429273511806;6465.967670161619;6573.5069869759;6610.025488530277;6621.3047629998155;6651.16860392451;6762.256151823197;6804.285550017375;6808.455323574003;6814;6840.486963477859;6463.192100987377;6476.5466417350335;6503.309604096416;6525.8694826104165;6537.771178008747 17:45:50 INFO - PID 13488 | |5;yui.html;889.6263569300894;905.8686490458883;913.0367462327247;915.190056799732;917.7200953709121;19016.809831901675;19779.307724229653;19830.900845495788;19845.305414310504;19894.20423183073;17332.220050097745;17559.648807023852;17597.208125634344;17611.735823962652;17631.64736705265;949.0414681171997;962.9855552166723;963.5471328475605;967.1440774914216;967.9661211857587;964.6334392930677;975.2685485885586;978.2614126334643;978.6330126202674;980.4509474694158;989.2432289298692;1008.0675375277875;1027.6403258859414;1027.8047171037479;1028.7222449938513;982.5038355630433;1014.4167103915241;1018.1701912940929;1019.021739130432;1025.4462590201283;726.5241266970143;737;739.7743688175104;742.4913933955258;743.5315751076841;19281.4215573533;19464.70802937957;19551.413457596154;19580.608387832162;19596.902015489974;22026.559468810694;22210;22345.21791737298;22555;22761;17610.38363657266;17960;18239.72640410395;18246.452606421695;18250.269989200417;3637.727170462226;3667.064898450905;3672.4307732301536;3680.9263814723554;3684.1894783147663;110358;144439;145501;147790.26104869405;149229;17344.82655173432;17911.910440447977;18001.099945002697;18022.639547209244;18090.547736306697;31953.840230798698;32965.67034329674;33017.17457063593;33041.33917321688;33061.33877322488;8513.489190648581;8731.912680873236;8757.211850933447;8769.91230087691;8770.473771573726;4097.610726980932;4161.271777438936;4177.436046133733;4180.080382315886;4186.727862688916;5446.291982042389;5551.3893471718075;5551.666899986014;5574.470425309589;5578.525825304813;1070.9410982395887;1071.8231491803765;1092.4592326798286;1105.7567335186245;1109.57836022311;665.6339013542629;685.3934268172703;696.4567637242959;697.20866816163;707.4693979515364;11961;12133.701232929441;12284.262944223376;12575.371231438574;12983.717910298596;676.0805304785488;678.4538446550574;688.6487891175436;700.8598280343952;702.6627218934838;5536.390996990328;5547.140193270049;5551.1673249012165;5587.860303492445;5609.046462101453;124491;125595;126912;128163;128422.35788820995;104333.47833260937;106222.46888765506;107815;109065;110225;94511.52744236235;94691.52654236685;97867;99407.50296248472;100690.49654751825;10166.288359814742;10312.432816195182;10350.430726310125;10459.267851250645;10543.20925930543;43293.567064330215;43475.78262108669;43569.56430435655;44007.77996109999;45377.54622453865;54375.456245438625;54708.17937731017;55835.16247256376;55940.44059559515;56376;15390.538283851502;15701.214939253221;15734.685306294039;15785.526434206991;15837.604059898595;17488.562785930455;17582.120893955507;17629.118544073;17643.55891102733;17739.73390399171;15536.766948495555;15790.21048947571;15864.60338491547;15944.521664350088;15954.521364359089;16358.100304483367;16493.752593711342;16533.58666033359;16560.254788534785;16597.834021660114;15510.767338490157;15583.142927139117;15640.217989100727;15697.136657483949;15705.057696538244;11687.298762074302;11703.707407314545;11731.47208375608;11823.881761182278;11874.406279686154;11572.305661660328;11755;11789.410529473664;11961.880381196077;12088.697782555155 17:45:50 INFO - PID 13488 | __end_tp_report 17:45:50 INFO - PID 13488 | __start_cc_report 17:45:50 INFO - PID 13488 | _x_x_mozilla_cycle_collect,361 17:45:50 INFO - PID 13488 | __end_cc_report 17:45:50 INFO - PID 13488 | __startTimestamp1505349950886__endTimestamp 17:45:50 INFO - PID 13488 | 17:45:50 INFO - PID 13488 | ------- Summary: start ------- 17:45:50 INFO - PID 13488 | Number of tests: 6 17:45:50 INFO - PID 13488 | 17:45:50 INFO - PID 13488 | [#0] dojo.html Cycles:165 Average:6249.08 Median:6539.44 stddev:858.65 (13.1%) stddev-sans-first:825.65 17:45:50 INFO - PID 13488 | Values: 3128.2 3151.7 3190.6 3196.6 3204.9 6192.6 6324.0 6339.8 6342.5 6413.1 6209.1 6258.2 6325.7 6465.9 6480.3 5701.4 5792.7 5852.5 5862.8 5940.7 1292.7 5740.1 5799.6 5911.7 5947.5 5836.3 5839.4 5901.5 5923.0 5925.4 5848.9 5855.5 5928.0 5928.8 5938.0 5799.4 5820.9 5883.3 5891.8 5906.3 6370.9 6386.0 6393.3 6430.6 6465.8 6672.4 6776.2 6849.0 6876.4 6956.9 6836.5 6855.4 6862.3 6865.6 6869.5 6339.1 6347.2 6458.4 6464.1 6468.3 7084.7 7102.5 7178.5 7187.7 7203.7 6559.7 6690.9 6747.2 6785.3 6855.0 6769.8 6809.3 6895.5 6904.3 6906.1 6705.5 6758.7 6819.2 6820.2 6827.6 6734.2 6743.1 6824.1 6857.7 6862.3 5277.6 5301.5 5343.8 5359.4 5361.2 4622.7 4661.9 4706.1 4720.6 4743.8 5779.7 5856.0 5865.7 5878.4 5921.0 6797.6 6822.1 6893.4 6973.1 6982.5 5684.2 5794.7 5823.9 5883.2 5899.4 5757.8 5764.6 5775.3 5778.5 5782.2 6440.5 6488.6 6512.2 6513.4 6546.4 6729.8 6928.1 6933.0 6933.1 6972.5 6616.1 6645.7 6694.3 6709.7 6716.4 6520.5 6711.2 6722.1 6788.0 6825.5 6780.8 6786.4 6831.6 6831.9 6835.8 6577.7 6603.2 6687.5 6690.6 6694.4 6596.2 6677.7 6687.3 6698.3 6708.5 6525.9 6571.0 6625.8 6634.9 6652.7 6544.7 6641.8 6693.1 6754.1 6771.1 6522.1 6539.4 6545.3 6576.4 6585.2 17:45:50 INFO - PID 13488 | 17:45:50 INFO - PID 13488 | [#1] ext.html Cycles:180 Average:36602.09 Median:33806.08 stddev:52562.67 (155.5%) stddev-sans-first:52641.06 17:45:50 INFO - PID 13488 | Values: 718.4 781.9 790.5 795.4 797.1 39831.4 40687.8 40752.2 40784.8 40992.0 36656.1 36975.4 36985.4 37018.4 37031.8 6977.8 7088.3 7120.5 7128.0 7131.8 6989.2 6994.7 6995.7 7007.8 7009.1 7065.9 7068.5 7070.4 7088.5 7781.1 7862.8 7920.3 7926.1 7932.4 7933.4 7556.2 7741.2 7783.2 7865.9 7872.8 36981.3 37328.3 37370.4 37382.4 37477.0 3537.9 3575.1 3582.7 3583.2 3586.5 30638.8 30714.0 30770.4 30809.0 30868.5 5096.7 5102.5 5144.5 5146.4 5146.8 183958.0 184376.0 185532.0 186336.0 186863.0 45888.0 45906.5 45959.0 46047.5 46173.3 49241.8 49258.5 49303.0 49346.0 49393.0 15579.8 15784.4 15784.7 15785.0 15846.8 12822.6 12833.7 12834.9 12841.9 12966.5 14048.2 14151.4 14173.7 14186.5 14337.3 5818.8 5870.3 5881.4 5932.9 5947.6 1010.9 1012.2 1013.9 1018.1 1019.3 22079.0 22295.0 22348.7 22381.1 22412.4 1098.4 1101.8 1116.5 1118.3 1128.3 11880.9 11891.5 11901.9 12019.9 12042.9 225952.0 227297.0 227572.0 227859.0 228019.0 50562.5 51700.2 52837.7 55288.0 55464.0 1417.2 1460.8 1464.7 1467.4 1478.7 26122.7 26456.9 26612.3 26906.3 27183.3 36391.8 36470.0 36499.0 36522.5 36534.8 192700.0 193763.0 193822.0 193902.0 194931.0 31853.0 31863.2 31977.2 32040.0 32176.0 38784.0 39963.4 40480.2 40670.0 40719.8 30447.7 30478.5 30660.7 30846.4 32008.5 30102.3 30219.7 30408.8 30871.5 31571.8 33755.5 33856.7 34459.5 34534.7 34553.0 29815.0 29850.6 30013.5 30087.1 30206.8 22674.4 22781.3 23127.9 23247.4 23358.5 17:45:50 INFO - PID 13488 | 17:45:50 INFO - PID 13488 | [#2] jquery.html Cycles:180 Average:34055.28 Median:22012.61 stddev:81762.84 (371.4%) stddev-sans-first:81953.52 17:45:50 INFO - PID 13488 | Values: 553.5 556.3 563.9 565.2 569.8 22004.9 22746.2 22754.3 22767.3 22779.7 23418.6 24191.9 24502.5 24550.6 24590.9 6388.3 6535.0 6575.6 6576.2 6576.5 6468.4 6550.3 6562.9 6565.6 6568.2 6194.1 6420.3 6439.1 6460.5 6533.5 6360.7 6407.5 6413.6 6433.4 6439.3 5771.9 5904.7 5955.1 5957.6 5973.7 27676.9 28376.4 28503.3 28510.3 28567.0 2004.3 2022.0 2058.4 2060.5 2071.1 18492.5 18703.6 19139.2 19188.0 19295.0 2427.8 2448.2 2503.2 2505.7 2516.2 121172.0 128519.0 129604.4 136978.0 137051.3 13935.6 14442.6 14449.2 14580.9 14757.6 22020.3 22024.2 22050.4 22125.3 22154.6 10113.9 10382.2 10383.3 10418.5 10453.4 9680.7 9692.6 9710.9 9797.1 9802.4 8935.2 9026.9 9077.9 9139.2 9153.4 2684.6 2685.1 2706.7 2707.3 2761.3 951.1 966.9 973.8 982.2 982.8 18455.5 18583.5 18991.1 19010.1 19045.1 1010.5 1015.6 1026.9 1034.2 1038.0 10278.0 10320.0 10419.9 10442.5 10551.1 482367.0 483763.0 484514.0 490957.0 492290.0 107922.5 109195.0 112139.0 113027.0 113827.0 1038.5 1080.1 1136.8 1139.3 1191.3 19218.7 19252.9 19515.2 19577.0 19584.4 54423.5 54548.5 54577.7 56398.0 56648.4 71624.0 71956.0 72054.3 72086.6 72772.0 13725.7 13851.2 13877.8 13889.9 13894.4 21485.1 21771.5 21900.3 21913.9 21929.6 17659.9 17672.5 17966.1 18046.5 18116.8 15602.3 15613.3 15637.5 15754.8 15856.7 17766.8 18067.7 18080.1 18175.7 18192.7 13572.8 13625.9 13765.8 13839.0 13843.3 17529.2 17535.7 17746.4 17856.5 17886.6 17:45:50 INFO - PID 13488 | 17:45:50 INFO - PID 13488 | [#3] mootools.html Cycles:180 Average:9292.15 Median:26995.37 stddev:6661.12 (24.7%) stddev-sans-first:6652.78 17:45:50 INFO - PID 13488 | Values: 1306.8 1384.9 1406.0 1407.8 1417.8 15257.8 15724.4 15733.3 15742.8 15755.1 15358.5 15366.5 15370.4 15512.6 15550.8 2698.2 2703.9 2759.8 2761.9 2764.9 2678.4 2691.2 2706.4 2706.9 2708.1 2578.7 2674.6 2695.6 2695.7 2696.4 2762.3 2773.7 2781.5 2787.9 2789.8 2733.1 2745.4 2746.5 2766.3 2770.7 14751.0 15094.2 15097.2 15101.8 15112.5 7852.1 8041.4 8043.8 8048.0 8105.0 5047.0 5156.8 5180.3 5240.9 5250.7 1995.8 2005.6 2008.8 2042.0 2055.2 26732.7 26791.1 26993.7 26997.0 26997.3 6567.7 6685.2 6739.5 6866.8 6914.2 17498.9 17505.5 17520.8 17523.2 17543.0 7691.4 7949.3 8078.8 8265.5 8311.7 7280.8 7324.6 7356.8 7373.9 7402.4 5141.2 5318.7 5329.5 5371.8 5396.3 1471.8 1487.8 1595.7 1613.3 1623.2 876.7 900.4 900.7 916.8 921.0 8330.1 8453.5 8527.9 8531.7 8550.5 722.3 726.8 726.9 728.9 804.9 5160.5 5204.3 5250.3 5369.4 5503.4 21086.9 21178.6 21434.7 21544.6 22260.6 20321.3 20822.8 20942.4 21066.8 21337.0 10346.4 10463.3 10571.8 10602.5 10645.8 7961.5 8137.7 8299.5 8395.5 8443.7 18124.1 18167.9 18197.9 18329.2 18464.4 18702.0 18832.7 18891.8 18942.1 19079.7 10683.3 10767.2 10889.7 10894.9 10899.9 13611.9 13894.2 13901.4 13946.8 13955.8 11269.8 11289.7 11371.7 11514.7 11619.3 11042.3 11231.4 11331.3 11450.0 11629.8 9452.5 9739.9 9741.7 9747.1 9747.9 6961.4 6968.8 6971.5 6976.5 7058.3 6738.6 6851.0 6893.5 6918.2 6958.4 17:45:50 INFO - PID 13488 | 17:45:50 INFO - PID 13488 | [#4] prototype.html Cycles:180 Average:5572.17 Median:6175.98 stddev:1570.52 (25.4%) stddev-sans-first:1527.72 17:45:50 INFO - PID 13488 | Values: 480.3 504.8 515.1 519.0 525.4 6263.6 6311.9 6336.8 6347.8 6387.3 6144.6 6150.9 6153.4 6179.7 6282.8 4877.8 4917.8 5156.3 5161.4 5183.8 4945.2 4984.7 5000.2 5000.4 5038.4 4909.7 4942.0 4976.7 4990.2 4990.9 4985.2 4987.7 5028.1 5048.8 5053.2 4508.6 4543.2 4546.0 4549.0 4563.4 6147.0 6172.3 6193.3 6198.3 6330.3 5674.6 5739.8 5751.3 5766.8 5778.9 6700.9 6702.4 6703.5 6722.6 6727.6 4905.7 4908.0 4913.7 4918.4 4943.4 6698.6 6762.2 6867.6 6886.7 6963.7 5001.8 5011.7 5059.4 5061.2 5063.7 5078.7 5091.9 5093.4 5096.8 5147.2 5715.6 5733.9 5738.4 5741.0 5804.2 6682.3 6707.9 6721.3 6737.7 6767.2 1755.6 1759.6 1764.3 1776.9 1782.0 1154.5 1196.9 1207.8 1216.4 1235.2 5728.8 5756.8 5766.5 5789.4 5815.9 6764.6 6836.7 6853.7 6855.4 6873.9 5791.4 5806.0 5808.6 5819.7 5827.4 3602.8 3610.2 3630.9 3632.8 3636.7 6489.3 6523.8 6537.3 6605.6 6687.9 6867.2 6904.6 6908.2 6925.5 6961.5 6157.3 6485.6 6528.0 6565.8 6594.2 6576.3 6699.3 6703.3 6759.4 6762.0 6628.6 6757.9 6854.5 6882.8 6910.0 6518.5 6595.0 6693.2 6695.9 6697.9 5007.1 5012.7 5037.0 5047.6 5360.4 6424.8 6514.3 6670.8 6960.3 6961.8 6493.4 6526.2 6534.6 6682.6 6688.2 6488.2 6534.5 6588.3 6625.9 6714.4 6466.0 6573.5 6610.0 6621.3 6651.2 6762.3 6804.3 6808.5 6814.0 6840.5 6463.2 6476.5 6503.3 6525.9 6537.8 17:45:50 INFO - PID 13488 | 17:45:50 INFO - PID 13488 | [#5] yui.html Cycles:180 Average:24492.06 Median:19373.06 stddev:35666.00 (184.1%) stddev-sans-first:35722.03 17:45:50 INFO - PID 13488 | Values: 889.6 905.9 913.0 915.2 917.7 19016.8 19779.3 19830.9 19845.3 19894.2 17332.2 17559.6 17597.2 17611.7 17631.6 949.0 963.0 963.5 967.1 968.0 964.6 975.3 978.3 978.6 980.5 989.2 1008.1 1027.6 1027.8 1028.7 982.5 1014.4 1018.2 1019.0 1025.4 726.5 737.0 739.8 742.5 743.5 19281.4 19464.7 19551.4 19580.6 19596.9 22026.6 22210.0 22345.2 22555.0 22761.0 17610.4 17960.0 18239.7 18246.5 18250.3 3637.7 3667.1 3672.4 3680.9 3684.2 110358.0 144439.0 145501.0 147790.3 149229.0 17344.8 17911.9 18001.1 18022.6 18090.5 31953.8 32965.7 33017.2 33041.3 33061.3 8513.5 8731.9 8757.2 8769.9 8770.5 4097.6 4161.3 4177.4 4180.1 4186.7 5446.3 5551.4 5551.7 5574.5 5578.5 1070.9 1071.8 1092.5 1105.8 1109.6 665.6 685.4 696.5 697.2 707.5 11961.0 12133.7 12284.3 12575.4 12983.7 676.1 678.5 688.6 700.9 702.7 5536.4 5547.1 5551.2 5587.9 5609.0 124491.0 125595.0 126912.0 128163.0 128422.4 104333.5 106222.5 107815.0 109065.0 110225.0 94511.5 94691.5 97867.0 99407.5 100690.5 10166.3 10312.4 10350.4 10459.3 10543.2 43293.6 43475.8 43569.6 44007.8 45377.5 54375.5 54708.2 55835.2 55940.4 56376.0 15390.5 15701.2 15734.7 15785.5 15837.6 17488.6 17582.1 17629.1 17643.6 17739.7 15536.8 15790.2 15864.6 15944.5 15954.5 16358.1 16493.8 16533.6 16560.3 16597.8 15510.8 15583.1 15640.2 15697.1 15705.1 11687.3 11703.7 11731.5 11823.9 11874.4 11572.3 11755.0 11789.4 11961.9 12088.7 17:45:50 INFO - PID 13488 | -------- Summary: end -------- 17:45:50 INFO - PID 13488 | 17:45:51 INFO - TEST-INFO | 13488: exit 0 17:45:51 INFO - TEST-OK | dromaeo_css | took 1109267ms 17:45:51 INFO - TEST-START | kraken 17:45:51 INFO - Initialising browser for kraken test... 17:45:51 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43812/getInfo.html -profile /tmp/tmp2oOYWU/profile 17:45:51 INFO - TEST-INFO | started process 13854 (/builds/slave/test/build/application/firefox/firefox http://localhost:43812/getInfo.html) 17:45:56 INFO - TEST-INFO | 13854: exit 0 17:45:56 INFO - Browser initialized. 17:45:56 INFO - Running cycle 1/1 for kraken test... 17:45:56 INFO - Using env: {'DISPLAY': ':0', 17:45:56 INFO - 'HOME': '/home/cltbld', 17:45:56 INFO - 'JSGC_DISABLE_POISONING': '1', 17:45:56 INFO - 'LANG': 'en_US.UTF-8', 17:45:56 INFO - 'LANGUAGE': 'en_US:en', 17:45:56 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:45:56 INFO - 'LOGNAME': 'cltbld', 17:45:56 INFO - 'MAIL': '/var/mail/cltbld', 17:45:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:45:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:45:56 INFO - 'MOZ_CRASHREPORTER': '1', 17:45:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:56 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:45:56 INFO - 'MOZ_NO_REMOTE': '1', 17:45:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:45:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:45:56 INFO - 'NO_EM_RESTART': '1', 17:45:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:45:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:56 INFO - 'PWD': '/builds/slave/test', 17:45:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:45:56 INFO - 'RUST_BACKTRACE': 'full', 17:45:56 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:45:56 INFO - 'SHELL': '/bin/bash', 17:45:56 INFO - 'SHLVL': '1', 17:45:56 INFO - 'STYLO_FORCE_DISABLED': '1', 17:45:56 INFO - 'TERM': 'linux', 17:45:56 INFO - 'TMOUT': '86400', 17:45:56 INFO - 'USER': 'cltbld', 17:45:56 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1505348783.246139-355573265', 17:45:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:56 INFO - '_': '/tools/buildbot/bin/python'} 17:45:56 INFO - TEST-INFO | started process 14088 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2oOYWU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:45:57 INFO - PID 14088 | 17:45:57 INFO - PID 14088 | (/builds/slave/test/build/application/firefox/firefox:14137): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:45:57 INFO - PID 14088 | 17:46:08 INFO - PID 14088 | RSS: Main: 173719552 17:46:08 INFO - PID 14088 | 17:46:10 INFO - PID 14088 | Cycle 1(1): loaded http://localhost:43812/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43812/tests/kraken/driver.html?testName=audio-beat-detection) 17:46:11 INFO - PID 14088 | RSS: Main: 179986432 17:46:11 INFO - PID 14088 | 17:46:14 INFO - PID 14088 | Cycle 1(1): loaded http://localhost:43812/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43812/tests/kraken/driver.html?testName=audio-dft) 17:46:15 INFO - PID 14088 | RSS: Main: 180342784 17:46:15 INFO - PID 14088 | 17:46:18 INFO - PID 14088 | Cycle 1(1): loaded http://localhost:43812/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43812/tests/kraken/driver.html?testName=audio-fft) 17:46:18 INFO - PID 14088 | RSS: Main: 174448640 17:46:18 INFO - PID 14088 | 17:46:20 INFO - PID 14088 | Cycle 1(1): loaded http://localhost:43812/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43812/tests/kraken/driver.html?testName=audio-oscillator) 17:46:21 INFO - PID 14088 | RSS: Main: 174915584 17:46:21 INFO - PID 14088 | 17:46:23 INFO - PID 14088 | Cycle 1(1): loaded http://localhost:43812/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43812/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:46:24 INFO - PID 14088 | RSS: Main: 175140864 17:46:24 INFO - PID 14088 | 17:46:27 INFO - PID 14088 | Cycle 1(1): loaded http://localhost:43812/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43812/tests/kraken/driver.html?testName=imaging-darkroom) 17:46:27 INFO - PID 14088 | RSS: Main: 177709056 17:46:27 INFO - PID 14088 | 17:46:31 INFO - PID 14088 | Cycle 1(1): loaded http://localhost:43812/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43812/tests/kraken/driver.html?testName=imaging-desaturate) 17:46:32 INFO - PID 14088 | RSS: Main: 177840128 17:46:32 INFO - PID 14088 | 17:46:35 INFO - PID 14088 | Cycle 1(1): loaded http://localhost:43812/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43812/tests/kraken/driver.html?testName=json-parse-financial) 17:46:35 INFO - PID 14088 | RSS: Main: 178020352 17:46:35 INFO - PID 14088 | 17:46:37 INFO - PID 14088 | Cycle 1(1): loaded http://localhost:43812/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43812/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:46:38 INFO - PID 14088 | RSS: Main: 178089984 17:46:38 INFO - PID 14088 | 17:46:39 INFO - PID 14088 | Cycle 1(1): loaded http://localhost:43812/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43812/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:46:40 INFO - PID 14088 | RSS: Main: 178221056 17:46:40 INFO - PID 14088 | 17:46:42 INFO - PID 14088 | Cycle 1(1): loaded http://localhost:43812/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43812/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:46:43 INFO - PID 14088 | RSS: Main: 174964736 17:46:43 INFO - PID 14088 | 17:46:45 INFO - PID 14088 | Cycle 1(1): loaded http://localhost:43812/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43812/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:46:46 INFO - PID 14088 | RSS: Main: 175620096 17:46:46 INFO - PID 14088 | 17:46:49 INFO - PID 14088 | Cycle 1(1): loaded http://localhost:43812/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43812/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:46:49 INFO - PID 14088 | RSS: Main: 175550464 17:46:49 INFO - PID 14088 | 17:46:51 INFO - PID 14088 | Cycle 1(1): loaded http://localhost:43812/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43812/tests/kraken/driver.html?testName=ai-astar) 17:46:51 INFO - PID 14088 | RSS: Main: 176672768 17:46:51 INFO - PID 14088 | 17:46:51 INFO - PID 14088 | __start_tp_report 17:46:51 INFO - PID 14088 | _x_x_mozilla_page_load 17:46:51 INFO - PID 14088 | _x_x_mozilla_page_load_details 17:46:51 INFO - PID 14088 | |i|pagename|runs| 17:46:51 INFO - PID 14088 | |0;ai-astar;108;107;107;106;107;107;109;106;110;109 17:46:51 INFO - PID 14088 | |1;audio-beat-detection;122;117;116;121;117;115;116;122;115;147 17:46:51 INFO - PID 14088 | |2;audio-dft;164;163;163;162;162;162;165;170;171;166 17:46:51 INFO - PID 14088 | |3;audio-fft;75;74;73;73;73;74;76;76;82;73 17:46:51 INFO - PID 14088 | |4;audio-oscillator;79;78;79;80;80;79;79;79;80;82 17:46:51 INFO - PID 14088 | |5;imaging-gaussian-blur;113;113;113;113;114;116;114;114;110;115 17:46:51 INFO - PID 14088 | |6;imaging-darkroom;150;153;149;148;148;147;149;149;151;148 17:46:51 INFO - PID 14088 | |7;imaging-desaturate;94;94;94;94;94;94;94;95;96;95 17:46:51 INFO - PID 14088 | |8;json-parse-financial;54;53;52;53;52;53;52;52;51;51 17:46:51 INFO - PID 14088 | |9;json-stringify-tinderbox;38;37;38;38;38;38;37;42;38;38 17:46:51 INFO - PID 14088 | |10;stanford-crypto-aes;75;72;82;73;75;74;74;74;73;73 17:46:51 INFO - PID 14088 | |11;stanford-crypto-ccm;116;110;113;115;114;118;120;113;115;116 17:46:51 INFO - PID 14088 | |12;stanford-crypto-pbkdf2;169;168;170;168;169;186;173;166;176;176 17:46:51 INFO - PID 14088 | |13;stanford-crypto-sha256-iterative;68;84;68;70;65;65;65;63;71;68 17:46:51 INFO - PID 14088 | __end_tp_report 17:46:51 INFO - PID 14088 | __start_cc_report 17:46:51 INFO - PID 14088 | _x_x_mozilla_cycle_collect,946 17:46:51 INFO - PID 14088 | __end_cc_report 17:46:51 INFO - PID 14088 | __startTimestamp1505350011931__endTimestamp 17:46:51 INFO - PID 14088 | 17:46:51 INFO - PID 14088 | ------- Summary: start ------- 17:46:51 INFO - PID 14088 | Number of tests: 14 17:46:51 INFO - PID 14088 | 17:46:51 INFO - PID 14088 | [#0] ai-astar Cycles:10 Average:107.60 Median:107.50 stddev:1.35 (1.3%) stddev-sans-first:1.42 17:46:51 INFO - PID 14088 | Values: 108.0 107.0 107.0 106.0 107.0 107.0 109.0 106.0 110.0 109.0 17:46:51 INFO - PID 14088 | 17:46:51 INFO - PID 14088 | [#1] audio-beat-detection Cycles:10 Average:120.80 Median:119.00 stddev:9.61 (8.1%) stddev-sans-first:10.19 17:46:51 INFO - PID 14088 | Values: 122.0 117.0 116.0 121.0 117.0 115.0 116.0 122.0 115.0 147.0 17:46:51 INFO - PID 14088 | 17:46:51 INFO - PID 14088 | [#2] audio-dft Cycles:10 Average:164.80 Median:164.50 stddev:3.29 (2.0%) stddev-sans-first:3.48 17:46:51 INFO - PID 14088 | Values: 164.0 163.0 163.0 162.0 162.0 162.0 165.0 170.0 171.0 166.0 17:46:51 INFO - PID 14088 | 17:46:51 INFO - PID 14088 | [#3] audio-fft Cycles:10 Average:74.90 Median:74.50 stddev:2.77 (3.7%) stddev-sans-first:2.93 17:46:51 INFO - PID 14088 | Values: 75.0 74.0 73.0 73.0 73.0 74.0 76.0 76.0 82.0 73.0 17:46:51 INFO - PID 14088 | 17:46:51 INFO - PID 14088 | [#4] audio-oscillator Cycles:10 Average:79.50 Median:79.50 stddev:1.08 (1.4%) stddev-sans-first:1.13 17:46:51 INFO - PID 14088 | Values: 79.0 78.0 79.0 80.0 80.0 79.0 79.0 79.0 80.0 82.0 17:46:51 INFO - PID 14088 | 17:46:51 INFO - PID 14088 | [#5] imaging-gaussian-blur Cycles:10 Average:113.50 Median:114.00 stddev:1.58 (1.4%) stddev-sans-first:1.67 17:46:51 INFO - PID 14088 | Values: 113.0 113.0 113.0 113.0 114.0 116.0 114.0 114.0 110.0 115.0 17:46:51 INFO - PID 14088 | 17:46:51 INFO - PID 14088 | [#6] imaging-darkroom Cycles:10 Average:149.20 Median:149.00 stddev:1.75 (1.2%) stddev-sans-first:1.83 17:46:51 INFO - PID 14088 | Values: 150.0 153.0 149.0 148.0 148.0 147.0 149.0 149.0 151.0 148.0 17:46:51 INFO - PID 14088 | 17:46:51 INFO - PID 14088 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 17:46:51 INFO - PID 14088 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 94.0 95.0 96.0 95.0 17:46:51 INFO - PID 14088 | 17:46:51 INFO - PID 14088 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:52.50 stddev:0.95 (1.8%) stddev-sans-first:0.78 17:46:51 INFO - PID 14088 | Values: 54.0 53.0 52.0 53.0 52.0 53.0 52.0 52.0 51.0 51.0 17:46:51 INFO - PID 14088 | 17:46:51 INFO - PID 14088 | [#9] json-stringify-tinderbox Cycles:10 Average:38.20 Median:38.00 stddev:1.40 (3.7%) stddev-sans-first:1.48 17:46:51 INFO - PID 14088 | Values: 38.0 37.0 38.0 38.0 38.0 38.0 37.0 42.0 38.0 38.0 17:46:51 INFO - PID 14088 | 17:46:51 INFO - PID 14088 | [#10] stanford-crypto-aes Cycles:10 Average:74.50 Median:74.00 stddev:2.80 (3.8%) stddev-sans-first:2.96 17:46:51 INFO - PID 14088 | Values: 75.0 72.0 82.0 73.0 75.0 74.0 74.0 74.0 73.0 73.0 17:46:51 INFO - PID 14088 | 17:46:51 INFO - PID 14088 | [#11] stanford-crypto-ccm Cycles:10 Average:115.00 Median:115.50 stddev:2.79 (2.4%) stddev-sans-first:2.93 17:46:51 INFO - PID 14088 | Values: 116.0 110.0 113.0 115.0 114.0 118.0 120.0 113.0 115.0 116.0 17:46:51 INFO - PID 14088 | 17:46:51 INFO - PID 14088 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.10 Median:171.50 stddev:5.95 (3.5%) stddev-sans-first:6.21 17:46:51 INFO - PID 14088 | Values: 169.0 168.0 170.0 168.0 169.0 186.0 173.0 166.0 176.0 176.0 17:46:51 INFO - PID 14088 | 17:46:51 INFO - PID 14088 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:68.00 stddev:5.93 (8.7%) stddev-sans-first:6.28 17:46:51 INFO - PID 14088 | Values: 68.0 84.0 68.0 70.0 65.0 65.0 65.0 63.0 71.0 68.0 17:46:51 INFO - PID 14088 | -------- Summary: end -------- 17:46:51 INFO - PID 14088 | 17:46:52 INFO - PID 14088 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:46:52 INFO - TEST-INFO | 14088: exit 0 17:46:52 INFO - TEST-OK | kraken | took 61029ms 17:46:52 INFO - SUITE-END | took 1170s 17:46:53 INFO - Completed test suite (00:19:30) 17:46:53 INFO - javascript benchmark 17:46:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8465.637555159352, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3128.1553980425283, 3151.6848315168477, 3190.5692731481245, 3196.5684632574594, 3204.9038528844144, 6192.628442293454, 6324.0, 6339.841503962403, 6342.5243106767, 6413.102165696806, 6209.099680546329, 6258.217722784652, 6325.746970121201, 6465.903011454832, 6480.319566445526, 5701.372848986619, 5792.68140252286, 5852.473277405033, 5862.765489380441, 5940.702964851762, 1292.7448520822293, 5740.1102829061565, 5799.565032622549, 5911.704414779266, 5947.464728174464, 5836.267737163745, 5839.416058394169, 5901.4688678018965, 5923.022701254288, 5925.377835327272, 5848.941510584882, 5855.531557475391, 5927.970360148215, 5928.79249226275, 5938.020226662596, 5799.449052340021, 5820.882115160024, 5883.264591926009, 5891.764329426818, 5906.3207731110615, 6370.904436433457, 6386.0, 6393.296737358934, 6430.61416315018, 6465.806025819233, 6672.366125218096, 6776.220734615533, 6848.965755171242, 6876.415504682108, 6956.930430695729, 6836.521443498957, 6855.383015528626, 6862.313768623148, 6865.5537390069485, 6869.484788640872, 6339.0808332791485, 6347.206599175103, 6458.418742313167, 6464.062710906939, 6468.3208263132165, 7084.716611335592, 7102.538335008208, 7178.533395329391, 7187.676554554953, 7203.675834587456, 6559.672016399161, 6690.899636505359, 6747.156605424322, 6785.321467853274, 6855.0, 6769.830754231184, 6809.250982391933, 6895.482838787111, 6904.344087311697, 6906.102206713095, 6705.4970877184405, 6758.695858686371, 6819.24988251292, 6820.181578210547, 6827.590344579242, 6734.225564060098, 6743.123393958754, 6824.112865327475, 6857.7256909723055, 6862.313768623198, 5277.551408130275, 5301.5493683037375, 5343.839684809462, 5359.410464848864, 5361.169018802092, 4622.722636641813, 4661.86014419568, 4706.129366067288, 4720.598749106296, 4743.786529606176, 5779.653220806765, 5856.033754430471, 5865.67738774363, 5878.353381128072, 5921.0, 6797.5921444712485, 6822.079019332326, 6893.414059804973, 6973.093497845248, 6982.546134501241, 5684.204211410406, 5794.710264486759, 5823.854403639943, 5883.2057672213705, 5899.380565040695, 5757.769689212469, 5764.625299355528, 5775.33583637887, 5778.479936805707, 5782.2483077199695, 6440.452561532322, 6488.643124628096, 6512.153420055362, 6513.381228783258, 6546.378094081055, 6729.798106056826, 6928.1339832520935, 6932.965335173292, 6933.064036355027, 6972.51192416526, 6616.073749675145, 6645.734170633121, 6694.29709880475, 6709.698063587052, 6716.361945615159, 6520.543561950618, 6711.161104861892, 6722.058911752456, 6787.966060169668, 6825.522213445011, 6780.830479238059, 6786.3892249697765, 6831.6242606657115, 6831.9316806833285, 6835.7949261522235, 6577.671116444254, 6603.174603174603, 6687.465002799861, 6690.59856408617, 6694.397504224643, 6596.208454985433, 6677.699503522256, 6687.297833727584, 6698.296678848846, 6708.530402871752, 6525.902111468236, 6570.981497867838, 6625.768098116543, 6634.933650663432, 6652.7006284716335, 6544.705488252945, 6641.833954151185, 6693.096431981815, 6754.12196414463, 6771.119754431892, 6522.119513865568, 6539.444147247347, 6545.312742162005, 6576.44100251484, 6585.242697089704], "value": 6185.445195934156, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.4324383736845, 781.8709912864377, 790.5098838719995, 795.4471642208665, 797.1271457753758, 39831.402528962055, 40687.796561017225, 40752.184956300895, 40784.79607601965, 40992.0, 36656.08359791007, 36975.445368319495, 36985.44521832174, 37018.44472332911, 37031.81484092583, 6977.79066628002, 7088.326608972139, 7120.50156489046, 7128.0, 7131.7503887363955, 6989.161300643905, 6994.68523916425, 6995.720171193147, 7007.789766307019, 7009.08881845362, 7065.858682826341, 7068.469864760138, 7070.363667269945, 7088.4683648726295, 7781.144074151839, 7862.764117076496, 7920.32677222431, 7926.128125906146, 7932.444728868982, 7933.404994625397, 7556.206598307153, 7741.187175346564, 7783.182765809565, 7865.921340786576, 7872.76381708544, 36981.26037479236, 37328.253434931146, 37370.43944340837, 37382.43926341107, 37477.0, 3537.9292414151832, 3575.0883524701294, 3582.695470884978, 3583.2475180212186, 3586.4620306953907, 30638.84680576605, 30714.0, 30770.38459230825, 30809.0, 30868.53697194544, 5096.719680417576, 5102.540771330561, 5144.485551444863, 5146.408163061258, 5146.7683954221775, 183958.0, 184376.0, 185532.0, 186336.0, 186863.0, 45888.0, 45906.54093459023, 45959.0, 46047.539524604326, 46173.30740038902, 49241.75379123153, 49258.507414926105, 49303.0, 49346.0, 49393.0, 15579.766303505456, 15784.36862525509, 15784.684306314039, 15785.0, 15846.841531584536, 12822.551210707581, 12833.679158021125, 12834.935825320814, 12841.93579032099, 12966.546170884163, 14048.227347495986, 14151.433942642385, 14173.716525669635, 14186.503472378417, 14337.283135843167, 5818.796342128006, 5870.3249126350165, 5881.411858814085, 5932.911006334908, 5947.5539334550085, 1010.8635334229932, 1012.1851909213007, 1013.9340942838692, 1018.1040684197859, 1019.3476175247847, 22079.0, 22295.0, 22348.664770028463, 22381.104755809913, 22412.439689007904, 1098.357460885391, 1101.8402331661864, 1116.508736156105, 1118.2563595209094, 1128.306091753582, 11880.940595297141, 11891.464884080237, 11901.940490297493, 12019.87980120205, 12042.939785301018, 225952.0, 227297.0, 227572.0, 227859.0, 228019.0, 50562.49437505578, 51700.22449663258, 52837.735811320694, 55288.0, 55464.0, 1417.2134465371612, 1460.832004319517, 1464.7143806957754, 1467.4350375105662, 1478.6894752101964, 26122.738772612032, 26456.867715661298, 26612.334691632863, 26906.32734181661, 27183.320416989733, 36391.818040909624, 36470.0, 36499.0, 36522.452163218106, 36534.817325914264, 192700.0, 193763.0, 193822.0, 193902.0, 194931.0, 31853.044408667778, 31863.203419914687, 31977.200569985005, 32040.0, 32176.0, 38784.0, 39963.40054899121, 40480.1903961925, 40670.0, 40719.796401017804, 30447.695523044487, 30478.542821857245, 30660.693393065783, 30846.383072338875, 32008.51987220147, 30102.3443710598, 30219.69780302169, 30408.847955760964, 30871.536926945664, 31571.842140789147, 33755.493667594514, 33856.66143338535, 34459.4831077529, 34534.654653453144, 34553.0, 29815.0, 29850.552241715955, 30013.5497967535, 30087.097387078422, 30206.84896575503, 22674.43313917165, 22781.31656050321, 23127.88436057809, 23247.41881452977, 23358.532829343658], "value": 16727.311258405138, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.5267346418809, 556.3324011186575, 563.9238702775124, 565.2087078090675, 569.7977267964595, 22004.88997555014, 22746.203882864123, 22754.31737047887, 22767.316980490592, 22779.658305125435, 23418.648720269208, 24191.879040604817, 24502.509949800995, 24550.631740523906, 24590.877045614747, 6388.329225431333, 6535.0, 6575.572587781803, 6576.243731970837, 6576.539642225046, 6468.417842394184, 6550.344965503459, 6562.8687426251445, 6565.638889861056, 6568.1789776277965, 6194.101855230989, 6420.293767685551, 6439.130717353144, 6460.515461340395, 6533.509986750989, 6360.745570177188, 6407.455366293871, 6413.583117097373, 6433.3566643335525, 6439.259485159197, 5771.88456230873, 5904.7342869570975, 5955.076963070731, 5957.553183511254, 5973.7311820967725, 27676.861615691992, 28376.432471350457, 28503.287417814514, 28510.28724281889, 28567.0, 2004.3385682724665, 2021.9797802022085, 2058.361907808584, 2060.484878780305, 2071.109422948132, 18492.53768655781, 18703.62592748151, 19139.234430622757, 19188.040597970186, 19295.0, 2427.8179136564827, 2448.2410452759523, 2503.198976327576, 2505.749425057498, 2516.169664010872, 121172.0, 128519.0, 129604.35197824045, 136978.0, 137051.31474342765, 13935.58193254204, 14442.566722998326, 14449.20401508864, 14580.924279277433, 14757.631059223606, 22020.33938981833, 22024.229151979605, 22050.44873878166, 22125.336239912827, 22154.556908861734, 10113.949430252802, 10382.169426446017, 10383.325083869524, 10418.531166097544, 10453.372797632166, 9680.709578712509, 9692.612295508241, 9710.863610005787, 9797.118259356692, 9802.411855288705, 8935.151160639858, 9026.909730902738, 9077.863832042525, 9139.223166030828, 9153.359264851397, 2684.637573927495, 2685.1273336165823, 2706.742859428351, 2707.2555047362134, 2761.337279053053, 951.0917074194266, 966.9033096690415, 973.8295798235281, 982.2387649571497, 982.8427451607708, 18455.53861153455, 18583.53541161482, 18991.1453984571, 19010.144543495575, 19045.14296856617, 1010.4897027001317, 1015.5683834370363, 1026.9127124194379, 1034.2088302448633, 1037.9636712715019, 10278.0, 10320.0, 10419.94790026045, 10442.530086146142, 10551.050405463391, 482367.0, 483763.0, 484514.0, 490957.0, 492290.0, 107922.46038769756, 109195.0, 112139.0, 113027.0, 113827.0, 1038.4651904269308, 1080.060347497682, 1136.8181091025397, 1139.27655938478, 1191.2852288626927, 19218.711719323943, 19252.90373548123, 19515.219391224193, 19577.0, 19584.412467625425, 54423.45576544184, 54548.454515455924, 54577.72711136419, 56398.0, 56648.433515664314, 71624.0, 71956.0, 72054.27945720476, 72086.63956680182, 72772.0, 13725.725485490433, 13851.16892986424, 13877.79183312231, 13889.930550347184, 13894.374753135931, 21485.14059437605, 21771.455713606654, 21900.342989709698, 21913.890430547744, 21929.561408771417, 17659.911700441415, 17672.469825905242, 17966.101694915462, 18046.5488362792, 18116.81883181204, 15602.297896594908, 15613.297401617181, 15637.452689155825, 15754.763678544601, 15856.682866342839, 17766.84515506488, 18067.728984065514, 18080.09599520045, 18175.727364089285, 18192.72710909311, 13572.79640805369, 13625.931870340584, 13765.793513097511, 13839.0, 13843.307834608027, 17529.211185496937, 17535.736963945295, 17746.37887673925, 17856.46430607084, 17886.642267154322], "value": 11723.752162329016, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1306.758249723801, 1384.9169049857005, 1405.9859401405995, 1407.8169837921068, 1417.7660685986818, 15257.847421525781, 15724.371025158995, 15733.292001859914, 15742.763858542132, 15755.133467659274, 15358.46245381409, 15366.462173823918, 15370.385184592604, 15512.612184695388, 15550.84449155508, 2698.1500827239356, 2703.9324016899636, 2759.8206116602455, 2761.903333383332, 2764.8894044238205, 2678.3973605938704, 2691.165738621024, 2706.404590989979, 2706.905258315959, 2708.1063249127837, 2578.7034491033583, 2674.61218123372, 2695.649565556475, 2695.689995650496, 2696.406790506095, 2762.323230808455, 2773.653293338333, 2781.5410457274625, 2787.916362509128, 2789.7628701560393, 2733.139061195717, 2745.3960128771637, 2746.533089374811, 2766.336079340964, 2770.7229277072133, 14751.0, 15094.245287735679, 15097.24513774307, 15101.773473397909, 15112.471063512725, 7852.136265010844, 8041.3968952328805, 8043.758687239392, 8048.0, 8104.959475202645, 5046.999061508414, 5156.793728250866, 5180.300659410969, 5240.9213861792105, 5250.737463126867, 1995.7605087389607, 2005.5688027074102, 2008.8192062714427, 2041.9795802041938, 2055.1779288284656, 26732.732672673414, 26791.062312818958, 26993.730062699316, 26997.0, 26997.325066873484, 6567.737290508422, 6685.161580565384, 6739.494537909676, 6866.793996180123, 6914.239433662293, 17498.91250543739, 17505.474835754947, 17520.824791752173, 17523.211455484532, 17543.0, 7691.384689224848, 7949.324307433817, 8078.757637270891, 8265.545395003333, 8311.709090181814, 7280.817979550554, 7324.560526368328, 7356.816079598053, 7373.88939165913, 7402.407807375397, 5141.177411614124, 5318.680879147263, 5329.493698098674, 5371.838844834661, 5396.32713858705, 1471.7865909443071, 1487.7991471151256, 1595.6649103688123, 1613.2659639863834, 1623.2127418202163, 876.6887754847065, 900.4192295969063, 900.6622516556291, 916.7891384981358, 920.9685152628964, 8330.083690794008, 8453.492790432594, 8527.914720852712, 8531.74404767858, 8550.529720865288, 722.2849379114639, 726.7819654103748, 726.8764310067302, 728.9343959043712, 804.9114597394282, 5160.509751573594, 5204.323437953042, 5250.291210686585, 5369.40936496985, 5503.367112782002, 21086.894565527073, 21178.576428471653, 21434.678479822815, 21544.56910861774, 22260.55478890413, 20321.288754893507, 20822.79177208239, 20942.37172884816, 21066.78933210679, 21337.0, 10346.430946297874, 10463.319884207502, 10571.788564228673, 10602.469876506144, 10645.78708425827, 7961.522308661499, 8137.715179968673, 8299.543525106177, 8395.454295470774, 8443.662253510036, 18124.093795309916, 18167.909160454114, 18197.909010454863, 18329.175187116878, 18464.35374761877, 18702.0, 18832.717509237646, 18891.811081889005, 18942.147603358157, 19079.71380429267, 10683.30558513694, 10767.246292759432, 10889.673309800719, 10894.891051089387, 10899.945500272448, 13611.86388136106, 13894.166350019032, 13901.37443815051, 13946.79079813824, 13955.790663139858, 11269.830952535554, 11289.71775705614, 11371.715707107389, 11514.712132196762, 11619.302841829518, 11042.282251653616, 11231.38227397501, 11331.32012079278, 11450.0, 11629.825552616887, 9452.480113593818, 9739.9026009739, 9741.707748767549, 9747.122758951728, 9747.9025209747, 6961.37347638715, 6968.79093627192, 6971.51199416036, 6976.5465244758925, 7058.258882817436, 6738.59568425896, 6851.0, 6893.517453778188, 6918.238993710587, 6958.443324534126], "value": 6624.193441860448, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [480.30355983823466, 504.8334049763578, 515.1397166731558, 518.9948100518993, 525.4115390762347, 6263.557212687056, 6311.873762524747, 6336.778212762554, 6347.777827776029, 6387.329330420309, 6144.6006009609455, 6150.938490615093, 6153.384661533844, 6179.660118693481, 6282.811515654537, 4877.780499877514, 4917.82787602434, 5156.3296771419755, 5161.4322424533275, 5183.818566350178, 4945.159322915095, 4984.725840078794, 5000.224965130411, 5000.449950505442, 5038.445770965191, 4909.656324057318, 4941.975290123544, 4976.701397916118, 4990.201567749161, 4990.900181996358, 4985.152524070917, 4987.730582584952, 5028.145215313405, 5048.829003528482, 5053.216751403502, 4508.639308855284, 4543.182227199103, 4545.977270113628, 4548.999220171557, 4563.383943167663, 6147.0, 6172.29018662855, 6193.3496982816605, 6198.287196972361, 6330.335314791927, 5674.602777805555, 5739.827805165852, 5751.309842818847, 5766.769329226868, 5778.855528611776, 6700.93299067008, 6702.396784289389, 6703.463722902156, 6722.563033402862, 6727.562708423986, 4905.730184839832, 4908.01839632075, 4913.656044076916, 4918.434380046305, 4943.406791185081, 6698.564593301468, 6762.188537375498, 6867.587944723333, 6886.724531018754, 6963.651817409109, 5001.799928002912, 5011.749412529359, 5059.392872855281, 5061.164907790173, 5063.721495317719, 5078.669886457368, 5091.8981620367385, 5093.363329583802, 5096.847094587169, 5147.176451767774, 5715.599908006399, 5733.913991290134, 5738.426157384228, 5741.034005585138, 5804.158397032491, 6682.3317668232785, 6707.899381509281, 6721.327867213239, 6737.652469506118, 6767.2066902270935, 1755.6225411536582, 1759.5513144148417, 1764.3207365164503, 1776.9111544422726, 1782.0466050662833, 1154.5266440759249, 1196.9401529923468, 1207.8309036734863, 1216.4282787090053, 1235.2218102595307, 5728.828135155952, 5756.798512052058, 5766.538676905838, 5789.363170051291, 5815.94184058154, 6764.594124352555, 6836.6923488443135, 6853.732059568995, 6855.4172895304455, 6873.931260687429, 5791.362950075489, 5805.970970145122, 5808.564357673192, 5819.679917604488, 5827.388124246978, 3602.8470889315167, 3610.1588190023276, 3630.854765809338, 3632.8183590820354, 3636.7090632749846, 6489.318621544764, 6523.836904077436, 6537.280899101095, 6605.603663780189, 6687.899681504781, 6867.175938887365, 6904.551204171713, 6908.171019477594, 6925.549839260432, 6961.503276795514, 6157.291911430243, 6485.643289618927, 6527.967360163168, 6565.8358541035905, 6594.1865986854, 6576.342365763386, 6699.29657385987, 6703.296153903965, 6759.391654751096, 6761.966190169018, 6628.5691430056895, 6757.86484270302, 6854.520183587101, 6882.797504798416, 6910.0, 6518.511111666549, 6595.0, 6693.230278518033, 6695.928651415945, 6697.899531506934, 5007.1487847065355, 5012.699238045729, 5036.960031187375, 5047.621428392812, 5360.437154098763, 6424.775132870514, 6514.250861151028, 6670.831979606744, 6960.269171737097, 6961.79114626562, 6493.396165128399, 6526.184226971629, 6534.607923524603, 6682.63245521501, 6688.163979502562, 6488.188976377953, 6534.523851161969, 6588.308227636221, 6625.867482650224, 6714.429273511806, 6465.967670161619, 6573.5069869759, 6610.025488530277, 6621.3047629998155, 6651.16860392451, 6762.256151823197, 6804.285550017375, 6808.455323574003, 6814.0, 6840.486963477859, 6463.192100987377, 6476.5466417350335, 6503.309604096416, 6525.8694826104165, 6537.771178008747], "value": 5105.6560898851885, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [889.6263569300894, 905.8686490458883, 913.0367462327247, 915.190056799732, 917.7200953709121, 19016.809831901675, 19779.307724229653, 19830.900845495788, 19845.305414310504, 19894.20423183073, 17332.220050097745, 17559.648807023852, 17597.208125634344, 17611.735823962652, 17631.64736705265, 949.0414681171997, 962.9855552166723, 963.5471328475605, 967.1440774914216, 967.9661211857587, 964.6334392930677, 975.2685485885586, 978.2614126334643, 978.6330126202674, 980.4509474694158, 989.2432289298692, 1008.0675375277875, 1027.6403258859414, 1027.8047171037479, 1028.7222449938513, 982.5038355630433, 1014.4167103915241, 1018.1701912940929, 1019.021739130432, 1025.4462590201283, 726.5241266970143, 737.0, 739.7743688175104, 742.4913933955258, 743.5315751076841, 19281.4215573533, 19464.70802937957, 19551.413457596154, 19580.608387832162, 19596.902015489974, 22026.559468810694, 22210.0, 22345.21791737298, 22555.0, 22761.0, 17610.38363657266, 17960.0, 18239.72640410395, 18246.452606421695, 18250.269989200417, 3637.727170462226, 3667.064898450905, 3672.4307732301536, 3680.9263814723554, 3684.1894783147663, 110358.0, 144439.0, 145501.0, 147790.26104869405, 149229.0, 17344.82655173432, 17911.910440447977, 18001.099945002697, 18022.639547209244, 18090.547736306697, 31953.840230798698, 32965.67034329674, 33017.17457063593, 33041.33917321688, 33061.33877322488, 8513.489190648581, 8731.912680873236, 8757.211850933447, 8769.91230087691, 8770.473771573726, 4097.610726980932, 4161.271777438936, 4177.436046133733, 4180.080382315886, 4186.727862688916, 5446.291982042389, 5551.3893471718075, 5551.666899986014, 5574.470425309589, 5578.525825304813, 1070.9410982395887, 1071.8231491803765, 1092.4592326798286, 1105.7567335186245, 1109.57836022311, 665.6339013542629, 685.3934268172703, 696.4567637242959, 697.20866816163, 707.4693979515364, 11961.0, 12133.701232929441, 12284.262944223376, 12575.371231438574, 12983.717910298596, 676.0805304785488, 678.4538446550574, 688.6487891175436, 700.8598280343952, 702.6627218934838, 5536.390996990328, 5547.140193270049, 5551.1673249012165, 5587.860303492445, 5609.046462101453, 124491.0, 125595.0, 126912.0, 128163.0, 128422.35788820995, 104333.47833260937, 106222.46888765506, 107815.0, 109065.0, 110225.0, 94511.52744236235, 94691.52654236685, 97867.0, 99407.50296248472, 100690.49654751825, 10166.288359814742, 10312.432816195182, 10350.430726310125, 10459.267851250645, 10543.20925930543, 43293.567064330215, 43475.78262108669, 43569.56430435655, 44007.77996109999, 45377.54622453865, 54375.456245438625, 54708.17937731017, 55835.16247256376, 55940.44059559515, 56376.0, 15390.538283851502, 15701.214939253221, 15734.685306294039, 15785.526434206991, 15837.604059898595, 17488.562785930455, 17582.120893955507, 17629.118544073, 17643.55891102733, 17739.73390399171, 15536.766948495555, 15790.21048947571, 15864.60338491547, 15944.521664350088, 15954.521364359089, 16358.100304483367, 16493.752593711342, 16533.58666033359, 16560.254788534785, 16597.834021660114, 15510.767338490157, 15583.142927139117, 15640.217989100727, 15697.136657483949, 15705.057696538244, 11687.298762074302, 11703.707407314545, 11731.47208375608, 11823.881761182278, 11874.406279686154, 11572.305661660328, 11755.0, 11789.410529473664, 11961.880381196077, 12088.697782555155], "value": 8971.917927637747, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1425.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 107.0, 107.0, 106.0, 107.0, 107.0, 109.0, 106.0, 110.0, 109.0], "value": 107.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 117.0, 116.0, 121.0, 117.0, 115.0, 116.0, 122.0, 115.0, 147.0], "value": 120.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 163.0, 162.0, 162.0, 162.0, 165.0, 170.0, 171.0, 166.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 73.0, 73.0, 73.0, 74.0, 76.0, 76.0, 82.0, 73.0], "value": 74.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 79.0, 80.0, 80.0, 79.0, 79.0, 79.0, 80.0, 82.0], "value": 79.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 113.0, 114.0, 116.0, 114.0, 114.0, 110.0, 115.0], "value": 113.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 153.0, 149.0, 148.0, 148.0, 147.0, 149.0, 149.0, 151.0, 148.0], "value": 149.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 96.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 52.0, 53.0, 52.0, 53.0, 52.0, 52.0, 51.0, 51.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 37.0, 38.0, 38.0, 38.0, 38.0, 37.0, 42.0, 38.0, 38.0], "value": 38.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 72.0, 82.0, 73.0, 75.0, 74.0, 74.0, 74.0, 73.0, 73.0], "value": 74.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 110.0, 113.0, 115.0, 114.0, 118.0, 120.0, 113.0, 115.0, 116.0], "value": 115.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 168.0, 170.0, 168.0, 169.0, 186.0, 173.0, 166.0, 176.0, 176.0], "value": 172.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 84.0, 68.0, 70.0, 65.0, 65.0, 65.0, 63.0, 71.0, 68.0], "value": 68.7, "unit": "score"}]}]} 17:46:53 INFO - Return code: 0 17:46:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:46:53 INFO - # TBPL SUCCESS # 17:46:53 INFO - Running post-action listener: _package_coverage_data 17:46:53 INFO - Running post-action listener: _resource_record_post_action 17:46:53 INFO - [mozharness: 2017-09-14 00:46:53.224550Z] Finished run-tests step (success) 17:46:53 INFO - Running post-run listener: _resource_record_post_run 17:46:53 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 336670720; Read time: 12; Write time: 195384 17:46:53 INFO - TinderboxPrint: CPU usage
13.1% 17:46:53 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 17:46:53 INFO - TinderboxPrint: I/O write bytes / time
336,670,720 / 195,384 17:46:53 INFO - TinderboxPrint: CPU idle
8,235.9 (86.9%) 17:46:53 INFO - TinderboxPrint: CPU user
1,193.3 (12.6%) 17:46:53 INFO - TinderboxPrint: Swap in / out
0 / 0 17:46:53 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 10108928; Read time: 0; Write time: 644 17:46:53 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:46:53 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 326561792; Read time: 0; Write time: 194740 17:46:53 INFO - Running post-run listener: _upload_blobber_files 17:46:53 INFO - Blob upload gear active. 17:46:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:46:53 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 17:46:53 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'] 17:46:53 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 17:46:54 INFO - (blobuploader) - INFO - Open directory for files ... 17:46:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:46:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:46:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:47:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:47:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:47:01 INFO - (blobuploader) - INFO - Done attempting. 17:47:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 17:47:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:47:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:47:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 17:47:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:47:02 INFO - (blobuploader) - INFO - Done attempting. 17:47:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 17:47:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:47:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:47:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 17:47:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:47:03 INFO - (blobuploader) - INFO - Done attempting. 17:47:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:47:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:47:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:47:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:47:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:47:04 INFO - (blobuploader) - INFO - Done attempting. 17:47:04 INFO - (blobuploader) - INFO - Iteration through files over. 17:47:04 INFO - Return code: 0 17:47:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:47:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:47:04 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/63f05555cd3f299f072fe47958ea9f0ef15d663b9e2580f949e6f4c7b9ec538a95a7c4c54238c3c679b5f6db846b310078239d6b553fb25ea16d350a7b73b116", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/14ad4ae2a7504246552253ab72fee9c479ee32e876b81a1a99c639f23f1985b814459e44e7484899adf2e56b83dcb51dfd46fb90a0862443b0305996dce7dc88", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/52b6ff2f567726336b8371d716618aa07d3ba8d16aeb6cf9801eb3cd3a59fd32c3f224ba3c905a8f4b449ed60d1610bf3d7136f1898b150101011e84140f11d1", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/daa91c288ec22c9740eefb1f43ba5602b05a7b3e51f99d25fdca8af125ceb8139f492a7f17b108ff4e14ff7c219e0ad0a9c668a0426aea2a2e56fd97356b22ec"} 17:47:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:47:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:47:04 INFO - Contents: 17:47:04 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/63f05555cd3f299f072fe47958ea9f0ef15d663b9e2580f949e6f4c7b9ec538a95a7c4c54238c3c679b5f6db846b310078239d6b553fb25ea16d350a7b73b116", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/14ad4ae2a7504246552253ab72fee9c479ee32e876b81a1a99c639f23f1985b814459e44e7484899adf2e56b83dcb51dfd46fb90a0862443b0305996dce7dc88", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/52b6ff2f567726336b8371d716618aa07d3ba8d16aeb6cf9801eb3cd3a59fd32c3f224ba3c905a8f4b449ed60d1610bf3d7136f1898b150101011e84140f11d1", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/daa91c288ec22c9740eefb1f43ba5602b05a7b3e51f99d25fdca8af125ceb8139f492a7f17b108ff4e14ff7c219e0ad0a9c668a0426aea2a2e56fd97356b22ec"} 17:47:04 INFO - Running post-run listener: copy_logs_to_upload_dir 17:47:04 INFO - Copying logs to upload dir... 17:47:04 INFO - mkdir: /builds/slave/test/build/upload/logs 17:47:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.838611 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-13 17:47:04.515830) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-13 17:47:04.519525) ========= 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=199fb4c72b90437b990b419b000001c5-1505348783.246139-355573265 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/63f05555cd3f299f072fe47958ea9f0ef15d663b9e2580f949e6f4c7b9ec538a95a7c4c54238c3c679b5f6db846b310078239d6b553fb25ea16d350a7b73b116", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/14ad4ae2a7504246552253ab72fee9c479ee32e876b81a1a99c639f23f1985b814459e44e7484899adf2e56b83dcb51dfd46fb90a0862443b0305996dce7dc88", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/52b6ff2f567726336b8371d716618aa07d3ba8d16aeb6cf9801eb3cd3a59fd32c3f224ba3c905a8f4b449ed60d1610bf3d7136f1898b150101011e84140f11d1", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/daa91c288ec22c9740eefb1f43ba5602b05a7b3e51f99d25fdca8af125ceb8139f492a7f17b108ff4e14ff7c219e0ad0a9c668a0426aea2a2e56fd97356b22ec"} build_url:https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011430 build_url: 'https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/63f05555cd3f299f072fe47958ea9f0ef15d663b9e2580f949e6f4c7b9ec538a95a7c4c54238c3c679b5f6db846b310078239d6b553fb25ea16d350a7b73b116", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/14ad4ae2a7504246552253ab72fee9c479ee32e876b81a1a99c639f23f1985b814459e44e7484899adf2e56b83dcb51dfd46fb90a0862443b0305996dce7dc88", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/52b6ff2f567726336b8371d716618aa07d3ba8d16aeb6cf9801eb3cd3a59fd32c3f224ba3c905a8f4b449ed60d1610bf3d7136f1898b150101011e84140f11d1", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/daa91c288ec22c9740eefb1f43ba5602b05a7b3e51f99d25fdca8af125ceb8139f492a7f17b108ff4e14ff7c219e0ad0a9c668a0426aea2a2e56fd97356b22ec"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-13 17:47:04.548276) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 17:47:04.548607) ========= 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=199fb4c72b90437b990b419b000001c5-1505348783.246139-355573265 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 17:47:04.634203) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-13 17:47:04.634535) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-13 17:47:04.634856) ========= ========= Total master_lag: 0.19 =========