builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-028 starttime: 1505688625.52 results: success (0) revision: ae39864562c6048fdc2950c5dfedb48e247c3300 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-17 15:50:25.523335) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-17 15:50:25.523766) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-17 15:50:25.524072) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-17 15:50:25.799564) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:50:25.799832) ========= 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=836cfdc75598d54cb747368e000001a9-1505687706.741790-1390120011 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-17 15:50:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.1M=0s 2017-09-17 15:50:25 (46.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.141315 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:50:26.024395) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:50:26.024813) ========= 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=836cfdc75598d54cb747368e000001a9-1505687706.741790-1390120011 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022287 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:50:26.126788) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:50:26.127123) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ae39864562c6048fdc2950c5dfedb48e247c3300 --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 ae39864562c6048fdc2950c5dfedb48e247c3300 --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=836cfdc75598d54cb747368e000001a9-1505687706.741790-1390120011 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-17 15:50:26,226 truncating revision to first 12 chars 2017-09-17 15:50:26,226 Setting DEBUG logging. 2017-09-17 15:50:26,226 attempt 1/10 2017-09-17 15:50:26,226 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ae39864562c6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-17 15:50:26,599 unpacking tar archive at: mozilla-central-ae39864562c6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.678619 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:50:26.871769) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-17 15:50:26.872070) ========= script_repo_revision: ae39864562c6048fdc2950c5dfedb48e247c3300 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-17 15:50:26.872468) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-17 15:50:26.872731) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-17 15:50:26.890853) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-17 15:50:26.891114) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1505687706.741790-1390120011 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:50:27 INFO - MultiFileLogger online at 20170917 15:50:27 in /builds/slave/test 15:50:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 15:50:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:50:27 INFO - {'append_to_log': False, 15:50:27 INFO - 'base_work_dir': '/builds/slave/test', 15:50:27 INFO - 'blob_upload_branch': 'Firefox', 15:50:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:50:27 INFO - 'branch': 'Firefox', 15:50:27 INFO - 'buildbot_json_path': 'buildprops.json', 15:50:27 INFO - 'code_coverage': False, 15:50:27 INFO - 'config_files': ('talos/linux_config.py',), 15:50:27 INFO - 'default_actions': ('clobber', 15:50:27 INFO - 'read-buildbot-config', 15:50:27 INFO - 'download-and-extract', 15:50:27 INFO - 'populate-webroot', 15:50:27 INFO - 'create-virtualenv', 15:50:27 INFO - 'install', 15:50:27 INFO - 'setup-mitmproxy', 15:50:27 INFO - 'run-tests'), 15:50:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:50:27 INFO - 'disable_ccov_upload': False, 15:50:27 INFO - 'disable_stylo': False, 15:50:27 INFO - 'download_minidump_stackwalk': True, 15:50:27 INFO - 'download_symbols': 'ondemand', 15:50:27 INFO - 'enable_stylo': False, 15:50:27 INFO - 'enable_webrender': False, 15:50:27 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:50:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:50:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:50:27 INFO - 'gecko_profile': False, 15:50:27 INFO - 'gecko_profile_interval': 0, 15:50:27 INFO - 'installer_path': 'installer.exe', 15:50:27 INFO - 'log_level': 'info', 15:50:27 INFO - 'log_name': 'talos', 15:50:27 INFO - 'log_to_console': True, 15:50:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:50:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:50:27 INFO - 'opt_config_files': (), 15:50:27 INFO - 'pip_index': False, 15:50:27 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 15:50:27 INFO - 'system_bits': '32', 15:50:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:50:27 INFO - 'title': 'talos-linux64-ix-028', 15:50:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:50:27 INFO - 'use_talos_json': True, 15:50:27 INFO - 'verify': 'False', 15:50:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:50:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:50:27 INFO - 'work_dir': 'build'} 15:50:27 INFO - [mozharness: 2017-09-17 22:50:27.093517Z] Running clobber step. 15:50:27 INFO - Running pre-action listener: _resource_record_pre_action 15:50:27 INFO - Running main action method: clobber 15:50:27 INFO - rmtree: /builds/slave/test/build 15:50:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:50:28 INFO - Running post-action listener: _resource_record_post_action 15:50:28 INFO - [mozharness: 2017-09-17 22:50:28.083523Z] Finished clobber step (success) 15:50:28 INFO - [mozharness: 2017-09-17 22:50:28.083621Z] Running read-buildbot-config step. 15:50:28 INFO - Running pre-action listener: _resource_record_pre_action 15:50:28 INFO - Running main action method: read_buildbot_config 15:50:28 INFO - Using buildbot properties: 15:50:28 INFO - { 15:50:28 INFO - "project": "", 15:50:28 INFO - "product": "firefox", 15:50:28 INFO - "who": "archaeopteryx@coole-files.de", 15:50:28 INFO - "installer_path": "public/build/target.tar.bz2", 15:50:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 15:50:28 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:50:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 15:50:28 INFO - "stage_platform": "linux64-pgo", 15:50:28 INFO - "basedir": "/builds/slave/test", 15:50:28 INFO - "buildnumber": 27, 15:50:28 INFO - "platform": "ubuntu64_hw", 15:50:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:50:28 INFO - "slavebuilddir": "test", 15:50:28 INFO - "taskId": "AsZnQR41RienYqSvdzAtvQ", 15:50:28 INFO - "branch": "mozilla-central", 15:50:28 INFO - "script_repo_revision": "production", 15:50:28 INFO - "revision": "ae39864562c6048fdc2950c5dfedb48e247c3300", 15:50:28 INFO - "slavename": "talos-linux64-ix-028", 15:50:28 INFO - "repo_path": "mozilla-central" 15:50:28 INFO - } 15:50:28 INFO - Finding installer, test and symbols from parent task. 15:50:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AsZnQR41RienYqSvdzAtvQ'}, attempt #1 15:50:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AsZnQR41RienYqSvdzAtvQ'}, attempt #1 15:50:29 INFO - Task dependencies: Tm_s3FMBRbu6xkB0TPt4pA 15:50:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tm_s3FMBRbu6xkB0TPt4pA'}, attempt #1 15:50:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Tm_s3FMBRbu6xkB0TPt4pA/artifacts/public/build/target.tar.bz2 15:50:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Tm_s3FMBRbu6xkB0TPt4pA/artifacts/public/build/target.test_packages.json 15:50:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Tm_s3FMBRbu6xkB0TPt4pA/artifacts/public/build/target.crashreporter-symbols.zip 15:50:29 INFO - Running post-action listener: _resource_record_post_action 15:50:29 INFO - [mozharness: 2017-09-17 22:50:29.497665Z] Finished read-buildbot-config step (success) 15:50:29 INFO - [mozharness: 2017-09-17 22:50:29.497882Z] Running download-and-extract step. 15:50:29 INFO - Running pre-action listener: _resource_record_pre_action 15:50:29 INFO - Running main action method: download_and_extract 15:50:29 INFO - mkdir: /builds/slave/test/build/tests 15:50:29 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')]} 15:50:29 INFO - trying https://queue.taskcluster.net/v1/task/Tm_s3FMBRbu6xkB0TPt4pA/artifacts/public/build/target.test_packages.json 15:50:29 INFO - Downloading https://queue.taskcluster.net/v1/task/Tm_s3FMBRbu6xkB0TPt4pA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:50:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tm_s3FMBRbu6xkB0TPt4pA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:50:30 INFO - Downloaded 989 bytes. 15:50:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:50:30 INFO - Using the following test package requirements: 15:50:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:50:30 INFO - u'common': [u'target.common.tests.zip'], 15:50:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:50:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:50:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:50:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:50:30 INFO - u'mozbase': [u'target.common.tests.zip'], 15:50:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:50:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:50:30 INFO - u'web-platform': [u'target.common.tests.zip', 15:50:30 INFO - u'target.web-platform.tests.tar.gz'], 15:50:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:50:30 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 15:50:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Tm_s3FMBRbu6xkB0TPt4pA/artifacts/public/build/target.common.tests.zip 15:50:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Tm_s3FMBRbu6xkB0TPt4pA/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:50:30 INFO - Fetch https://queue.taskcluster.net/v1/task/Tm_s3FMBRbu6xkB0TPt4pA/artifacts/public/build/target.common.tests.zip into memory 15:50:32 INFO - Content-Length response header: 55324248 15:50:32 INFO - Bytes received: 55324248 15:50:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Tm_s3FMBRbu6xkB0TPt4pA/artifacts/public/build/target.talos.tests.zip 15:50:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Tm_s3FMBRbu6xkB0TPt4pA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:50:43 INFO - Fetch https://queue.taskcluster.net/v1/task/Tm_s3FMBRbu6xkB0TPt4pA/artifacts/public/build/target.talos.tests.zip into memory 15:50:44 INFO - Content-Length response header: 14508748 15:50:44 INFO - Bytes received: 14508748 15:50: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')]} 15:50:44 INFO - trying https://queue.taskcluster.net/v1/task/Tm_s3FMBRbu6xkB0TPt4pA/artifacts/public/build/target.tar.bz2 15:50:44 INFO - Downloading https://queue.taskcluster.net/v1/task/Tm_s3FMBRbu6xkB0TPt4pA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:50:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tm_s3FMBRbu6xkB0TPt4pA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:50:47 INFO - Downloaded 62191165 bytes. 15:50:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Tm_s3FMBRbu6xkB0TPt4pA/artifacts/public/build/target.tar.bz2 15:50:47 INFO - mkdir: /builds/slave/test/properties 15:50:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:50:47 INFO - Writing to file /builds/slave/test/properties/build_url 15:50:47 INFO - Contents: 15:50:47 INFO - build_url:https://queue.taskcluster.net/v1/task/Tm_s3FMBRbu6xkB0TPt4pA/artifacts/public/build/target.tar.bz2 15:50:47 INFO - Running post-action listener: _resource_record_post_action 15:50:47 INFO - Running post-action listener: find_tests_for_verification 15:50:47 INFO - Running post-action listener: set_extra_try_arguments 15:50:47 INFO - [mozharness: 2017-09-17 22:50:47.324143Z] Finished download-and-extract step (success) 15:50:47 INFO - [mozharness: 2017-09-17 22:50:47.324333Z] Running populate-webroot step. 15:50:47 INFO - Running pre-action listener: _resource_record_pre_action 15:50:47 INFO - Running main action method: populate_webroot 15:50:47 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:50:47 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:50:47 INFO - 'tests': ['tresize', 15:50:47 INFO - 'tcanvasmark']}, 15:50:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:50:47 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:50:47 INFO - 'tests': ['dromaeo_css', 15:50:47 INFO - 'kraken']}, 15:50:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:50:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:50:47 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:50:47 INFO - 'talos_options': ['--disable-stylo'], 15:50:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:50:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:50:47 INFO - 'tests': ['damp', 'tps']}, 15:50:47 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:50:47 INFO - 'talos_options': ['--disable-stylo'], 15:50:47 INFO - 'tests': ['damp', 'tps']}, 15:50:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:50:47 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:50:47 INFO - 'tests': ['dromaeo_dom']}, 15:50:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:50:47 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:50:47 INFO - 'tests': ['basic_compositor_video', 15:50:47 INFO - 'glvideo']}, 15:50:47 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:50:47 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:50:47 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:50:47 INFO - 'talos_options': ['--disable-stylo'], 15:50:47 INFO - 'tests': ['ts_paint_webext', 15:50:47 INFO - 'tp5o_webext']}, 15:50:47 INFO - 'other-e10s': {'tests': ['a11yr', 15:50:47 INFO - 'ts_paint', 15:50:47 INFO - 'tpaint', 15:50:47 INFO - 'sessionrestore', 15:50:47 INFO - 'sessionrestore_many_windows', 15:50:47 INFO - 'sessionrestore_no_auto_restore', 15:50:47 INFO - 'tabpaint']}, 15:50:47 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:50:47 INFO - 'tests': ['a11yr', 15:50:47 INFO - 'ts_paint', 15:50:47 INFO - 'tpaint', 15:50:47 INFO - 'sessionrestore', 15:50:47 INFO - 'sessionrestore_many_windows', 15:50:47 INFO - 'sessionrestore_no_auto_restore', 15:50:47 INFO - 'tabpaint']}, 15:50:47 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:50:47 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 15:50:47 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:50:47 INFO - 'tests': ['perf_reftest_singletons']}, 15:50:47 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:50:47 INFO - 'tests': ['bloom_basic']}, 15:50:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:50:47 INFO - 'tsvgr_opacity', 15:50:47 INFO - 'tart', 15:50:47 INFO - 'tscrollx', 15:50:47 INFO - 'tsvg_static']}, 15:50:47 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:50:47 INFO - 'tests': ['tsvgx', 15:50:47 INFO - 'tsvgr_opacity', 15:50:47 INFO - 'tart', 15:50:47 INFO - 'tscrollx', 15:50:47 INFO - 'tsvg_static']}, 15:50:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:50:47 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:50:47 INFO - 'talos_options': ['--disable-stylo'], 15:50:47 INFO - 'tests': ['tp5o']}, 15:50:47 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:50:47 INFO - 'talos_options': ['--mitmproxy', 15:50:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:50:47 INFO - '--firstNonBlankPaint'], 15:50:47 INFO - 'tests': ['tp6_google', 15:50:47 INFO - 'tp6_youtube', 15:50:47 INFO - 'tp6_amazon', 15:50:47 INFO - 'tp6_facebook']}, 15:50:47 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:50:47 INFO - 'talos_options': ['--disable-stylo', 15:50:47 INFO - '--mitmproxy', 15:50:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:50:47 INFO - '--firstNonBlankPaint'], 15:50:47 INFO - 'tests': ['tp6_google', 15:50:47 INFO - 'tp6_youtube', 15:50:47 INFO - 'tp6_amazon', 15:50:47 INFO - 'tp6_facebook']}, 15:50:47 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:50:47 INFO - 'talos_options': ['--stylo-threads=1', 15:50:47 INFO - '--mitmproxy', 15:50:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:50:47 INFO - '--firstNonBlankPaint'], 15:50:47 INFO - 'tests': ['tp6_google', 15:50:47 INFO - 'tp6_youtube', 15:50:47 INFO - 'tp6_amazon', 15:50:47 INFO - 'tp6_facebook']}, 15:50:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:50:47 INFO - 'talos_options': ['--xperf_path', 15:50:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:50:47 INFO - 'tests': ['tp5n']}, 15:50:47 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:50:47 INFO - 'talos_options': ['--disable-stylo', 15:50:47 INFO - '--xperf_path', 15:50:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:50:47 INFO - 'tests': ['tp5n']}}} 15:50:47 INFO - Running post-action listener: _resource_record_post_action 15:50:47 INFO - [mozharness: 2017-09-17 22:50:47.346612Z] Finished populate-webroot step (success) 15:50:47 INFO - [mozharness: 2017-09-17 22:50:47.346718Z] Running create-virtualenv step. 15:50:47 INFO - Running pre-action listener: _resource_record_pre_action 15:50:47 INFO - Running main action method: create_virtualenv 15:50:47 INFO - Creating virtualenv /builds/slave/test/build/venv 15:50:47 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:50:47 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:50:47 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:50:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:50:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:50:50 INFO - Installing distribute.............................................................................................................................................................................................done. 15:50:51 INFO - Installing pip...............done. 15:50:51 INFO - Return code: 0 15:50:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:50:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:50:51 INFO - Reading from file tmpfile_stdout 15:50:51 INFO - Output received: 15:50:51 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 15:50:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:50:51 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')]} 15:50:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:51 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')]} 15:50:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:51 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 0x1dd71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2143a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2147090>, '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 0x2147d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2141f90>, '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': '836cfdc75598d54cb747368e000001a9-1505687706.741790-1390120011', '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 15:50:51 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 15:50:51 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 15:50:51 INFO - Using env: {'DISPLAY': ':0', 15:50:51 INFO - 'HOME': '/home/cltbld', 15:50:51 INFO - 'LANG': 'en_US.UTF-8', 15:50:51 INFO - 'LANGUAGE': 'en_US:en', 15:50:51 INFO - 'LOGNAME': 'cltbld', 15:50:51 INFO - 'MAIL': '/var/mail/cltbld', 15:50:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:51 INFO - 'MOZ_NO_REMOTE': '1', 15:50:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:51 INFO - 'NO_EM_RESTART': '1', 15:50:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:51 INFO - 'PWD': '/builds/slave/test', 15:50:51 INFO - 'SHELL': '/bin/bash', 15:50:51 INFO - 'SHLVL': '1', 15:50:51 INFO - 'TERM': 'linux', 15:50:51 INFO - 'TMOUT': '86400', 15:50:51 INFO - 'USER': 'cltbld', 15:50:51 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505687706.741790-1390120011', 15:50:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:51 INFO - '_': '/tools/buildbot/bin/python'} 15:50:52 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:50:52 INFO - Downloading/unpacking pip>=1.5 15:50:52 INFO - Running setup.py egg_info for package pip 15:50:52 INFO - warning: no files found matching 'pip/cacert.pem' 15:50:52 INFO - warning: no files found matching '*.html' under directory 'docs' 15:50:52 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:50:52 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:50:52 INFO - Installing collected packages: pip 15:50:52 INFO - Found existing installation: pip 1.1 15:50:52 INFO - Uninstalling pip: 15:50:52 INFO - Successfully uninstalled pip 15:50:52 INFO - Running setup.py install for pip 15:50:52 INFO - warning: no files found matching 'pip/cacert.pem' 15:50:52 INFO - warning: no files found matching '*.html' under directory 'docs' 15:50:52 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:50:52 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:50:52 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:50:52 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:50:52 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:50:52 INFO - Successfully installed pip 15:50:52 INFO - Cleaning up... 15:50:52 INFO - Return code: 0 15:50:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:50: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')]} 15:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50: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')]} 15:50:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50: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', '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 0x1dd71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2143a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2147090>, '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 0x2147d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2141f90>, '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': '836cfdc75598d54cb747368e000001a9-1505687706.741790-1390120011', '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 15:50: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', 'psutil>=3.1.1'] in /builds/slave/test/build 15:50: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 psutil>=3.1.1 15:50:52 INFO - Using env: {'DISPLAY': ':0', 15:50:52 INFO - 'HOME': '/home/cltbld', 15:50:52 INFO - 'LANG': 'en_US.UTF-8', 15:50:52 INFO - 'LANGUAGE': 'en_US:en', 15:50:52 INFO - 'LOGNAME': 'cltbld', 15:50:52 INFO - 'MAIL': '/var/mail/cltbld', 15:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:52 INFO - 'MOZ_NO_REMOTE': '1', 15:50:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:52 INFO - 'NO_EM_RESTART': '1', 15:50:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:52 INFO - 'PWD': '/builds/slave/test', 15:50:52 INFO - 'SHELL': '/bin/bash', 15:50:52 INFO - 'SHLVL': '1', 15:50:52 INFO - 'TERM': 'linux', 15:50:52 INFO - 'TMOUT': '86400', 15:50:52 INFO - 'USER': 'cltbld', 15:50:52 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505687706.741790-1390120011', 15:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:52 INFO - '_': '/tools/buildbot/bin/python'} 15:50:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:52 INFO - Downloading/unpacking psutil>=3.1.1 15:50: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 15:50: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 15:50: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 15:50: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 15:50:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:50:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:50:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:50:53 INFO - Installing collected packages: psutil 15:50:53 INFO - Running setup.py install for psutil 15:50:54 INFO - building 'psutil._psutil_linux' extension 15:50:54 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 15:50:54 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 15:50:54 INFO - building 'psutil._psutil_posix' extension 15:50:54 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 15:50:54 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 15:50:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:50:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:50:54 INFO - Successfully installed psutil 15:50:54 INFO - Cleaning up... 15:50:54 INFO - Return code: 0 15:50:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:50: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')]} 15:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50: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')]} 15:50:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:54 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 0x1dd71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2143a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2147090>, '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 0x2147d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2141f90>, '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': '836cfdc75598d54cb747368e000001a9-1505687706.741790-1390120011', '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 15:50:54 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 15:50:54 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 15:50:54 INFO - Using env: {'DISPLAY': ':0', 15:50:54 INFO - 'HOME': '/home/cltbld', 15:50:54 INFO - 'LANG': 'en_US.UTF-8', 15:50:54 INFO - 'LANGUAGE': 'en_US:en', 15:50:54 INFO - 'LOGNAME': 'cltbld', 15:50:54 INFO - 'MAIL': '/var/mail/cltbld', 15:50:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:54 INFO - 'MOZ_NO_REMOTE': '1', 15:50:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:54 INFO - 'NO_EM_RESTART': '1', 15:50:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:54 INFO - 'PWD': '/builds/slave/test', 15:50:54 INFO - 'SHELL': '/bin/bash', 15:50:54 INFO - 'SHLVL': '1', 15:50:54 INFO - 'TERM': 'linux', 15:50:54 INFO - 'TMOUT': '86400', 15:50:54 INFO - 'USER': 'cltbld', 15:50:54 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505687706.741790-1390120011', 15:50:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:54 INFO - '_': '/tools/buildbot/bin/python'} 15:50:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:50: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 15:50: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 15:50: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 15:50: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 15:50:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:50:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:50:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:50:55 INFO - Installing collected packages: mozsystemmonitor 15:50:55 INFO - Running setup.py install for mozsystemmonitor 15:50:55 INFO - Successfully installed mozsystemmonitor 15:50:55 INFO - Cleaning up... 15:50:55 INFO - Return code: 0 15:50:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:50:55 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')]} 15:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:55 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')]} 15:50:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:55 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 0x1dd71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2143a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2147090>, '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 0x2147d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2141f90>, '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': '836cfdc75598d54cb747368e000001a9-1505687706.741790-1390120011', '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 15:50:55 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 15:50:55 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 15:50:55 INFO - Using env: {'DISPLAY': ':0', 15:50:55 INFO - 'HOME': '/home/cltbld', 15:50:55 INFO - 'LANG': 'en_US.UTF-8', 15:50:55 INFO - 'LANGUAGE': 'en_US:en', 15:50:55 INFO - 'LOGNAME': 'cltbld', 15:50:55 INFO - 'MAIL': '/var/mail/cltbld', 15:50:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:55 INFO - 'MOZ_NO_REMOTE': '1', 15:50:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:55 INFO - 'NO_EM_RESTART': '1', 15:50:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:55 INFO - 'PWD': '/builds/slave/test', 15:50:55 INFO - 'SHELL': '/bin/bash', 15:50:55 INFO - 'SHLVL': '1', 15:50:55 INFO - 'TERM': 'linux', 15:50:55 INFO - 'TMOUT': '86400', 15:50:55 INFO - 'USER': 'cltbld', 15:50:55 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505687706.741790-1390120011', 15:50:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:55 INFO - '_': '/tools/buildbot/bin/python'} 15:50:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:56 INFO - Downloading/unpacking jsonschema==2.5.1 15:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:50:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:50:57 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 15:50:57 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 15:50:57 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 15:50:57 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 15:50:57 INFO - Downloading functools32-3.2.3-2.tar.gz 15:50:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:50:57 INFO - warning: no files found matching '*.txt' 15:50:57 INFO - no previously-included directories found matching 'build' 15:50:57 INFO - no previously-included directories found matching 'dist' 15:50:57 INFO - no previously-included directories found matching '.git*' 15:50:57 INFO - Installing collected packages: jsonschema, functools32 15:50:57 INFO - Running setup.py install for functools32 15:50:57 INFO - warning: no files found matching '*.txt' 15:50:57 INFO - no previously-included directories found matching 'build' 15:50:57 INFO - no previously-included directories found matching 'dist' 15:50:57 INFO - no previously-included directories found matching '.git*' 15:50:57 INFO - Successfully installed jsonschema functools32 15:50:57 INFO - Cleaning up... 15:50:57 INFO - Return code: 0 15:50:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:50:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1dd71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2143a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2147090>, '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 0x2147d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2141f90>, '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': '836cfdc75598d54cb747368e000001a9-1505687706.741790-1390120011', '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 15:50:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:50:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:50:57 INFO - Using env: {'DISPLAY': ':0', 15:50:57 INFO - 'HOME': '/home/cltbld', 15:50:57 INFO - 'LANG': 'en_US.UTF-8', 15:50:57 INFO - 'LANGUAGE': 'en_US:en', 15:50:57 INFO - 'LOGNAME': 'cltbld', 15:50:57 INFO - 'MAIL': '/var/mail/cltbld', 15:50:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:57 INFO - 'MOZ_NO_REMOTE': '1', 15:50:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:57 INFO - 'NO_EM_RESTART': '1', 15:50:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:57 INFO - 'PWD': '/builds/slave/test', 15:50:57 INFO - 'SHELL': '/bin/bash', 15:50:57 INFO - 'SHLVL': '1', 15:50:57 INFO - 'TERM': 'linux', 15:50:57 INFO - 'TMOUT': '86400', 15:50:57 INFO - 'USER': 'cltbld', 15:50:57 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505687706.741790-1390120011', 15:50:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:57 INFO - '_': '/tools/buildbot/bin/python'} 15:50:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:50:57 INFO - Cleaning up... 15:50:57 INFO - Return code: 0 15:50:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:50:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1dd71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2143a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2147090>, '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 0x2147d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2141f90>, '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': '836cfdc75598d54cb747368e000001a9-1505687706.741790-1390120011', '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 15:50:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:50:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:50:57 INFO - Using env: {'DISPLAY': ':0', 15:50:57 INFO - 'HOME': '/home/cltbld', 15:50:57 INFO - 'LANG': 'en_US.UTF-8', 15:50:57 INFO - 'LANGUAGE': 'en_US:en', 15:50:57 INFO - 'LOGNAME': 'cltbld', 15:50:57 INFO - 'MAIL': '/var/mail/cltbld', 15:50:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:57 INFO - 'MOZ_NO_REMOTE': '1', 15:50:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:57 INFO - 'NO_EM_RESTART': '1', 15:50:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:57 INFO - 'PWD': '/builds/slave/test', 15:50:57 INFO - 'SHELL': '/bin/bash', 15:50:57 INFO - 'SHLVL': '1', 15:50:57 INFO - 'TERM': 'linux', 15:50:57 INFO - 'TMOUT': '86400', 15:50:57 INFO - 'USER': 'cltbld', 15:50:57 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505687706.741790-1390120011', 15:50:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:57 INFO - '_': '/tools/buildbot/bin/python'} 15:50:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:58 INFO - Downloading/unpacking blobuploader==1.2.4 15:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:59 INFO - Downloading blobuploader-1.2.4.tar.gz 15:50:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:50:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:50: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 15:50: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 15:50: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 15:50: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 15:50:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:50:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:50: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 15:50: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 15:50: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 15:50: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 15:50:59 INFO - Downloading docopt-0.6.1.tar.gz 15:50:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:50:59 INFO - Installing collected packages: blobuploader, requests, docopt 15:50:59 INFO - Running setup.py install for blobuploader 15:50:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:50:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:50:59 INFO - Running setup.py install for requests 15:51:00 INFO - Running setup.py install for docopt 15:51:00 INFO - Successfully installed blobuploader requests docopt 15:51:00 INFO - Cleaning up... 15:51:00 INFO - Return code: 0 15:51:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:00 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 0x1dd71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2143a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2147090>, '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 0x2147d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2141f90>, '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': '836cfdc75598d54cb747368e000001a9-1505687706.741790-1390120011', '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 15:51:00 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 15:51:00 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 15:51:00 INFO - Using env: {'DISPLAY': ':0', 15:51:00 INFO - 'HOME': '/home/cltbld', 15:51:00 INFO - 'LANG': 'en_US.UTF-8', 15:51:00 INFO - 'LANGUAGE': 'en_US:en', 15:51:00 INFO - 'LOGNAME': 'cltbld', 15:51:00 INFO - 'MAIL': '/var/mail/cltbld', 15:51:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:00 INFO - 'MOZ_NO_REMOTE': '1', 15:51:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:00 INFO - 'NO_EM_RESTART': '1', 15:51:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:00 INFO - 'PWD': '/builds/slave/test', 15:51:00 INFO - 'SHELL': '/bin/bash', 15:51:00 INFO - 'SHLVL': '1', 15:51:00 INFO - 'TERM': 'linux', 15:51:00 INFO - 'TMOUT': '86400', 15:51:00 INFO - 'USER': 'cltbld', 15:51:00 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505687706.741790-1390120011', 15:51:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:00 INFO - '_': '/tools/buildbot/bin/python'} 15:51:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:51:00 INFO - Running setup.py (path:/tmp/pip-CQVRyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:51:00 INFO - Running setup.py (path:/tmp/pip-Do6uKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:51:00 INFO - Running setup.py (path:/tmp/pip-ecopPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:51:00 INFO - Running setup.py (path:/tmp/pip-EflnjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:51:00 INFO - Running setup.py (path:/tmp/pip-UVJwsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:51:00 INFO - Running setup.py (path:/tmp/pip-T8RlQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:51:00 INFO - Running setup.py (path:/tmp/pip-vAdl3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:51:01 INFO - Running setup.py (path:/tmp/pip-C83ax0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:51:01 INFO - Running setup.py (path:/tmp/pip-B48Kvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:51:01 INFO - Running setup.py (path:/tmp/pip-E24Ywi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:51:01 INFO - Running setup.py (path:/tmp/pip-zYMJhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:51:01 INFO - Running setup.py (path:/tmp/pip-eNxAiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:51:01 INFO - Running setup.py (path:/tmp/pip-1ZDnkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:51:01 INFO - Running setup.py (path:/tmp/pip-JdNJfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:01 INFO - Running setup.py (path:/tmp/pip-ABXflL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:51:01 INFO - Running setup.py (path:/tmp/pip-ccEnmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:51:01 INFO - Running setup.py (path:/tmp/pip-oPQWfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:51:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:51:01 INFO - Running setup.py install for manifestparser 15:51:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:51:01 INFO - Running setup.py install for mozcrash 15:51:01 INFO - Running setup.py install for mozdebug 15:51:02 INFO - Running setup.py install for mozdevice 15:51:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:51:02 INFO - Running setup.py install for mozfile 15:51:02 INFO - Running setup.py install for mozhttpd 15:51:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:51:02 INFO - Running setup.py install for mozinfo 15:51:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:51:02 INFO - Running setup.py install for mozInstall 15:51:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:51:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:51:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:51:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:51:02 INFO - Running setup.py install for mozleak 15:51:02 INFO - Running setup.py install for mozlog 15:51:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:51:02 INFO - Running setup.py install for moznetwork 15:51:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:51:02 INFO - Running setup.py install for mozprocess 15:51:02 INFO - Running setup.py install for mozprofile 15:51:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:51:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:51:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:51:03 INFO - Running setup.py install for mozrunner 15:51:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:51:03 INFO - Running setup.py install for mozscreenshot 15:51:03 INFO - Running setup.py install for moztest 15:51:03 INFO - Running setup.py install for mozversion 15:51:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:51:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:51:03 INFO - Cleaning up... 15:51:03 INFO - Return code: 0 15:51:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51: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')]} 15:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51: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')]} 15:51:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:03 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 0x1dd71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2143a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2147090>, '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 0x2147d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2141f90>, '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': '836cfdc75598d54cb747368e000001a9-1505687706.741790-1390120011', '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 15:51:03 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 15:51:03 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 15:51:03 INFO - Using env: {'DISPLAY': ':0', 15:51:03 INFO - 'HOME': '/home/cltbld', 15:51:03 INFO - 'LANG': 'en_US.UTF-8', 15:51:03 INFO - 'LANGUAGE': 'en_US:en', 15:51:03 INFO - 'LOGNAME': 'cltbld', 15:51:03 INFO - 'MAIL': '/var/mail/cltbld', 15:51:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:03 INFO - 'MOZ_NO_REMOTE': '1', 15:51:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:03 INFO - 'NO_EM_RESTART': '1', 15:51:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:03 INFO - 'PWD': '/builds/slave/test', 15:51:03 INFO - 'SHELL': '/bin/bash', 15:51:03 INFO - 'SHLVL': '1', 15:51:03 INFO - 'TERM': 'linux', 15:51:03 INFO - 'TMOUT': '86400', 15:51:03 INFO - 'USER': 'cltbld', 15:51:03 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505687706.741790-1390120011', 15:51:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:03 INFO - '_': '/tools/buildbot/bin/python'} 15:51:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:51:03 INFO - Running setup.py (path:/tmp/pip-38n_yd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:51:03 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)) 15:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:51:03 INFO - Running setup.py (path:/tmp/pip-WtZ9Bd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:51:03 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)) 15:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:51:03 INFO - Running setup.py (path:/tmp/pip-NLfajX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:51:03 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)) 15:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:51:03 INFO - Running setup.py (path:/tmp/pip-HL81yT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:51:04 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)) 15:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:51:04 INFO - Running setup.py (path:/tmp/pip-w_3cge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:51:04 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)) 15:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:51:04 INFO - Running setup.py (path:/tmp/pip-PUg6XD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:51:04 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)) 15:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:51:04 INFO - Running setup.py (path:/tmp/pip-7Nfkz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:51:04 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)) 15:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:51:04 INFO - Running setup.py (path:/tmp/pip-vjKH0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:51:04 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)) 15:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:51:04 INFO - Running setup.py (path:/tmp/pip-9oNRCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:51:04 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)) 15:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:51:04 INFO - Running setup.py (path:/tmp/pip-5CVvM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:51:04 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)) 15:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:51:04 INFO - Running setup.py (path:/tmp/pip-aTDXVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:51:04 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)) 15:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:51:04 INFO - Running setup.py (path:/tmp/pip-WYcmWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:51:04 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)) 15:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:51:04 INFO - Running setup.py (path:/tmp/pip-iSr1IT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:51:04 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)) 15:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:51:04 INFO - Running setup.py (path:/tmp/pip-9oTLiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:51:04 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)) 15:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:04 INFO - Running setup.py (path:/tmp/pip-8BND4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:04 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)) 15:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:51:04 INFO - Running setup.py (path:/tmp/pip-mYhgaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:51:04 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)) 15:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:51:04 INFO - Running setup.py (path:/tmp/pip-Nz9GRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:51:04 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)) 15:51:04 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)) 15:51:04 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)) 15:51:04 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)) 15:51:04 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)) 15:51:04 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)) 15:51:04 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)) 15:51:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:06 INFO - Downloading blessings-1.6.tar.gz 15:51:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:51:06 INFO - Installing collected packages: blessings 15:51:06 INFO - Running setup.py install for blessings 15:51:06 INFO - Successfully installed blessings 15:51:06 INFO - Cleaning up... 15:51:06 INFO - Return code: 0 15:51:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:51:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:51:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:51:06 INFO - Reading from file tmpfile_stdout 15:51:06 INFO - Current package versions: 15:51:06 INFO - argparse == 1.2.1 15:51:06 INFO - blessings == 1.6 15:51:06 INFO - blobuploader == 1.2.4 15:51:06 INFO - docopt == 0.6.1 15:51:06 INFO - functools32 == 3.2.3-2 15:51:06 INFO - jsonschema == 2.5.1 15:51:06 INFO - manifestparser == 1.1 15:51:06 INFO - mozInstall == 1.13 15:51:06 INFO - mozcrash == 1.0 15:51:06 INFO - mozdebug == 0.1 15:51:06 INFO - mozdevice == 0.51 15:51:06 INFO - mozfile == 1.2 15:51:06 INFO - mozhttpd == 0.7 15:51:06 INFO - mozinfo == 0.10 15:51:06 INFO - mozleak == 0.1 15:51:06 INFO - mozlog == 3.5 15:51:06 INFO - moznetwork == 0.27 15:51:06 INFO - mozprocess == 0.25 15:51:06 INFO - mozprofile == 0.28 15:51:06 INFO - mozrunner == 6.13 15:51:06 INFO - mozscreenshot == 0.1 15:51:06 INFO - mozsystemmonitor == 0.3 15:51:06 INFO - moztest == 0.8 15:51:06 INFO - mozversion == 1.4 15:51:06 INFO - psutil == 3.1.1 15:51:06 INFO - requests == 1.2.3 15:51:06 INFO - wsgiref == 0.1.2 15:51:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:06 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 0x1dd71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2143a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2147090>, '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 0x2147d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2141f90>, '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': '836cfdc75598d54cb747368e000001a9-1505687706.741790-1390120011', '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 15:51:06 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 15:51:06 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 15:51:06 INFO - Using env: {'DISPLAY': ':0', 15:51:06 INFO - 'HOME': '/home/cltbld', 15:51:06 INFO - 'LANG': 'en_US.UTF-8', 15:51:06 INFO - 'LANGUAGE': 'en_US:en', 15:51:06 INFO - 'LOGNAME': 'cltbld', 15:51:06 INFO - 'MAIL': '/var/mail/cltbld', 15:51:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:06 INFO - 'MOZ_NO_REMOTE': '1', 15:51:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:06 INFO - 'NO_EM_RESTART': '1', 15:51:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:06 INFO - 'PWD': '/builds/slave/test', 15:51:06 INFO - 'SHELL': '/bin/bash', 15:51:06 INFO - 'SHLVL': '1', 15:51:06 INFO - 'TERM': 'linux', 15:51:06 INFO - 'TMOUT': '86400', 15:51:06 INFO - 'USER': 'cltbld', 15:51:06 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505687706.741790-1390120011', 15:51:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:06 INFO - '_': '/tools/buildbot/bin/python'} 15:51:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:06 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)) 15:51:06 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)) 15:51:06 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)) 15:51:06 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)) 15:51:06 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)) 15:51:06 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)) 15:51:06 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)) 15:51:06 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)) 15:51:06 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)) 15:51:06 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:51:07 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)) 15:51:07 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)) 15:51:07 INFO - Installing collected packages: simplejson 15:51:07 INFO - Running setup.py install for simplejson 15:51:08 INFO - building 'simplejson._speedups' extension 15:51:08 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 15:51:08 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 15:51:08 INFO - Successfully installed simplejson 15:51:08 INFO - Cleaning up... 15:51:08 INFO - Return code: 0 15:51:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:51:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:08 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 0x1dd71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2143a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2147090>, '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 0x2147d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2141f90>, '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': '836cfdc75598d54cb747368e000001a9-1505687706.741790-1390120011', '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 15:51:08 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 15:51:08 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 15:51:08 INFO - Using env: {'DISPLAY': ':0', 15:51:08 INFO - 'HOME': '/home/cltbld', 15:51:08 INFO - 'LANG': 'en_US.UTF-8', 15:51:08 INFO - 'LANGUAGE': 'en_US:en', 15:51:08 INFO - 'LOGNAME': 'cltbld', 15:51:08 INFO - 'MAIL': '/var/mail/cltbld', 15:51:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:08 INFO - 'MOZ_NO_REMOTE': '1', 15:51:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:08 INFO - 'NO_EM_RESTART': '1', 15:51:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:08 INFO - 'PWD': '/builds/slave/test', 15:51:08 INFO - 'SHELL': '/bin/bash', 15:51:08 INFO - 'SHLVL': '1', 15:51:08 INFO - 'TERM': 'linux', 15:51:08 INFO - 'TMOUT': '86400', 15:51:08 INFO - 'USER': 'cltbld', 15:51:08 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505687706.741790-1390120011', 15:51:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:08 INFO - '_': '/tools/buildbot/bin/python'} 15:51:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:51:09 INFO - Cleaning up... 15:51:09 INFO - Return code: 0 15:51:09 INFO - Running post-action listener: _resource_record_post_action 15:51:09 INFO - Running post-action listener: _start_resource_monitoring 15:51:09 INFO - Starting resource monitoring. 15:51:09 INFO - [mozharness: 2017-09-17 22:51:09.231740Z] Finished create-virtualenv step (success) 15:51:09 INFO - [mozharness: 2017-09-17 22:51:09.232255Z] Running install step. 15:51:09 INFO - Running pre-action listener: _resource_record_pre_action 15:51:09 INFO - Running main action method: install 15:51:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:51:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:51:09 INFO - Reading from file tmpfile_stdout 15:51:09 INFO - Detecting whether we're running mozinstall >=1.0... 15:51:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:51:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:51:09 INFO - Reading from file tmpfile_stdout 15:51:09 INFO - Output received: 15:51:09 INFO - Usage: mozinstall [options] installer 15:51:09 INFO - Options: 15:51:09 INFO - -h, --help show this help message and exit 15:51:09 INFO - -d DEST, --destination=DEST 15:51:09 INFO - Directory to install application into. [default: 15:51:09 INFO - "/builds/slave/test"] 15:51:09 INFO - --app=APP Application being installed. [default: firefox] 15:51:09 INFO - mkdir: /builds/slave/test/build/application 15:51:09 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'] 15:51:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:51:27 INFO - Reading from file tmpfile_stdout 15:51:27 INFO - Output received: 15:51:27 INFO - /builds/slave/test/build/application/firefox/firefox 15:51:27 INFO - Running post-action listener: _resource_record_post_action 15:51:27 INFO - [mozharness: 2017-09-17 22:51:27.141884Z] Finished install step (success) 15:51:27 INFO - [mozharness: 2017-09-17 22:51:27.142137Z] Running setup-mitmproxy step. 15:51:27 INFO - Running pre-action listener: _resource_record_pre_action 15:51:27 INFO - Running main action method: setup_mitmproxy 15:51:27 INFO - Skipping: mitmproxy is not required 15:51:27 INFO - Running post-action listener: _resource_record_post_action 15:51:27 INFO - [mozharness: 2017-09-17 22:51:27.143266Z] Finished setup-mitmproxy step (success) 15:51:27 INFO - [mozharness: 2017-09-17 22:51:27.143486Z] Running run-tests step. 15:51:27 INFO - Running pre-action listener: _resource_record_pre_action 15:51:27 INFO - Running pre-action listener: _set_gcov_prefix 15:51:27 INFO - Running main action method: run_tests 15:51:27 WARNING - Try message not found. 15:51:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:51:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:51:27 INFO - Python 2.7.3 15:51:27 INFO - Return code: 0 15:51:27 INFO - grabbing minidump binary from tooltool 15:51:27 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')]} 15:51:27 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 0x2147090>, '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 0x2147d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2141f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:51:27 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 15:51:27 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 15:51:27 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 15:51:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:51:27 INFO - Return code: 0 15:51:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:51:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:51:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:51:27 INFO - ENV: RUST_BACKTRACE is now full 15:51:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:51:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:51:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Tm_s3FMBRbu6xkB0TPt4pA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 15:51:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Tm_s3FMBRbu6xkB0TPt4pA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-028 --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 15:51:27 INFO - Using env: {'DISPLAY': ':0', 15:51:27 INFO - 'HOME': '/home/cltbld', 15:51:27 INFO - 'LANG': 'en_US.UTF-8', 15:51:27 INFO - 'LANGUAGE': 'en_US:en', 15:51:27 INFO - 'LOGNAME': 'cltbld', 15:51:27 INFO - 'MAIL': '/var/mail/cltbld', 15:51:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:51:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:51:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:27 INFO - 'MOZ_NO_REMOTE': '1', 15:51:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:51:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:27 INFO - 'NO_EM_RESTART': '1', 15:51:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:27 INFO - 'PWD': '/builds/slave/test', 15:51:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:51:27 INFO - 'RUST_BACKTRACE': 'full', 15:51:27 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:51:27 INFO - 'SHELL': '/bin/bash', 15:51:27 INFO - 'SHLVL': '1', 15:51:27 INFO - 'TERM': 'linux', 15:51:27 INFO - 'TMOUT': '86400', 15:51:27 INFO - 'USER': 'cltbld', 15:51:27 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505687706.741790-1390120011', 15:51:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:27 INFO - '_': '/tools/buildbot/bin/python'} 15:51:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Tm_s3FMBRbu6xkB0TPt4pA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 15:51:27 INFO - mozversion application_buildid: 20170917213235 15:51:27 INFO - mozversion application_changeset: ae39864562c6048fdc2950c5dfedb48e247c3300 15:51:27 INFO - mozversion application_display_name: Nightly 15:51:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:51:27 INFO - mozversion application_name: Firefox 15:51:27 INFO - mozversion application_remotingname: firefox 15:51:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:51:27 INFO - mozversion application_vendor: Mozilla 15:51:27 INFO - mozversion application_version: 57.0a1 15:51:27 INFO - mozversion platform_buildid: 20170917213235 15:51:27 INFO - mozversion platform_changeset: ae39864562c6048fdc2950c5dfedb48e247c3300 15:51:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:51:27 INFO - mozversion platform_version: 57.0a1 15:51:27 INFO - using testdate: 1505688687 15:51:27 INFO - actual date: 1505688687 15:51:27 INFO - starting webserver on 'localhost:41891' 15:51:27 INFO - SUITE-START | Running 2 tests 15:51:27 INFO - TEST-START | dromaeo_css 15:51:27 INFO - Initialising browser for dromaeo_css test... 15:51:27 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41891/getInfo.html -profile /tmp/tmpSi9boI/profile 15:51:27 INFO - TEST-INFO | started process 7324 (/builds/slave/test/build/application/firefox/firefox http://localhost:41891/getInfo.html) 15:51:33 INFO - TEST-INFO | 7324: exit 0 15:51:33 INFO - Browser initialized. 15:51:33 INFO - Running cycle 1/1 for dromaeo_css test... 15:51:33 INFO - Using env: {'DISPLAY': ':0', 15:51:33 INFO - 'HOME': '/home/cltbld', 15:51:33 INFO - 'JSGC_DISABLE_POISONING': '1', 15:51:33 INFO - 'LANG': 'en_US.UTF-8', 15:51:33 INFO - 'LANGUAGE': 'en_US:en', 15:51:33 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:51:33 INFO - 'LOGNAME': 'cltbld', 15:51:33 INFO - 'MAIL': '/var/mail/cltbld', 15:51:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:51:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:51:33 INFO - 'MOZ_CRASHREPORTER': '1', 15:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:33 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:51:33 INFO - 'MOZ_NO_REMOTE': '1', 15:51:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:51:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:33 INFO - 'NO_EM_RESTART': '1', 15:51:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:33 INFO - 'PWD': '/builds/slave/test', 15:51:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:51:33 INFO - 'RUST_BACKTRACE': 'full', 15:51:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:51:33 INFO - 'SHELL': '/bin/bash', 15:51:33 INFO - 'SHLVL': '1', 15:51:33 INFO - 'STYLO_FORCE_DISABLED': '1', 15:51:33 INFO - 'TERM': 'linux', 15:51:33 INFO - 'TMOUT': '86400', 15:51:33 INFO - 'USER': 'cltbld', 15:51:33 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505687706.741790-1390120011', 15:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:33 INFO - '_': '/tools/buildbot/bin/python'} 15:51:33 INFO - TEST-INFO | started process 7564 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSi9boI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:51:34 INFO - PID 7564 | 15:51:34 INFO - PID 7564 | (/builds/slave/test/build/application/firefox/firefox:7613): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:51:34 INFO - PID 7564 | 15:51:44 INFO - PID 7564 | RSS: Main: 147996672 15:51:44 INFO - PID 7564 | 15:54:41 INFO - PID 7564 | Cycle 1(1): loaded http://localhost:41891/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41891/tests/dromaeo/cssquery-ext.html) 15:54:42 INFO - PID 7564 | RSS: Main: 148680704 15:54:42 INFO - PID 7564 | 15:57:43 INFO - PID 7564 | Cycle 1(1): loaded http://localhost:41891/tests/dromaeo/cssquery-ext.html (next: http://localhost:41891/tests/dromaeo/cssquery-jquery.html) 15:57:44 INFO - PID 7564 | RSS: Main: 148688896 15:57:44 INFO - PID 7564 | 16:00:46 INFO - PID 7564 | Cycle 1(1): loaded http://localhost:41891/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41891/tests/dromaeo/cssquery-mootools.html) 16:00:46 INFO - PID 7564 | RSS: Main: 150728704 16:00:46 INFO - PID 7564 | 16:03:48 INFO - PID 7564 | Cycle 1(1): loaded http://localhost:41891/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41891/tests/dromaeo/cssquery-prototype.html) 16:03:48 INFO - PID 7564 | RSS: Main: 149532672 16:03:48 INFO - PID 7564 | 16:06:51 INFO - PID 7564 | Cycle 1(1): loaded http://localhost:41891/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41891/tests/dromaeo/cssquery-yui.html) 16:06:52 INFO - PID 7564 | RSS: Main: 150462464 16:06:52 INFO - PID 7564 | 16:09:53 INFO - PID 7564 | Cycle 1(1): loaded http://localhost:41891/tests/dromaeo/cssquery-yui.html (next: http://localhost:41891/tests/dromaeo/cssquery-dojo.html) 16:09:54 INFO - PID 7564 | RSS: Main: 153174016 16:09:54 INFO - PID 7564 | 16:09:54 INFO - PID 7564 | __start_tp_report 16:09:54 INFO - PID 7564 | _x_x_mozilla_page_load 16:09:54 INFO - PID 7564 | _x_x_mozilla_page_load_details 16:09:54 INFO - PID 7564 | |i|pagename|runs| 16:09:54 INFO - PID 7564 | |0;dojo.html;3843.3274177019034;3850.5764365919745;3857.6720978716808;3860.613938606139;3867.9419808702855;6264.342244064376;6264.718087686065;6270.623762574237;6293;6395.616263024222;6285.371462853713;6286.465650419708;6298.874022519558;6315.305316415191;6329.77845775398;5654.208410822488;5669.546436285098;5679.290088738908;5761;5770.480656740892;5774.2782152230975;5785.479306862381;5800.129980502916;5810.1865738796605;5845.357010728816;103.2154653196036;5682.54539636828;5738.081906894877;5832.154337621042;5837.066069428871;5684.261046063985;5699.430056994309;5717.199592057115;5778.3066032076;5786.363500014995;5692.089265717506;5707.571932105108;5758.79844205455;5769.538436925036;5786.797462088806;6228.657423841687;6274.811755647338;6306.968465157691;6386.16979792624;6420.165378500812;6861.759838405632;6865.759698410581;6949.652517374162;6958.130233720785;6968.547044442095;6797;6877.6217308048035;6913.343232392915;6931.757388491378;7005.334493223136;6322;6356.523260755415;6376.904346434807;6382.904256436157;6396.712147953307;6940.687669054904;6950.791476255619;7043.612601306977;7045.11936007999;7052.541584796972;6657.500687448461;6727.730890764315;6730.394264516119;6794.762183323659;6810.216825065082;6758.966205169041;6882.483813713991;6911.7926462206215;6978.337057979484;6982.197047339621;6776.9322306777285;6825.35159159879;6842.178938527409;6843.7604683835825;6852.794416167523;6673.466122710269;6804;6805.693743781541;6902.585844849325;6920.550164239308;4879.414470263591;4944.653874228841;4956.727379994063;4985.351904252424;4989.351384320015;4541.227991241497;4556.3393307970155;4576.679632425698;4621.19129152397;4637.211674015425;6276.686165691697;6363.045543168561;6364.6181229126405;6366.681665916778;6369.71336289868;6768.255491895888;6892.965535172392;6963.721451141999;6967.965160174167;6970.860582788316;6083.6045657032155;6234.470070044006;6259.561830671809;6341.619502829845;6351.587146835441;5498.477644623755;5599;5602.663840169603;5617.073182924772;5630.859228519238;6934.687939042755;6947.949878762964;7049.9647501762165;7226.132864056347;7258.419326453871;6874.759383421556;6882.139732533434;6885.793426197222;6886.827829304308;6889.621070841152;7033.9296607033275;7039.19049309336;7072.009918611501;7168.390686791473;7181.640917954186;6622.10601568782;6740.797776066725;6787.864242715019;6799.354061364163;6803.557768745016;6927.272636373108;6940.646573918038;6955.860882782417;6988.8951665724035;6989;6656.400923916871;6662.300458451793;6670.266270710121;6744.0895479109695;6756.358145976124;6499.5125365598715;6659.800205993828;6662.367075127855;6752.966235168793;6765.627890466071;6556.082148499309;6566.8358291043105;6572.539922205399;6576.177977752781;6594.274629790815;6555.115059467102;6609.405153536205;6664.966675166593;6672.666366681744;6721.596704197764;6516.185476815398;6529.085927969993;6534.281229064704;6594.736210551524;6598.571092878948 16:09:54 INFO - PID 7564 | |1;ext.html;941.2187884056234;969.6557722008687;993.0317940008488;996.2776986684654;997.416511340866;43855;44325.33511997323;44673.32990005148;44751;44760.77619611901;41813.581864181346;44622;46061.30908036374;46095.53904460954;46178;8169.918300817005;8278.379121565877;8324.209200125979;8327.208915153082;8328.458650187718;7970.561619110947;8057.3554115670895;8086.636101375423;8117.675292988273;8129.4715843469985;8105.351571874236;8143.429959902809;8146.226108519711;8149.714759983402;8155.755327340189;8082.9492166018335;8110.067342255657;8115.95942020292;8130.55281959492;8151.307138893201;7680.769576912701;7701.6919323227;7743.9225607743765;7748.380129589619;7756.108047574545;40611.593884061076;40989.745563994264;41012;41017.38473922894;41031;3676.1361080146144;3703.53705786774;3717.7211709121652;3719.033051406627;3719.75821571597;32529.51205731916;32570.83714581412;32660;33478.497822532685;33636.663633363845;5255.894882102375;5442.836714898559;5474.233607294982;5478.58910581708;5572.832815015556;211298;216010;224130.99999999837;230076;230750;53813.46186538163;54201.1869821953;54278.45721542813;54468.72765636226;54606.45393546093;55671.443285566624;55750;55921;55956.44043559513;55961;15094.471693490676;15133.167675777939;15145.091294522364;15156.772648410282;15388.076715397112;12304.323262220663;12335.93832030852;12374;12385.504579816887;12387.256764594153;14266.928665356814;14378.35297411619;14528.418863245352;14710.55868323952;14728.481309109857;5331.893362132736;5376.247325374451;5387.164989426645;5394.352677678625;5485.396606373296;1079.956801727922;1096.0792933935531;1104.9116070714324;1107.6012635451232;1113.3375641493299;24914.501709965698;25146.24561263165;25412.74587254104;25551.61672574913;25588.616170757454;1182.3319824299415;1186.145974898072;1202.8616709078392;1210.2315029956042;1216.9330686812311;13172.802407963889;13370.064095513415;13426.718650938177;13495;13512.527061552799;282102;282489;282915;283597;284293;58474.7076264616;58611;58826.11760823591;58859;59030.70484647635;1499.730048591264;1506.0737646347636;1513.5761986643756;1516.1736853414916;1527.7784721215362;24466.75533244716;24840.75159248457;24877.253682389557;24909.75090249147;25027.87486062558;36183.63816361803;37423.06442338963;37577;37651;37724;235311;237270;237387;237785;237816;33306.83346583252;34009.97970060902;34180.14549636279;34347.14132146716;37218.255634886606;40996;41152;41375.37936931009;41646;42001.159976800904;34550;34653.82673086618;34941.650583493836;35060.64939350574;35817.10457238486;34476.13809654779;34532.482012769324;34661;34992.30015399729;35159.64840351666;38697.22605547817;39702;39762;39851.2029759409;39963;32566.34867302688;32970.340593187524;33112.668873310955;33288.83355583207;33777.83111084429;25438.109666162334;25477.74522254754;25669.614955775305;26209.4758104833;26245.606315905658 16:09:54 INFO - PID 7564 | |2;jquery.html;586.3462239602843;593.2765316754828;593.6942474625567;595.365935278928;598.9281286245648;22732.77267227329;23404.765952340473;23414.297571072893;23452.179173728902;23453.296401107953;24917.50164996699;25947.74052259477;26081.608775868328;26133.60799588003;26254.6061809073;6258.405451482102;6423.839404014913;6428;6441.903371449409;6445.129907462503;6313.905291420632;6395.616263024233;6418.614883107029;6652.567583107107;6672.266050734415;6555.606663600175;6582.637954912478;6615.702293396785;6619.040239165318;6621.370969757865;6262.2172228471445;6584.341565843377;6585.539012269143;6603.273639899608;6608.471322294205;6058.1215723719815;6078.939210607881;6133.1413602095745;6134.754609815602;6143.017117261262;29057;29629.70370296291;29670.70329296701;29674.406511869856;29731.40537189244;2255.650374192003;2283.303592404316;2284.4288927768057;2284.4745708486976;2284.805791507724;19995.400137995737;20688.275910343214;20717;20814.687779683318;20842.5831483371;2531.5696331623667;2554.463562651845;2612.164107485605;2613.281347629398;2617.869106544665;123371;128865;150633;158775.99999999884;159361;15120.388281574225;15717.685646287011;15890.76163857543;16122.67754644924;16787;25176.24471265865;25255.87372063128;25331.240062798144;25346.493070138495;25364.746352536607;9934.403935763878;9969.102780749767;10133.189344852393;10182.23633227496;10270.794584108276;9217.539123043955;9312.487813170204;9324.720258392259;9326.160645541933;9357.111074447917;9574.590012806699;9683.273754468442;9748.976357482505;9885.406875587487;9949.353292035994;2859.828410295389;2870.1246119933203;2915.2420370703344;2921.6786153523094;3020.622422197225;1041.6198087697935;1052.5737076484036;1060.6446840308429;1062.9946850265699;1079.5627770752858;20350.28773992903;20915.37253882386;21075;21119.26082587102;21362.252321168686;1086.266769930294;1094.2559059839386;1097.1825989637612;1105.38098664748;1107.9778404432027;11489.54041838317;11576.594819181288;11643.243189192845;11665.24175928579;11668.358240296695;596774;598561.0143898593;602004.9799502037;619064;632492;125503;127757.36121319333;127821.3608931968;127902;128695;1185.1170877696172;1211.2853416484318;1236.1841184818156;1238.5726924211133;1242.105683907585;18382.81617183811;18580.814191858448;18590.44228673142;18675.533111672317;19081.332153374566;60648.39351606427;62209.68895155676;62247;63405;64438;74571;74681.62659186669;75297.62351188209;76686.61656691681;77780.61109694415;14650;14981.250937452865;15079;15086.622834428788;15088.924555377153;21087.261945831822;22800.771992279864;22935.42661433411;22990.540189195788;23010.654840177747;17663.116844157485;18979.90510047441;19188.040597970325;19414.417567473;19433.931133787777;16916.447546015475;16946.830531694526;17177.914110429367;17220.138993050547;17722.46832595024;19439.3196238131;19473.318433854747;19503.122359493573;19699.80300197037;19717.30989415421;13993.790093148407;14680.265986700835;14723.411063557338;14848.183349915858;14896.85103148998;18520.536986575444;18580.628387432447;18876.622467550296;18894.433167005012;18979.90510047441 16:09:54 INFO - PID 7564 | |3;mootools.html;1433.956981290561;1451.637090727318;1480.1637075052595;1494.4545240987043;1499.8650121489063;16222.351105955748;16953.23710433032;17033.318667253312;17133.571660708487;17150.742738858928;16700.248488818;16742.41401550946;16827.579310517212;16898.493045208663;16916.323347066103;2857.5427931530958;2896.56551517272;2953.4683756923746;2953.822770633758;2957;2846.4307138572267;2867.25451382641;2868.0965495868736;2868.4549935512186;2871.856407179643;2806.957895631567;2857.22854829196;2905.128461461564;2907.1569244919056;2908.0548821632947;2779.3051737065734;2827.9010234641687;2828.250513613894;2828.4343131373703;2830.561263004238;2807.7192280771965;2826.0956493921954;2833.489971805074;2834.2772592988654;2843.7156284371604;15834.129122898235;16104.516864494084;16146.354145834153;16287;16326.75509867353;8201.753947381589;8550.914490855137;8558.614862331147;8560;8560.186782255676;5343.839684809462;5453.15476101201;5697.1739097831;5713.028785106542;5820;1928.1034319041573;1937.321937321926;1940.5439721665398;1992.3524854422371;2010.2461576908659;26588.202353929413;27359.589606155925;27380.45239095207;29003.854980725173;30000.69999300001;7604.505707129019;7707.34487568563;7709.6530656119485;7843.4117441191;7853.842923141619;22399;22475.325740227818;22476;22482.100715971177;22515;8704.825903481895;8713.954325480983;8826.51454170014;8826.51454170014;8833.60248788806;7412.1476030256135;7781.455298129076;7819.257170568787;7823.139454659983;7828.060632723996;5697.4302569742695;5843.795467158714;5856.180134781134;5886.411358864165;5979.790707325223;1841.0886611127578;1859.3213477080767;1881.0876724788466;1888.6694828404975;1889.2065332560358;969.3747532841278;976.1312431935582;982.4105536677936;996.1731762636994;1003.3628645809817;8673.219410253107;8724.651013959498;8752.124787521325;8764;8873.245774109273;805.4804651000072;806.3871457692079;806.8628333183373;813.113706060397;823.2097186700714;5112.539871411591;5112.923306150411;5210.947890521122;5223.425423203445;5242.816501422432;24288.87855560746;25485.74514254871;25665.10172143966;25681.614775778376;25684;24460.633090503656;24727.752722472906;25012.874935625205;25291.241262762145;25369.492610148063;10696.51865666047;11043;11983.221090629255;12119.030477561773;12156.756864862653;10122.291439599452;10135.442550659785;10166.593336266467;10323.741906452398;10507.369557826554;20825.89587052055;21709.15472184882;21947.670784938557;21956.78043219547;22057.11771529121;21022;21364.465888352915;21877.343679689635;21912.78087219171;22306.10775568959;13029.674258143623;13064.738705226033;13290.136141150795;13292.20246785196;13314.86685133175;14798;15058.623534411288;15065.774013390028;15070.698586028437;15078.095314281178;12291.32397718134;12369.134160608672;12369.876301237233;12397.318147501974;12788.936055319664;12091.879081209427;12395.690107747378;12453.128281020241;12549.184303020274;12896.8065479016;10233.130183934449;10238.33450825694;10271.84592231132;10283.742906427398;10351.741206469898;7785.221477852396;8011.519308841488;8018.957535520345;8057.919420805717;8140;8108.594570271581;8131.146229646039;8147.348212142896;8180.550069746221;8196.385271104571 16:09:54 INFO - PID 7564 | |4;prototype.html;531.8138651471983;552.9032419326617;555.7499125393574;557.436988641472;571.3486625247216;6338.841528961767;6343.42909138178;6353.904691429632;6354.555181137316;6378.4486205517815;6281.748730050793;6317.210348706411;6327.303996560375;6330.746770129189;6331.873362532747;5129.410117836459;5183.2743415921805;5194.948050519493;5200.297959775438;5219.9478005220035;4900.99059385652;5006.148954677714;5180.11937970544;5213.556847667953;5214.06146893559;4952.950470495303;5021.397432308128;5027.944131732341;5044.672096313746;5056.165732654126;4980.431164183271;5028.120078986181;5033.92252275656;5036.647434679574;5038.823641172541;4451.643868490513;4523.84166554169;4549;4553.225951588238;4561.40701708779;6096.536831160533;6120.693965301762;6176.567640265183;6255.71757789652;6281.937180628181;5923.496502797268;5930.229070220887;5941.762329506814;5956.612820166719;5969.224000879901;6699.76550820719;6717.026031225445;6738.460923126138;6759.797206083826;6789.1174147360525;5084.516970887797;5085.1355269604255;5089.05852417304;5091.414487333967;5091.872703182413;6773.72905083796;6788.2193547742145;6929.896051559231;6943.201531823855;7007.4394048476;5134.2812006319145;5168;5189.987952349331;5199;5212.166053431432;5245.160774276097;5246.97376513115;5249.973750131301;5256.106461901486;5287.947120528823;5753.137029445533;5836.095405212199;5888.941110588839;5890.528757699374;5906.3207731110615;6764.323567643196;6765.695543700545;6769.695363708645;6788.694508747119;6795.422389096982;1797.5506123469133;1824.9817501825078;1831.789344225431;1838.6230822681318;1846.8707190496805;1230.446299165379;1279.7248591552861;1294.566320282697;1298.7921932490756;1304.6673098359859;6131.386861313833;6148.862460444832;6234.3453937336835;6237.500999919996;6286.271275399302;6601.306862779339;6667.233268174222;6874.415674667609;6884.208316043719;6888.965555172293;6162.7226774795245;6202.224721909762;6202.844928876814;6209.379062093845;6231.501479881598;3485.686288234071;3535.964640353615;3560.732945029133;3589;3614.204874927512;6857.27998560154;6924.3421874921805;6983.93016069843;7004.824879378057;7006.814956931834;6838.384545390839;6871.209810871814;6871.244163142051;6920.342567456084;6954.165500140016;6889.552179108242;6899.724011039502;6956.617386043817;6984.825379365557;7050;6616.172978377703;6647;6745.392914637706;6784.76253331131;6803.7618683345845;6664.300248473841;6680.899786503109;6684.966575167093;6735.158105236846;6786.423154031962;6972.477064220102;7005.369516743517;7021.543599666005;7029.437644988491;7048.189458212166;5147.2279158126585;5165.874645839363;5168.560672342743;5172.689638621695;5204.2714020036465;6646.202455705346;6731.259561448334;6816.386525212754;6821.965890170517;6837.282085381163;6180.227471566054;6509;6559.212894452697;6574.671266436755;6591.143151390289;6548.639824809491;6633.9336606633315;6635.9004614929845;6672.299408562031;6683.565568238049;6480.805575832733;6511.804645860631;6569.277379488157;6581.6709164540625;6628.469722422291;6577.868442631025;6656.966715166393;6725.596464212163;6754.729810807709;6765.864682706417;6395.93604063972;6464.5798023128345;6482.254540727877;6509.934900650933;6547.9672601636685 16:09:54 INFO - PID 7564 | |5;yui.html;972.2027937091583;986.3145114145667;1002.5989604158339;1005.4671024357089;1009.4347165587276;17371.82628173718;17968.73046904294;17972.550686232833;17978.910105449486;17981.730274045884;18283.90858045708;18475.907620461912;18718.812811871878;18747.437576872682;18779.62440751184;1048.1719441641094;1052.6368402900987;1053.5891002509009;1055.2929537210089;1061.1669839176247;1048.5910494906993;1061.2306078093359;1062.0335494699787;1063.6702622187108;1065.6270305393127;1073.6993641780275;1110.9777804443906;1131.564347726123;1147.810611249143;1150.8158694608865;1135.9034482069035;1138.925969811968;1140.0936255676716;1142.3774043146504;1142.8114361130404;793.5199204481263;812.4921923797626;819.9672013119468;820.2740574591529;824.6701319472199;18681.906590467097;18792.624147516974;18829.152688129067;18845.905770471196;18899.716504252447;22986.310410687707;23021.309360719206;23488.882555587283;23521.76478235213;23638.40903977397;18223;18479.44561663152;18602;18628.72056919147;18967.90516047425;3972.543157536891;4022.155347377054;4027.818748156311;4036.6972477064046;4036.8183431745642;127880;158424;158563.99999999884;159584;162553.18723406424;18706.532336691693;18728;18995.24019039223;19132.426027219204;19133.904330478257;34638.653613463546;35036.12409689778;35158.64841351554;35645.82177089098;35795.64204357923;9239.861402078974;9289.442633442015;9310.86033709495;9315;9336.11306925841;4414.558544145624;4436.3567282743825;4460.8661740147845;4542.136993971201;4547.658925580595;5724.713764311768;5820.835832833451;5827.067669172912;5863.296404431496;5871.148683440877;1111.3276467737064;1144.6852115668257;1147.3861484105964;1150.5340337163461;1157.450211149714;738.9704411823467;745.6868115391549;750.7072241825583;769.3076231391792;773.122505955733;11605.941970290094;12082.69793255158;12134.817977730341;13052.738945221043;13378.13042152257;704.7145905908116;708.596100222868;710.8578284343153;726.0887586079436;726.5350175887436;6000.849978750479;6100.54245931548;6137.447629713347;6198.132261483396;6212.378762123842;146534;148994;149611;152389;153765;98698;100563;118266.40866795783;129695;136267;109326.45336773424;112115.87884121218;112568.43715781532;112798;114408;12889.291088990196;13123.278219697626;13129.60611181666;13199.604011879659;13455.86544134546;49957.50042499528;51264.74367628138;53227.4677253238;53391.73304133455;54545;66234;66908;68428.6578567104;68924;69674.65162674154;19443.222271108996;19499.902500487973;19515;19546.51133721668;19743.506412339808;19911.800881990996;19916.90041549783;19932.800671993093;20137.59724805525;20229.6965545514;18307.35924242645;18515.074246287902;18777.530561736065;18818.059097045367;18829.435116946515;18379.356722514647;18600.16299266563;18622.255109795457;18730.812691872907;18891.811081889555;18203.45389638313;18287.90272583649;18393.540161495534;18604.2558297672;18609.53476163107;13302.93348533251;13371.465141394236;13494.190348578724;13629.727405452033;13689.657758556115;13613.455461781417;13729.382177802223;13815.86184138186;13861.168329900238;13966.37151328213 16:09:54 INFO - PID 7564 | __end_tp_report 16:09:54 INFO - PID 7564 | __start_cc_report 16:09:54 INFO - PID 7564 | _x_x_mozilla_cycle_collect,263 16:09:54 INFO - PID 7564 | __end_cc_report 16:09:54 INFO - PID 7564 | __startTimestamp1505689794154__endTimestamp 16:09:54 INFO - PID 7564 | 16:09:54 INFO - PID 7564 | ------- Summary: start ------- 16:09:54 INFO - PID 7564 | Number of tests: 6 16:09:54 INFO - PID 7564 | 16:09:54 INFO - PID 7564 | [#0] dojo.html Cycles:165 Average:6286.63 Median:6572.54 stddev:890.36 (13.5%) stddev-sans-first:872.22 16:09:54 INFO - PID 7564 | Values: 3843.3 3850.6 3857.7 3860.6 3867.9 6264.3 6264.7 6270.6 6293.0 6395.6 6285.4 6286.5 6298.9 6315.3 6329.8 5654.2 5669.5 5679.3 5761.0 5770.5 5774.3 5785.5 5800.1 5810.2 5845.4 103.2 5682.5 5738.1 5832.2 5837.1 5684.3 5699.4 5717.2 5778.3 5786.4 5692.1 5707.6 5758.8 5769.5 5786.8 6228.7 6274.8 6307.0 6386.2 6420.2 6861.8 6865.8 6949.7 6958.1 6968.5 6797.0 6877.6 6913.3 6931.8 7005.3 6322.0 6356.5 6376.9 6382.9 6396.7 6940.7 6950.8 7043.6 7045.1 7052.5 6657.5 6727.7 6730.4 6794.8 6810.2 6759.0 6882.5 6911.8 6978.3 6982.2 6776.9 6825.4 6842.2 6843.8 6852.8 6673.5 6804.0 6805.7 6902.6 6920.6 4879.4 4944.7 4956.7 4985.4 4989.4 4541.2 4556.3 4576.7 4621.2 4637.2 6276.7 6363.0 6364.6 6366.7 6369.7 6768.3 6893.0 6963.7 6968.0 6970.9 6083.6 6234.5 6259.6 6341.6 6351.6 5498.5 5599.0 5602.7 5617.1 5630.9 6934.7 6947.9 7050.0 7226.1 7258.4 6874.8 6882.1 6885.8 6886.8 6889.6 7033.9 7039.2 7072.0 7168.4 7181.6 6622.1 6740.8 6787.9 6799.4 6803.6 6927.3 6940.6 6955.9 6988.9 6989.0 6656.4 6662.3 6670.3 6744.1 6756.4 6499.5 6659.8 6662.4 6753.0 6765.6 6556.1 6566.8 6572.5 6576.2 6594.3 6555.1 6609.4 6665.0 6672.7 6721.6 6516.2 6529.1 6534.3 6594.7 6598.6 16:09:54 INFO - PID 7564 | 16:09:54 INFO - PID 7564 | [#1] ext.html Cycles:180 Average:42273.00 Median:3689.84 stddev:64808.42 (1756.4%) stddev-sans-first:64915.92 16:09:54 INFO - PID 7564 | Values: 941.2 969.7 993.0 996.3 997.4 43855.0 44325.3 44673.3 44751.0 44760.8 41813.6 44622.0 46061.3 46095.5 46178.0 8169.9 8278.4 8324.2 8327.2 8328.5 7970.6 8057.4 8086.6 8117.7 8129.5 8105.4 8143.4 8146.2 8149.7 8155.8 8082.9 8110.1 8116.0 8130.6 8151.3 7680.8 7701.7 7743.9 7748.4 7756.1 40611.6 40989.7 41012.0 41017.4 41031.0 3676.1 3703.5 3717.7 3719.0 3719.8 32529.5 32570.8 32660.0 33478.5 33636.7 5255.9 5442.8 5474.2 5478.6 5572.8 211298.0 216010.0 224131.0 230076.0 230750.0 53813.5 54201.2 54278.5 54468.7 54606.5 55671.4 55750.0 55921.0 55956.4 55961.0 15094.5 15133.2 15145.1 15156.8 15388.1 12304.3 12335.9 12374.0 12385.5 12387.3 14266.9 14378.4 14528.4 14710.6 14728.5 5331.9 5376.2 5387.2 5394.4 5485.4 1080.0 1096.1 1104.9 1107.6 1113.3 24914.5 25146.2 25412.7 25551.6 25588.6 1182.3 1186.1 1202.9 1210.2 1216.9 13172.8 13370.1 13426.7 13495.0 13512.5 282102.0 282489.0 282915.0 283597.0 284293.0 58474.7 58611.0 58826.1 58859.0 59030.7 1499.7 1506.1 1513.6 1516.2 1527.8 24466.8 24840.8 24877.3 24909.8 25027.9 36183.6 37423.1 37577.0 37651.0 37724.0 235311.0 237270.0 237387.0 237785.0 237816.0 33306.8 34010.0 34180.1 34347.1 37218.3 40996.0 41152.0 41375.4 41646.0 42001.2 34550.0 34653.8 34941.7 35060.6 35817.1 34476.1 34532.5 34661.0 34992.3 35159.6 38697.2 39702.0 39762.0 39851.2 39963.0 32566.3 32970.3 33112.7 33288.8 33777.8 25438.1 25477.7 25669.6 26209.5 26245.6 16:09:54 INFO - PID 7564 | 16:09:54 INFO - PID 7564 | [#2] jquery.html Cycles:180 Average:39205.19 Median:12610.12 stddev:101775.66 (807.1%) stddev-sans-first:102019.86 16:09:54 INFO - PID 7564 | Values: 586.3 593.3 593.7 595.4 598.9 22732.8 23404.8 23414.3 23452.2 23453.3 24917.5 25947.7 26081.6 26133.6 26254.6 6258.4 6423.8 6428.0 6441.9 6445.1 6313.9 6395.6 6418.6 6652.6 6672.3 6555.6 6582.6 6615.7 6619.0 6621.4 6262.2 6584.3 6585.5 6603.3 6608.5 6058.1 6078.9 6133.1 6134.8 6143.0 29057.0 29629.7 29670.7 29674.4 29731.4 2255.7 2283.3 2284.4 2284.5 2284.8 19995.4 20688.3 20717.0 20814.7 20842.6 2531.6 2554.5 2612.2 2613.3 2617.9 123371.0 128865.0 150633.0 158776.0 159361.0 15120.4 15717.7 15890.8 16122.7 16787.0 25176.2 25255.9 25331.2 25346.5 25364.7 9934.4 9969.1 10133.2 10182.2 10270.8 9217.5 9312.5 9324.7 9326.2 9357.1 9574.6 9683.3 9749.0 9885.4 9949.4 2859.8 2870.1 2915.2 2921.7 3020.6 1041.6 1052.6 1060.6 1063.0 1079.6 20350.3 20915.4 21075.0 21119.3 21362.3 1086.3 1094.3 1097.2 1105.4 1108.0 11489.5 11576.6 11643.2 11665.2 11668.4 596774.0 598561.0 602005.0 619064.0 632492.0 125503.0 127757.4 127821.4 127902.0 128695.0 1185.1 1211.3 1236.2 1238.6 1242.1 18382.8 18580.8 18590.4 18675.5 19081.3 60648.4 62209.7 62247.0 63405.0 64438.0 74571.0 74681.6 75297.6 76686.6 77780.6 14650.0 14981.3 15079.0 15086.6 15088.9 21087.3 22800.8 22935.4 22990.5 23010.7 17663.1 18979.9 19188.0 19414.4 19433.9 16916.4 16946.8 17177.9 17220.1 17722.5 19439.3 19473.3 19503.1 19699.8 19717.3 13993.8 14680.3 14723.4 14848.2 14896.9 18520.5 18580.6 18876.6 18894.4 18979.9 16:09:54 INFO - PID 7564 | 16:09:54 INFO - PID 7564 | [#3] mootools.html Cycles:180 Average:10419.20 Median:26136.10 stddev:7660.78 (29.3%) stddev-sans-first:7652.52 16:09:54 INFO - PID 7564 | Values: 1434.0 1451.6 1480.2 1494.5 1499.9 16222.4 16953.2 17033.3 17133.6 17150.7 16700.2 16742.4 16827.6 16898.5 16916.3 2857.5 2896.6 2953.5 2953.8 2957.0 2846.4 2867.3 2868.1 2868.5 2871.9 2807.0 2857.2 2905.1 2907.2 2908.1 2779.3 2827.9 2828.3 2828.4 2830.6 2807.7 2826.1 2833.5 2834.3 2843.7 15834.1 16104.5 16146.4 16287.0 16326.8 8201.8 8550.9 8558.6 8560.0 8560.2 5343.8 5453.2 5697.2 5713.0 5820.0 1928.1 1937.3 1940.5 1992.4 2010.2 26588.2 27359.6 27380.5 29003.9 30000.7 7604.5 7707.3 7709.7 7843.4 7853.8 22399.0 22475.3 22476.0 22482.1 22515.0 8704.8 8714.0 8826.5 8826.5 8833.6 7412.1 7781.5 7819.3 7823.1 7828.1 5697.4 5843.8 5856.2 5886.4 5979.8 1841.1 1859.3 1881.1 1888.7 1889.2 969.4 976.1 982.4 996.2 1003.4 8673.2 8724.7 8752.1 8764.0 8873.2 805.5 806.4 806.9 813.1 823.2 5112.5 5112.9 5210.9 5223.4 5242.8 24288.9 25485.7 25665.1 25681.6 25684.0 24460.6 24727.8 25012.9 25291.2 25369.5 10696.5 11043.0 11983.2 12119.0 12156.8 10122.3 10135.4 10166.6 10323.7 10507.4 20825.9 21709.2 21947.7 21956.8 22057.1 21022.0 21364.5 21877.3 21912.8 22306.1 13029.7 13064.7 13290.1 13292.2 13314.9 14798.0 15058.6 15065.8 15070.7 15078.1 12291.3 12369.1 12369.9 12397.3 12788.9 12091.9 12395.7 12453.1 12549.2 12896.8 10233.1 10238.3 10271.8 10283.7 10351.7 7785.2 8011.5 8019.0 8057.9 8140.0 8108.6 8131.1 8147.3 8180.6 8196.4 16:09:54 INFO - PID 7564 | 16:09:54 INFO - PID 7564 | [#4] prototype.html Cycles:180 Average:5663.94 Median:6284.10 stddev:1581.06 (25.2%) stddev-sans-first:1537.85 16:09:54 INFO - PID 7564 | Values: 531.8 552.9 555.7 557.4 571.3 6338.8 6343.4 6353.9 6354.6 6378.4 6281.7 6317.2 6327.3 6330.7 6331.9 5129.4 5183.3 5194.9 5200.3 5219.9 4901.0 5006.1 5180.1 5213.6 5214.1 4953.0 5021.4 5027.9 5044.7 5056.2 4980.4 5028.1 5033.9 5036.6 5038.8 4451.6 4523.8 4549.0 4553.2 4561.4 6096.5 6120.7 6176.6 6255.7 6281.9 5923.5 5930.2 5941.8 5956.6 5969.2 6699.8 6717.0 6738.5 6759.8 6789.1 5084.5 5085.1 5089.1 5091.4 5091.9 6773.7 6788.2 6929.9 6943.2 7007.4 5134.3 5168.0 5190.0 5199.0 5212.2 5245.2 5247.0 5250.0 5256.1 5287.9 5753.1 5836.1 5888.9 5890.5 5906.3 6764.3 6765.7 6769.7 6788.7 6795.4 1797.6 1825.0 1831.8 1838.6 1846.9 1230.4 1279.7 1294.6 1298.8 1304.7 6131.4 6148.9 6234.3 6237.5 6286.3 6601.3 6667.2 6874.4 6884.2 6889.0 6162.7 6202.2 6202.8 6209.4 6231.5 3485.7 3536.0 3560.7 3589.0 3614.2 6857.3 6924.3 6983.9 7004.8 7006.8 6838.4 6871.2 6871.2 6920.3 6954.2 6889.6 6899.7 6956.6 6984.8 7050.0 6616.2 6647.0 6745.4 6784.8 6803.8 6664.3 6680.9 6685.0 6735.2 6786.4 6972.5 7005.4 7021.5 7029.4 7048.2 5147.2 5165.9 5168.6 5172.7 5204.3 6646.2 6731.3 6816.4 6822.0 6837.3 6180.2 6509.0 6559.2 6574.7 6591.1 6548.6 6633.9 6635.9 6672.3 6683.6 6480.8 6511.8 6569.3 6581.7 6628.5 6577.9 6657.0 6725.6 6754.7 6765.9 6395.9 6464.6 6482.3 6509.9 6548.0 16:09:54 INFO - PID 7564 | 16:09:54 INFO - PID 7564 | [#5] yui.html Cycles:180 Average:27534.09 Median:18723.41 stddev:40615.15 (216.9%) stddev-sans-first:40680.12 16:09:54 INFO - PID 7564 | Values: 972.2 986.3 1002.6 1005.5 1009.4 17371.8 17968.7 17972.6 17978.9 17981.7 18283.9 18475.9 18718.8 18747.4 18779.6 1048.2 1052.6 1053.6 1055.3 1061.2 1048.6 1061.2 1062.0 1063.7 1065.6 1073.7 1111.0 1131.6 1147.8 1150.8 1135.9 1138.9 1140.1 1142.4 1142.8 793.5 812.5 820.0 820.3 824.7 18681.9 18792.6 18829.2 18845.9 18899.7 22986.3 23021.3 23488.9 23521.8 23638.4 18223.0 18479.4 18602.0 18628.7 18967.9 3972.5 4022.2 4027.8 4036.7 4036.8 127880.0 158424.0 158564.0 159584.0 162553.2 18706.5 18728.0 18995.2 19132.4 19133.9 34638.7 35036.1 35158.6 35645.8 35795.6 9239.9 9289.4 9310.9 9315.0 9336.1 4414.6 4436.4 4460.9 4542.1 4547.7 5724.7 5820.8 5827.1 5863.3 5871.1 1111.3 1144.7 1147.4 1150.5 1157.5 739.0 745.7 750.7 769.3 773.1 11605.9 12082.7 12134.8 13052.7 13378.1 704.7 708.6 710.9 726.1 726.5 6000.8 6100.5 6137.4 6198.1 6212.4 146534.0 148994.0 149611.0 152389.0 153765.0 98698.0 100563.0 118266.4 129695.0 136267.0 109326.5 112115.9 112568.4 112798.0 114408.0 12889.3 13123.3 13129.6 13199.6 13455.9 49957.5 51264.7 53227.5 53391.7 54545.0 66234.0 66908.0 68428.7 68924.0 69674.7 19443.2 19499.9 19515.0 19546.5 19743.5 19911.8 19916.9 19932.8 20137.6 20229.7 18307.4 18515.1 18777.5 18818.1 18829.4 18379.4 18600.2 18622.3 18730.8 18891.8 18203.5 18287.9 18393.5 18604.3 18609.5 13302.9 13371.5 13494.2 13629.7 13689.7 13613.5 13729.4 13815.9 13861.2 13966.4 16:09:54 INFO - PID 7564 | -------- Summary: end -------- 16:09:54 INFO - PID 7564 | 16:09:54 INFO - TEST-INFO | 7564: exit 0 16:09:54 INFO - TEST-OK | dromaeo_css | took 1107331ms 16:09:54 INFO - TEST-START | kraken 16:09:54 INFO - Initialising browser for kraken test... 16:09:54 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41891/getInfo.html -profile /tmp/tmp7dQ9A_/profile 16:09:54 INFO - TEST-INFO | started process 7932 (/builds/slave/test/build/application/firefox/firefox http://localhost:41891/getInfo.html) 16:10:00 INFO - TEST-INFO | 7932: exit 0 16:10:00 INFO - Browser initialized. 16:10:00 INFO - Running cycle 1/1 for kraken test... 16:10:00 INFO - Using env: {'DISPLAY': ':0', 16:10:00 INFO - 'HOME': '/home/cltbld', 16:10:00 INFO - 'JSGC_DISABLE_POISONING': '1', 16:10:00 INFO - 'LANG': 'en_US.UTF-8', 16:10:00 INFO - 'LANGUAGE': 'en_US:en', 16:10:00 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:10:00 INFO - 'LOGNAME': 'cltbld', 16:10:00 INFO - 'MAIL': '/var/mail/cltbld', 16:10:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:10:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:10:00 INFO - 'MOZ_CRASHREPORTER': '1', 16:10:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:00 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:10:00 INFO - 'MOZ_NO_REMOTE': '1', 16:10:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:10:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:00 INFO - 'NO_EM_RESTART': '1', 16:10:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:00 INFO - 'PWD': '/builds/slave/test', 16:10:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:10:00 INFO - 'RUST_BACKTRACE': 'full', 16:10:00 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:10:00 INFO - 'SHELL': '/bin/bash', 16:10:00 INFO - 'SHLVL': '1', 16:10:00 INFO - 'STYLO_FORCE_DISABLED': '1', 16:10:00 INFO - 'TERM': 'linux', 16:10:00 INFO - 'TMOUT': '86400', 16:10:00 INFO - 'USER': 'cltbld', 16:10:00 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505687706.741790-1390120011', 16:10:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:00 INFO - '_': '/tools/buildbot/bin/python'} 16:10:00 INFO - TEST-INFO | started process 8165 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7dQ9A_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:10:01 INFO - PID 8165 | 16:10:01 INFO - PID 8165 | (/builds/slave/test/build/application/firefox/firefox:8214): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:10:01 INFO - PID 8165 | 16:10:11 INFO - PID 8165 | RSS: Main: 147390464 16:10:11 INFO - PID 8165 | 16:10:14 INFO - PID 8165 | Cycle 1(1): loaded http://localhost:41891/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41891/tests/kraken/driver.html?testName=audio-beat-detection) 16:10:15 INFO - PID 8165 | RSS: Main: 154247168 16:10:15 INFO - PID 8165 | 16:10:17 INFO - PID 8165 | Cycle 1(1): loaded http://localhost:41891/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41891/tests/kraken/driver.html?testName=audio-dft) 16:10:18 INFO - PID 8165 | RSS: Main: 154324992 16:10:18 INFO - PID 8165 | 16:10:21 INFO - PID 8165 | Cycle 1(1): loaded http://localhost:41891/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41891/tests/kraken/driver.html?testName=audio-fft) 16:10:21 INFO - PID 8165 | RSS: Main: 149446656 16:10:21 INFO - PID 8165 | 16:10:23 INFO - PID 8165 | Cycle 1(1): loaded http://localhost:41891/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41891/tests/kraken/driver.html?testName=audio-oscillator) 16:10:24 INFO - PID 8165 | RSS: Main: 150839296 16:10:24 INFO - PID 8165 | 16:10:26 INFO - PID 8165 | Cycle 1(1): loaded http://localhost:41891/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41891/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:10:26 INFO - PID 8165 | RSS: Main: 150724608 16:10:26 INFO - PID 8165 | 16:10:29 INFO - PID 8165 | Cycle 1(1): loaded http://localhost:41891/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41891/tests/kraken/driver.html?testName=imaging-darkroom) 16:10:30 INFO - PID 8165 | RSS: Main: 150859776 16:10:30 INFO - PID 8165 | 16:10:34 INFO - PID 8165 | Cycle 1(1): loaded http://localhost:41891/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41891/tests/kraken/driver.html?testName=imaging-desaturate) 16:10:34 INFO - PID 8165 | RSS: Main: 152694784 16:10:34 INFO - PID 8165 | 16:10:37 INFO - PID 8165 | Cycle 1(1): loaded http://localhost:41891/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41891/tests/kraken/driver.html?testName=json-parse-financial) 16:10:38 INFO - PID 8165 | RSS: Main: 153960448 16:10:38 INFO - PID 8165 | 16:10:39 INFO - PID 8165 | Cycle 1(1): loaded http://localhost:41891/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41891/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:10:40 INFO - PID 8165 | RSS: Main: 153808896 16:10:40 INFO - PID 8165 | 16:10:41 INFO - PID 8165 | Cycle 1(1): loaded http://localhost:41891/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41891/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:10:42 INFO - PID 8165 | RSS: Main: 153608192 16:10:42 INFO - PID 8165 | 16:10:44 INFO - PID 8165 | Cycle 1(1): loaded http://localhost:41891/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41891/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:10:45 INFO - PID 8165 | RSS: Main: 150343680 16:10:45 INFO - PID 8165 | 16:10:47 INFO - PID 8165 | Cycle 1(1): loaded http://localhost:41891/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41891/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:10:48 INFO - PID 8165 | RSS: Main: 150749184 16:10:48 INFO - PID 8165 | 16:10:50 INFO - PID 8165 | Cycle 1(1): loaded http://localhost:41891/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41891/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:10:51 INFO - PID 8165 | RSS: Main: 151031808 16:10:51 INFO - PID 8165 | 16:10:53 INFO - PID 8165 | Cycle 1(1): loaded http://localhost:41891/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41891/tests/kraken/driver.html?testName=ai-astar) 16:10:53 INFO - PID 8165 | RSS: Main: 152936448 16:10:53 INFO - PID 8165 | 16:10:53 INFO - PID 8165 | __start_tp_report 16:10:53 INFO - PID 8165 | _x_x_mozilla_page_load 16:10:53 INFO - PID 8165 | _x_x_mozilla_page_load_details 16:10:53 INFO - PID 8165 | |i|pagename|runs| 16:10:53 INFO - PID 8165 | |0;ai-astar;105;108;104;105;105;108;106;106;106;107 16:10:53 INFO - PID 8165 | |1;audio-beat-detection;112;112;111;111;110;111;109;137;113;113 16:10:53 INFO - PID 8165 | |2;audio-dft;162;161;162;160;161;161;160;162;162;170 16:10:53 INFO - PID 8165 | |3;audio-fft;73;73;73;72;75;75;73;74;72;73 16:10:53 INFO - PID 8165 | |4;audio-oscillator;79;78;78;77;77;78;78;81;77;77 16:10:53 INFO - PID 8165 | |5;imaging-gaussian-blur;114;115;113;114;113;114;114;114;113;114 16:10:53 INFO - PID 8165 | |6;imaging-darkroom;151;149;148;154;149;149;149;152;150;150 16:10:53 INFO - PID 8165 | |7;imaging-desaturate;93;94;94;93;94;93;95;94;95;94 16:10:53 INFO - PID 8165 | |8;json-parse-financial;43;44;42;44;48;44;45;42;42;42 16:10:53 INFO - PID 8165 | |9;json-stringify-tinderbox;39;42;38;38;38;39;39;38;38;39 16:10:53 INFO - PID 8165 | |10;stanford-crypto-aes;73;72;70;72;75;73;73;73;74;73 16:10:53 INFO - PID 8165 | |11;stanford-crypto-ccm;113;117;106;111;109;105;117;107;109;108 16:10:53 INFO - PID 8165 | |12;stanford-crypto-pbkdf2;153;153;151;152;165;151;157;153;155;152 16:10:53 INFO - PID 8165 | |13;stanford-crypto-sha256-iterative;62;59;60;60;62;59;59;67;64;62 16:10:53 INFO - PID 8165 | __end_tp_report 16:10:53 INFO - PID 8165 | __start_cc_report 16:10:53 INFO - PID 8165 | _x_x_mozilla_cycle_collect,715 16:10:53 INFO - PID 8165 | __end_cc_report 16:10:53 INFO - PID 8165 | __startTimestamp1505689853472__endTimestamp 16:10:53 INFO - PID 8165 | 16:10:53 INFO - PID 8165 | ------- Summary: start ------- 16:10:53 INFO - PID 8165 | Number of tests: 14 16:10:53 INFO - PID 8165 | 16:10:53 INFO - PID 8165 | [#0] ai-astar Cycles:10 Average:106.00 Median:106.00 stddev:1.33 (1.3%) stddev-sans-first:1.36 16:10:53 INFO - PID 8165 | Values: 105.0 108.0 104.0 105.0 105.0 108.0 106.0 106.0 106.0 107.0 16:10:53 INFO - PID 8165 | 16:10:53 INFO - PID 8165 | [#1] audio-beat-detection Cycles:10 Average:113.90 Median:112.00 stddev:8.21 (7.3%) stddev-sans-first:8.68 16:10:53 INFO - PID 8165 | Values: 112.0 112.0 111.0 111.0 110.0 111.0 109.0 137.0 113.0 113.0 16:10:53 INFO - PID 8165 | 16:10:53 INFO - PID 8165 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:2.88 (1.8%) stddev-sans-first:3.06 16:10:53 INFO - PID 8165 | Values: 162.0 161.0 162.0 160.0 161.0 161.0 160.0 162.0 162.0 170.0 16:10:53 INFO - PID 8165 | 16:10:53 INFO - PID 8165 | [#3] audio-fft Cycles:10 Average:73.30 Median:73.00 stddev:1.06 (1.5%) stddev-sans-first:1.12 16:10:53 INFO - PID 8165 | Values: 73.0 73.0 73.0 72.0 75.0 75.0 73.0 74.0 72.0 73.0 16:10:53 INFO - PID 8165 | 16:10:53 INFO - PID 8165 | [#4] audio-oscillator Cycles:10 Average:78.00 Median:78.00 stddev:1.25 (1.6%) stddev-sans-first:1.27 16:10:53 INFO - PID 8165 | Values: 79.0 78.0 78.0 77.0 77.0 78.0 78.0 81.0 77.0 77.0 16:10:53 INFO - PID 8165 | 16:10:53 INFO - PID 8165 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 16:10:53 INFO - PID 8165 | Values: 114.0 115.0 113.0 114.0 113.0 114.0 114.0 114.0 113.0 114.0 16:10:53 INFO - PID 8165 | 16:10:53 INFO - PID 8165 | [#6] imaging-darkroom Cycles:10 Average:150.10 Median:150.00 stddev:1.79 (1.2%) stddev-sans-first:1.87 16:10:53 INFO - PID 8165 | Values: 151.0 149.0 148.0 154.0 149.0 149.0 149.0 152.0 150.0 150.0 16:10:53 INFO - PID 8165 | 16:10:53 INFO - PID 8165 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 16:10:53 INFO - PID 8165 | Values: 93.0 94.0 94.0 93.0 94.0 93.0 95.0 94.0 95.0 94.0 16:10:53 INFO - PID 8165 | 16:10:53 INFO - PID 8165 | [#8] json-parse-financial Cycles:10 Average:43.60 Median:44.00 stddev:1.90 (4.3%) stddev-sans-first:2.00 16:10:53 INFO - PID 8165 | Values: 43.0 44.0 42.0 44.0 48.0 44.0 45.0 42.0 42.0 42.0 16:10:53 INFO - PID 8165 | 16:10:53 INFO - PID 8165 | [#9] json-stringify-tinderbox Cycles:10 Average:38.80 Median:39.00 stddev:1.23 (3.2%) stddev-sans-first:1.30 16:10:53 INFO - PID 8165 | Values: 39.0 42.0 38.0 38.0 38.0 39.0 39.0 38.0 38.0 39.0 16:10:53 INFO - PID 8165 | 16:10:53 INFO - PID 8165 | [#10] stanford-crypto-aes Cycles:10 Average:72.80 Median:73.00 stddev:1.32 (1.8%) stddev-sans-first:1.39 16:10:53 INFO - PID 8165 | Values: 73.0 72.0 70.0 72.0 75.0 73.0 73.0 73.0 74.0 73.0 16:10:53 INFO - PID 8165 | 16:10:53 INFO - PID 8165 | [#11] stanford-crypto-ccm Cycles:10 Average:110.20 Median:110.00 stddev:4.26 (3.9%) stddev-sans-first:4.40 16:10:53 INFO - PID 8165 | Values: 113.0 117.0 106.0 111.0 109.0 105.0 117.0 107.0 109.0 108.0 16:10:53 INFO - PID 8165 | 16:10:53 INFO - PID 8165 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.20 Median:153.00 stddev:4.21 (2.8%) stddev-sans-first:4.44 16:10:53 INFO - PID 8165 | Values: 153.0 153.0 151.0 152.0 165.0 151.0 157.0 153.0 155.0 152.0 16:10:53 INFO - PID 8165 | 16:10:53 INFO - PID 8165 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.40 Median:62.00 stddev:2.59 (4.2%) stddev-sans-first:2.74 16:10:53 INFO - PID 8165 | Values: 62.0 59.0 60.0 60.0 62.0 59.0 59.0 67.0 64.0 62.0 16:10:53 INFO - PID 8165 | -------- Summary: end -------- 16:10:53 INFO - PID 8165 | 16:10:53 INFO - PID 8165 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:10:54 INFO - TEST-INFO | 8165: exit 0 16:10:54 INFO - TEST-OK | kraken | took 59299ms 16:10:54 INFO - SUITE-END | took 1166s 16:10:54 INFO - Completed test suite (00:19:27) 16:10:54 INFO - javascript benchmark 16:10:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9006.297474392464, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3843.3274177019034, 3850.5764365919745, 3857.6720978716808, 3860.613938606139, 3867.9419808702855, 6264.342244064376, 6264.718087686065, 6270.623762574237, 6293.0, 6395.616263024222, 6285.371462853713, 6286.465650419708, 6298.874022519558, 6315.305316415191, 6329.77845775398, 5654.208410822488, 5669.546436285098, 5679.290088738908, 5761.0, 5770.480656740892, 5774.2782152230975, 5785.479306862381, 5800.129980502916, 5810.1865738796605, 5845.357010728816, 103.2154653196036, 5682.54539636828, 5738.081906894877, 5832.154337621042, 5837.066069428871, 5684.261046063985, 5699.430056994309, 5717.199592057115, 5778.3066032076, 5786.363500014995, 5692.089265717506, 5707.571932105108, 5758.79844205455, 5769.538436925036, 5786.797462088806, 6228.657423841687, 6274.811755647338, 6306.968465157691, 6386.16979792624, 6420.165378500812, 6861.759838405632, 6865.759698410581, 6949.652517374162, 6958.130233720785, 6968.547044442095, 6797.0, 6877.6217308048035, 6913.343232392915, 6931.757388491378, 7005.334493223136, 6322.0, 6356.523260755415, 6376.904346434807, 6382.904256436157, 6396.712147953307, 6940.687669054904, 6950.791476255619, 7043.612601306977, 7045.11936007999, 7052.541584796972, 6657.500687448461, 6727.730890764315, 6730.394264516119, 6794.762183323659, 6810.216825065082, 6758.966205169041, 6882.483813713991, 6911.7926462206215, 6978.337057979484, 6982.197047339621, 6776.9322306777285, 6825.35159159879, 6842.178938527409, 6843.7604683835825, 6852.794416167523, 6673.466122710269, 6804.0, 6805.693743781541, 6902.585844849325, 6920.550164239308, 4879.414470263591, 4944.653874228841, 4956.727379994063, 4985.351904252424, 4989.351384320015, 4541.227991241497, 4556.3393307970155, 4576.679632425698, 4621.19129152397, 4637.211674015425, 6276.686165691697, 6363.045543168561, 6364.6181229126405, 6366.681665916778, 6369.71336289868, 6768.255491895888, 6892.965535172392, 6963.721451141999, 6967.965160174167, 6970.860582788316, 6083.6045657032155, 6234.470070044006, 6259.561830671809, 6341.619502829845, 6351.587146835441, 5498.477644623755, 5599.0, 5602.663840169603, 5617.073182924772, 5630.859228519238, 6934.687939042755, 6947.949878762964, 7049.9647501762165, 7226.132864056347, 7258.419326453871, 6874.759383421556, 6882.139732533434, 6885.793426197222, 6886.827829304308, 6889.621070841152, 7033.9296607033275, 7039.19049309336, 7072.009918611501, 7168.390686791473, 7181.640917954186, 6622.10601568782, 6740.797776066725, 6787.864242715019, 6799.354061364163, 6803.557768745016, 6927.272636373108, 6940.646573918038, 6955.860882782417, 6988.8951665724035, 6989.0, 6656.400923916871, 6662.300458451793, 6670.266270710121, 6744.0895479109695, 6756.358145976124, 6499.5125365598715, 6659.800205993828, 6662.367075127855, 6752.966235168793, 6765.627890466071, 6556.082148499309, 6566.8358291043105, 6572.539922205399, 6576.177977752781, 6594.274629790815, 6555.115059467102, 6609.405153536205, 6664.966675166593, 6672.666366681744, 6721.596704197764, 6516.185476815398, 6529.085927969993, 6534.281229064704, 6594.736210551524, 6598.571092878948], "value": 6228.531372019284, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [941.2187884056234, 969.6557722008687, 993.0317940008488, 996.2776986684654, 997.416511340866, 43855.0, 44325.33511997323, 44673.32990005148, 44751.0, 44760.77619611901, 41813.581864181346, 44622.0, 46061.30908036374, 46095.53904460954, 46178.0, 8169.918300817005, 8278.379121565877, 8324.209200125979, 8327.208915153082, 8328.458650187718, 7970.561619110947, 8057.3554115670895, 8086.636101375423, 8117.675292988273, 8129.4715843469985, 8105.351571874236, 8143.429959902809, 8146.226108519711, 8149.714759983402, 8155.755327340189, 8082.9492166018335, 8110.067342255657, 8115.95942020292, 8130.55281959492, 8151.307138893201, 7680.769576912701, 7701.6919323227, 7743.9225607743765, 7748.380129589619, 7756.108047574545, 40611.593884061076, 40989.745563994264, 41012.0, 41017.38473922894, 41031.0, 3676.1361080146144, 3703.53705786774, 3717.7211709121652, 3719.033051406627, 3719.75821571597, 32529.51205731916, 32570.83714581412, 32660.0, 33478.497822532685, 33636.663633363845, 5255.894882102375, 5442.836714898559, 5474.233607294982, 5478.58910581708, 5572.832815015556, 211298.0, 216010.0, 224130.99999999837, 230076.0, 230750.0, 53813.46186538163, 54201.1869821953, 54278.45721542813, 54468.72765636226, 54606.45393546093, 55671.443285566624, 55750.0, 55921.0, 55956.44043559513, 55961.0, 15094.471693490676, 15133.167675777939, 15145.091294522364, 15156.772648410282, 15388.076715397112, 12304.323262220663, 12335.93832030852, 12374.0, 12385.504579816887, 12387.256764594153, 14266.928665356814, 14378.35297411619, 14528.418863245352, 14710.55868323952, 14728.481309109857, 5331.893362132736, 5376.247325374451, 5387.164989426645, 5394.352677678625, 5485.396606373296, 1079.956801727922, 1096.0792933935531, 1104.9116070714324, 1107.6012635451232, 1113.3375641493299, 24914.501709965698, 25146.24561263165, 25412.74587254104, 25551.61672574913, 25588.616170757454, 1182.3319824299415, 1186.145974898072, 1202.8616709078392, 1210.2315029956042, 1216.9330686812311, 13172.802407963889, 13370.064095513415, 13426.718650938177, 13495.0, 13512.527061552799, 282102.0, 282489.0, 282915.0, 283597.0, 284293.0, 58474.7076264616, 58611.0, 58826.11760823591, 58859.0, 59030.70484647635, 1499.730048591264, 1506.0737646347636, 1513.5761986643756, 1516.1736853414916, 1527.7784721215362, 24466.75533244716, 24840.75159248457, 24877.253682389557, 24909.75090249147, 25027.87486062558, 36183.63816361803, 37423.06442338963, 37577.0, 37651.0, 37724.0, 235311.0, 237270.0, 237387.0, 237785.0, 237816.0, 33306.83346583252, 34009.97970060902, 34180.14549636279, 34347.14132146716, 37218.255634886606, 40996.0, 41152.0, 41375.37936931009, 41646.0, 42001.159976800904, 34550.0, 34653.82673086618, 34941.650583493836, 35060.64939350574, 35817.10457238486, 34476.13809654779, 34532.482012769324, 34661.0, 34992.30015399729, 35159.64840351666, 38697.22605547817, 39702.0, 39762.0, 39851.2029759409, 39963.0, 32566.34867302688, 32970.340593187524, 33112.668873310955, 33288.83355583207, 33777.83111084429, 25438.109666162334, 25477.74522254754, 25669.614955775305, 26209.4758104833, 26245.606315905658], "value": 18270.95003696995, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.3462239602843, 593.2765316754828, 593.6942474625567, 595.365935278928, 598.9281286245648, 22732.77267227329, 23404.765952340473, 23414.297571072893, 23452.179173728902, 23453.296401107953, 24917.50164996699, 25947.74052259477, 26081.608775868328, 26133.60799588003, 26254.6061809073, 6258.405451482102, 6423.839404014913, 6428.0, 6441.903371449409, 6445.129907462503, 6313.905291420632, 6395.616263024233, 6418.614883107029, 6652.567583107107, 6672.266050734415, 6555.606663600175, 6582.637954912478, 6615.702293396785, 6619.040239165318, 6621.370969757865, 6262.2172228471445, 6584.341565843377, 6585.539012269143, 6603.273639899608, 6608.471322294205, 6058.1215723719815, 6078.939210607881, 6133.1413602095745, 6134.754609815602, 6143.017117261262, 29057.0, 29629.70370296291, 29670.70329296701, 29674.406511869856, 29731.40537189244, 2255.650374192003, 2283.303592404316, 2284.4288927768057, 2284.4745708486976, 2284.805791507724, 19995.400137995737, 20688.275910343214, 20717.0, 20814.687779683318, 20842.5831483371, 2531.5696331623667, 2554.463562651845, 2612.164107485605, 2613.281347629398, 2617.869106544665, 123371.0, 128865.0, 150633.0, 158775.99999999884, 159361.0, 15120.388281574225, 15717.685646287011, 15890.76163857543, 16122.67754644924, 16787.0, 25176.24471265865, 25255.87372063128, 25331.240062798144, 25346.493070138495, 25364.746352536607, 9934.403935763878, 9969.102780749767, 10133.189344852393, 10182.23633227496, 10270.794584108276, 9217.539123043955, 9312.487813170204, 9324.720258392259, 9326.160645541933, 9357.111074447917, 9574.590012806699, 9683.273754468442, 9748.976357482505, 9885.406875587487, 9949.353292035994, 2859.828410295389, 2870.1246119933203, 2915.2420370703344, 2921.6786153523094, 3020.622422197225, 1041.6198087697935, 1052.5737076484036, 1060.6446840308429, 1062.9946850265699, 1079.5627770752858, 20350.28773992903, 20915.37253882386, 21075.0, 21119.26082587102, 21362.252321168686, 1086.266769930294, 1094.2559059839386, 1097.1825989637612, 1105.38098664748, 1107.9778404432027, 11489.54041838317, 11576.594819181288, 11643.243189192845, 11665.24175928579, 11668.358240296695, 596774.0, 598561.0143898593, 602004.9799502037, 619064.0, 632492.0, 125503.0, 127757.36121319333, 127821.3608931968, 127902.0, 128695.0, 1185.1170877696172, 1211.2853416484318, 1236.1841184818156, 1238.5726924211133, 1242.105683907585, 18382.81617183811, 18580.814191858448, 18590.44228673142, 18675.533111672317, 19081.332153374566, 60648.39351606427, 62209.68895155676, 62247.0, 63405.0, 64438.0, 74571.0, 74681.62659186669, 75297.62351188209, 76686.61656691681, 77780.61109694415, 14650.0, 14981.250937452865, 15079.0, 15086.622834428788, 15088.924555377153, 21087.261945831822, 22800.771992279864, 22935.42661433411, 22990.540189195788, 23010.654840177747, 17663.116844157485, 18979.90510047441, 19188.040597970325, 19414.417567473, 19433.931133787777, 16916.447546015475, 16946.830531694526, 17177.914110429367, 17220.138993050547, 17722.46832595024, 19439.3196238131, 19473.318433854747, 19503.122359493573, 19699.80300197037, 19717.30989415421, 13993.790093148407, 14680.265986700835, 14723.411063557338, 14848.183349915858, 14896.85103148998, 18520.536986575444, 18580.628387432447, 18876.622467550296, 18894.433167005012, 18979.90510047441], "value": 12501.18596722749, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1433.956981290561, 1451.637090727318, 1480.1637075052595, 1494.4545240987043, 1499.8650121489063, 16222.351105955748, 16953.23710433032, 17033.318667253312, 17133.571660708487, 17150.742738858928, 16700.248488818, 16742.41401550946, 16827.579310517212, 16898.493045208663, 16916.323347066103, 2857.5427931530958, 2896.56551517272, 2953.4683756923746, 2953.822770633758, 2957.0, 2846.4307138572267, 2867.25451382641, 2868.0965495868736, 2868.4549935512186, 2871.856407179643, 2806.957895631567, 2857.22854829196, 2905.128461461564, 2907.1569244919056, 2908.0548821632947, 2779.3051737065734, 2827.9010234641687, 2828.250513613894, 2828.4343131373703, 2830.561263004238, 2807.7192280771965, 2826.0956493921954, 2833.489971805074, 2834.2772592988654, 2843.7156284371604, 15834.129122898235, 16104.516864494084, 16146.354145834153, 16287.0, 16326.75509867353, 8201.753947381589, 8550.914490855137, 8558.614862331147, 8560.0, 8560.186782255676, 5343.839684809462, 5453.15476101201, 5697.1739097831, 5713.028785106542, 5820.0, 1928.1034319041573, 1937.321937321926, 1940.5439721665398, 1992.3524854422371, 2010.2461576908659, 26588.202353929413, 27359.589606155925, 27380.45239095207, 29003.854980725173, 30000.69999300001, 7604.505707129019, 7707.34487568563, 7709.6530656119485, 7843.4117441191, 7853.842923141619, 22399.0, 22475.325740227818, 22476.0, 22482.100715971177, 22515.0, 8704.825903481895, 8713.954325480983, 8826.51454170014, 8826.51454170014, 8833.60248788806, 7412.1476030256135, 7781.455298129076, 7819.257170568787, 7823.139454659983, 7828.060632723996, 5697.4302569742695, 5843.795467158714, 5856.180134781134, 5886.411358864165, 5979.790707325223, 1841.0886611127578, 1859.3213477080767, 1881.0876724788466, 1888.6694828404975, 1889.2065332560358, 969.3747532841278, 976.1312431935582, 982.4105536677936, 996.1731762636994, 1003.3628645809817, 8673.219410253107, 8724.651013959498, 8752.124787521325, 8764.0, 8873.245774109273, 805.4804651000072, 806.3871457692079, 806.8628333183373, 813.113706060397, 823.2097186700714, 5112.539871411591, 5112.923306150411, 5210.947890521122, 5223.425423203445, 5242.816501422432, 24288.87855560746, 25485.74514254871, 25665.10172143966, 25681.614775778376, 25684.0, 24460.633090503656, 24727.752722472906, 25012.874935625205, 25291.241262762145, 25369.492610148063, 10696.51865666047, 11043.0, 11983.221090629255, 12119.030477561773, 12156.756864862653, 10122.291439599452, 10135.442550659785, 10166.593336266467, 10323.741906452398, 10507.369557826554, 20825.89587052055, 21709.15472184882, 21947.670784938557, 21956.78043219547, 22057.11771529121, 21022.0, 21364.465888352915, 21877.343679689635, 21912.78087219171, 22306.10775568959, 13029.674258143623, 13064.738705226033, 13290.136141150795, 13292.20246785196, 13314.86685133175, 14798.0, 15058.623534411288, 15065.774013390028, 15070.698586028437, 15078.095314281178, 12291.32397718134, 12369.134160608672, 12369.876301237233, 12397.318147501974, 12788.936055319664, 12091.879081209427, 12395.690107747378, 12453.128281020241, 12549.184303020274, 12896.8065479016, 10233.130183934449, 10238.33450825694, 10271.84592231132, 10283.742906427398, 10351.741206469898, 7785.221477852396, 8011.519308841488, 8018.957535520345, 8057.919420805717, 8140.0, 8108.594570271581, 8131.146229646039, 8147.348212142896, 8180.550069746221, 8196.385271104571], "value": 7294.657522410732, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [531.8138651471983, 552.9032419326617, 555.7499125393574, 557.436988641472, 571.3486625247216, 6338.841528961767, 6343.42909138178, 6353.904691429632, 6354.555181137316, 6378.4486205517815, 6281.748730050793, 6317.210348706411, 6327.303996560375, 6330.746770129189, 6331.873362532747, 5129.410117836459, 5183.2743415921805, 5194.948050519493, 5200.297959775438, 5219.9478005220035, 4900.99059385652, 5006.148954677714, 5180.11937970544, 5213.556847667953, 5214.06146893559, 4952.950470495303, 5021.397432308128, 5027.944131732341, 5044.672096313746, 5056.165732654126, 4980.431164183271, 5028.120078986181, 5033.92252275656, 5036.647434679574, 5038.823641172541, 4451.643868490513, 4523.84166554169, 4549.0, 4553.225951588238, 4561.40701708779, 6096.536831160533, 6120.693965301762, 6176.567640265183, 6255.71757789652, 6281.937180628181, 5923.496502797268, 5930.229070220887, 5941.762329506814, 5956.612820166719, 5969.224000879901, 6699.76550820719, 6717.026031225445, 6738.460923126138, 6759.797206083826, 6789.1174147360525, 5084.516970887797, 5085.1355269604255, 5089.05852417304, 5091.414487333967, 5091.872703182413, 6773.72905083796, 6788.2193547742145, 6929.896051559231, 6943.201531823855, 7007.4394048476, 5134.2812006319145, 5168.0, 5189.987952349331, 5199.0, 5212.166053431432, 5245.160774276097, 5246.97376513115, 5249.973750131301, 5256.106461901486, 5287.947120528823, 5753.137029445533, 5836.095405212199, 5888.941110588839, 5890.528757699374, 5906.3207731110615, 6764.323567643196, 6765.695543700545, 6769.695363708645, 6788.694508747119, 6795.422389096982, 1797.5506123469133, 1824.9817501825078, 1831.789344225431, 1838.6230822681318, 1846.8707190496805, 1230.446299165379, 1279.7248591552861, 1294.566320282697, 1298.7921932490756, 1304.6673098359859, 6131.386861313833, 6148.862460444832, 6234.3453937336835, 6237.500999919996, 6286.271275399302, 6601.306862779339, 6667.233268174222, 6874.415674667609, 6884.208316043719, 6888.965555172293, 6162.7226774795245, 6202.224721909762, 6202.844928876814, 6209.379062093845, 6231.501479881598, 3485.686288234071, 3535.964640353615, 3560.732945029133, 3589.0, 3614.204874927512, 6857.27998560154, 6924.3421874921805, 6983.93016069843, 7004.824879378057, 7006.814956931834, 6838.384545390839, 6871.209810871814, 6871.244163142051, 6920.342567456084, 6954.165500140016, 6889.552179108242, 6899.724011039502, 6956.617386043817, 6984.825379365557, 7050.0, 6616.172978377703, 6647.0, 6745.392914637706, 6784.76253331131, 6803.7618683345845, 6664.300248473841, 6680.899786503109, 6684.966575167093, 6735.158105236846, 6786.423154031962, 6972.477064220102, 7005.369516743517, 7021.543599666005, 7029.437644988491, 7048.189458212166, 5147.2279158126585, 5165.874645839363, 5168.560672342743, 5172.689638621695, 5204.2714020036465, 6646.202455705346, 6731.259561448334, 6816.386525212754, 6821.965890170517, 6837.282085381163, 6180.227471566054, 6509.0, 6559.212894452697, 6574.671266436755, 6591.143151390289, 6548.639824809491, 6633.9336606633315, 6635.9004614929845, 6672.299408562031, 6683.565568238049, 6480.805575832733, 6511.804645860631, 6569.277379488157, 6581.6709164540625, 6628.469722422291, 6577.868442631025, 6656.966715166393, 6725.596464212163, 6754.729810807709, 6765.864682706417, 6395.93604063972, 6464.5798023128345, 6482.254540727877, 6509.934900650933, 6547.9672601636685], "value": 5205.723657258856, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [972.2027937091583, 986.3145114145667, 1002.5989604158339, 1005.4671024357089, 1009.4347165587276, 17371.82628173718, 17968.73046904294, 17972.550686232833, 17978.910105449486, 17981.730274045884, 18283.90858045708, 18475.907620461912, 18718.812811871878, 18747.437576872682, 18779.62440751184, 1048.1719441641094, 1052.6368402900987, 1053.5891002509009, 1055.2929537210089, 1061.1669839176247, 1048.5910494906993, 1061.2306078093359, 1062.0335494699787, 1063.6702622187108, 1065.6270305393127, 1073.6993641780275, 1110.9777804443906, 1131.564347726123, 1147.810611249143, 1150.8158694608865, 1135.9034482069035, 1138.925969811968, 1140.0936255676716, 1142.3774043146504, 1142.8114361130404, 793.5199204481263, 812.4921923797626, 819.9672013119468, 820.2740574591529, 824.6701319472199, 18681.906590467097, 18792.624147516974, 18829.152688129067, 18845.905770471196, 18899.716504252447, 22986.310410687707, 23021.309360719206, 23488.882555587283, 23521.76478235213, 23638.40903977397, 18223.0, 18479.44561663152, 18602.0, 18628.72056919147, 18967.90516047425, 3972.543157536891, 4022.155347377054, 4027.818748156311, 4036.6972477064046, 4036.8183431745642, 127880.0, 158424.0, 158563.99999999884, 159584.0, 162553.18723406424, 18706.532336691693, 18728.0, 18995.24019039223, 19132.426027219204, 19133.904330478257, 34638.653613463546, 35036.12409689778, 35158.64841351554, 35645.82177089098, 35795.64204357923, 9239.861402078974, 9289.442633442015, 9310.86033709495, 9315.0, 9336.11306925841, 4414.558544145624, 4436.3567282743825, 4460.8661740147845, 4542.136993971201, 4547.658925580595, 5724.713764311768, 5820.835832833451, 5827.067669172912, 5863.296404431496, 5871.148683440877, 1111.3276467737064, 1144.6852115668257, 1147.3861484105964, 1150.5340337163461, 1157.450211149714, 738.9704411823467, 745.6868115391549, 750.7072241825583, 769.3076231391792, 773.122505955733, 11605.941970290094, 12082.69793255158, 12134.817977730341, 13052.738945221043, 13378.13042152257, 704.7145905908116, 708.596100222868, 710.8578284343153, 726.0887586079436, 726.5350175887436, 6000.849978750479, 6100.54245931548, 6137.447629713347, 6198.132261483396, 6212.378762123842, 146534.0, 148994.0, 149611.0, 152389.0, 153765.0, 98698.0, 100563.0, 118266.40866795783, 129695.0, 136267.0, 109326.45336773424, 112115.87884121218, 112568.43715781532, 112798.0, 114408.0, 12889.291088990196, 13123.278219697626, 13129.60611181666, 13199.604011879659, 13455.86544134546, 49957.50042499528, 51264.74367628138, 53227.4677253238, 53391.73304133455, 54545.0, 66234.0, 66908.0, 68428.6578567104, 68924.0, 69674.65162674154, 19443.222271108996, 19499.902500487973, 19515.0, 19546.51133721668, 19743.506412339808, 19911.800881990996, 19916.90041549783, 19932.800671993093, 20137.59724805525, 20229.6965545514, 18307.35924242645, 18515.074246287902, 18777.530561736065, 18818.059097045367, 18829.435116946515, 18379.356722514647, 18600.16299266563, 18622.255109795457, 18730.812691872907, 18891.811081889555, 18203.45389638313, 18287.90272583649, 18393.540161495534, 18604.2558297672, 18609.53476163107, 13302.93348533251, 13371.465141394236, 13494.190348578724, 13629.727405452033, 13689.657758556115, 13613.455461781417, 13729.382177802223, 13815.86184138186, 13861.168329900238, 13966.37151328213], "value": 9877.97388757539, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1372.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 108.0, 104.0, 105.0, 105.0, 108.0, 106.0, 106.0, 106.0, 107.0], "value": 106.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 111.0, 111.0, 110.0, 111.0, 109.0, 137.0, 113.0, 113.0], "value": 113.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 160.0, 161.0, 161.0, 160.0, 162.0, 162.0, 170.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 72.0, 75.0, 75.0, 73.0, 74.0, 72.0, 73.0], "value": 73.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 78.0, 77.0, 77.0, 78.0, 78.0, 81.0, 77.0, 77.0], "value": 78.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 113.0, 114.0, 113.0, 114.0, 114.0, 114.0, 113.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 149.0, 148.0, 154.0, 149.0, 149.0, 149.0, 152.0, 150.0, 150.0], "value": 150.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 93.0, 94.0, 93.0, 95.0, 94.0, 95.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [43.0, 44.0, 42.0, 44.0, 48.0, 44.0, 45.0, 42.0, 42.0, 42.0], "value": 43.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 42.0, 38.0, 38.0, 38.0, 39.0, 39.0, 38.0, 38.0, 39.0], "value": 38.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 70.0, 72.0, 75.0, 73.0, 73.0, 73.0, 74.0, 73.0], "value": 72.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 117.0, 106.0, 111.0, 109.0, 105.0, 117.0, 107.0, 109.0, 108.0], "value": 110.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 153.0, 151.0, 152.0, 165.0, 151.0, 157.0, 153.0, 155.0, 152.0], "value": 154.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 59.0, 60.0, 60.0, 62.0, 59.0, 59.0, 67.0, 64.0, 62.0], "value": 61.4, "unit": "score"}]}]} 16:10:54 INFO - Return code: 0 16:10:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:10:54 INFO - # TBPL SUCCESS # 16:10:54 INFO - Running post-action listener: _package_coverage_data 16:10:54 INFO - Running post-action listener: _resource_record_post_action 16:10:54 INFO - [mozharness: 2017-09-17 23:10:54.774304Z] Finished run-tests step (success) 16:10:54 INFO - Running post-run listener: _resource_record_post_run 16:10:54 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 438272; Write bytes: 397918208; Read time: 540; Write time: 389312 16:10:54 INFO - TinderboxPrint: CPU usage
13.1% 16:10:54 INFO - TinderboxPrint: I/O read bytes / time
438,272 / 540 16:10:54 INFO - TinderboxPrint: I/O write bytes / time
397,918,208 / 389,312 16:10:54 INFO - TinderboxPrint: CPU idle
8,212.6 (86.9%) 16:10:54 INFO - TinderboxPrint: CPU user
1,185.9 (12.5%) 16:10:54 INFO - TinderboxPrint: Swap in / out
0 / 0 16:10:54 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 12288; Write bytes: 75104256; Read time: 268; Write time: 58052 16:10:54 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:10:54 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 425984; Write bytes: 322813952; Read time: 272; Write time: 331260 16:10:55 INFO - Running post-run listener: _upload_blobber_files 16:10:55 INFO - Blob upload gear active. 16:10:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:10:55 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 16:10:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:10:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:10:55 INFO - (blobuploader) - INFO - Open directory for files ... 16:10:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 16:10:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:10:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:10:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 16:10:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:10:56 INFO - (blobuploader) - INFO - Done attempting. 16:10:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:10:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:10:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:10:57 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:10:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:10:57 INFO - (blobuploader) - INFO - Done attempting. 16:10:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:10:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:10:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:11:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:04 INFO - (blobuploader) - INFO - Done attempting. 16:11:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 16:11:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 16:11:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:05 INFO - (blobuploader) - INFO - Done attempting. 16:11:05 INFO - (blobuploader) - INFO - Iteration through files over. 16:11:05 INFO - Return code: 0 16:11:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:11:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:11:05 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15df135742194f27281344fad6ffa010675fcaa277ce8091d3311568b4b9323d24d6c080157886f550b37ff26a3bb23d79351618d2adcc25cb53745a3b6cd3dc", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/674716b8985bba28a1da772c6dcafe21ba41823dca5b7ba3e856f42b3219ff7bd83b531c2ba7f48b304da2fb1325f5ae3f41de5b996ae421a1aa567a2ad54b03", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7f87b798d97c8e455f33969e7d52e4061df1442cd893e2ec393906f8680b85631312ab7aa31baddf2b3ce76b99806084d35f6b9953d8b00885e84baec25f83a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21c5c0463370e09e136fac0d126b2d0ce0ac96bdc45f4aeadd6aff7acc630cd6cc362ab4650a369dcf718c199e997ba25fb5e835072b4c2c639ac12ad8e2d85a"} 16:11:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:11:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:11:05 INFO - Contents: 16:11:05 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15df135742194f27281344fad6ffa010675fcaa277ce8091d3311568b4b9323d24d6c080157886f550b37ff26a3bb23d79351618d2adcc25cb53745a3b6cd3dc", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/674716b8985bba28a1da772c6dcafe21ba41823dca5b7ba3e856f42b3219ff7bd83b531c2ba7f48b304da2fb1325f5ae3f41de5b996ae421a1aa567a2ad54b03", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7f87b798d97c8e455f33969e7d52e4061df1442cd893e2ec393906f8680b85631312ab7aa31baddf2b3ce76b99806084d35f6b9953d8b00885e84baec25f83a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21c5c0463370e09e136fac0d126b2d0ce0ac96bdc45f4aeadd6aff7acc630cd6cc362ab4650a369dcf718c199e997ba25fb5e835072b4c2c639ac12ad8e2d85a"} 16:11:05 INFO - Running post-run listener: copy_logs_to_upload_dir 16:11:05 INFO - Copying logs to upload dir... 16:11:05 INFO - mkdir: /builds/slave/test/build/upload/logs 16:11:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.570351 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-17 16:11:05.498939) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-17 16:11:05.507678) ========= 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=836cfdc75598d54cb747368e000001a9-1505687706.741790-1390120011 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15df135742194f27281344fad6ffa010675fcaa277ce8091d3311568b4b9323d24d6c080157886f550b37ff26a3bb23d79351618d2adcc25cb53745a3b6cd3dc", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/674716b8985bba28a1da772c6dcafe21ba41823dca5b7ba3e856f42b3219ff7bd83b531c2ba7f48b304da2fb1325f5ae3f41de5b996ae421a1aa567a2ad54b03", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7f87b798d97c8e455f33969e7d52e4061df1442cd893e2ec393906f8680b85631312ab7aa31baddf2b3ce76b99806084d35f6b9953d8b00885e84baec25f83a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21c5c0463370e09e136fac0d126b2d0ce0ac96bdc45f4aeadd6aff7acc630cd6cc362ab4650a369dcf718c199e997ba25fb5e835072b4c2c639ac12ad8e2d85a"} build_url:https://queue.taskcluster.net/v1/task/Tm_s3FMBRbu6xkB0TPt4pA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011341 build_url: 'https://queue.taskcluster.net/v1/task/Tm_s3FMBRbu6xkB0TPt4pA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15df135742194f27281344fad6ffa010675fcaa277ce8091d3311568b4b9323d24d6c080157886f550b37ff26a3bb23d79351618d2adcc25cb53745a3b6cd3dc", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/674716b8985bba28a1da772c6dcafe21ba41823dca5b7ba3e856f42b3219ff7bd83b531c2ba7f48b304da2fb1325f5ae3f41de5b996ae421a1aa567a2ad54b03", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7f87b798d97c8e455f33969e7d52e4061df1442cd893e2ec393906f8680b85631312ab7aa31baddf2b3ce76b99806084d35f6b9953d8b00885e84baec25f83a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21c5c0463370e09e136fac0d126b2d0ce0ac96bdc45f4aeadd6aff7acc630cd6cc362ab4650a369dcf718c199e997ba25fb5e835072b4c2c639ac12ad8e2d85a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-17 16:11:05.541126) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 16:11:05.541469) ========= 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=836cfdc75598d54cb747368e000001a9-1505687706.741790-1390120011 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004829 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 16:11:05.597138) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-17 16:11:05.599474) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-17 16:11:05.599804) ========= ========= Total master_lag: 0.34 =========