builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-050 starttime: 1505781505.37 results: success (0) revision: 30a386ff1192cba08a2f899343f81f6946bc6148 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-18 17:38:25.370805) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-18 17:38:25.371190) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-18 17:38:25.371495) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-18 17:38:25.568861) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 17:38:25.569184) ========= 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=ca6c2627acea03e666270f68000001e0-1505779151.298782-1465186499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-18 17:38: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% 58.5K=0.2s 2017-09-18 17:38:25 (58.5 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.406153 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 17:38:26.007088) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 17:38:26.007682) ========= 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=ca6c2627acea03e666270f68000001e0-1505779151.298782-1465186499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020314 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 17:38:26.088011) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 17:38:26.088364) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 30a386ff1192cba08a2f899343f81f6946bc6148 --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 30a386ff1192cba08a2f899343f81f6946bc6148 --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=ca6c2627acea03e666270f68000001e0-1505779151.298782-1465186499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-18 17:38:26,146 truncating revision to first 12 chars 2017-09-18 17:38:26,146 Setting DEBUG logging. 2017-09-18 17:38:26,146 attempt 1/10 2017-09-18 17:38:26,147 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/30a386ff1192?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-18 17:38:26,527 unpacking tar archive at: mozilla-central-30a386ff1192/testing/mozharness/ program finished with exit code 0 elapsedTime=0.723083 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 17:38:26.849187) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-18 17:38:26.849469) ========= script_repo_revision: 30a386ff1192cba08a2f899343f81f6946bc6148 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-18 17:38:26.849835) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-18 17:38:26.850095) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-18 17:38:26.876269) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-18 17:38:26.876554) ========= /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=ca6c2627acea03e666270f68000001e0-1505779151.298782-1465186499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:38:27 INFO - MultiFileLogger online at 20170918 17:38:27 in /builds/slave/test 17:38: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 17:38:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:38:27 INFO - {'append_to_log': False, 17:38:27 INFO - 'base_work_dir': '/builds/slave/test', 17:38:27 INFO - 'blob_upload_branch': 'Firefox', 17:38:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:38:27 INFO - 'branch': 'Firefox', 17:38:27 INFO - 'buildbot_json_path': 'buildprops.json', 17:38:27 INFO - 'code_coverage': False, 17:38:27 INFO - 'config_files': ('talos/linux_config.py',), 17:38:27 INFO - 'default_actions': ('clobber', 17:38:27 INFO - 'read-buildbot-config', 17:38:27 INFO - 'download-and-extract', 17:38:27 INFO - 'populate-webroot', 17:38:27 INFO - 'create-virtualenv', 17:38:27 INFO - 'install', 17:38:27 INFO - 'setup-mitmproxy', 17:38:27 INFO - 'run-tests'), 17:38:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:38:27 INFO - 'disable_ccov_upload': False, 17:38:27 INFO - 'disable_stylo': False, 17:38:27 INFO - 'download_minidump_stackwalk': True, 17:38:27 INFO - 'download_symbols': 'ondemand', 17:38:27 INFO - 'enable_stylo': False, 17:38:27 INFO - 'enable_webrender': False, 17:38:27 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 17:38:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:38:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:38:27 INFO - 'gecko_profile': False, 17:38:27 INFO - 'gecko_profile_interval': 0, 17:38:27 INFO - 'installer_path': 'installer.exe', 17:38:27 INFO - 'log_level': 'info', 17:38:27 INFO - 'log_name': 'talos', 17:38:27 INFO - 'log_to_console': True, 17:38:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:38:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:38:27 INFO - 'opt_config_files': (), 17:38:27 INFO - 'pip_index': False, 17:38:27 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 17:38:27 INFO - 'system_bits': '32', 17:38:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:38:27 INFO - 'title': 'talos-linux64-ix-050', 17:38:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:38:27 INFO - 'use_talos_json': True, 17:38:27 INFO - 'verify': 'False', 17:38:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:38:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:38:27 INFO - 'work_dir': 'build'} 17:38:27 INFO - [mozharness: 2017-09-19 00:38:27.064065Z] Running clobber step. 17:38:27 INFO - Running pre-action listener: _resource_record_pre_action 17:38:27 INFO - Running main action method: clobber 17:38:27 INFO - rmtree: /builds/slave/test/build 17:38:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:38:28 INFO - Running post-action listener: _resource_record_post_action 17:38:28 INFO - [mozharness: 2017-09-19 00:38:28.588954Z] Finished clobber step (success) 17:38:28 INFO - [mozharness: 2017-09-19 00:38:28.589051Z] Running read-buildbot-config step. 17:38:28 INFO - Running pre-action listener: _resource_record_pre_action 17:38:28 INFO - Running main action method: read_buildbot_config 17:38:28 INFO - Using buildbot properties: 17:38:28 INFO - { 17:38:28 INFO - "project": "", 17:38:28 INFO - "product": "firefox", 17:38:28 INFO - "who": "kwierso@gmail.com", 17:38:28 INFO - "installer_path": "public/build/target.tar.bz2", 17:38:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 17:38:28 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:38:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 17:38:28 INFO - "stage_platform": "linux64-pgo", 17:38:28 INFO - "basedir": "/builds/slave/test", 17:38:28 INFO - "buildnumber": 32, 17:38:28 INFO - "platform": "ubuntu64_hw", 17:38:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:38:28 INFO - "slavebuilddir": "test", 17:38:28 INFO - "taskId": "eQhEyhXKRyGrNM98n49sjg", 17:38:28 INFO - "branch": "mozilla-central", 17:38:28 INFO - "script_repo_revision": "production", 17:38:28 INFO - "revision": "30a386ff1192cba08a2f899343f81f6946bc6148", 17:38:28 INFO - "slavename": "talos-linux64-ix-050", 17:38:28 INFO - "repo_path": "mozilla-central" 17:38:28 INFO - } 17:38:28 INFO - Finding installer, test and symbols from parent task. 17:38:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eQhEyhXKRyGrNM98n49sjg'}, attempt #1 17:38:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eQhEyhXKRyGrNM98n49sjg'}, attempt #1 17:38:29 INFO - Task dependencies: aQ8LhTnHTYe3TMkQjgKawg 17:38:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aQ8LhTnHTYe3TMkQjgKawg'}, attempt #1 17:38:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/aQ8LhTnHTYe3TMkQjgKawg/artifacts/public/build/target.tar.bz2 17:38:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/aQ8LhTnHTYe3TMkQjgKawg/artifacts/public/build/target.test_packages.json 17:38:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/aQ8LhTnHTYe3TMkQjgKawg/artifacts/public/build/target.crashreporter-symbols.zip 17:38:29 INFO - Running post-action listener: _resource_record_post_action 17:38:29 INFO - [mozharness: 2017-09-19 00:38:29.927968Z] Finished read-buildbot-config step (success) 17:38:29 INFO - [mozharness: 2017-09-19 00:38:29.928183Z] Running download-and-extract step. 17:38:29 INFO - Running pre-action listener: _resource_record_pre_action 17:38:29 INFO - Running main action method: download_and_extract 17:38:29 INFO - mkdir: /builds/slave/test/build/tests 17:38: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')]} 17:38:29 INFO - trying https://queue.taskcluster.net/v1/task/aQ8LhTnHTYe3TMkQjgKawg/artifacts/public/build/target.test_packages.json 17:38:29 INFO - Downloading https://queue.taskcluster.net/v1/task/aQ8LhTnHTYe3TMkQjgKawg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:38:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aQ8LhTnHTYe3TMkQjgKawg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:38:30 INFO - Downloaded 989 bytes. 17:38:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:38:30 INFO - Using the following test package requirements: 17:38:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:38:30 INFO - u'common': [u'target.common.tests.zip'], 17:38:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:38:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:38:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:38:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:38:30 INFO - u'mozbase': [u'target.common.tests.zip'], 17:38:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:38:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:38:30 INFO - u'web-platform': [u'target.common.tests.zip', 17:38:30 INFO - u'target.web-platform.tests.tar.gz'], 17:38:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:38:30 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 17:38:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aQ8LhTnHTYe3TMkQjgKawg/artifacts/public/build/target.common.tests.zip 17:38:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aQ8LhTnHTYe3TMkQjgKawg/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:38:30 INFO - Fetch https://queue.taskcluster.net/v1/task/aQ8LhTnHTYe3TMkQjgKawg/artifacts/public/build/target.common.tests.zip into memory 17:38:33 INFO - Content-Length response header: 55321386 17:38:33 INFO - Bytes received: 55321386 17:38:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aQ8LhTnHTYe3TMkQjgKawg/artifacts/public/build/target.talos.tests.zip 17:38:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aQ8LhTnHTYe3TMkQjgKawg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:38:44 INFO - Fetch https://queue.taskcluster.net/v1/task/aQ8LhTnHTYe3TMkQjgKawg/artifacts/public/build/target.talos.tests.zip into memory 17:38:45 INFO - Content-Length response header: 14508787 17:38:45 INFO - Bytes received: 14508787 17:38:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:45 INFO - trying https://queue.taskcluster.net/v1/task/aQ8LhTnHTYe3TMkQjgKawg/artifacts/public/build/target.tar.bz2 17:38:45 INFO - Downloading https://queue.taskcluster.net/v1/task/aQ8LhTnHTYe3TMkQjgKawg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:38:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aQ8LhTnHTYe3TMkQjgKawg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:38:50 INFO - Downloaded 62262576 bytes. 17:38:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aQ8LhTnHTYe3TMkQjgKawg/artifacts/public/build/target.tar.bz2 17:38:50 INFO - mkdir: /builds/slave/test/properties 17:38:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:38:50 INFO - Writing to file /builds/slave/test/properties/build_url 17:38:50 INFO - Contents: 17:38:50 INFO - build_url:https://queue.taskcluster.net/v1/task/aQ8LhTnHTYe3TMkQjgKawg/artifacts/public/build/target.tar.bz2 17:38:50 INFO - Running post-action listener: _resource_record_post_action 17:38:50 INFO - Running post-action listener: find_tests_for_verification 17:38:50 INFO - Running post-action listener: set_extra_try_arguments 17:38:50 INFO - [mozharness: 2017-09-19 00:38:50.252503Z] Finished download-and-extract step (success) 17:38:50 INFO - [mozharness: 2017-09-19 00:38:50.252731Z] Running populate-webroot step. 17:38:50 INFO - Running pre-action listener: _resource_record_pre_action 17:38:50 INFO - Running main action method: populate_webroot 17:38:50 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:38:50 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:38:50 INFO - 'tests': ['tresize', 17:38:50 INFO - 'tcanvasmark']}, 17:38:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:38:50 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:38:50 INFO - 'tests': ['dromaeo_css', 17:38:50 INFO - 'kraken']}, 17:38:50 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:38:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:38:50 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:38:50 INFO - 'talos_options': ['--disable-stylo'], 17:38:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:38:50 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:38:50 INFO - 'tests': ['damp', 'tps']}, 17:38:50 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:38:50 INFO - 'talos_options': ['--disable-stylo'], 17:38:50 INFO - 'tests': ['damp', 'tps']}, 17:38:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:38:50 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:38:50 INFO - 'tests': ['dromaeo_dom']}, 17:38:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:38:50 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:38:50 INFO - 'tests': ['basic_compositor_video', 17:38:50 INFO - 'glvideo']}, 17:38:50 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:38:50 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:38:50 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:38:50 INFO - 'talos_options': ['--disable-stylo'], 17:38:50 INFO - 'tests': ['ts_paint_webext', 17:38:50 INFO - 'tp5o_webext']}, 17:38:50 INFO - 'other-e10s': {'tests': ['a11yr', 17:38:50 INFO - 'ts_paint', 17:38:50 INFO - 'tpaint', 17:38:50 INFO - 'sessionrestore', 17:38:50 INFO - 'sessionrestore_many_windows', 17:38:50 INFO - 'sessionrestore_no_auto_restore', 17:38:50 INFO - 'tabpaint']}, 17:38:50 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:38:50 INFO - 'tests': ['a11yr', 17:38:50 INFO - 'ts_paint', 17:38:50 INFO - 'tpaint', 17:38:50 INFO - 'sessionrestore', 17:38:50 INFO - 'sessionrestore_many_windows', 17:38:50 INFO - 'sessionrestore_no_auto_restore', 17:38:50 INFO - 'tabpaint']}, 17:38:50 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 17:38:50 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 17:38:50 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:38:50 INFO - 'tests': ['perf_reftest_singletons']}, 17:38:50 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:38:50 INFO - 'tests': ['bloom_basic']}, 17:38:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:38:50 INFO - 'tsvgr_opacity', 17:38:50 INFO - 'tart', 17:38:50 INFO - 'tscrollx', 17:38:50 INFO - 'tsvg_static']}, 17:38:50 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:38:50 INFO - 'tests': ['tsvgx', 17:38:50 INFO - 'tsvgr_opacity', 17:38:50 INFO - 'tart', 17:38:50 INFO - 'tscrollx', 17:38:50 INFO - 'tsvg_static']}, 17:38:50 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:38:50 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:38:50 INFO - 'talos_options': ['--disable-stylo'], 17:38:50 INFO - 'tests': ['tp5o']}, 17:38:50 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:38:50 INFO - 'talos_options': ['--mitmproxy', 17:38:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:38:50 INFO - '--firstNonBlankPaint'], 17:38:50 INFO - 'tests': ['tp6_google', 17:38:50 INFO - 'tp6_youtube', 17:38:50 INFO - 'tp6_amazon', 17:38:50 INFO - 'tp6_facebook']}, 17:38:50 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:38:50 INFO - 'talos_options': ['--disable-stylo', 17:38:50 INFO - '--mitmproxy', 17:38:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:38:50 INFO - '--firstNonBlankPaint'], 17:38:50 INFO - 'tests': ['tp6_google', 17:38:50 INFO - 'tp6_youtube', 17:38:50 INFO - 'tp6_amazon', 17:38:50 INFO - 'tp6_facebook']}, 17:38:50 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:38:50 INFO - 'talos_options': ['--stylo-threads=1', 17:38:50 INFO - '--mitmproxy', 17:38:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:38:50 INFO - '--firstNonBlankPaint'], 17:38:50 INFO - 'tests': ['tp6_google', 17:38:50 INFO - 'tp6_youtube', 17:38:50 INFO - 'tp6_amazon', 17:38:50 INFO - 'tp6_facebook']}, 17:38:50 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:38:50 INFO - 'talos_options': ['--xperf_path', 17:38:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:38:50 INFO - 'tests': ['tp5n']}, 17:38:50 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:38:50 INFO - 'talos_options': ['--disable-stylo', 17:38:50 INFO - '--xperf_path', 17:38:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:38:50 INFO - 'tests': ['tp5n']}}} 17:38:50 INFO - Running post-action listener: _resource_record_post_action 17:38:50 INFO - [mozharness: 2017-09-19 00:38:50.268528Z] Finished populate-webroot step (success) 17:38:50 INFO - [mozharness: 2017-09-19 00:38:50.268617Z] Running create-virtualenv step. 17:38:50 INFO - Running pre-action listener: _resource_record_pre_action 17:38:50 INFO - Running main action method: create_virtualenv 17:38:50 INFO - Creating virtualenv /builds/slave/test/build/venv 17:38:50 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:38:50 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 17:38:50 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:38:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:38:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:38:50 INFO - Installing distribute.............................................................................................................................................................................................done. 17:38:51 INFO - Installing pip...............done. 17:38:51 INFO - Return code: 0 17:38:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:38:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:38:51 INFO - Reading from file tmpfile_stdout 17:38:51 INFO - Output received: 17:38: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) 17:38:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:38: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')]} 17:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38: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')]} 17:38:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38: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 0x1cf11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2061090>, '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 0x2061d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205bf90>, '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': 'ca6c2627acea03e666270f68000001e0-1505779151.298782-1465186499', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:38: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 17:38: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 17:38:51 INFO - Using env: {'DISPLAY': ':0', 17:38:51 INFO - 'HOME': '/home/cltbld', 17:38:51 INFO - 'LANG': 'en_US.UTF-8', 17:38:51 INFO - 'LANGUAGE': 'en_US:en', 17:38:51 INFO - 'LOGNAME': 'cltbld', 17:38:51 INFO - 'MAIL': '/var/mail/cltbld', 17:38:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:51 INFO - 'MOZ_NO_REMOTE': '1', 17:38:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:38:51 INFO - 'NO_EM_RESTART': '1', 17:38:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:38:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:51 INFO - 'PWD': '/builds/slave/test', 17:38:51 INFO - 'SHELL': '/bin/bash', 17:38:51 INFO - 'SHLVL': '1', 17:38:51 INFO - 'TERM': 'linux', 17:38:51 INFO - 'TMOUT': '86400', 17:38:51 INFO - 'USER': 'cltbld', 17:38:51 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505779151.298782-1465186499', 17:38:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:51 INFO - '_': '/tools/buildbot/bin/python'} 17:38:52 INFO - Ignoring indexes: http://pypi.python.org/simple/ 17:38:52 INFO - Downloading/unpacking pip>=1.5 17:38:52 INFO - Running setup.py egg_info for package pip 17:38:52 INFO - warning: no files found matching 'pip/cacert.pem' 17:38:52 INFO - warning: no files found matching '*.html' under directory 'docs' 17:38:52 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:38:52 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:38:52 INFO - Installing collected packages: pip 17:38:52 INFO - Found existing installation: pip 1.1 17:38:52 INFO - Uninstalling pip: 17:38:52 INFO - Successfully uninstalled pip 17:38:52 INFO - Running setup.py install for pip 17:38:52 INFO - warning: no files found matching 'pip/cacert.pem' 17:38:52 INFO - warning: no files found matching '*.html' under directory 'docs' 17:38:52 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:38:52 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:38:52 INFO - Installing pip script to /builds/slave/test/build/venv/bin 17:38:52 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 17:38:52 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 17:38:52 INFO - Successfully installed pip 17:38:52 INFO - Cleaning up... 17:38:52 INFO - Return code: 0 17:38:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:38:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38: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 0x1cf11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2061090>, '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 0x2061d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205bf90>, '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': 'ca6c2627acea03e666270f68000001e0-1505779151.298782-1465186499', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:38: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 17:38: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 17:38:52 INFO - Using env: {'DISPLAY': ':0', 17:38:52 INFO - 'HOME': '/home/cltbld', 17:38:52 INFO - 'LANG': 'en_US.UTF-8', 17:38:52 INFO - 'LANGUAGE': 'en_US:en', 17:38:52 INFO - 'LOGNAME': 'cltbld', 17:38:52 INFO - 'MAIL': '/var/mail/cltbld', 17:38:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:52 INFO - 'MOZ_NO_REMOTE': '1', 17:38:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:38:52 INFO - 'NO_EM_RESTART': '1', 17:38:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:38:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:52 INFO - 'PWD': '/builds/slave/test', 17:38:52 INFO - 'SHELL': '/bin/bash', 17:38:52 INFO - 'SHLVL': '1', 17:38:52 INFO - 'TERM': 'linux', 17:38:52 INFO - 'TMOUT': '86400', 17:38:52 INFO - 'USER': 'cltbld', 17:38:52 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505779151.298782-1465186499', 17:38:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:52 INFO - '_': '/tools/buildbot/bin/python'} 17:38:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:52 INFO - Downloading/unpacking psutil>=3.1.1 17:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:38:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:38:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:38:53 INFO - Installing collected packages: psutil 17:38:53 INFO - Running setup.py install for psutil 17:38:54 INFO - building 'psutil._psutil_linux' extension 17:38: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 17:38: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 17:38:54 INFO - building 'psutil._psutil_posix' extension 17:38: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 17:38: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 17:38:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:38:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:38:54 INFO - Successfully installed psutil 17:38:54 INFO - Cleaning up... 17:38:54 INFO - Return code: 0 17:38:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:38:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38: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 0x1cf11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2061090>, '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 0x2061d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205bf90>, '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': 'ca6c2627acea03e666270f68000001e0-1505779151.298782-1465186499', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:38: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 17:38: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 17:38:54 INFO - Using env: {'DISPLAY': ':0', 17:38:54 INFO - 'HOME': '/home/cltbld', 17:38:54 INFO - 'LANG': 'en_US.UTF-8', 17:38:54 INFO - 'LANGUAGE': 'en_US:en', 17:38:54 INFO - 'LOGNAME': 'cltbld', 17:38:54 INFO - 'MAIL': '/var/mail/cltbld', 17:38:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:54 INFO - 'MOZ_NO_REMOTE': '1', 17:38:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:38:54 INFO - 'NO_EM_RESTART': '1', 17:38:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:38:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:54 INFO - 'PWD': '/builds/slave/test', 17:38:54 INFO - 'SHELL': '/bin/bash', 17:38:54 INFO - 'SHLVL': '1', 17:38:54 INFO - 'TERM': 'linux', 17:38:54 INFO - 'TMOUT': '86400', 17:38:54 INFO - 'USER': 'cltbld', 17:38:54 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505779151.298782-1465186499', 17:38:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:54 INFO - '_': '/tools/buildbot/bin/python'} 17:38:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:38:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:38:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:38:56 INFO - Installing collected packages: mozsystemmonitor 17:38:56 INFO - Running setup.py install for mozsystemmonitor 17:38:56 INFO - Successfully installed mozsystemmonitor 17:38:56 INFO - Cleaning up... 17:38:57 INFO - Return code: 0 17:38:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:38: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')]} 17:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38: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')]} 17:38:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38: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', '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 0x1cf11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2061090>, '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 0x2061d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205bf90>, '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': 'ca6c2627acea03e666270f68000001e0-1505779151.298782-1465186499', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:38: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:38: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 jsonschema==2.5.1 17:38:57 INFO - Using env: {'DISPLAY': ':0', 17:38:57 INFO - 'HOME': '/home/cltbld', 17:38:57 INFO - 'LANG': 'en_US.UTF-8', 17:38:57 INFO - 'LANGUAGE': 'en_US:en', 17:38:57 INFO - 'LOGNAME': 'cltbld', 17:38:57 INFO - 'MAIL': '/var/mail/cltbld', 17:38:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:57 INFO - 'MOZ_NO_REMOTE': '1', 17:38:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:38:57 INFO - 'NO_EM_RESTART': '1', 17:38:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:38:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:57 INFO - 'PWD': '/builds/slave/test', 17:38:57 INFO - 'SHELL': '/bin/bash', 17:38:57 INFO - 'SHLVL': '1', 17:38:57 INFO - 'TERM': 'linux', 17:38:57 INFO - 'TMOUT': '86400', 17:38:57 INFO - 'USER': 'cltbld', 17:38:57 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505779151.298782-1465186499', 17:38:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:57 INFO - '_': '/tools/buildbot/bin/python'} 17:38:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:57 INFO - Downloading/unpacking jsonschema==2.5.1 17:38: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 17:38: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 17:38: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 17:38: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 17:38:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:38:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:59 INFO - Downloading functools32-3.2.3-2.tar.gz 17:38:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:38:59 INFO - warning: no files found matching '*.txt' 17:38:59 INFO - no previously-included directories found matching 'build' 17:38:59 INFO - no previously-included directories found matching 'dist' 17:38:59 INFO - no previously-included directories found matching '.git*' 17:38:59 INFO - Installing collected packages: jsonschema, functools32 17:38:59 INFO - Running setup.py install for functools32 17:38:59 INFO - warning: no files found matching '*.txt' 17:38:59 INFO - no previously-included directories found matching 'build' 17:38:59 INFO - no previously-included directories found matching 'dist' 17:38:59 INFO - no previously-included directories found matching '.git*' 17:38:59 INFO - Successfully installed jsonschema functools32 17:38:59 INFO - Cleaning up... 17:38:59 INFO - Return code: 0 17:38:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:38:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:59 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 0x1cf11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2061090>, '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 0x2061d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205bf90>, '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': 'ca6c2627acea03e666270f68000001e0-1505779151.298782-1465186499', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:38:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:38:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:38:59 INFO - Using env: {'DISPLAY': ':0', 17:38:59 INFO - 'HOME': '/home/cltbld', 17:38:59 INFO - 'LANG': 'en_US.UTF-8', 17:38:59 INFO - 'LANGUAGE': 'en_US:en', 17:38:59 INFO - 'LOGNAME': 'cltbld', 17:38:59 INFO - 'MAIL': '/var/mail/cltbld', 17:38:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:59 INFO - 'MOZ_NO_REMOTE': '1', 17:38:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:38:59 INFO - 'NO_EM_RESTART': '1', 17:38:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:38:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:59 INFO - 'PWD': '/builds/slave/test', 17:38:59 INFO - 'SHELL': '/bin/bash', 17:38:59 INFO - 'SHLVL': '1', 17:38:59 INFO - 'TERM': 'linux', 17:38:59 INFO - 'TMOUT': '86400', 17:38:59 INFO - 'USER': 'cltbld', 17:38:59 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505779151.298782-1465186499', 17:38:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:59 INFO - '_': '/tools/buildbot/bin/python'} 17:38:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:38:59 INFO - Cleaning up... 17:38:59 INFO - Return code: 0 17:38:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:38:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:59 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 0x1cf11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2061090>, '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 0x2061d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205bf90>, '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': 'ca6c2627acea03e666270f68000001e0-1505779151.298782-1465186499', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:38:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:38:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:38:59 INFO - Using env: {'DISPLAY': ':0', 17:38:59 INFO - 'HOME': '/home/cltbld', 17:38:59 INFO - 'LANG': 'en_US.UTF-8', 17:38:59 INFO - 'LANGUAGE': 'en_US:en', 17:38:59 INFO - 'LOGNAME': 'cltbld', 17:38:59 INFO - 'MAIL': '/var/mail/cltbld', 17:38:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:59 INFO - 'MOZ_NO_REMOTE': '1', 17:38:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:38:59 INFO - 'NO_EM_RESTART': '1', 17:38:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:38:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:59 INFO - 'PWD': '/builds/slave/test', 17:38:59 INFO - 'SHELL': '/bin/bash', 17:38:59 INFO - 'SHLVL': '1', 17:38:59 INFO - 'TERM': 'linux', 17:38:59 INFO - 'TMOUT': '86400', 17:38:59 INFO - 'USER': 'cltbld', 17:38:59 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505779151.298782-1465186499', 17:38:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:59 INFO - '_': '/tools/buildbot/bin/python'} 17:38:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:59 INFO - Downloading/unpacking blobuploader==1.2.4 17:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:00 INFO - Downloading blobuploader-1.2.4.tar.gz 17:39:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:39:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:39:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:01 INFO - Downloading docopt-0.6.1.tar.gz 17:39:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:39:01 INFO - Installing collected packages: blobuploader, requests, docopt 17:39:01 INFO - Running setup.py install for blobuploader 17:39:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:39:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:39:01 INFO - Running setup.py install for requests 17:39:02 INFO - Running setup.py install for docopt 17:39:02 INFO - Successfully installed blobuploader requests docopt 17:39:02 INFO - Cleaning up... 17:39:02 INFO - Return code: 0 17:39:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:39:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:39:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:02 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 0x1cf11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2061090>, '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 0x2061d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205bf90>, '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': 'ca6c2627acea03e666270f68000001e0-1505779151.298782-1465186499', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:39:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:39:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:39:02 INFO - Using env: {'DISPLAY': ':0', 17:39:02 INFO - 'HOME': '/home/cltbld', 17:39:02 INFO - 'LANG': 'en_US.UTF-8', 17:39:02 INFO - 'LANGUAGE': 'en_US:en', 17:39:02 INFO - 'LOGNAME': 'cltbld', 17:39:02 INFO - 'MAIL': '/var/mail/cltbld', 17:39:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:02 INFO - 'MOZ_NO_REMOTE': '1', 17:39:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:39:02 INFO - 'NO_EM_RESTART': '1', 17:39:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:39:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:02 INFO - 'PWD': '/builds/slave/test', 17:39:02 INFO - 'SHELL': '/bin/bash', 17:39:02 INFO - 'SHLVL': '1', 17:39:02 INFO - 'TERM': 'linux', 17:39:02 INFO - 'TMOUT': '86400', 17:39:02 INFO - 'USER': 'cltbld', 17:39:02 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505779151.298782-1465186499', 17:39:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:02 INFO - '_': '/tools/buildbot/bin/python'} 17:39:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:39:02 INFO - Running setup.py (path:/tmp/pip-W5j1SX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:39:02 INFO - Running setup.py (path:/tmp/pip-1infUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:39:02 INFO - Running setup.py (path:/tmp/pip-rFtdc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:39:02 INFO - Running setup.py (path:/tmp/pip-UXRGfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:39:02 INFO - Running setup.py (path:/tmp/pip-K7h7qM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:39:02 INFO - Running setup.py (path:/tmp/pip-J8FZ0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:39:02 INFO - Running setup.py (path:/tmp/pip-n7igu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:39:02 INFO - Running setup.py (path:/tmp/pip-UmtH83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:39:02 INFO - Running setup.py (path:/tmp/pip-zLH2xm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:39:02 INFO - Running setup.py (path:/tmp/pip-3FMSxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:39:03 INFO - Running setup.py (path:/tmp/pip-_2d4zZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:39:03 INFO - Running setup.py (path:/tmp/pip-8Hw75c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:39:03 INFO - Running setup.py (path:/tmp/pip-Buxg0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:39:03 INFO - Running setup.py (path:/tmp/pip-C6fZqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:39:03 INFO - Running setup.py (path:/tmp/pip-rC1m5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:39:03 INFO - Running setup.py (path:/tmp/pip-60SciO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:39:03 INFO - Running setup.py (path:/tmp/pip-zqxlj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:39:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:39:03 INFO - Running setup.py install for manifestparser 17:39:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:39:03 INFO - Running setup.py install for mozcrash 17:39:03 INFO - Running setup.py install for mozdebug 17:39:03 INFO - Running setup.py install for mozdevice 17:39:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:39:03 INFO - Running setup.py install for mozfile 17:39:04 INFO - Running setup.py install for mozhttpd 17:39:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:39:04 INFO - Running setup.py install for mozinfo 17:39:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:39:04 INFO - Running setup.py install for mozInstall 17:39:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:39:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:39:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:39:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:39:04 INFO - Running setup.py install for mozleak 17:39:04 INFO - Running setup.py install for mozlog 17:39:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:39:04 INFO - Running setup.py install for moznetwork 17:39:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:39:04 INFO - Running setup.py install for mozprocess 17:39:04 INFO - Running setup.py install for mozprofile 17:39:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:39:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:39:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:39:04 INFO - Running setup.py install for mozrunner 17:39:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:39:05 INFO - Running setup.py install for mozscreenshot 17:39:05 INFO - Running setup.py install for moztest 17:39:05 INFO - Running setup.py install for mozversion 17:39:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:39:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:39:05 INFO - Cleaning up... 17:39:05 INFO - Return code: 0 17:39:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:39:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:05 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 0x1cf11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2061090>, '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 0x2061d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205bf90>, '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': 'ca6c2627acea03e666270f68000001e0-1505779151.298782-1465186499', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:39:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:39:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:39:05 INFO - Using env: {'DISPLAY': ':0', 17:39:05 INFO - 'HOME': '/home/cltbld', 17:39:05 INFO - 'LANG': 'en_US.UTF-8', 17:39:05 INFO - 'LANGUAGE': 'en_US:en', 17:39:05 INFO - 'LOGNAME': 'cltbld', 17:39:05 INFO - 'MAIL': '/var/mail/cltbld', 17:39:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:05 INFO - 'MOZ_NO_REMOTE': '1', 17:39:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:39:05 INFO - 'NO_EM_RESTART': '1', 17:39:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:39:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:05 INFO - 'PWD': '/builds/slave/test', 17:39:05 INFO - 'SHELL': '/bin/bash', 17:39:05 INFO - 'SHLVL': '1', 17:39:05 INFO - 'TERM': 'linux', 17:39:05 INFO - 'TMOUT': '86400', 17:39:05 INFO - 'USER': 'cltbld', 17:39:05 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505779151.298782-1465186499', 17:39:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:05 INFO - '_': '/tools/buildbot/bin/python'} 17:39:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:39:05 INFO - Running setup.py (path:/tmp/pip-XYW9Vp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:39:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:39:05 INFO - Running setup.py (path:/tmp/pip-R5DBJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:39:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:39:05 INFO - Running setup.py (path:/tmp/pip-8hxtlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:39:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:39:05 INFO - Running setup.py (path:/tmp/pip-1CkRz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:39:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:39:05 INFO - Running setup.py (path:/tmp/pip-htlan5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:39:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:39:05 INFO - Running setup.py (path:/tmp/pip-xZaIUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:39:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:39:05 INFO - Running setup.py (path:/tmp/pip-ojR2UJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:39:06 INFO - Running setup.py (path:/tmp/pip-Mo5_HF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:39:06 INFO - Running setup.py (path:/tmp/pip-moTY04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:39:06 INFO - Running setup.py (path:/tmp/pip-Q_jvk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:39:06 INFO - Running setup.py (path:/tmp/pip-cofJEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:39:06 INFO - Running setup.py (path:/tmp/pip-Jvnwya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:39:06 INFO - Running setup.py (path:/tmp/pip-Epf9w9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:39:06 INFO - Running setup.py (path:/tmp/pip-4DVrQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:39:06 INFO - Running setup.py (path:/tmp/pip-5rm85a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:39:06 INFO - Running setup.py (path:/tmp/pip-kHupDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:39:06 INFO - Running setup.py (path:/tmp/pip-6J7r1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:39:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:39: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 17:39: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 17:39: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 17:39: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 17:39:07 INFO - Downloading blessings-1.6.tar.gz 17:39:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:39:07 INFO - Installing collected packages: blessings 17:39:07 INFO - Running setup.py install for blessings 17:39:08 INFO - Successfully installed blessings 17:39:08 INFO - Cleaning up... 17:39:08 INFO - Return code: 0 17:39:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:39:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:39:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:39:08 INFO - Reading from file tmpfile_stdout 17:39:08 INFO - Current package versions: 17:39:08 INFO - argparse == 1.2.1 17:39:08 INFO - blessings == 1.6 17:39:08 INFO - blobuploader == 1.2.4 17:39:08 INFO - docopt == 0.6.1 17:39:08 INFO - functools32 == 3.2.3-2 17:39:08 INFO - jsonschema == 2.5.1 17:39:08 INFO - manifestparser == 1.1 17:39:08 INFO - mozInstall == 1.13 17:39:08 INFO - mozcrash == 1.0 17:39:08 INFO - mozdebug == 0.1 17:39:08 INFO - mozdevice == 0.51 17:39:08 INFO - mozfile == 1.2 17:39:08 INFO - mozhttpd == 0.7 17:39:08 INFO - mozinfo == 0.10 17:39:08 INFO - mozleak == 0.1 17:39:08 INFO - mozlog == 3.5 17:39:08 INFO - moznetwork == 0.27 17:39:08 INFO - mozprocess == 0.25 17:39:08 INFO - mozprofile == 0.28 17:39:08 INFO - mozrunner == 6.13 17:39:08 INFO - mozscreenshot == 0.1 17:39:08 INFO - mozsystemmonitor == 0.3 17:39:08 INFO - moztest == 0.8 17:39:08 INFO - mozversion == 1.4 17:39:08 INFO - psutil == 3.1.1 17:39:08 INFO - requests == 1.2.3 17:39:08 INFO - wsgiref == 0.1.2 17:39:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:39: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')]} 17:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39: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')]} 17:39:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:08 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 0x1cf11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2061090>, '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 0x2061d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205bf90>, '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': 'ca6c2627acea03e666270f68000001e0-1505779151.298782-1465186499', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:39:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:39:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:39:08 INFO - Using env: {'DISPLAY': ':0', 17:39:08 INFO - 'HOME': '/home/cltbld', 17:39:08 INFO - 'LANG': 'en_US.UTF-8', 17:39:08 INFO - 'LANGUAGE': 'en_US:en', 17:39:08 INFO - 'LOGNAME': 'cltbld', 17:39:08 INFO - 'MAIL': '/var/mail/cltbld', 17:39:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:08 INFO - 'MOZ_NO_REMOTE': '1', 17:39:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:39:08 INFO - 'NO_EM_RESTART': '1', 17:39:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:39:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:08 INFO - 'PWD': '/builds/slave/test', 17:39:08 INFO - 'SHELL': '/bin/bash', 17:39:08 INFO - 'SHLVL': '1', 17:39:08 INFO - 'TERM': 'linux', 17:39:08 INFO - 'TMOUT': '86400', 17:39:08 INFO - 'USER': 'cltbld', 17:39:08 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505779151.298782-1465186499', 17:39:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:08 INFO - '_': '/tools/buildbot/bin/python'} 17:39:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:39:08 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:39:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:39:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:39:09 INFO - Installing collected packages: simplejson 17:39:09 INFO - Running setup.py install for simplejson 17:39:09 INFO - building 'simplejson._speedups' extension 17:39:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 17:39:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 17:39:10 INFO - Successfully installed simplejson 17:39:10 INFO - Cleaning up... 17:39:10 INFO - Return code: 0 17:39:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:39:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:10 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 0x1cf11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2061090>, '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 0x2061d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205bf90>, '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': 'ca6c2627acea03e666270f68000001e0-1505779151.298782-1465186499', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:39:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:39:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:39:10 INFO - Using env: {'DISPLAY': ':0', 17:39:10 INFO - 'HOME': '/home/cltbld', 17:39:10 INFO - 'LANG': 'en_US.UTF-8', 17:39:10 INFO - 'LANGUAGE': 'en_US:en', 17:39:10 INFO - 'LOGNAME': 'cltbld', 17:39:10 INFO - 'MAIL': '/var/mail/cltbld', 17:39:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:10 INFO - 'MOZ_NO_REMOTE': '1', 17:39:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:39:10 INFO - 'NO_EM_RESTART': '1', 17:39:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:39:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:10 INFO - 'PWD': '/builds/slave/test', 17:39:10 INFO - 'SHELL': '/bin/bash', 17:39:10 INFO - 'SHLVL': '1', 17:39:10 INFO - 'TERM': 'linux', 17:39:10 INFO - 'TMOUT': '86400', 17:39:10 INFO - 'USER': 'cltbld', 17:39:10 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505779151.298782-1465186499', 17:39:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:10 INFO - '_': '/tools/buildbot/bin/python'} 17:39:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:39:10 INFO - Cleaning up... 17:39:10 INFO - Return code: 0 17:39:10 INFO - Running post-action listener: _resource_record_post_action 17:39:10 INFO - Running post-action listener: _start_resource_monitoring 17:39:11 INFO - Starting resource monitoring. 17:39:11 INFO - [mozharness: 2017-09-19 00:39:11.028412Z] Finished create-virtualenv step (success) 17:39:11 INFO - [mozharness: 2017-09-19 00:39:11.028923Z] Running install step. 17:39:11 INFO - Running pre-action listener: _resource_record_pre_action 17:39:11 INFO - Running main action method: install 17:39:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:39:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:39:11 INFO - Reading from file tmpfile_stdout 17:39:11 INFO - Detecting whether we're running mozinstall >=1.0... 17:39:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:39:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:39:11 INFO - Reading from file tmpfile_stdout 17:39:11 INFO - Output received: 17:39:11 INFO - Usage: mozinstall [options] installer 17:39:11 INFO - Options: 17:39:11 INFO - -h, --help show this help message and exit 17:39:11 INFO - -d DEST, --destination=DEST 17:39:11 INFO - Directory to install application into. [default: 17:39:11 INFO - "/builds/slave/test"] 17:39:11 INFO - --app=APP Application being installed. [default: firefox] 17:39:11 INFO - mkdir: /builds/slave/test/build/application 17:39:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:39:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:39:28 INFO - Reading from file tmpfile_stdout 17:39:28 INFO - Output received: 17:39:28 INFO - /builds/slave/test/build/application/firefox/firefox 17:39:28 INFO - Running post-action listener: _resource_record_post_action 17:39:28 INFO - [mozharness: 2017-09-19 00:39:28.980451Z] Finished install step (success) 17:39:28 INFO - [mozharness: 2017-09-19 00:39:28.980599Z] Running setup-mitmproxy step. 17:39:28 INFO - Running pre-action listener: _resource_record_pre_action 17:39:28 INFO - Running main action method: setup_mitmproxy 17:39:28 INFO - Skipping: mitmproxy is not required 17:39:28 INFO - Running post-action listener: _resource_record_post_action 17:39:28 INFO - [mozharness: 2017-09-19 00:39:28.981137Z] Finished setup-mitmproxy step (success) 17:39:28 INFO - [mozharness: 2017-09-19 00:39:28.981240Z] Running run-tests step. 17:39:28 INFO - Running pre-action listener: _resource_record_pre_action 17:39:28 INFO - Running pre-action listener: _set_gcov_prefix 17:39:28 INFO - Running main action method: run_tests 17:39:28 WARNING - Try message not found. 17:39:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:39:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:39:28 INFO - Python 2.7.3 17:39:28 INFO - Return code: 0 17:39:28 INFO - grabbing minidump binary from tooltool 17:39:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:39:28 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 0x2061090>, '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 0x2061d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205bf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:39:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:39:28 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:39:28 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:39:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:39:29 INFO - Return code: 0 17:39:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:39:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:39:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:39:29 INFO - ENV: RUST_BACKTRACE is now full 17:39:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:39:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:39:29 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/aQ8LhTnHTYe3TMkQjgKawg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 17:39:29 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/aQ8LhTnHTYe3TMkQjgKawg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-050 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 17:39:29 INFO - Using env: {'DISPLAY': ':0', 17:39:29 INFO - 'HOME': '/home/cltbld', 17:39:29 INFO - 'LANG': 'en_US.UTF-8', 17:39:29 INFO - 'LANGUAGE': 'en_US:en', 17:39:29 INFO - 'LOGNAME': 'cltbld', 17:39:29 INFO - 'MAIL': '/var/mail/cltbld', 17:39:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:39:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:39:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:29 INFO - 'MOZ_NO_REMOTE': '1', 17:39:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:39:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:39:29 INFO - 'NO_EM_RESTART': '1', 17:39:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:39:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:29 INFO - 'PWD': '/builds/slave/test', 17:39:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:39:29 INFO - 'RUST_BACKTRACE': 'full', 17:39:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:39:29 INFO - 'SHELL': '/bin/bash', 17:39:29 INFO - 'SHLVL': '1', 17:39:29 INFO - 'TERM': 'linux', 17:39:29 INFO - 'TMOUT': '86400', 17:39:29 INFO - 'USER': 'cltbld', 17:39:29 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505779151.298782-1465186499', 17:39:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:29 INFO - '_': '/tools/buildbot/bin/python'} 17:39:29 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/aQ8LhTnHTYe3TMkQjgKawg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 17:39:29 INFO - mozversion application_buildid: 20170918232117 17:39:29 INFO - mozversion application_changeset: 30a386ff1192cba08a2f899343f81f6946bc6148 17:39:29 INFO - mozversion application_display_name: Nightly 17:39:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:39:29 INFO - mozversion application_name: Firefox 17:39:29 INFO - mozversion application_remotingname: firefox 17:39:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:39:29 INFO - mozversion application_vendor: Mozilla 17:39:29 INFO - mozversion application_version: 57.0a1 17:39:29 INFO - mozversion platform_buildid: 20170918232117 17:39:29 INFO - mozversion platform_changeset: 30a386ff1192cba08a2f899343f81f6946bc6148 17:39:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:39:29 INFO - mozversion platform_version: 57.0a1 17:39:29 INFO - using testdate: 1505781569 17:39:29 INFO - actual date: 1505781569 17:39:29 INFO - starting webserver on 'localhost:36549' 17:39:29 INFO - SUITE-START | Running 2 tests 17:39:29 INFO - TEST-START | dromaeo_css 17:39:29 INFO - Initialising browser for dromaeo_css test... 17:39:29 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36549/getInfo.html -profile /tmp/tmpjwYsyp/profile 17:39:29 INFO - TEST-INFO | started process 31315 (/builds/slave/test/build/application/firefox/firefox http://localhost:36549/getInfo.html) 17:39:35 INFO - TEST-INFO | 31315: exit 0 17:39:35 INFO - Browser initialized. 17:39:35 INFO - Running cycle 1/1 for dromaeo_css test... 17:39:35 INFO - Using env: {'DISPLAY': ':0', 17:39:35 INFO - 'HOME': '/home/cltbld', 17:39:35 INFO - 'JSGC_DISABLE_POISONING': '1', 17:39:35 INFO - 'LANG': 'en_US.UTF-8', 17:39:35 INFO - 'LANGUAGE': 'en_US:en', 17:39:35 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:39:35 INFO - 'LOGNAME': 'cltbld', 17:39:35 INFO - 'MAIL': '/var/mail/cltbld', 17:39:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:39:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:39:35 INFO - 'MOZ_CRASHREPORTER': '1', 17:39:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:35 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:39:35 INFO - 'MOZ_NO_REMOTE': '1', 17:39:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:39:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:39:35 INFO - 'NO_EM_RESTART': '1', 17:39:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:39:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:35 INFO - 'PWD': '/builds/slave/test', 17:39:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:39:35 INFO - 'RUST_BACKTRACE': 'full', 17:39:35 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:39:35 INFO - 'SHELL': '/bin/bash', 17:39:35 INFO - 'SHLVL': '1', 17:39:35 INFO - 'STYLO_FORCE_DISABLED': '1', 17:39:35 INFO - 'TERM': 'linux', 17:39:35 INFO - 'TMOUT': '86400', 17:39:35 INFO - 'USER': 'cltbld', 17:39:35 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505779151.298782-1465186499', 17:39:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:35 INFO - '_': '/tools/buildbot/bin/python'} 17:39:35 INFO - TEST-INFO | started process 31556 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjwYsyp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:39:35 INFO - PID 31556 | 17:39:35 INFO - PID 31556 | (/builds/slave/test/build/application/firefox/firefox:31605): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:39:35 INFO - PID 31556 | 17:39:46 INFO - PID 31556 | RSS: Main: 147906560 17:39:46 INFO - PID 31556 | 17:42:44 INFO - PID 31556 | Cycle 1(1): loaded http://localhost:36549/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36549/tests/dromaeo/cssquery-ext.html) 17:42:45 INFO - PID 31556 | RSS: Main: 149389312 17:42:45 INFO - PID 31556 | 17:45:47 INFO - PID 31556 | Cycle 1(1): loaded http://localhost:36549/tests/dromaeo/cssquery-ext.html (next: http://localhost:36549/tests/dromaeo/cssquery-jquery.html) 17:45:47 INFO - PID 31556 | RSS: Main: 148815872 17:45:47 INFO - PID 31556 | 17:48:49 INFO - PID 31556 | Cycle 1(1): loaded http://localhost:36549/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36549/tests/dromaeo/cssquery-mootools.html) 17:48:49 INFO - PID 31556 | RSS: Main: 151080960 17:48:49 INFO - PID 31556 | 17:51:51 INFO - PID 31556 | Cycle 1(1): loaded http://localhost:36549/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36549/tests/dromaeo/cssquery-prototype.html) 17:51:51 INFO - PID 31556 | RSS: Main: 148774912 17:51:51 INFO - PID 31556 | 17:54:54 INFO - PID 31556 | Cycle 1(1): loaded http://localhost:36549/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36549/tests/dromaeo/cssquery-yui.html) 17:54:55 INFO - PID 31556 | RSS: Main: 150175744 17:54:55 INFO - PID 31556 | 17:57:56 INFO - PID 31556 | Cycle 1(1): loaded http://localhost:36549/tests/dromaeo/cssquery-yui.html (next: http://localhost:36549/tests/dromaeo/cssquery-dojo.html) 17:57:57 INFO - PID 31556 | RSS: Main: 152948736 17:57:57 INFO - PID 31556 | 17:57:57 INFO - PID 31556 | __start_tp_report 17:57:57 INFO - PID 31556 | _x_x_mozilla_page_load 17:57:57 INFO - PID 31556 | _x_x_mozilla_page_load_details 17:57:57 INFO - PID 31556 | |i|pagename|runs| 17:57:57 INFO - PID 31556 | |0;dojo.html;3849.153186299014;3900.3759398496245;3924.058226025753;3924.5486769021563;3947.447357369967;6265.091561723548;6275.090111933772;6371.4584260337815;6384.936150638492;6387.329330420309;6351.809445716624;6374.171357723501;6391.169148010764;6400.231972163347;6402.8079157625225;5648.039833228361;5670.829875103754;5687.943120568803;5693.686847223401;5719.771209151629;5760.56795740319;5772.4227577242145;5853.034249348852;5855.648661080328;5866.442687944638;5757.769689212427;5827.388124246957;5838.4453476919625;5843.883122337551;5850.385709500505;5589.74846131925;5677.6309539880185;5683.3464151622675;5764.682942438164;5785.566082543805;5251.947480525222;5699.458551437607;5770.567207459458;5775.537956963432;5776.884462310731;6252.917862783447;6366.172397588331;6398.360163983611;6438.806835794933;6477.902831457532;6726.293739157367;6751.088603038576;6801.115854938876;6813.897791533131;6917.7232910683515;6885.380315771605;6888.896666550006;6923.307669233036;6931.480138989596;6937.7224911003495;6397.392247736458;6407.359264073555;6427.228732552124;6433.517486188554;6457.580257283308;6888.242293347727;6979.685914133876;7063.293670632998;7081.681324340417;7114.288571142844;6739.898901516482;6747.797566073025;6788;6863.759768408082;6873.037774711544;6809.693563789641;6910.30896910315;6910.792676219721;6927.168739751262;6927.445804335641;6801;6891.414229790524;6893.379595836399;6894.655267236618;6948.096747422803;6710.563813352214;6734.158230221223;6792.76225332111;6825;6873.140857392826;4852.102361063215;4930.6795058321095;4931.5315045070665;4936.358273424504;4952.752362381866;4531.8413855515555;4568.657350698711;4588.77056147198;4613.077384523109;4649.209634362167;6301.779437719658;6314.494840412756;6394.8721025579225;6402.071699603624;6411.935880641227;6738.292479289604;6818.556793808387;6827.2490026098085;6843.349881761224;6911.205211400753;6250.468710159687;6262.655553944577;6381.074744162163;6390.0734393512685;6404.071409645575;5529.778808847682;5586.24585680936;5598.748056337475;5601.243832082698;5609.915851262234;7092.397146242627;7110.92889071113;7113.57318560888;7179.174394944544;7209.639518024078;6780.457563394818;6831.599522097858;6832.282610326043;6848.280930502425;6941.132358455193;7017.894731579133;7041.3310735480045;7078.858422831618;7084.043654106629;7090;6724.764633238009;6752.527323087534;6811.489138314745;6815.795526134224;6825.283345248876;6968.512204145661;7020.613866237406;7046.964765176142;7052.647367631701;7059.541129826544;6693.19681638187;6696.966515167393;6769.796906092825;6783.966080169567;6798.116244888331;6566.4418524425955;6639.834004149935;6661.367170118831;6681.098051763144;6772.898406523807;6560.704768285344;6582.76960306387;6584.045313429621;6613.702383392662;6646.202455705346;6736.259011508632;6741.359570840762;6742.629155396304;6752.493562982698;6789;6467.7736279231885;6506.902396464152;6518.217813862367;6531.2489063756375;6565.901511477427 17:57:57 INFO - PID 31556 | |1;ext.html;895.2944640459924;943.5470973932512;944.3672739264692;983.0906411569297;986.4229425785915;44333.556664433345;44766.776166119125;44768.77615611925;44881.32678009829;44894.77552612232;42624.78687606558;42809;42901.7854910725;44435.77782111093;45372.773136134354;8439.831203375945;8526.147385261485;8601.096884827097;8621.18098780618;8631.13688631135;8349.33205343571;8466.365022623297;8473.533955632438;8491.74524764255;8495.405321627488;8481.745547633582;8516.574171291442;8530.914690853075;8550.871736923951;8603.053664096944;8510.319174466058;8510.872336914921;8521.233089021956;8549.273311768507;8565.657373705044;8358.373122015812;8386.287165590933;8395.580220988926;8400.495970241805;8454.365922555833;39315.803420983;39438.60561394378;39513.40729889054;40947;41235.58764412347;3738.9813050934845;3767.321882061228;3772.830222639988;3773.0755964788527;3773.867914622975;33141;33420;33473.66526334754;33532.83233583841;33706.49440258398;5180.4042535108565;5434.8913021739345;5478.616496845222;5483.314585676791;5489.066858634042;211987;216836;221000;222726;234856.82571587202;54573.72713136488;54826.45173548214;54837.725811370685;54902.725486372314;54928;56793.71603141958;56998.43001570014;57023;57182.42817571771;57471.425285746605;14824;14907.552773416815;15019.324130414157;15028.09831410119;15268.541943741484;12152.696182595506;12166.75666486683;12185.573504927284;12201.69495762613;12218.144729869002;13640.386182621805;13713.588592342247;13734.862651373558;13748.725025499434;13817.516386926409;5601.8599535011135;5609.5501266721485;5663.235463212496;5772.653640781483;5781.797637082682;1068.2628985999636;1091.858058452412;1097.3306283167262;1100.3068067117665;1111.8610173728284;25586.744132558437;25728.356791080372;26092;26191.607125893126;26420;1178.482230541832;1183.514758948844;1187.6496433552122;1190.3274649822822;1210.3101232297681;13694.93152534231;13749.862501375059;13953.441862325597;14065.663761942598;14088.366023528966;267684;269137;269209;271580;271801;58815.41184588185;59031.52421189505;59087;59263.70368148218;59276.70361648164;1482.5255918106102;1493.111598598832;1496.2743069611229;1512.5159948816492;1525.2831169350388;25347.704798376093;25444.363890902874;25486.23541293764;25501.872490637426;25728;40551;40657.79671101626;40829.79585102174;40855.795721021204;40862.182756345304;237388;238454;239178;239364;239378;36697.44953825748;36932;38790.80604597072;39393.40909886411;39465;50584;52327.73836130795;52492;52610;52621;37393.43909841409;37457.25085498329;37512.437313439776;37788.81105594454;38181.618183818915;36716;36882.07794805044;37105.81447092747;37373.2525349486;37659.246815062994;43618.781906091535;43750;44038.77980610076;44066.779666101465;44172.55827441813;36056.819715902304;36266.63733362738;36586.26827463489;36747.816260918524;37035.07412314714;25906.35234119162;26867.596986044835;27322.863385682944;27468.450630987667;27566.5865012029 17:57:57 INFO - PID 31556 | |2;jquery.html;583.7489879351878;591.5977135547826;592.9703514824258;609.1076572820816;614.7571709174877;21405.67891481627;22096.22663206788;22165.889170554165;22201.44496387591;22206.777932220673;23089.653655195143;24371.26886193417;25679.48641027183;25728.22815315539;26152.738472615267;6524.478041756672;6567.310432404601;6570.507211959099;6573.211214654249;6575.605463672171;6564.1138446309615;6670.7331706731675;6685.799426017227;6689.464842812587;6691.732330706766;6627.602343859384;6646.601203927756;6671.166104236971;6674.799756007304;6678.699458524378;6277.623342599436;6651.135352404205;6655.201375834882;6663.2337281212795;6674.866502669944;6175.197224360804;6204.286507051702;6213.813585592439;6219.973704338824;6234.750609975596;29149.854250728822;29278.853605731834;29419.558706619417;29490.70509294901;29509.557356639667;2126.0539060118253;2177.1835561664375;2180.324099529151;2185.672149177636;2190.1020581561643;19018.61962760737;20414.285500007576;20587.794122058887;20587.89706051475;20610.38168854937;2315.710536182977;2479.8760061996827;2525.305540976228;2587.8188526803133;2598.9350266243305;153131;155464;155466;155710;155895;16004.439844605384;16122.178618741673;16172;16185.676286474205;16336.183190840648;25941.870290648803;26188.214353569423;26227.082052128466;26264.47471050568;26277.211683649522;9504.904950950402;10002.549885255181;10096.242781791396;10116.797664046679;10238.744031399126;8734.30125589964;8994.235489983294;9033.412828166149;9056.818863622691;9148.405353651991;9669.709908702609;9766.609335626637;9781.853272200922;9786.608535658635;9916.900830991743;2881.7838662100426;2897.7392034716977;2900.463414268325;2955.143008527546;2960.2895305126613;1030.1810061001522;1047.0785708576557;1058.6453538064682;1060.2684147937898;1065.190455253997;20464.488387790425;20488.795112048985;20505.589888202452;20531.692024619642;21087.472813179793;1095.0965453500894;1095.424901926495;1103.9448027598587;1105.3975583307117;1114.2144787924656;11257.774844503065;11435;11520.94239528797;11534.480948357344;11577.710557236136;588195;594953;595208;603903;627897;127974;128820.35589822178;129619.35190323988;131474.34262828817;131789.34105329413;1216.6714986953473;1235.1354052163522;1291.6706239908763;1319.5249710104354;1322.3652646729624;21723.239686610894;21950.231741888958;22116;22139.55720885541;22600.321990340315;62129.37870621236;62261.37738622737;63715.6814215926;64127;65046;80999.59500202697;81296.18703813123;81413.59293203497;82306;82598.17401826144;15274.541763747106;15526.767098493758;16000.759988600414;16025.599360016093;16029.91985040114;24259.878700606383;24391.14630987907;24669;24775.62836557417;24787.13245036415;19243.422697319103;19424.8057519423;19653.901730491827;20111.29610463627;20128.19487220495;17429.651406971538;17673.558161046076;17702.20340084725;17858.107094645475;17958.730619040463;19885;19925.202991880164;19973.800261997196;20049.59900802005;20151.294704685264;15484.303206355517;15544.455944041903;15556.766648500508;15629.765553516934;15673.373065077725;19197.424077277705;19271.807281927002;19409.126589303232;19604.313849015216;19618.90190549095 17:57:57 INFO - PID 31556 | |3;mootools.html;1377.2631642071494;1468.1484738851468;1471.9852801471982;1482.0959214878922;1483.0286162563525;17402;17896.10519474026;17904.46286611402;17935.461936141903;17943;17541.561460963483;17584.296628134893;17631.559211019732;17650.823491765077;17680.02759848211;2738.8082834201514;2796.4407118576264;2807.3964097718986;2809.2134202423354;2810.156952914128;2685.355514676483;2692.8115031947773;2722.48272828163;2724.4551089782026;2733.439644872796;2741.972580274202;2855.828650280979;2859.756006137337;2860.556613724876;2865.1118153372418;2824.096289187461;2828.6747024092288;2856.31448452371;2856.685764565896;2864.6562412510634;2710.7966902482194;2782.986085069582;2794.706555811631;2795.077624383948;2825.0536070416433;16740.41408550695;16798.664026719518;16805.915970420192;16808.15959202035;16816.32734690611;8082.757517274491;8318.66725330986;8327.875081873777;8329.250367466957;8390.706325278647;5612.550995920316;5716.971415142939;5757;5840.386759390245;5855.180274761537;2051.2205361962506;2080.573482436097;2106.9157233710635;2117.1637203304763;2160.5354848707602;30993.38013239745;31151;31170.376592468252;31284.217894552592;31292.374152517048;6804.149481314836;7040.4302429613845;7042.507024508338;7245.275472452712;7527.059117610299;19991.40025799228;20078.498037548885;20092.59814803725;20106;20132.89933550323;7965.163657815961;8152.755417337489;8164.469309494983;8172.550509721904;8178.7955301117945;7467.4772765906955;7510.774676759706;7610.695572177162;7650.808729781688;7666;5535.861603459945;5537.473939975695;5648.6893220872425;5700.201971723962;5913.58604897653;1620.983790162107;1633.6079340958322;1659.9336026558803;1671.882968192239;1674.983250167507;964.864918911353;978.0806042320196;985.84719368498;1001.7695929936156;1012.1750773119884;8633;8758.91241087581;8759.34304927133;8773.605187766565;8940.50827204497;769.7382889817488;779.3609240422912;779.7270955165646;788.9723859664999;799.8000499875031;5347.652402593897;5700.8859822803315;5918.8816223675285;5936.406359364116;6026.578139530191;23316.88341558281;24904.875475622506;25239.62140567893;25260.368490787878;25288.494230115295;23138.421539461313;24427;24529;24574.13990510359;24957.625635615117;12077.51689932393;12288.938555307166;12303.200291980993;12315.82999615035;12344.81482777759;9642.276829237695;9746.512674366395;9759.804803904024;9806.313558050868;9843.212542996685;20642.807661063744;20735.688964665846;20862;20973.475663107933;21178.152873884872;21575.136994520042;21610.35168944934;21768.89115554412;22309.553808924054;22411.88794056019;12133.39333033327;12205.69485762863;12327.137100402886;12344;12461.93769031149;15154.318055687741;15570.9221453892;15591.06453612787;15613.531594052196;15707.685846283239;12013.279203247834;12304.138710290552;12323.815142772686;12352.320622365856;12532.310722909962;11377.829332560184;11677.299362038304;11767.941160294144;11939.164258501822;12249.448774805333;11176.664700059011;11275.041621462267;11522.76954460923;11530.192886497865;11538.94230528842;8168.346532277523;8306.252437280673;8364.790880228044;8447.239748422671;8497;8454.196851299117;8477.660893564434;8578.78553036179;8579.313654907468;8605.526696031528 17:57:57 INFO - PID 31556 | |4;prototype.html;537.5135502370356;566.4533724955419;566.501478698745;576.538768984812;577.7024832211409;6326.9999999999945;6376.458001069915;6415;6433.874072037393;6502.7724029658975;6274.278457977334;6275.435210831024;6337.936620633804;6348.301971662048;6372.113011063259;5207.270982062514;5234.37187537496;5237.685738855681;5245.527902488775;5272.367315922094;4887.535684110004;5002.499750025005;5217.2695822584865;5246.632735708502;5284.550813180885;5012.448630650625;5013.849584512471;5014.272930425086;5019.67372120811;5077.619178561604;4989.800407983676;4999.700017998932;5000.62495312853;5041.1178043842365;5041.932807548924;4501.504834468205;4564.8174073037035;4570.954290457086;4574.817007319703;4583;6280.466160376373;6319.684015799192;6327.272363678144;6328.240611126648;6360.809175724736;5860.765569377262;5943.910841337383;5953.404659534055;5979.192808970777;5996.730147143389;6713.798586042427;6795.830104247384;6800.829979250509;6803.4897382696;6804.693788779517;5118.795248190068;5130.589088000792;5135.3324067870935;5137.434882162959;5154.92267615986;6798.150231221098;6885.586864788129;6943.340382663639;6977.93022069783;7040.894386584206;5205.193195054772;5218.478152184751;5245.895082098336;5249.396319423316;5279.815206467755;5319.255304257407;5323.707196104174;5330.600204984564;5337.946620533823;5377.112776391929;5844.561657875676;5878.118282257696;5897.262842144732;5924.229850119457;5929.258842644669;6670.299618539983;6721.563098398588;6779.898301525481;6789.321067893171;6831.04365388846;1833.3491610478088;1837.8162183781783;1851.1484717030048;1855.8979256141042;1856.071964017991;1251.0296283353755;1296.2028352563107;1307.267929959226;1312.527490103562;1320.3662242123835;6102.969485152635;6205.503559715212;6287.371262873768;6290.622562646256;6318.241810982711;6663.20041595002;6728.932710672929;6766.545192783575;6803.727850885909;6846.383825455733;6161.706041731197;6211.3167551569295;6240.812775616739;6280.371962803774;6300.905486417708;3568.232829941575;3611.6749492545273;3617.4264195075225;3629.4393410833595;3632.3824949758605;7012.333828286304;7012.859742805217;7015.3864611139725;7015.719371225094;7028.367446929698;7001.649917504104;7004.614746189009;7007.404370628452;7040.859182816417;7067.43460523157;6914.274001229899;6962.373386395248;6984.825379365557;7009.334113259232;7029.824254393681;6642.368974947372;6706.12820333373;6713.832154196184;6732.249615100011;6746.460283177236;6770.627615481196;6783.457323414016;6847.931520684929;6850.931490685229;6851.383375496229;6984.930150698428;7000;7017.087778588751;7080.114985626797;7089.298568343457;5138.614603904647;5187.429382767817;5202.921956170736;5211.791528338824;5229.398619158694;6450.387213214737;6562;6853.4859885507785;6886.139232595926;6973.3375329343635;6559.375640173571;6611.966940165461;6688;6716.1940567130305;6731.495137864582;6543.691261747575;6621.172353455818;6664.366885145903;6669.833254168685;6707.932920670731;6399.840003999937;6533.150690410216;6587.011948207807;6600.471962243105;6726.293739157318;6731.158605174353;6751.898721519279;6788.355106264897;6808.693608787517;6864.965675171592;6501.382368674968;6565.376289252514;6568.573042752206;6628.270890201978;6642.800715978528 17:57:57 INFO - PID 31556 | |5;yui.html;965.599276300335;972.2027937091584;972.7519482531953;984.5126662302162;993.1806259835635;18565.350212742556;18705.43883683488;18814.34149804757;18845.811541884577;18891.52771180721;17126.14369281537;17326.220320085595;17389.39137130201;17641.911790441063;17836.197371118298;1035.3425574760024;1057.9682609521726;1063.5639387850983;1063.6596289187464;1065.0414626835832;1042.2495803021811;1042.6142327338896;1042.9165666746642;1043.9582416703322;1044.5873879817468;1062.1237479079753;1095.1348434736549;1103.564092183587;1104.1222228328497;1108.257467496775;1097.5664612478026;1098.505672447398;1101.4823033174434;1102.2559772153763;1104.8011357955565;787.2481779900181;813.3533840596681;813.4427916876958;821.8191997760483;822.45717826235;17646.91176544122;17815.910920445443;17883.19525621337;17924.55188620282;17971;22535.54928901413;22676.65985010226;23669.171578994654;23829.761702382926;23913.641295380585;16168.11075390853;16472.917635411748;16544.090075045868;16594.75107873383;16610.75083873743;3751.118487155516;3796.1268908151005;3798.582155962842;3799.145192331703;3813.904652383713;117576;158576.2071189648;160123;162615;164044;18441.354552590863;18585.25658973653;18883.81116188848;19064.33274835374;19076;34989.47515787265;35142.472862907074;35233.64766352355;35289.82355088208;35347.4697879532;9332.580033898355;9335.953320233491;9349.579268932914;9350.812983740287;9353.625854965725;4339.956600433955;4364.650827933758;4409.757463339483;4450.910981780346;4458.6878918475395;5563.165525171256;5619.044762390404;5634.154876768517;5641.943580564224;5668.971655141698;1120.383788916093;1149.5804031528432;1156.444906444911;1170.5317872850928;1172.3434876469205;709.8757717399434;728.9307515785991;737.3953358246187;739.6080077558902;757.8332766791297;13040.80438793419;13145.73708525824;13248.754055256524;14243.501477448239;14248.572542823731;711.4344096443236;727.054828722669;728.9380402665832;737.1964558631117;740.3743836458184;6300.464460520815;6442.903356449657;6569.835754106186;6578.5395022347975;6654.6672666366485;144310.33879584764;145490.5450945477;147632;150797;152831.23584382006;129517.69066158467;130836.3458182703;134911.32544337216;137056;139217;117737.4113129446;118930.40534797443;120918.39540802415;122211.38894305471;122991.38504307422;13480.5281815136;13629.500754916753;13833.584992450242;13928.303584820922;14022.439102435788;54826.72586637041;54922.450775491736;55555;56098.15852762294;56977.71511142418;72870.27129728635;73178;73790.63104684443;74302.62848685723;74362;20622;20692.58614827665;20802.791972080086;20842.583148336646;21037.474063148544;22779.316620501413;22781;22992.885035575386;23125.768742313034;23343.533129336978;19769.604607907473;19992.20031198736;20079.899600501903;20087.19651213935;20088.79911200869;20888;21267.680984784933;21291.68062479095;21346.359609211748;21542.67685984743;20571.07430165616;20765.273215437388;20777;20843.37469875906;20933.26733564318;12768.170068945488;13058.281794501394;13099.345032748133;13113.40989655487;13446.663833404244;14385.496507622183;14489.927550362181;14496.275186240857;14502;14512.63718407006 17:57:57 INFO - PID 31556 | __end_tp_report 17:57:57 INFO - PID 31556 | __start_cc_report 17:57:57 INFO - PID 31556 | _x_x_mozilla_cycle_collect,285 17:57:57 INFO - PID 31556 | __end_cc_report 17:57:57 INFO - PID 31556 | __startTimestamp1505782677187__endTimestamp 17:57:57 INFO - PID 31556 | 17:57:57 INFO - PID 31556 | ------- Summary: start ------- 17:57:57 INFO - PID 31556 | Number of tests: 6 17:57:57 INFO - PID 31556 | 17:57:57 INFO - PID 31556 | [#0] dojo.html Cycles:165 Average:6333.70 Median:6582.77 stddev:749.60 (11.4%) stddev-sans-first:726.12 17:57:57 INFO - PID 31556 | Values: 3849.2 3900.4 3924.1 3924.5 3947.4 6265.1 6275.1 6371.5 6384.9 6387.3 6351.8 6374.2 6391.2 6400.2 6402.8 5648.0 5670.8 5687.9 5693.7 5719.8 5760.6 5772.4 5853.0 5855.6 5866.4 5757.8 5827.4 5838.4 5843.9 5850.4 5589.7 5677.6 5683.3 5764.7 5785.6 5251.9 5699.5 5770.6 5775.5 5776.9 6252.9 6366.2 6398.4 6438.8 6477.9 6726.3 6751.1 6801.1 6813.9 6917.7 6885.4 6888.9 6923.3 6931.5 6937.7 6397.4 6407.4 6427.2 6433.5 6457.6 6888.2 6979.7 7063.3 7081.7 7114.3 6739.9 6747.8 6788.0 6863.8 6873.0 6809.7 6910.3 6910.8 6927.2 6927.4 6801.0 6891.4 6893.4 6894.7 6948.1 6710.6 6734.2 6792.8 6825.0 6873.1 4852.1 4930.7 4931.5 4936.4 4952.8 4531.8 4568.7 4588.8 4613.1 4649.2 6301.8 6314.5 6394.9 6402.1 6411.9 6738.3 6818.6 6827.2 6843.3 6911.2 6250.5 6262.7 6381.1 6390.1 6404.1 5529.8 5586.2 5598.7 5601.2 5609.9 7092.4 7110.9 7113.6 7179.2 7209.6 6780.5 6831.6 6832.3 6848.3 6941.1 7017.9 7041.3 7078.9 7084.0 7090.0 6724.8 6752.5 6811.5 6815.8 6825.3 6968.5 7020.6 7047.0 7052.6 7059.5 6693.2 6697.0 6769.8 6784.0 6798.1 6566.4 6639.8 6661.4 6681.1 6772.9 6560.7 6582.8 6584.0 6613.7 6646.2 6736.3 6741.4 6742.6 6752.5 6789.0 6467.8 6506.9 6518.2 6531.2 6565.9 17:57:57 INFO - PID 31556 | 17:57:57 INFO - PID 31556 | [#1] ext.html Cycles:180 Average:42913.65 Median:37985.21 stddev:63468.20 (167.1%) stddev-sans-first:63567.83 17:57:57 INFO - PID 31556 | Values: 895.3 943.5 944.4 983.1 986.4 44333.6 44766.8 44768.8 44881.3 44894.8 42624.8 42809.0 42901.8 44435.8 45372.8 8439.8 8526.1 8601.1 8621.2 8631.1 8349.3 8466.4 8473.5 8491.7 8495.4 8481.7 8516.6 8530.9 8550.9 8603.1 8510.3 8510.9 8521.2 8549.3 8565.7 8358.4 8386.3 8395.6 8400.5 8454.4 39315.8 39438.6 39513.4 40947.0 41235.6 3739.0 3767.3 3772.8 3773.1 3773.9 33141.0 33420.0 33473.7 33532.8 33706.5 5180.4 5434.9 5478.6 5483.3 5489.1 211987.0 216836.0 221000.0 222726.0 234856.8 54573.7 54826.5 54837.7 54902.7 54928.0 56793.7 56998.4 57023.0 57182.4 57471.4 14824.0 14907.6 15019.3 15028.1 15268.5 12152.7 12166.8 12185.6 12201.7 12218.1 13640.4 13713.6 13734.9 13748.7 13817.5 5601.9 5609.6 5663.2 5772.7 5781.8 1068.3 1091.9 1097.3 1100.3 1111.9 25586.7 25728.4 26092.0 26191.6 26420.0 1178.5 1183.5 1187.6 1190.3 1210.3 13694.9 13749.9 13953.4 14065.7 14088.4 267684.0 269137.0 269209.0 271580.0 271801.0 58815.4 59031.5 59087.0 59263.7 59276.7 1482.5 1493.1 1496.3 1512.5 1525.3 25347.7 25444.4 25486.2 25501.9 25728.0 40551.0 40657.8 40829.8 40855.8 40862.2 237388.0 238454.0 239178.0 239364.0 239378.0 36697.4 36932.0 38790.8 39393.4 39465.0 50584.0 52327.7 52492.0 52610.0 52621.0 37393.4 37457.3 37512.4 37788.8 38181.6 36716.0 36882.1 37105.8 37373.3 37659.2 43618.8 43750.0 44038.8 44066.8 44172.6 36056.8 36266.6 36586.3 36747.8 37035.1 25906.4 26867.6 27322.9 27468.5 27566.6 17:57:57 INFO - PID 31556 | 17:57:57 INFO - PID 31556 | [#2] jquery.html Cycles:180 Average:39758.08 Median:22183.67 stddev:100952.66 (455.1%) stddev-sans-first:101193.01 17:57:57 INFO - PID 31556 | Values: 583.7 591.6 593.0 609.1 614.8 21405.7 22096.2 22165.9 22201.4 22206.8 23089.7 24371.3 25679.5 25728.2 26152.7 6524.5 6567.3 6570.5 6573.2 6575.6 6564.1 6670.7 6685.8 6689.5 6691.7 6627.6 6646.6 6671.2 6674.8 6678.7 6277.6 6651.1 6655.2 6663.2 6674.9 6175.2 6204.3 6213.8 6220.0 6234.8 29149.9 29278.9 29419.6 29490.7 29509.6 2126.1 2177.2 2180.3 2185.7 2190.1 19018.6 20414.3 20587.8 20587.9 20610.4 2315.7 2479.9 2525.3 2587.8 2598.9 153131.0 155464.0 155466.0 155710.0 155895.0 16004.4 16122.2 16172.0 16185.7 16336.2 25941.9 26188.2 26227.1 26264.5 26277.2 9504.9 10002.5 10096.2 10116.8 10238.7 8734.3 8994.2 9033.4 9056.8 9148.4 9669.7 9766.6 9781.9 9786.6 9916.9 2881.8 2897.7 2900.5 2955.1 2960.3 1030.2 1047.1 1058.6 1060.3 1065.2 20464.5 20488.8 20505.6 20531.7 21087.5 1095.1 1095.4 1103.9 1105.4 1114.2 11257.8 11435.0 11520.9 11534.5 11577.7 588195.0 594953.0 595208.0 603903.0 627897.0 127974.0 128820.4 129619.4 131474.3 131789.3 1216.7 1235.1 1291.7 1319.5 1322.4 21723.2 21950.2 22116.0 22139.6 22600.3 62129.4 62261.4 63715.7 64127.0 65046.0 80999.6 81296.2 81413.6 82306.0 82598.2 15274.5 15526.8 16000.8 16025.6 16029.9 24259.9 24391.1 24669.0 24775.6 24787.1 19243.4 19424.8 19653.9 20111.3 20128.2 17429.7 17673.6 17702.2 17858.1 17958.7 19885.0 19925.2 19973.8 20049.6 20151.3 15484.3 15544.5 15556.8 15629.8 15673.4 19197.4 19271.8 19409.1 19604.3 19618.9 17:57:57 INFO - PID 31556 | 17:57:57 INFO - PID 31556 | [#3] mootools.html Cycles:180 Average:10437.55 Median:2723.47 stddev:7765.76 (285.1%) stddev-sans-first:7757.71 17:57:57 INFO - PID 31556 | Values: 1377.3 1468.1 1472.0 1482.1 1483.0 17402.0 17896.1 17904.5 17935.5 17943.0 17541.6 17584.3 17631.6 17650.8 17680.0 2738.8 2796.4 2807.4 2809.2 2810.2 2685.4 2692.8 2722.5 2724.5 2733.4 2742.0 2855.8 2859.8 2860.6 2865.1 2824.1 2828.7 2856.3 2856.7 2864.7 2710.8 2783.0 2794.7 2795.1 2825.1 16740.4 16798.7 16805.9 16808.2 16816.3 8082.8 8318.7 8327.9 8329.3 8390.7 5612.6 5717.0 5757.0 5840.4 5855.2 2051.2 2080.6 2106.9 2117.2 2160.5 30993.4 31151.0 31170.4 31284.2 31292.4 6804.1 7040.4 7042.5 7245.3 7527.1 19991.4 20078.5 20092.6 20106.0 20132.9 7965.2 8152.8 8164.5 8172.6 8178.8 7467.5 7510.8 7610.7 7650.8 7666.0 5535.9 5537.5 5648.7 5700.2 5913.6 1621.0 1633.6 1659.9 1671.9 1675.0 964.9 978.1 985.8 1001.8 1012.2 8633.0 8758.9 8759.3 8773.6 8940.5 769.7 779.4 779.7 789.0 799.8 5347.7 5700.9 5918.9 5936.4 6026.6 23316.9 24904.9 25239.6 25260.4 25288.5 23138.4 24427.0 24529.0 24574.1 24957.6 12077.5 12288.9 12303.2 12315.8 12344.8 9642.3 9746.5 9759.8 9806.3 9843.2 20642.8 20735.7 20862.0 20973.5 21178.2 21575.1 21610.4 21768.9 22309.6 22411.9 12133.4 12205.7 12327.1 12344.0 12461.9 15154.3 15570.9 15591.1 15613.5 15707.7 12013.3 12304.1 12323.8 12352.3 12532.3 11377.8 11677.3 11767.9 11939.2 12249.4 11176.7 11275.0 11522.8 11530.2 11538.9 8168.3 8306.3 8364.8 8447.2 8497.0 8454.2 8477.7 8578.8 8579.3 8605.5 17:57:57 INFO - PID 31556 | 17:57:57 INFO - PID 31556 | [#4] prototype.html Cycles:180 Average:5704.98 Median:6327.76 stddev:1589.67 (25.1%) stddev-sans-first:1546.09 17:57:57 INFO - PID 31556 | Values: 537.5 566.5 566.5 576.5 577.7 6327.0 6376.5 6415.0 6433.9 6502.8 6274.3 6275.4 6337.9 6348.3 6372.1 5207.3 5234.4 5237.7 5245.5 5272.4 4887.5 5002.5 5217.3 5246.6 5284.6 5012.4 5013.8 5014.3 5019.7 5077.6 4989.8 4999.7 5000.6 5041.1 5041.9 4501.5 4564.8 4571.0 4574.8 4583.0 6280.5 6319.7 6327.3 6328.2 6360.8 5860.8 5943.9 5953.4 5979.2 5996.7 6713.8 6795.8 6800.8 6803.5 6804.7 5118.8 5130.6 5135.3 5137.4 5154.9 6798.2 6885.6 6943.3 6977.9 7040.9 5205.2 5218.5 5245.9 5249.4 5279.8 5319.3 5323.7 5330.6 5337.9 5377.1 5844.6 5878.1 5897.3 5924.2 5929.3 6670.3 6721.6 6779.9 6789.3 6831.0 1833.3 1837.8 1851.1 1855.9 1856.1 1251.0 1296.2 1307.3 1312.5 1320.4 6103.0 6205.5 6287.4 6290.6 6318.2 6663.2 6728.9 6766.5 6803.7 6846.4 6161.7 6211.3 6240.8 6280.4 6300.9 3568.2 3611.7 3617.4 3629.4 3632.4 7012.3 7012.9 7015.4 7015.7 7028.4 7001.6 7004.6 7007.4 7040.9 7067.4 6914.3 6962.4 6984.8 7009.3 7029.8 6642.4 6706.1 6713.8 6732.2 6746.5 6770.6 6783.5 6847.9 6850.9 6851.4 6984.9 7000.0 7017.1 7080.1 7089.3 5138.6 5187.4 5202.9 5211.8 5229.4 6450.4 6562.0 6853.5 6886.1 6973.3 6559.4 6612.0 6688.0 6716.2 6731.5 6543.7 6621.2 6664.4 6669.8 6707.9 6399.8 6533.2 6587.0 6600.5 6726.3 6731.2 6751.9 6788.4 6808.7 6865.0 6501.4 6565.4 6568.6 6628.3 6642.8 17:57:57 INFO - PID 31556 | 17:57:57 INFO - PID 31556 | [#5] yui.html Cycles:180 Average:28669.50 Median:19880.90 stddev:42179.83 (212.2%) stddev-sans-first:42246.86 17:57:57 INFO - PID 31556 | Values: 965.6 972.2 972.8 984.5 993.2 18565.4 18705.4 18814.3 18845.8 18891.5 17126.1 17326.2 17389.4 17641.9 17836.2 1035.3 1058.0 1063.6 1063.7 1065.0 1042.2 1042.6 1042.9 1044.0 1044.6 1062.1 1095.1 1103.6 1104.1 1108.3 1097.6 1098.5 1101.5 1102.3 1104.8 787.2 813.4 813.4 821.8 822.5 17646.9 17815.9 17883.2 17924.6 17971.0 22535.5 22676.7 23669.2 23829.8 23913.6 16168.1 16472.9 16544.1 16594.8 16610.8 3751.1 3796.1 3798.6 3799.1 3813.9 117576.0 158576.2 160123.0 162615.0 164044.0 18441.4 18585.3 18883.8 19064.3 19076.0 34989.5 35142.5 35233.6 35289.8 35347.5 9332.6 9336.0 9349.6 9350.8 9353.6 4340.0 4364.7 4409.8 4450.9 4458.7 5563.2 5619.0 5634.2 5641.9 5669.0 1120.4 1149.6 1156.4 1170.5 1172.3 709.9 728.9 737.4 739.6 757.8 13040.8 13145.7 13248.8 14243.5 14248.6 711.4 727.1 728.9 737.2 740.4 6300.5 6442.9 6569.8 6578.5 6654.7 144310.3 145490.5 147632.0 150797.0 152831.2 129517.7 130836.3 134911.3 137056.0 139217.0 117737.4 118930.4 120918.4 122211.4 122991.4 13480.5 13629.5 13833.6 13928.3 14022.4 54826.7 54922.5 55555.0 56098.2 56977.7 72870.3 73178.0 73790.6 74302.6 74362.0 20622.0 20692.6 20802.8 20842.6 21037.5 22779.3 22781.0 22992.9 23125.8 23343.5 19769.6 19992.2 20079.9 20087.2 20088.8 20888.0 21267.7 21291.7 21346.4 21542.7 20571.1 20765.3 20777.0 20843.4 20933.3 12768.2 13058.3 13099.3 13113.4 13446.7 14385.5 14489.9 14496.3 14502.0 14512.6 17:57:57 INFO - PID 31556 | -------- Summary: end -------- 17:57:57 INFO - PID 31556 | 17:57:57 INFO - TEST-INFO | 31556: exit 0 17:57:57 INFO - TEST-OK | dromaeo_css | took 1108525ms 17:57:57 INFO - TEST-START | kraken 17:57:57 INFO - Initialising browser for kraken test... 17:57:57 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36549/getInfo.html -profile /tmp/tmpZ4f9tg/profile 17:57:57 INFO - TEST-INFO | started process 31919 (/builds/slave/test/build/application/firefox/firefox http://localhost:36549/getInfo.html) 17:58:03 INFO - TEST-INFO | 31919: exit 0 17:58:03 INFO - Browser initialized. 17:58:03 INFO - Running cycle 1/1 for kraken test... 17:58:03 INFO - Using env: {'DISPLAY': ':0', 17:58:03 INFO - 'HOME': '/home/cltbld', 17:58:03 INFO - 'JSGC_DISABLE_POISONING': '1', 17:58:03 INFO - 'LANG': 'en_US.UTF-8', 17:58:03 INFO - 'LANGUAGE': 'en_US:en', 17:58:03 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:58:03 INFO - 'LOGNAME': 'cltbld', 17:58:03 INFO - 'MAIL': '/var/mail/cltbld', 17:58:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:58:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:58:03 INFO - 'MOZ_CRASHREPORTER': '1', 17:58:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:58:03 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:58:03 INFO - 'MOZ_NO_REMOTE': '1', 17:58:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:58:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:58:03 INFO - 'NO_EM_RESTART': '1', 17:58:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:58:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:58:03 INFO - 'PWD': '/builds/slave/test', 17:58:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:58:03 INFO - 'RUST_BACKTRACE': 'full', 17:58:03 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:58:03 INFO - 'SHELL': '/bin/bash', 17:58:03 INFO - 'SHLVL': '1', 17:58:03 INFO - 'STYLO_FORCE_DISABLED': '1', 17:58:03 INFO - 'TERM': 'linux', 17:58:03 INFO - 'TMOUT': '86400', 17:58:03 INFO - 'USER': 'cltbld', 17:58:03 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505779151.298782-1465186499', 17:58:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:58:03 INFO - '_': '/tools/buildbot/bin/python'} 17:58:03 INFO - TEST-INFO | started process 32157 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ4f9tg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:58:04 INFO - PID 32157 | 17:58:04 INFO - PID 32157 | (/builds/slave/test/build/application/firefox/firefox:32208): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:58:04 INFO - PID 32157 | 17:58:14 INFO - PID 32157 | RSS: Main: 143425536 17:58:14 INFO - PID 32157 | 17:58:17 INFO - PID 32157 | Cycle 1(1): loaded http://localhost:36549/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36549/tests/kraken/driver.html?testName=audio-beat-detection) 17:58:18 INFO - PID 32157 | RSS: Main: 148791296 17:58:18 INFO - PID 32157 | 17:58:20 INFO - PID 32157 | Cycle 1(1): loaded http://localhost:36549/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36549/tests/kraken/driver.html?testName=audio-dft) 17:58:21 INFO - PID 32157 | RSS: Main: 149454848 17:58:21 INFO - PID 32157 | 17:58:24 INFO - PID 32157 | Cycle 1(1): loaded http://localhost:36549/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36549/tests/kraken/driver.html?testName=audio-fft) 17:58:24 INFO - PID 32157 | RSS: Main: 145526784 17:58:24 INFO - PID 32157 | 17:58:26 INFO - PID 32157 | Cycle 1(1): loaded http://localhost:36549/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36549/tests/kraken/driver.html?testName=audio-oscillator) 17:58:27 INFO - PID 32157 | RSS: Main: 146784256 17:58:27 INFO - PID 32157 | 17:58:29 INFO - PID 32157 | Cycle 1(1): loaded http://localhost:36549/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36549/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:58:30 INFO - PID 32157 | RSS: Main: 146710528 17:58:30 INFO - PID 32157 | 17:58:33 INFO - PID 32157 | Cycle 1(1): loaded http://localhost:36549/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36549/tests/kraken/driver.html?testName=imaging-darkroom) 17:58:33 INFO - PID 32157 | RSS: Main: 146825216 17:58:33 INFO - PID 32157 | 17:58:37 INFO - PID 32157 | Cycle 1(1): loaded http://localhost:36549/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36549/tests/kraken/driver.html?testName=imaging-desaturate) 17:58:37 INFO - PID 32157 | RSS: Main: 148107264 17:58:37 INFO - PID 32157 | 17:58:40 INFO - PID 32157 | Cycle 1(1): loaded http://localhost:36549/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36549/tests/kraken/driver.html?testName=json-parse-financial) 17:58:41 INFO - PID 32157 | RSS: Main: 149852160 17:58:41 INFO - PID 32157 | 17:58:42 INFO - PID 32157 | Cycle 1(1): loaded http://localhost:36549/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36549/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:58:43 INFO - PID 32157 | RSS: Main: 149889024 17:58:43 INFO - PID 32157 | 17:58:45 INFO - PID 32157 | Cycle 1(1): loaded http://localhost:36549/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36549/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:58:45 INFO - PID 32157 | RSS: Main: 149766144 17:58:45 INFO - PID 32157 | 17:58:47 INFO - PID 32157 | Cycle 1(1): loaded http://localhost:36549/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36549/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:58:48 INFO - PID 32157 | RSS: Main: 149577728 17:58:48 INFO - PID 32157 | 17:58:50 INFO - PID 32157 | Cycle 1(1): loaded http://localhost:36549/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36549/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:58:51 INFO - PID 32157 | RSS: Main: 149856256 17:58:51 INFO - PID 32157 | 17:58:54 INFO - PID 32157 | Cycle 1(1): loaded http://localhost:36549/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36549/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:58:54 INFO - PID 32157 | RSS: Main: 150478848 17:58:54 INFO - PID 32157 | 17:58:56 INFO - PID 32157 | Cycle 1(1): loaded http://localhost:36549/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36549/tests/kraken/driver.html?testName=ai-astar) 17:58:56 INFO - PID 32157 | RSS: Main: 151834624 17:58:56 INFO - PID 32157 | 17:58:56 INFO - PID 32157 | __start_tp_report 17:58:56 INFO - PID 32157 | _x_x_mozilla_page_load 17:58:56 INFO - PID 32157 | _x_x_mozilla_page_load_details 17:58:56 INFO - PID 32157 | |i|pagename|runs| 17:58:56 INFO - PID 32157 | |0;ai-astar;108;110;106;105;105;110;107;106;106;104 17:58:56 INFO - PID 32157 | |1;audio-beat-detection;112;110;113;113;112;113;115;135;113;115 17:58:56 INFO - PID 32157 | |2;audio-dft;161;162;160;163;162;163;161;161;162;164 17:58:56 INFO - PID 32157 | |3;audio-fft;73;75;74;75;73;73;75;83;74;81 17:58:56 INFO - PID 32157 | |4;audio-oscillator;79;78;78;77;77;78;78;78;79;78 17:58:56 INFO - PID 32157 | |5;imaging-gaussian-blur;114;113;113;113;113;113;114;113;114;110 17:58:56 INFO - PID 32157 | |6;imaging-darkroom;149;149;150;150;148;147;149;150;150;151 17:58:56 INFO - PID 32157 | |7;imaging-desaturate;94;93;94;94;94;95;93;94;97;94 17:58:56 INFO - PID 32157 | |8;json-parse-financial;49;44;45;44;46;44;45;47;45;43 17:58:56 INFO - PID 32157 | |9;json-stringify-tinderbox;37;36;36;37;39;40;41;37;36;37 17:58:56 INFO - PID 32157 | |10;stanford-crypto-aes;76;71;73;71;72;70;71;71;71;70 17:58:56 INFO - PID 32157 | |11;stanford-crypto-ccm;106;110;116;105;112;106;108;111;107;114 17:58:56 INFO - PID 32157 | |12;stanford-crypto-pbkdf2;169;154;157;159;155;152;159;158;171;156 17:58:56 INFO - PID 32157 | |13;stanford-crypto-sha256-iterative;62;62;61;59;59;58;60;64;59;63 17:58:56 INFO - PID 32157 | __end_tp_report 17:58:56 INFO - PID 32157 | __start_cc_report 17:58:56 INFO - PID 32157 | _x_x_mozilla_cycle_collect,696 17:58:56 INFO - PID 32157 | __end_cc_report 17:58:56 INFO - PID 32157 | __startTimestamp1505782736687__endTimestamp 17:58:56 INFO - PID 32157 | 17:58:56 INFO - PID 32157 | ------- Summary: start ------- 17:58:56 INFO - PID 32157 | Number of tests: 14 17:58:56 INFO - PID 32157 | 17:58:56 INFO - PID 32157 | [#0] ai-astar Cycles:10 Average:106.70 Median:106.50 stddev:2.06 (1.9%) stddev-sans-first:2.13 17:58:56 INFO - PID 32157 | Values: 108.0 110.0 106.0 105.0 105.0 110.0 107.0 106.0 106.0 104.0 17:58:56 INFO - PID 32157 | 17:58:56 INFO - PID 32157 | [#1] audio-beat-detection Cycles:10 Average:115.10 Median:113.00 stddev:7.14 (6.3%) stddev-sans-first:7.49 17:58:56 INFO - PID 32157 | Values: 112.0 110.0 113.0 113.0 112.0 113.0 115.0 135.0 113.0 115.0 17:58:56 INFO - PID 32157 | 17:58:56 INFO - PID 32157 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.20 (0.7%) stddev-sans-first:1.22 17:58:56 INFO - PID 32157 | Values: 161.0 162.0 160.0 163.0 162.0 163.0 161.0 161.0 162.0 164.0 17:58:56 INFO - PID 32157 | 17:58:56 INFO - PID 32157 | [#3] audio-fft Cycles:10 Average:75.60 Median:75.00 stddev:3.50 (4.7%) stddev-sans-first:3.59 17:58:56 INFO - PID 32157 | Values: 73.0 75.0 74.0 75.0 73.0 73.0 75.0 83.0 74.0 81.0 17:58:56 INFO - PID 32157 | 17:58:56 INFO - PID 32157 | [#4] audio-oscillator Cycles:10 Average:78.00 Median:78.00 stddev:0.67 (0.9%) stddev-sans-first:0.60 17:58:56 INFO - PID 32157 | Values: 79.0 78.0 78.0 77.0 77.0 78.0 78.0 78.0 79.0 78.0 17:58:56 INFO - PID 32157 | 17:58:56 INFO - PID 32157 | [#5] imaging-gaussian-blur Cycles:10 Average:113.00 Median:113.00 stddev:1.15 (1.0%) stddev-sans-first:1.17 17:58:56 INFO - PID 32157 | Values: 114.0 113.0 113.0 113.0 113.0 113.0 114.0 113.0 114.0 110.0 17:58:56 INFO - PID 32157 | 17:58:56 INFO - PID 32157 | [#6] imaging-darkroom Cycles:10 Average:149.30 Median:150.00 stddev:1.16 (0.8%) stddev-sans-first:1.22 17:58:56 INFO - PID 32157 | Values: 149.0 149.0 150.0 150.0 148.0 147.0 149.0 150.0 150.0 151.0 17:58:56 INFO - PID 32157 | 17:58:56 INFO - PID 32157 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:1.14 (1.2%) stddev-sans-first:1.20 17:58:56 INFO - PID 32157 | Values: 94.0 93.0 94.0 94.0 94.0 95.0 93.0 94.0 97.0 94.0 17:58:56 INFO - PID 32157 | 17:58:56 INFO - PID 32157 | [#8] json-parse-financial Cycles:10 Average:45.20 Median:45.00 stddev:1.75 (3.9%) stddev-sans-first:1.20 17:58:56 INFO - PID 32157 | Values: 49.0 44.0 45.0 44.0 46.0 44.0 45.0 47.0 45.0 43.0 17:58:56 INFO - PID 32157 | 17:58:56 INFO - PID 32157 | [#9] json-stringify-tinderbox Cycles:10 Average:37.60 Median:37.00 stddev:1.78 (4.8%) stddev-sans-first:1.87 17:58:56 INFO - PID 32157 | Values: 37.0 36.0 36.0 37.0 39.0 40.0 41.0 37.0 36.0 37.0 17:58:56 INFO - PID 32157 | 17:58:56 INFO - PID 32157 | [#10] stanford-crypto-aes Cycles:10 Average:71.60 Median:71.00 stddev:1.78 (2.5%) stddev-sans-first:0.93 17:58:56 INFO - PID 32157 | Values: 76.0 71.0 73.0 71.0 72.0 70.0 71.0 71.0 71.0 70.0 17:58:56 INFO - PID 32157 | 17:58:56 INFO - PID 32157 | [#11] stanford-crypto-ccm Cycles:10 Average:109.50 Median:110.50 stddev:3.72 (3.4%) stddev-sans-first:3.72 17:58:56 INFO - PID 32157 | Values: 106.0 110.0 116.0 105.0 112.0 106.0 108.0 111.0 107.0 114.0 17:58:56 INFO - PID 32157 | 17:58:56 INFO - PID 32157 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.00 Median:158.50 stddev:6.22 (3.9%) stddev-sans-first:5.44 17:58:56 INFO - PID 32157 | Values: 169.0 154.0 157.0 159.0 155.0 152.0 159.0 158.0 171.0 156.0 17:58:56 INFO - PID 32157 | 17:58:56 INFO - PID 32157 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.70 Median:61.50 stddev:2.00 (3.3%) stddev-sans-first:2.07 17:58:56 INFO - PID 32157 | Values: 62.0 62.0 61.0 59.0 59.0 58.0 60.0 64.0 59.0 63.0 17:58:56 INFO - PID 32157 | -------- Summary: end -------- 17:58:56 INFO - PID 32157 | 17:58:57 INFO - PID 32157 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:58:57 INFO - TEST-INFO | 32157: exit 0 17:58:57 INFO - TEST-OK | kraken | took 59503ms 17:58:57 INFO - SUITE-END | took 1168s 17:58:57 INFO - Completed test suite (00:19:28) 17:58:57 INFO - javascript benchmark 17:58:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9120.829138336418, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3849.153186299014, 3900.3759398496245, 3924.058226025753, 3924.5486769021563, 3947.447357369967, 6265.091561723548, 6275.090111933772, 6371.4584260337815, 6384.936150638492, 6387.329330420309, 6351.809445716624, 6374.171357723501, 6391.169148010764, 6400.231972163347, 6402.8079157625225, 5648.039833228361, 5670.829875103754, 5687.943120568803, 5693.686847223401, 5719.771209151629, 5760.56795740319, 5772.4227577242145, 5853.034249348852, 5855.648661080328, 5866.442687944638, 5757.769689212427, 5827.388124246957, 5838.4453476919625, 5843.883122337551, 5850.385709500505, 5589.74846131925, 5677.6309539880185, 5683.3464151622675, 5764.682942438164, 5785.566082543805, 5251.947480525222, 5699.458551437607, 5770.567207459458, 5775.537956963432, 5776.884462310731, 6252.917862783447, 6366.172397588331, 6398.360163983611, 6438.806835794933, 6477.902831457532, 6726.293739157367, 6751.088603038576, 6801.115854938876, 6813.897791533131, 6917.7232910683515, 6885.380315771605, 6888.896666550006, 6923.307669233036, 6931.480138989596, 6937.7224911003495, 6397.392247736458, 6407.359264073555, 6427.228732552124, 6433.517486188554, 6457.580257283308, 6888.242293347727, 6979.685914133876, 7063.293670632998, 7081.681324340417, 7114.288571142844, 6739.898901516482, 6747.797566073025, 6788.0, 6863.759768408082, 6873.037774711544, 6809.693563789641, 6910.30896910315, 6910.792676219721, 6927.168739751262, 6927.445804335641, 6801.0, 6891.414229790524, 6893.379595836399, 6894.655267236618, 6948.096747422803, 6710.563813352214, 6734.158230221223, 6792.76225332111, 6825.0, 6873.140857392826, 4852.102361063215, 4930.6795058321095, 4931.5315045070665, 4936.358273424504, 4952.752362381866, 4531.8413855515555, 4568.657350698711, 4588.77056147198, 4613.077384523109, 4649.209634362167, 6301.779437719658, 6314.494840412756, 6394.8721025579225, 6402.071699603624, 6411.935880641227, 6738.292479289604, 6818.556793808387, 6827.2490026098085, 6843.349881761224, 6911.205211400753, 6250.468710159687, 6262.655553944577, 6381.074744162163, 6390.0734393512685, 6404.071409645575, 5529.778808847682, 5586.24585680936, 5598.748056337475, 5601.243832082698, 5609.915851262234, 7092.397146242627, 7110.92889071113, 7113.57318560888, 7179.174394944544, 7209.639518024078, 6780.457563394818, 6831.599522097858, 6832.282610326043, 6848.280930502425, 6941.132358455193, 7017.894731579133, 7041.3310735480045, 7078.858422831618, 7084.043654106629, 7090.0, 6724.764633238009, 6752.527323087534, 6811.489138314745, 6815.795526134224, 6825.283345248876, 6968.512204145661, 7020.613866237406, 7046.964765176142, 7052.647367631701, 7059.541129826544, 6693.19681638187, 6696.966515167393, 6769.796906092825, 6783.966080169567, 6798.116244888331, 6566.4418524425955, 6639.834004149935, 6661.367170118831, 6681.098051763144, 6772.898406523807, 6560.704768285344, 6582.76960306387, 6584.045313429621, 6613.702383392662, 6646.202455705346, 6736.259011508632, 6741.359570840762, 6742.629155396304, 6752.493562982698, 6789.0, 6467.7736279231885, 6506.902396464152, 6518.217813862367, 6531.2489063756375, 6565.901511477427], "value": 6282.7493316718355, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [895.2944640459924, 943.5470973932512, 944.3672739264692, 983.0906411569297, 986.4229425785915, 44333.556664433345, 44766.776166119125, 44768.77615611925, 44881.32678009829, 44894.77552612232, 42624.78687606558, 42809.0, 42901.7854910725, 44435.77782111093, 45372.773136134354, 8439.831203375945, 8526.147385261485, 8601.096884827097, 8621.18098780618, 8631.13688631135, 8349.33205343571, 8466.365022623297, 8473.533955632438, 8491.74524764255, 8495.405321627488, 8481.745547633582, 8516.574171291442, 8530.914690853075, 8550.871736923951, 8603.053664096944, 8510.319174466058, 8510.872336914921, 8521.233089021956, 8549.273311768507, 8565.657373705044, 8358.373122015812, 8386.287165590933, 8395.580220988926, 8400.495970241805, 8454.365922555833, 39315.803420983, 39438.60561394378, 39513.40729889054, 40947.0, 41235.58764412347, 3738.9813050934845, 3767.321882061228, 3772.830222639988, 3773.0755964788527, 3773.867914622975, 33141.0, 33420.0, 33473.66526334754, 33532.83233583841, 33706.49440258398, 5180.4042535108565, 5434.8913021739345, 5478.616496845222, 5483.314585676791, 5489.066858634042, 211987.0, 216836.0, 221000.0, 222726.0, 234856.82571587202, 54573.72713136488, 54826.45173548214, 54837.725811370685, 54902.725486372314, 54928.0, 56793.71603141958, 56998.43001570014, 57023.0, 57182.42817571771, 57471.425285746605, 14824.0, 14907.552773416815, 15019.324130414157, 15028.09831410119, 15268.541943741484, 12152.696182595506, 12166.75666486683, 12185.573504927284, 12201.69495762613, 12218.144729869002, 13640.386182621805, 13713.588592342247, 13734.862651373558, 13748.725025499434, 13817.516386926409, 5601.8599535011135, 5609.5501266721485, 5663.235463212496, 5772.653640781483, 5781.797637082682, 1068.2628985999636, 1091.858058452412, 1097.3306283167262, 1100.3068067117665, 1111.8610173728284, 25586.744132558437, 25728.356791080372, 26092.0, 26191.607125893126, 26420.0, 1178.482230541832, 1183.514758948844, 1187.6496433552122, 1190.3274649822822, 1210.3101232297681, 13694.93152534231, 13749.862501375059, 13953.441862325597, 14065.663761942598, 14088.366023528966, 267684.0, 269137.0, 269209.0, 271580.0, 271801.0, 58815.41184588185, 59031.52421189505, 59087.0, 59263.70368148218, 59276.70361648164, 1482.5255918106102, 1493.111598598832, 1496.2743069611229, 1512.5159948816492, 1525.2831169350388, 25347.704798376093, 25444.363890902874, 25486.23541293764, 25501.872490637426, 25728.0, 40551.0, 40657.79671101626, 40829.79585102174, 40855.795721021204, 40862.182756345304, 237388.0, 238454.0, 239178.0, 239364.0, 239378.0, 36697.44953825748, 36932.0, 38790.80604597072, 39393.40909886411, 39465.0, 50584.0, 52327.73836130795, 52492.0, 52610.0, 52621.0, 37393.43909841409, 37457.25085498329, 37512.437313439776, 37788.81105594454, 38181.618183818915, 36716.0, 36882.07794805044, 37105.81447092747, 37373.2525349486, 37659.246815062994, 43618.781906091535, 43750.0, 44038.77980610076, 44066.779666101465, 44172.55827441813, 36056.819715902304, 36266.63733362738, 36586.26827463489, 36747.816260918524, 37035.07412314714, 25906.35234119162, 26867.596986044835, 27322.863385682944, 27468.450630987667, 27566.5865012029], "value": 18810.425651582762, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.7489879351878, 591.5977135547826, 592.9703514824258, 609.1076572820816, 614.7571709174877, 21405.67891481627, 22096.22663206788, 22165.889170554165, 22201.44496387591, 22206.777932220673, 23089.653655195143, 24371.26886193417, 25679.48641027183, 25728.22815315539, 26152.738472615267, 6524.478041756672, 6567.310432404601, 6570.507211959099, 6573.211214654249, 6575.605463672171, 6564.1138446309615, 6670.7331706731675, 6685.799426017227, 6689.464842812587, 6691.732330706766, 6627.602343859384, 6646.601203927756, 6671.166104236971, 6674.799756007304, 6678.699458524378, 6277.623342599436, 6651.135352404205, 6655.201375834882, 6663.2337281212795, 6674.866502669944, 6175.197224360804, 6204.286507051702, 6213.813585592439, 6219.973704338824, 6234.750609975596, 29149.854250728822, 29278.853605731834, 29419.558706619417, 29490.70509294901, 29509.557356639667, 2126.0539060118253, 2177.1835561664375, 2180.324099529151, 2185.672149177636, 2190.1020581561643, 19018.61962760737, 20414.285500007576, 20587.794122058887, 20587.89706051475, 20610.38168854937, 2315.710536182977, 2479.8760061996827, 2525.305540976228, 2587.8188526803133, 2598.9350266243305, 153131.0, 155464.0, 155466.0, 155710.0, 155895.0, 16004.439844605384, 16122.178618741673, 16172.0, 16185.676286474205, 16336.183190840648, 25941.870290648803, 26188.214353569423, 26227.082052128466, 26264.47471050568, 26277.211683649522, 9504.904950950402, 10002.549885255181, 10096.242781791396, 10116.797664046679, 10238.744031399126, 8734.30125589964, 8994.235489983294, 9033.412828166149, 9056.818863622691, 9148.405353651991, 9669.709908702609, 9766.609335626637, 9781.853272200922, 9786.608535658635, 9916.900830991743, 2881.7838662100426, 2897.7392034716977, 2900.463414268325, 2955.143008527546, 2960.2895305126613, 1030.1810061001522, 1047.0785708576557, 1058.6453538064682, 1060.2684147937898, 1065.190455253997, 20464.488387790425, 20488.795112048985, 20505.589888202452, 20531.692024619642, 21087.472813179793, 1095.0965453500894, 1095.424901926495, 1103.9448027598587, 1105.3975583307117, 1114.2144787924656, 11257.774844503065, 11435.0, 11520.94239528797, 11534.480948357344, 11577.710557236136, 588195.0, 594953.0, 595208.0, 603903.0, 627897.0, 127974.0, 128820.35589822178, 129619.35190323988, 131474.34262828817, 131789.34105329413, 1216.6714986953473, 1235.1354052163522, 1291.6706239908763, 1319.5249710104354, 1322.3652646729624, 21723.239686610894, 21950.231741888958, 22116.0, 22139.55720885541, 22600.321990340315, 62129.37870621236, 62261.37738622737, 63715.6814215926, 64127.0, 65046.0, 80999.59500202697, 81296.18703813123, 81413.59293203497, 82306.0, 82598.17401826144, 15274.541763747106, 15526.767098493758, 16000.759988600414, 16025.599360016093, 16029.91985040114, 24259.878700606383, 24391.14630987907, 24669.0, 24775.62836557417, 24787.13245036415, 19243.422697319103, 19424.8057519423, 19653.901730491827, 20111.29610463627, 20128.19487220495, 17429.651406971538, 17673.558161046076, 17702.20340084725, 17858.107094645475, 17958.730619040463, 19885.0, 19925.202991880164, 19973.800261997196, 20049.59900802005, 20151.294704685264, 15484.303206355517, 15544.455944041903, 15556.766648500508, 15629.765553516934, 15673.373065077725, 19197.424077277705, 19271.807281927002, 19409.126589303232, 19604.313849015216, 19618.90190549095], "value": 12703.855100110934, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1377.2631642071494, 1468.1484738851468, 1471.9852801471982, 1482.0959214878922, 1483.0286162563525, 17402.0, 17896.10519474026, 17904.46286611402, 17935.461936141903, 17943.0, 17541.561460963483, 17584.296628134893, 17631.559211019732, 17650.823491765077, 17680.02759848211, 2738.8082834201514, 2796.4407118576264, 2807.3964097718986, 2809.2134202423354, 2810.156952914128, 2685.355514676483, 2692.8115031947773, 2722.48272828163, 2724.4551089782026, 2733.439644872796, 2741.972580274202, 2855.828650280979, 2859.756006137337, 2860.556613724876, 2865.1118153372418, 2824.096289187461, 2828.6747024092288, 2856.31448452371, 2856.685764565896, 2864.6562412510634, 2710.7966902482194, 2782.986085069582, 2794.706555811631, 2795.077624383948, 2825.0536070416433, 16740.41408550695, 16798.664026719518, 16805.915970420192, 16808.15959202035, 16816.32734690611, 8082.757517274491, 8318.66725330986, 8327.875081873777, 8329.250367466957, 8390.706325278647, 5612.550995920316, 5716.971415142939, 5757.0, 5840.386759390245, 5855.180274761537, 2051.2205361962506, 2080.573482436097, 2106.9157233710635, 2117.1637203304763, 2160.5354848707602, 30993.38013239745, 31151.0, 31170.376592468252, 31284.217894552592, 31292.374152517048, 6804.149481314836, 7040.4302429613845, 7042.507024508338, 7245.275472452712, 7527.059117610299, 19991.40025799228, 20078.498037548885, 20092.59814803725, 20106.0, 20132.89933550323, 7965.163657815961, 8152.755417337489, 8164.469309494983, 8172.550509721904, 8178.7955301117945, 7467.4772765906955, 7510.774676759706, 7610.695572177162, 7650.808729781688, 7666.0, 5535.861603459945, 5537.473939975695, 5648.6893220872425, 5700.201971723962, 5913.58604897653, 1620.983790162107, 1633.6079340958322, 1659.9336026558803, 1671.882968192239, 1674.983250167507, 964.864918911353, 978.0806042320196, 985.84719368498, 1001.7695929936156, 1012.1750773119884, 8633.0, 8758.91241087581, 8759.34304927133, 8773.605187766565, 8940.50827204497, 769.7382889817488, 779.3609240422912, 779.7270955165646, 788.9723859664999, 799.8000499875031, 5347.652402593897, 5700.8859822803315, 5918.8816223675285, 5936.406359364116, 6026.578139530191, 23316.88341558281, 24904.875475622506, 25239.62140567893, 25260.368490787878, 25288.494230115295, 23138.421539461313, 24427.0, 24529.0, 24574.13990510359, 24957.625635615117, 12077.51689932393, 12288.938555307166, 12303.200291980993, 12315.82999615035, 12344.81482777759, 9642.276829237695, 9746.512674366395, 9759.804803904024, 9806.313558050868, 9843.212542996685, 20642.807661063744, 20735.688964665846, 20862.0, 20973.475663107933, 21178.152873884872, 21575.136994520042, 21610.35168944934, 21768.89115554412, 22309.553808924054, 22411.88794056019, 12133.39333033327, 12205.69485762863, 12327.137100402886, 12344.0, 12461.93769031149, 15154.318055687741, 15570.9221453892, 15591.06453612787, 15613.531594052196, 15707.685846283239, 12013.279203247834, 12304.138710290552, 12323.815142772686, 12352.320622365856, 12532.310722909962, 11377.829332560184, 11677.299362038304, 11767.941160294144, 11939.164258501822, 12249.448774805333, 11176.664700059011, 11275.041621462267, 11522.76954460923, 11530.192886497865, 11538.94230528842, 8168.346532277523, 8306.252437280673, 8364.790880228044, 8447.239748422671, 8497.0, 8454.196851299117, 8477.660893564434, 8578.78553036179, 8579.313654907468, 8605.526696031528], "value": 7261.720113609563, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [537.5135502370356, 566.4533724955419, 566.501478698745, 576.538768984812, 577.7024832211409, 6326.9999999999945, 6376.458001069915, 6415.0, 6433.874072037393, 6502.7724029658975, 6274.278457977334, 6275.435210831024, 6337.936620633804, 6348.301971662048, 6372.113011063259, 5207.270982062514, 5234.37187537496, 5237.685738855681, 5245.527902488775, 5272.367315922094, 4887.535684110004, 5002.499750025005, 5217.2695822584865, 5246.632735708502, 5284.550813180885, 5012.448630650625, 5013.849584512471, 5014.272930425086, 5019.67372120811, 5077.619178561604, 4989.800407983676, 4999.700017998932, 5000.62495312853, 5041.1178043842365, 5041.932807548924, 4501.504834468205, 4564.8174073037035, 4570.954290457086, 4574.817007319703, 4583.0, 6280.466160376373, 6319.684015799192, 6327.272363678144, 6328.240611126648, 6360.809175724736, 5860.765569377262, 5943.910841337383, 5953.404659534055, 5979.192808970777, 5996.730147143389, 6713.798586042427, 6795.830104247384, 6800.829979250509, 6803.4897382696, 6804.693788779517, 5118.795248190068, 5130.589088000792, 5135.3324067870935, 5137.434882162959, 5154.92267615986, 6798.150231221098, 6885.586864788129, 6943.340382663639, 6977.93022069783, 7040.894386584206, 5205.193195054772, 5218.478152184751, 5245.895082098336, 5249.396319423316, 5279.815206467755, 5319.255304257407, 5323.707196104174, 5330.600204984564, 5337.946620533823, 5377.112776391929, 5844.561657875676, 5878.118282257696, 5897.262842144732, 5924.229850119457, 5929.258842644669, 6670.299618539983, 6721.563098398588, 6779.898301525481, 6789.321067893171, 6831.04365388846, 1833.3491610478088, 1837.8162183781783, 1851.1484717030048, 1855.8979256141042, 1856.071964017991, 1251.0296283353755, 1296.2028352563107, 1307.267929959226, 1312.527490103562, 1320.3662242123835, 6102.969485152635, 6205.503559715212, 6287.371262873768, 6290.622562646256, 6318.241810982711, 6663.20041595002, 6728.932710672929, 6766.545192783575, 6803.727850885909, 6846.383825455733, 6161.706041731197, 6211.3167551569295, 6240.812775616739, 6280.371962803774, 6300.905486417708, 3568.232829941575, 3611.6749492545273, 3617.4264195075225, 3629.4393410833595, 3632.3824949758605, 7012.333828286304, 7012.859742805217, 7015.3864611139725, 7015.719371225094, 7028.367446929698, 7001.649917504104, 7004.614746189009, 7007.404370628452, 7040.859182816417, 7067.43460523157, 6914.274001229899, 6962.373386395248, 6984.825379365557, 7009.334113259232, 7029.824254393681, 6642.368974947372, 6706.12820333373, 6713.832154196184, 6732.249615100011, 6746.460283177236, 6770.627615481196, 6783.457323414016, 6847.931520684929, 6850.931490685229, 6851.383375496229, 6984.930150698428, 7000.0, 7017.087778588751, 7080.114985626797, 7089.298568343457, 5138.614603904647, 5187.429382767817, 5202.921956170736, 5211.791528338824, 5229.398619158694, 6450.387213214737, 6562.0, 6853.4859885507785, 6886.139232595926, 6973.3375329343635, 6559.375640173571, 6611.966940165461, 6688.0, 6716.1940567130305, 6731.495137864582, 6543.691261747575, 6621.172353455818, 6664.366885145903, 6669.833254168685, 6707.932920670731, 6399.840003999937, 6533.150690410216, 6587.011948207807, 6600.471962243105, 6726.293739157318, 6731.158605174353, 6751.898721519279, 6788.355106264897, 6808.693608787517, 6864.965675171592, 6501.382368674968, 6565.376289252514, 6568.573042752206, 6628.270890201978, 6642.800715978528], "value": 5246.413426493903, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [965.599276300335, 972.2027937091584, 972.7519482531953, 984.5126662302162, 993.1806259835635, 18565.350212742556, 18705.43883683488, 18814.34149804757, 18845.811541884577, 18891.52771180721, 17126.14369281537, 17326.220320085595, 17389.39137130201, 17641.911790441063, 17836.197371118298, 1035.3425574760024, 1057.9682609521726, 1063.5639387850983, 1063.6596289187464, 1065.0414626835832, 1042.2495803021811, 1042.6142327338896, 1042.9165666746642, 1043.9582416703322, 1044.5873879817468, 1062.1237479079753, 1095.1348434736549, 1103.564092183587, 1104.1222228328497, 1108.257467496775, 1097.5664612478026, 1098.505672447398, 1101.4823033174434, 1102.2559772153763, 1104.8011357955565, 787.2481779900181, 813.3533840596681, 813.4427916876958, 821.8191997760483, 822.45717826235, 17646.91176544122, 17815.910920445443, 17883.19525621337, 17924.55188620282, 17971.0, 22535.54928901413, 22676.65985010226, 23669.171578994654, 23829.761702382926, 23913.641295380585, 16168.11075390853, 16472.917635411748, 16544.090075045868, 16594.75107873383, 16610.75083873743, 3751.118487155516, 3796.1268908151005, 3798.582155962842, 3799.145192331703, 3813.904652383713, 117576.0, 158576.2071189648, 160123.0, 162615.0, 164044.0, 18441.354552590863, 18585.25658973653, 18883.81116188848, 19064.33274835374, 19076.0, 34989.47515787265, 35142.472862907074, 35233.64766352355, 35289.82355088208, 35347.4697879532, 9332.580033898355, 9335.953320233491, 9349.579268932914, 9350.812983740287, 9353.625854965725, 4339.956600433955, 4364.650827933758, 4409.757463339483, 4450.910981780346, 4458.6878918475395, 5563.165525171256, 5619.044762390404, 5634.154876768517, 5641.943580564224, 5668.971655141698, 1120.383788916093, 1149.5804031528432, 1156.444906444911, 1170.5317872850928, 1172.3434876469205, 709.8757717399434, 728.9307515785991, 737.3953358246187, 739.6080077558902, 757.8332766791297, 13040.80438793419, 13145.73708525824, 13248.754055256524, 14243.501477448239, 14248.572542823731, 711.4344096443236, 727.054828722669, 728.9380402665832, 737.1964558631117, 740.3743836458184, 6300.464460520815, 6442.903356449657, 6569.835754106186, 6578.5395022347975, 6654.6672666366485, 144310.33879584764, 145490.5450945477, 147632.0, 150797.0, 152831.23584382006, 129517.69066158467, 130836.3458182703, 134911.32544337216, 137056.0, 139217.0, 117737.4113129446, 118930.40534797443, 120918.39540802415, 122211.38894305471, 122991.38504307422, 13480.5281815136, 13629.500754916753, 13833.584992450242, 13928.303584820922, 14022.439102435788, 54826.72586637041, 54922.450775491736, 55555.0, 56098.15852762294, 56977.71511142418, 72870.27129728635, 73178.0, 73790.63104684443, 74302.62848685723, 74362.0, 20622.0, 20692.58614827665, 20802.791972080086, 20842.583148336646, 21037.474063148544, 22779.316620501413, 22781.0, 22992.885035575386, 23125.768742313034, 23343.533129336978, 19769.604607907473, 19992.20031198736, 20079.899600501903, 20087.19651213935, 20088.79911200869, 20888.0, 21267.680984784933, 21291.68062479095, 21346.359609211748, 21542.67685984743, 20571.07430165616, 20765.273215437388, 20777.0, 20843.37469875906, 20933.26733564318, 12768.170068945488, 13058.281794501394, 13099.345032748133, 13113.40989655487, 13446.663833404244, 14385.496507622183, 14489.927550362181, 14496.275186240857, 14502.0, 14512.63718407006], "value": 10064.531915879566, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1377.4000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 110.0, 106.0, 105.0, 105.0, 110.0, 107.0, 106.0, 106.0, 104.0], "value": 106.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 110.0, 113.0, 113.0, 112.0, 113.0, 115.0, 135.0, 113.0, 115.0], "value": 115.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 163.0, 162.0, 163.0, 161.0, 161.0, 162.0, 164.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 74.0, 75.0, 73.0, 73.0, 75.0, 83.0, 74.0, 81.0], "value": 75.6, "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, 78.0, 79.0, 78.0], "value": 78.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 113.0, 113.0, 113.0, 114.0, 113.0, 114.0, 110.0], "value": 113.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 150.0, 150.0, 148.0, 147.0, 149.0, 150.0, 150.0, 151.0], "value": 149.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 94.0, 94.0, 95.0, 93.0, 94.0, 97.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 44.0, 45.0, 44.0, 46.0, 44.0, 45.0, 47.0, 45.0, 43.0], "value": 45.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 36.0, 36.0, 37.0, 39.0, 40.0, 41.0, 37.0, 36.0, 37.0], "value": 37.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 71.0, 73.0, 71.0, 72.0, 70.0, 71.0, 71.0, 71.0, 70.0], "value": 71.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 110.0, 116.0, 105.0, 112.0, 106.0, 108.0, 111.0, 107.0, 114.0], "value": 109.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 154.0, 157.0, 159.0, 155.0, 152.0, 159.0, 158.0, 171.0, 156.0], "value": 159.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 59.0, 59.0, 58.0, 60.0, 64.0, 59.0, 63.0], "value": 60.7, "unit": "score"}]}]} 17:58:57 INFO - Return code: 0 17:58:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:58:57 INFO - # TBPL SUCCESS # 17:58:57 INFO - Running post-action listener: _package_coverage_data 17:58:57 INFO - Running post-action listener: _resource_record_post_action 17:58:57 INFO - [mozharness: 2017-09-19 00:58:57.960733Z] Finished run-tests step (success) 17:58:57 INFO - Running post-run listener: _resource_record_post_run 17:58:58 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 332275712; Read time: 264; Write time: 311332 17:58:58 INFO - TinderboxPrint: CPU usage
13.1% 17:58:58 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 264 17:58:58 INFO - TinderboxPrint: I/O write bytes / time
332,275,712 / 311,332 17:58:58 INFO - TinderboxPrint: CPU idle
8,220.1 (86.9%) 17:58:58 INFO - TinderboxPrint: CPU user
1,187.9 (12.6%) 17:58:58 INFO - TinderboxPrint: Swap in / out
0 / 0 17:58:58 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 12505088; Read time: 0; Write time: 1536 17:58:58 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:58:58 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 4096; Write bytes: 319156224; Read time: 264; Write time: 309796 17:58:58 INFO - Running post-run listener: _upload_blobber_files 17:58:58 INFO - Blob upload gear active. 17:58:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:58:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:58:58 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'] 17:58:58 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 17:58:59 INFO - (blobuploader) - INFO - Open directory for files ... 17:58:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:58:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:58:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:59:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:59:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:59:02 INFO - (blobuploader) - INFO - Done attempting. 17:59:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 17:59:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:59:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:59:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 17:59:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:59:03 INFO - (blobuploader) - INFO - Done attempting. 17:59:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:59:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:59:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:59:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:59:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:59:04 INFO - (blobuploader) - INFO - Done attempting. 17:59:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 17:59:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:59:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:59:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 17:59:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:59:05 INFO - (blobuploader) - INFO - Done attempting. 17:59:05 INFO - (blobuploader) - INFO - Iteration through files over. 17:59:05 INFO - Return code: 0 17:59:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:59:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:59:05 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bdb07ea63c4445acf153c71f4f0c1aed79054121c56437977e444db98e00d6e187f224d5a43db62b3f34e461cc5ddfe855d24c21c9c948f4ccc9772d3c60b937", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e211aeee4f0b016d15e46f3db02f54f4749454f5a6a50a53fe1804778be3fbfa69d2f36cfe99687c6dcf0bc4858ed4018391e4e6de17c8081c43cc32638f9a92", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61580cc5653fb9bbd04cff745619f42dba58b6a913cb727d27b12c956e58ff3e996d684e5158854dfe157d32e40102789e3de6523ec47e31564a69ef2f29367a", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c602d7cac9d2d6306c8e1025c9a4ea6450c2aa0264b9a3dc6a31a1d580118a2a81c6bd0947741cf7859a5b118b1ab1ac05a34ccf67c2f12e789f04bf8d389a19"} 17:59:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:59:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:59:05 INFO - Contents: 17:59:05 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bdb07ea63c4445acf153c71f4f0c1aed79054121c56437977e444db98e00d6e187f224d5a43db62b3f34e461cc5ddfe855d24c21c9c948f4ccc9772d3c60b937", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e211aeee4f0b016d15e46f3db02f54f4749454f5a6a50a53fe1804778be3fbfa69d2f36cfe99687c6dcf0bc4858ed4018391e4e6de17c8081c43cc32638f9a92", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61580cc5653fb9bbd04cff745619f42dba58b6a913cb727d27b12c956e58ff3e996d684e5158854dfe157d32e40102789e3de6523ec47e31564a69ef2f29367a", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c602d7cac9d2d6306c8e1025c9a4ea6450c2aa0264b9a3dc6a31a1d580118a2a81c6bd0947741cf7859a5b118b1ab1ac05a34ccf67c2f12e789f04bf8d389a19"} 17:59:05 INFO - Running post-run listener: copy_logs_to_upload_dir 17:59:05 INFO - Copying logs to upload dir... 17:59:05 INFO - mkdir: /builds/slave/test/build/upload/logs 17:59:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.646768 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-18 17:59:05.573176) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-18 17:59:05.580692) ========= 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=ca6c2627acea03e666270f68000001e0-1505779151.298782-1465186499 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/bdb07ea63c4445acf153c71f4f0c1aed79054121c56437977e444db98e00d6e187f224d5a43db62b3f34e461cc5ddfe855d24c21c9c948f4ccc9772d3c60b937", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e211aeee4f0b016d15e46f3db02f54f4749454f5a6a50a53fe1804778be3fbfa69d2f36cfe99687c6dcf0bc4858ed4018391e4e6de17c8081c43cc32638f9a92", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61580cc5653fb9bbd04cff745619f42dba58b6a913cb727d27b12c956e58ff3e996d684e5158854dfe157d32e40102789e3de6523ec47e31564a69ef2f29367a", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c602d7cac9d2d6306c8e1025c9a4ea6450c2aa0264b9a3dc6a31a1d580118a2a81c6bd0947741cf7859a5b118b1ab1ac05a34ccf67c2f12e789f04bf8d389a19"} build_url:https://queue.taskcluster.net/v1/task/aQ8LhTnHTYe3TMkQjgKawg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011375 build_url: 'https://queue.taskcluster.net/v1/task/aQ8LhTnHTYe3TMkQjgKawg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bdb07ea63c4445acf153c71f4f0c1aed79054121c56437977e444db98e00d6e187f224d5a43db62b3f34e461cc5ddfe855d24c21c9c948f4ccc9772d3c60b937", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e211aeee4f0b016d15e46f3db02f54f4749454f5a6a50a53fe1804778be3fbfa69d2f36cfe99687c6dcf0bc4858ed4018391e4e6de17c8081c43cc32638f9a92", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61580cc5653fb9bbd04cff745619f42dba58b6a913cb727d27b12c956e58ff3e996d684e5158854dfe157d32e40102789e3de6523ec47e31564a69ef2f29367a", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c602d7cac9d2d6306c8e1025c9a4ea6450c2aa0264b9a3dc6a31a1d580118a2a81c6bd0947741cf7859a5b118b1ab1ac05a34ccf67c2f12e789f04bf8d389a19"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-18 17:59:05.611197) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 17:59:05.611510) ========= 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=ca6c2627acea03e666270f68000001e0-1505779151.298782-1465186499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004552 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 17:59:05.693068) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-18 17:59:05.696386) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-18 17:59:05.696693) ========= ========= Total master_lag: 0.28 =========