builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-068 starttime: 1506511142.86 results: success (0) revision: 35fbf14b96a633c3f66ea13c1a163a3f3a4219b9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-27 04:19:02.860728) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-27 04:19:02.861164) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-27 04:19:02.861469) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-27 04:19:02.929405) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 04:19:02.929692) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1506510008.725700-594462741 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-27 04:19:02-- 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% 41.9M=0s 2017-09-27 04:19:03 (41.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123638 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 04:19:03.070713) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 04:19:03.071069) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1506510008.725700-594462741 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017640 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 04:19:03.122484) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 04:19:03.122839) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 35fbf14b96a633c3f66ea13c1a163a3f3a4219b9 --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 35fbf14b96a633c3f66ea13c1a163a3f3a4219b9 --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=97facb8ba2ac28944cc45e6b000001d4-1506510008.725700-594462741 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-27 04:19:03,170 truncating revision to first 12 chars 2017-09-27 04:19:03,170 Setting DEBUG logging. 2017-09-27 04:19:03,170 attempt 1/10 2017-09-27 04:19:03,170 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/35fbf14b96a6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-27 04:19:03,596 unpacking tar archive at: mozilla-central-35fbf14b96a6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.699295 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 04:19:03.838886) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-27 04:19:03.839151) ========= script_repo_revision: 35fbf14b96a633c3f66ea13c1a163a3f3a4219b9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-27 04:19:03.839505) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-27 04:19:03.839806) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-27 04:19:03.857357) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-27 04:19:03.857634) ========= /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=97facb8ba2ac28944cc45e6b000001d4-1506510008.725700-594462741 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:19:04 INFO - MultiFileLogger online at 20170927 04:19:04 in /builds/slave/test 04:19:04 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 04:19:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:19:04 INFO - {'append_to_log': False, 04:19:04 INFO - 'base_work_dir': '/builds/slave/test', 04:19:04 INFO - 'blob_upload_branch': 'Firefox', 04:19:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:19:04 INFO - 'branch': 'Firefox', 04:19:04 INFO - 'buildbot_json_path': 'buildprops.json', 04:19:04 INFO - 'code_coverage': False, 04:19:04 INFO - 'config_files': ('talos/linux_config.py',), 04:19:04 INFO - 'default_actions': ('clobber', 04:19:04 INFO - 'read-buildbot-config', 04:19:04 INFO - 'download-and-extract', 04:19:04 INFO - 'populate-webroot', 04:19:04 INFO - 'create-virtualenv', 04:19:04 INFO - 'install', 04:19:04 INFO - 'setup-mitmproxy', 04:19:04 INFO - 'run-tests'), 04:19:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:19:04 INFO - 'disable_ccov_upload': False, 04:19:04 INFO - 'disable_stylo': False, 04:19:04 INFO - 'download_minidump_stackwalk': True, 04:19:04 INFO - 'download_symbols': 'ondemand', 04:19:04 INFO - 'enable_stylo': False, 04:19:04 INFO - 'enable_webrender': False, 04:19:04 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 04:19:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:19:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:19:04 INFO - 'gecko_profile': False, 04:19:04 INFO - 'gecko_profile_interval': 0, 04:19:04 INFO - 'installer_path': 'installer.exe', 04:19:04 INFO - 'log_level': 'info', 04:19:04 INFO - 'log_name': 'talos', 04:19:04 INFO - 'log_to_console': True, 04:19:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:19:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:19:04 INFO - 'opt_config_files': (), 04:19:04 INFO - 'pip_index': False, 04:19:04 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 04:19:04 INFO - 'system_bits': '32', 04:19:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:19:04 INFO - 'title': 'talos-linux64-ix-068', 04:19:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:19:04 INFO - 'use_talos_json': True, 04:19:04 INFO - 'verify': 'False', 04:19:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:19:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:19:04 INFO - 'work_dir': 'build'} 04:19:04 INFO - [mozharness: 2017-09-27 11:19:04.049866Z] Running clobber step. 04:19:04 INFO - Running pre-action listener: _resource_record_pre_action 04:19:04 INFO - Running main action method: clobber 04:19:04 INFO - rmtree: /builds/slave/test/build 04:19:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:19:05 INFO - Running post-action listener: _resource_record_post_action 04:19:05 INFO - [mozharness: 2017-09-27 11:19:05.053057Z] Finished clobber step (success) 04:19:05 INFO - [mozharness: 2017-09-27 11:19:05.053155Z] Running read-buildbot-config step. 04:19:05 INFO - Running pre-action listener: _resource_record_pre_action 04:19:05 INFO - Running main action method: read_buildbot_config 04:19:05 INFO - Using buildbot properties: 04:19:05 INFO - { 04:19:05 INFO - "project": "", 04:19:05 INFO - "product": "firefox", 04:19:05 INFO - "who": "archaeopteryx@coole-files.de", 04:19:05 INFO - "installer_path": "public/build/target.tar.bz2", 04:19:05 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 04:19:05 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 04:19:05 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 04:19:05 INFO - "stage_platform": "linux64-pgo", 04:19:05 INFO - "basedir": "/builds/slave/test", 04:19:05 INFO - "buildnumber": 44, 04:19:05 INFO - "platform": "ubuntu64_hw", 04:19:05 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:19:05 INFO - "slavebuilddir": "test", 04:19:05 INFO - "taskId": "Q9tPfScpRVW_RL-DxSzvHg", 04:19:05 INFO - "branch": "mozilla-central", 04:19:05 INFO - "script_repo_revision": "production", 04:19:05 INFO - "revision": "35fbf14b96a633c3f66ea13c1a163a3f3a4219b9", 04:19:05 INFO - "slavename": "talos-linux64-ix-068", 04:19:05 INFO - "repo_path": "mozilla-central" 04:19:05 INFO - } 04:19:05 INFO - Finding installer, test and symbols from parent task. 04:19:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q9tPfScpRVW_RL-DxSzvHg'}, attempt #1 04:19:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q9tPfScpRVW_RL-DxSzvHg'}, attempt #1 04:19:06 INFO - Task dependencies: NUZcoITBQvu1HCNBvdTH4w 04:19:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NUZcoITBQvu1HCNBvdTH4w'}, attempt #1 04:19:06 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/NUZcoITBQvu1HCNBvdTH4w/artifacts/public/build/target.tar.bz2 04:19:06 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/NUZcoITBQvu1HCNBvdTH4w/artifacts/public/build/target.test_packages.json 04:19:06 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/NUZcoITBQvu1HCNBvdTH4w/artifacts/public/build/target.crashreporter-symbols.zip 04:19:06 INFO - Running post-action listener: _resource_record_post_action 04:19:06 INFO - [mozharness: 2017-09-27 11:19:06.475518Z] Finished read-buildbot-config step (success) 04:19:06 INFO - [mozharness: 2017-09-27 11:19:06.475738Z] Running download-and-extract step. 04:19:06 INFO - Running pre-action listener: _resource_record_pre_action 04:19:06 INFO - Running main action method: download_and_extract 04:19:06 INFO - mkdir: /builds/slave/test/build/tests 04:19:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:19:06 INFO - trying https://queue.taskcluster.net/v1/task/NUZcoITBQvu1HCNBvdTH4w/artifacts/public/build/target.test_packages.json 04:19:06 INFO - Downloading https://queue.taskcluster.net/v1/task/NUZcoITBQvu1HCNBvdTH4w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:19:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NUZcoITBQvu1HCNBvdTH4w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:19:07 INFO - Downloaded 989 bytes. 04:19:07 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:19:07 INFO - Using the following test package requirements: 04:19:07 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:19:07 INFO - u'common': [u'target.common.tests.zip'], 04:19:07 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:19:07 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:19:07 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:19:07 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:19:07 INFO - u'mozbase': [u'target.common.tests.zip'], 04:19:07 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:19:07 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:19:07 INFO - u'web-platform': [u'target.common.tests.zip', 04:19:07 INFO - u'target.web-platform.tests.tar.gz'], 04:19:07 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:19:07 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 04:19:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NUZcoITBQvu1HCNBvdTH4w/artifacts/public/build/target.common.tests.zip 04:19:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NUZcoITBQvu1HCNBvdTH4w/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:19:07 INFO - Fetch https://queue.taskcluster.net/v1/task/NUZcoITBQvu1HCNBvdTH4w/artifacts/public/build/target.common.tests.zip into memory 04:19:10 INFO - Content-Length response header: 55350525 04:19:10 INFO - Bytes received: 55350525 04:19:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NUZcoITBQvu1HCNBvdTH4w/artifacts/public/build/target.talos.tests.zip 04:19:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NUZcoITBQvu1HCNBvdTH4w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:19:21 INFO - Fetch https://queue.taskcluster.net/v1/task/NUZcoITBQvu1HCNBvdTH4w/artifacts/public/build/target.talos.tests.zip into memory 04:19:22 INFO - Content-Length response header: 14513665 04:19:22 INFO - Bytes received: 14513665 04:19:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:19:23 INFO - trying https://queue.taskcluster.net/v1/task/NUZcoITBQvu1HCNBvdTH4w/artifacts/public/build/target.tar.bz2 04:19:23 INFO - Downloading https://queue.taskcluster.net/v1/task/NUZcoITBQvu1HCNBvdTH4w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:19:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NUZcoITBQvu1HCNBvdTH4w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:19:25 INFO - Downloaded 62320910 bytes. 04:19:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NUZcoITBQvu1HCNBvdTH4w/artifacts/public/build/target.tar.bz2 04:19:25 INFO - mkdir: /builds/slave/test/properties 04:19:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:19:25 INFO - Writing to file /builds/slave/test/properties/build_url 04:19:25 INFO - Contents: 04:19:25 INFO - build_url:https://queue.taskcluster.net/v1/task/NUZcoITBQvu1HCNBvdTH4w/artifacts/public/build/target.tar.bz2 04:19:25 INFO - Running post-action listener: _resource_record_post_action 04:19:25 INFO - Running post-action listener: find_tests_for_verification 04:19:25 INFO - Running post-action listener: set_extra_try_arguments 04:19:25 INFO - [mozharness: 2017-09-27 11:19:25.547788Z] Finished download-and-extract step (success) 04:19:25 INFO - [mozharness: 2017-09-27 11:19:25.547952Z] Running populate-webroot step. 04:19:25 INFO - Running pre-action listener: _resource_record_pre_action 04:19:25 INFO - Running main action method: populate_webroot 04:19:25 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:19:25 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:19:25 INFO - 'tests': ['tresize', 04:19:25 INFO - 'tcanvasmark']}, 04:19:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:19:25 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:19:25 INFO - 'tests': ['dromaeo_css', 04:19:25 INFO - 'kraken']}, 04:19:25 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:19:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:19:25 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:19:25 INFO - 'talos_options': ['--disable-stylo'], 04:19:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:19:25 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:19:25 INFO - 'tests': ['damp', 'tps']}, 04:19:25 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:19:25 INFO - 'talos_options': ['--disable-stylo'], 04:19:25 INFO - 'tests': ['damp', 'tps']}, 04:19:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:19:25 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:19:25 INFO - 'tests': ['dromaeo_dom']}, 04:19:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:19:25 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:19:25 INFO - 'tests': ['basic_compositor_video', 04:19:25 INFO - 'glvideo']}, 04:19:25 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 04:19:25 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 04:19:25 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:19:25 INFO - 'talos_options': ['--disable-stylo'], 04:19:25 INFO - 'tests': ['ts_paint_webext', 04:19:25 INFO - 'tp5o_webext']}, 04:19:25 INFO - 'other-e10s': {'tests': ['a11yr', 04:19:25 INFO - 'ts_paint', 04:19:25 INFO - 'tpaint', 04:19:25 INFO - 'sessionrestore', 04:19:25 INFO - 'sessionrestore_many_windows', 04:19:25 INFO - 'sessionrestore_no_auto_restore', 04:19:25 INFO - 'tabpaint']}, 04:19:25 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:19:25 INFO - 'tests': ['a11yr', 04:19:25 INFO - 'ts_paint', 04:19:25 INFO - 'tpaint', 04:19:25 INFO - 'sessionrestore', 04:19:25 INFO - 'sessionrestore_many_windows', 04:19:25 INFO - 'sessionrestore_no_auto_restore', 04:19:25 INFO - 'tabpaint']}, 04:19:25 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 04:19:25 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 04:19:25 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:19:25 INFO - 'tests': ['perf_reftest_singletons']}, 04:19:25 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:19:25 INFO - 'tests': ['perf_reftest']}, 04:19:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:19:25 INFO - 'tsvgr_opacity', 04:19:25 INFO - 'tart', 04:19:25 INFO - 'tscrollx', 04:19:25 INFO - 'tsvg_static']}, 04:19:25 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:19:25 INFO - 'tests': ['tsvgx', 04:19:25 INFO - 'tsvgr_opacity', 04:19:25 INFO - 'tart', 04:19:25 INFO - 'tscrollx', 04:19:25 INFO - 'tsvg_static']}, 04:19:25 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:19:25 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:19:25 INFO - 'talos_options': ['--disable-stylo'], 04:19:25 INFO - 'tests': ['tp5o']}, 04:19:25 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:19:25 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 04:19:25 INFO - 'talos_options': ['--mitmproxy', 04:19:25 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:19:25 INFO - '--firstNonBlankPaint'], 04:19:25 INFO - 'tests': ['tp6_google', 04:19:25 INFO - 'tp6_youtube', 04:19:25 INFO - 'tp6_amazon', 04:19:25 INFO - 'tp6_facebook']}, 04:19:25 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:19:25 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 04:19:25 INFO - 'talos_options': ['--disable-stylo', 04:19:25 INFO - '--mitmproxy', 04:19:25 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:19:25 INFO - '--firstNonBlankPaint'], 04:19:25 INFO - 'tests': ['tp6_google', 04:19:25 INFO - 'tp6_youtube', 04:19:25 INFO - 'tp6_amazon', 04:19:25 INFO - 'tp6_facebook']}, 04:19:25 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:19:25 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 04:19:25 INFO - 'talos_options': ['--stylo-threads=1', 04:19:25 INFO - '--mitmproxy', 04:19:25 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:19:25 INFO - '--firstNonBlankPaint'], 04:19:25 INFO - 'tests': ['tp6_google', 04:19:25 INFO - 'tp6_youtube', 04:19:25 INFO - 'tp6_amazon', 04:19:25 INFO - 'tp6_facebook']}, 04:19:25 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:19:25 INFO - 'talos_options': ['--xperf_path', 04:19:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:19:25 INFO - 'tests': ['tp5n']}, 04:19:25 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:19:25 INFO - 'talos_options': ['--disable-stylo', 04:19:25 INFO - '--xperf_path', 04:19:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:19:25 INFO - 'tests': ['tp5n']}}} 04:19:25 INFO - Running post-action listener: _resource_record_post_action 04:19:25 INFO - [mozharness: 2017-09-27 11:19:25.573648Z] Finished populate-webroot step (success) 04:19:25 INFO - [mozharness: 2017-09-27 11:19:25.573775Z] Running create-virtualenv step. 04:19:25 INFO - Running pre-action listener: _resource_record_pre_action 04:19:25 INFO - Running main action method: create_virtualenv 04:19:25 INFO - Creating virtualenv /builds/slave/test/build/venv 04:19:25 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:19:25 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 04:19:25 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 04:19:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:19:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:19:26 INFO - Installing distribute.............................................................................................................................................................................................done. 04:19:26 INFO - Installing pip...............done. 04:19:26 INFO - Return code: 0 04:19:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:19:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:19:26 INFO - Reading from file tmpfile_stdout 04:19:26 INFO - Output received: 04:19:26 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 04:19:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:19:26 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')]} 04:19:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:26 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')]} 04:19:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:26 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 0x24041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ccb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27719c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276ed60>, '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 0x276fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276fef0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1506510008.725700-594462741', '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 04:19:26 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 04:19:26 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 04:19:26 INFO - Using env: {'DISPLAY': ':0', 04:19:26 INFO - 'HOME': '/home/cltbld', 04:19:26 INFO - 'LANG': 'en_US.UTF-8', 04:19:26 INFO - 'LANGUAGE': 'en_US:en', 04:19:26 INFO - 'LOGNAME': 'cltbld', 04:19:26 INFO - 'MAIL': '/var/mail/cltbld', 04:19:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:26 INFO - 'MOZ_NO_REMOTE': '1', 04:19:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:26 INFO - 'NO_EM_RESTART': '1', 04:19:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:26 INFO - 'PWD': '/builds/slave/test', 04:19:26 INFO - 'SHELL': '/bin/bash', 04:19:26 INFO - 'SHLVL': '1', 04:19:26 INFO - 'TERM': 'linux', 04:19:26 INFO - 'TMOUT': '86400', 04:19:26 INFO - 'USER': 'cltbld', 04:19:26 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1506510008.725700-594462741', 04:19:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:26 INFO - '_': '/tools/buildbot/bin/python'} 04:19:27 INFO - Ignoring indexes: http://pypi.python.org/simple/ 04:19:27 INFO - Downloading/unpacking pip>=1.5 04:19:27 INFO - Running setup.py egg_info for package pip 04:19:27 INFO - warning: no files found matching 'pip/cacert.pem' 04:19:27 INFO - warning: no files found matching '*.html' under directory 'docs' 04:19:27 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:19:27 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:19:27 INFO - Installing collected packages: pip 04:19:27 INFO - Found existing installation: pip 1.1 04:19:27 INFO - Uninstalling pip: 04:19:27 INFO - Successfully uninstalled pip 04:19:27 INFO - Running setup.py install for pip 04:19:27 INFO - warning: no files found matching 'pip/cacert.pem' 04:19:27 INFO - warning: no files found matching '*.html' under directory 'docs' 04:19:27 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:19:27 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:19:27 INFO - Installing pip script to /builds/slave/test/build/venv/bin 04:19:27 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 04:19:27 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 04:19:27 INFO - Successfully installed pip 04:19:27 INFO - Cleaning up... 04:19:27 INFO - Return code: 0 04:19:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:19:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:19:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:27 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 0x24041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ccb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27719c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276ed60>, '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 0x276fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276fef0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1506510008.725700-594462741', '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 04:19:27 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 04:19:27 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 04:19:27 INFO - Using env: {'DISPLAY': ':0', 04:19:27 INFO - 'HOME': '/home/cltbld', 04:19:27 INFO - 'LANG': 'en_US.UTF-8', 04:19:27 INFO - 'LANGUAGE': 'en_US:en', 04:19:27 INFO - 'LOGNAME': 'cltbld', 04:19:27 INFO - 'MAIL': '/var/mail/cltbld', 04:19:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:27 INFO - 'MOZ_NO_REMOTE': '1', 04:19:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:27 INFO - 'NO_EM_RESTART': '1', 04:19:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:27 INFO - 'PWD': '/builds/slave/test', 04:19:27 INFO - 'SHELL': '/bin/bash', 04:19:27 INFO - 'SHLVL': '1', 04:19:27 INFO - 'TERM': 'linux', 04:19:27 INFO - 'TMOUT': '86400', 04:19:27 INFO - 'USER': 'cltbld', 04:19:27 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1506510008.725700-594462741', 04:19:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:27 INFO - '_': '/tools/buildbot/bin/python'} 04:19:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:28 INFO - Downloading/unpacking psutil>=3.1.1 04:19:28 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 04:19:28 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 04:19:28 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 04:19:28 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 04:19:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:19:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:19:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:19:29 INFO - Installing collected packages: psutil 04:19:29 INFO - Running setup.py install for psutil 04:19:29 INFO - building 'psutil._psutil_linux' extension 04:19:29 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 04:19:29 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 04:19:29 INFO - building 'psutil._psutil_posix' extension 04:19:29 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 04:19:29 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 04:19:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:19:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:19:30 INFO - Successfully installed psutil 04:19:30 INFO - Cleaning up... 04:19:31 INFO - Return code: 0 04:19:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:19:31 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')]} 04:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:31 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')]} 04:19:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:31 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 0x24041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ccb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27719c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276ed60>, '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 0x276fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276fef0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1506510008.725700-594462741', '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 04:19:31 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 04:19:31 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 04:19:31 INFO - Using env: {'DISPLAY': ':0', 04:19:31 INFO - 'HOME': '/home/cltbld', 04:19:31 INFO - 'LANG': 'en_US.UTF-8', 04:19:31 INFO - 'LANGUAGE': 'en_US:en', 04:19:31 INFO - 'LOGNAME': 'cltbld', 04:19:31 INFO - 'MAIL': '/var/mail/cltbld', 04:19:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:31 INFO - 'MOZ_NO_REMOTE': '1', 04:19:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:31 INFO - 'NO_EM_RESTART': '1', 04:19:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:31 INFO - 'PWD': '/builds/slave/test', 04:19:31 INFO - 'SHELL': '/bin/bash', 04:19:31 INFO - 'SHLVL': '1', 04:19:31 INFO - 'TERM': 'linux', 04:19:31 INFO - 'TMOUT': '86400', 04:19:31 INFO - 'USER': 'cltbld', 04:19:31 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1506510008.725700-594462741', 04:19:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:31 INFO - '_': '/tools/buildbot/bin/python'} 04:19:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:19:31 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 04:19:31 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 04:19:31 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 04:19:31 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 04:19:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:19:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:19:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:19:32 INFO - Installing collected packages: mozsystemmonitor 04:19:32 INFO - Running setup.py install for mozsystemmonitor 04:19:32 INFO - Successfully installed mozsystemmonitor 04:19:32 INFO - Cleaning up... 04:19:32 INFO - Return code: 0 04:19:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:19:32 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')]} 04:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:32 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')]} 04:19:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:32 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 0x24041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ccb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27719c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276ed60>, '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 0x276fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276fef0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1506510008.725700-594462741', '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 04:19:32 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 04:19:32 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 04:19:32 INFO - Using env: {'DISPLAY': ':0', 04:19:32 INFO - 'HOME': '/home/cltbld', 04:19:32 INFO - 'LANG': 'en_US.UTF-8', 04:19:32 INFO - 'LANGUAGE': 'en_US:en', 04:19:32 INFO - 'LOGNAME': 'cltbld', 04:19:32 INFO - 'MAIL': '/var/mail/cltbld', 04:19:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:32 INFO - 'MOZ_NO_REMOTE': '1', 04:19:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:32 INFO - 'NO_EM_RESTART': '1', 04:19:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:32 INFO - 'PWD': '/builds/slave/test', 04:19:32 INFO - 'SHELL': '/bin/bash', 04:19:32 INFO - 'SHLVL': '1', 04:19:32 INFO - 'TERM': 'linux', 04:19:32 INFO - 'TMOUT': '86400', 04:19:32 INFO - 'USER': 'cltbld', 04:19:32 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1506510008.725700-594462741', 04:19:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:32 INFO - '_': '/tools/buildbot/bin/python'} 04:19:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:32 INFO - Downloading/unpacking jsonschema==2.5.1 04:19:32 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 04:19:32 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 04:19:32 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 04:19:32 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 04:19:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:19:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:19:33 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 04:19:33 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 04:19:33 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 04:19:33 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 04:19:34 INFO - Downloading functools32-3.2.3-2.tar.gz 04:19:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:19:34 INFO - warning: no files found matching '*.txt' 04:19:34 INFO - no previously-included directories found matching 'build' 04:19:34 INFO - no previously-included directories found matching 'dist' 04:19:34 INFO - no previously-included directories found matching '.git*' 04:19:34 INFO - Installing collected packages: jsonschema, functools32 04:19:34 INFO - Running setup.py install for functools32 04:19:34 INFO - warning: no files found matching '*.txt' 04:19:34 INFO - no previously-included directories found matching 'build' 04:19:34 INFO - no previously-included directories found matching 'dist' 04:19:34 INFO - no previously-included directories found matching '.git*' 04:19:34 INFO - Successfully installed jsonschema functools32 04:19:34 INFO - Cleaning up... 04:19:34 INFO - Return code: 0 04:19:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:19:34 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')]} 04:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:34 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')]} 04:19:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:34 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 0x24041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ccb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27719c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276ed60>, '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 0x276fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276fef0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1506510008.725700-594462741', '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 04:19:34 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 04:19:34 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 04:19:34 INFO - Using env: {'DISPLAY': ':0', 04:19:34 INFO - 'HOME': '/home/cltbld', 04:19:34 INFO - 'LANG': 'en_US.UTF-8', 04:19:34 INFO - 'LANGUAGE': 'en_US:en', 04:19:34 INFO - 'LOGNAME': 'cltbld', 04:19:34 INFO - 'MAIL': '/var/mail/cltbld', 04:19:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:34 INFO - 'MOZ_NO_REMOTE': '1', 04:19:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:34 INFO - 'NO_EM_RESTART': '1', 04:19:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:34 INFO - 'PWD': '/builds/slave/test', 04:19:34 INFO - 'SHELL': '/bin/bash', 04:19:34 INFO - 'SHLVL': '1', 04:19:34 INFO - 'TERM': 'linux', 04:19:34 INFO - 'TMOUT': '86400', 04:19:34 INFO - 'USER': 'cltbld', 04:19:34 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1506510008.725700-594462741', 04:19:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:34 INFO - '_': '/tools/buildbot/bin/python'} 04:19:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:19:34 INFO - Cleaning up... 04:19:34 INFO - Return code: 0 04:19:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:19:34 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')]} 04:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:34 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')]} 04:19:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:34 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 0x24041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ccb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27719c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276ed60>, '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 0x276fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276fef0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1506510008.725700-594462741', '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 04:19:34 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 04:19:34 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 04:19:34 INFO - Using env: {'DISPLAY': ':0', 04:19:34 INFO - 'HOME': '/home/cltbld', 04:19:34 INFO - 'LANG': 'en_US.UTF-8', 04:19:34 INFO - 'LANGUAGE': 'en_US:en', 04:19:34 INFO - 'LOGNAME': 'cltbld', 04:19:34 INFO - 'MAIL': '/var/mail/cltbld', 04:19:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:34 INFO - 'MOZ_NO_REMOTE': '1', 04:19:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:34 INFO - 'NO_EM_RESTART': '1', 04:19:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:34 INFO - 'PWD': '/builds/slave/test', 04:19:34 INFO - 'SHELL': '/bin/bash', 04:19:34 INFO - 'SHLVL': '1', 04:19:34 INFO - 'TERM': 'linux', 04:19:34 INFO - 'TMOUT': '86400', 04:19:34 INFO - 'USER': 'cltbld', 04:19:34 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1506510008.725700-594462741', 04:19:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:34 INFO - '_': '/tools/buildbot/bin/python'} 04:19:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:34 INFO - Downloading/unpacking blobuploader==1.2.4 04:19:34 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 04:19:34 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 04:19:34 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 04:19:34 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 04:19:35 INFO - Downloading blobuploader-1.2.4.tar.gz 04:19:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:19:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:19:36 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 04:19:36 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 04:19:36 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 04:19:36 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 04:19:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:19:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:19:36 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 04:19:36 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 04:19:36 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 04:19:36 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 04:19:36 INFO - Downloading docopt-0.6.1.tar.gz 04:19:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:19:36 INFO - Installing collected packages: blobuploader, requests, docopt 04:19:36 INFO - Running setup.py install for blobuploader 04:19:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:19:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:19:36 INFO - Running setup.py install for requests 04:19:37 INFO - Running setup.py install for docopt 04:19:37 INFO - Successfully installed blobuploader requests docopt 04:19:37 INFO - Cleaning up... 04:19:37 INFO - Return code: 0 04:19:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:19:37 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')]} 04:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:37 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')]} 04:19:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:37 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 0x24041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ccb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27719c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276ed60>, '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 0x276fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276fef0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1506510008.725700-594462741', '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 04:19:37 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 04:19:37 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 04:19:37 INFO - Using env: {'DISPLAY': ':0', 04:19:37 INFO - 'HOME': '/home/cltbld', 04:19:37 INFO - 'LANG': 'en_US.UTF-8', 04:19:37 INFO - 'LANGUAGE': 'en_US:en', 04:19:37 INFO - 'LOGNAME': 'cltbld', 04:19:37 INFO - 'MAIL': '/var/mail/cltbld', 04:19:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:37 INFO - 'MOZ_NO_REMOTE': '1', 04:19:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:37 INFO - 'NO_EM_RESTART': '1', 04:19:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:37 INFO - 'PWD': '/builds/slave/test', 04:19:37 INFO - 'SHELL': '/bin/bash', 04:19:37 INFO - 'SHLVL': '1', 04:19:37 INFO - 'TERM': 'linux', 04:19:37 INFO - 'TMOUT': '86400', 04:19:37 INFO - 'USER': 'cltbld', 04:19:37 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1506510008.725700-594462741', 04:19:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:37 INFO - '_': '/tools/buildbot/bin/python'} 04:19:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:19:37 INFO - Running setup.py (path:/tmp/pip-NnX6k4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:19:37 INFO - Running setup.py (path:/tmp/pip-SjyLlw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:19:37 INFO - Running setup.py (path:/tmp/pip-IYoGaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:19:37 INFO - Running setup.py (path:/tmp/pip-kDr0p7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:19:37 INFO - Running setup.py (path:/tmp/pip-B197RO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:19:37 INFO - Running setup.py (path:/tmp/pip-JB7aWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:19:37 INFO - Running setup.py (path:/tmp/pip-JUELjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:19:37 INFO - Running setup.py (path:/tmp/pip-V3bB4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:19:38 INFO - Running setup.py (path:/tmp/pip-YJnhyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:19:38 INFO - Running setup.py (path:/tmp/pip-70uRyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:19:38 INFO - Running setup.py (path:/tmp/pip-55szw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:19:38 INFO - Running setup.py (path:/tmp/pip-OLr_N7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:19:38 INFO - Running setup.py (path:/tmp/pip-xiAPoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:19:38 INFO - Running setup.py (path:/tmp/pip-S57I9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:19:38 INFO - Running setup.py (path:/tmp/pip-iAGUFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:19:38 INFO - Running setup.py (path:/tmp/pip-BKyA9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:19:38 INFO - Running setup.py (path:/tmp/pip-ZrTivQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:19:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:19:38 INFO - Running setup.py install for manifestparser 04:19:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:19:38 INFO - Running setup.py install for mozcrash 04:19:38 INFO - Running setup.py install for mozdebug 04:19:38 INFO - Running setup.py install for mozdevice 04:19:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:19:39 INFO - Running setup.py install for mozfile 04:19:39 INFO - Running setup.py install for mozhttpd 04:19:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:19:39 INFO - Running setup.py install for mozinfo 04:19:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:19:39 INFO - Running setup.py install for mozInstall 04:19:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:19:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:19:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:19:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:19:39 INFO - Running setup.py install for mozleak 04:19:39 INFO - Running setup.py install for mozlog 04:19:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:19:39 INFO - Running setup.py install for moznetwork 04:19:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:19:39 INFO - Running setup.py install for mozprocess 04:19:39 INFO - Running setup.py install for mozprofile 04:19:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:19:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:19:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:19:39 INFO - Running setup.py install for mozrunner 04:19:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:19:40 INFO - Running setup.py install for mozscreenshot 04:19:40 INFO - Running setup.py install for moztest 04:19:40 INFO - Running setup.py install for mozversion 04:19:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:19:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:19:40 INFO - Cleaning up... 04:19:40 INFO - Return code: 0 04:19:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:19:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:19:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:19:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:40 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 0x24041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ccb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27719c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276ed60>, '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 0x276fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276fef0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1506510008.725700-594462741', '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 04:19:40 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 04:19:40 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 04:19:40 INFO - Using env: {'DISPLAY': ':0', 04:19:40 INFO - 'HOME': '/home/cltbld', 04:19:40 INFO - 'LANG': 'en_US.UTF-8', 04:19:40 INFO - 'LANGUAGE': 'en_US:en', 04:19:40 INFO - 'LOGNAME': 'cltbld', 04:19:40 INFO - 'MAIL': '/var/mail/cltbld', 04:19:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:40 INFO - 'MOZ_NO_REMOTE': '1', 04:19:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:40 INFO - 'NO_EM_RESTART': '1', 04:19:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:40 INFO - 'PWD': '/builds/slave/test', 04:19:40 INFO - 'SHELL': '/bin/bash', 04:19:40 INFO - 'SHLVL': '1', 04:19:40 INFO - 'TERM': 'linux', 04:19:40 INFO - 'TMOUT': '86400', 04:19:40 INFO - 'USER': 'cltbld', 04:19:40 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1506510008.725700-594462741', 04:19:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:40 INFO - '_': '/tools/buildbot/bin/python'} 04:19:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:19:40 INFO - Running setup.py (path:/tmp/pip-4GQBLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:19:40 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)) 04:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:19:40 INFO - Running setup.py (path:/tmp/pip-wamfmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:19:40 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)) 04:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:19:40 INFO - Running setup.py (path:/tmp/pip-Keg7dp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:19:40 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)) 04:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:19:40 INFO - Running setup.py (path:/tmp/pip-yGGmpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:19:40 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)) 04:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:19:40 INFO - Running setup.py (path:/tmp/pip-SI0Zgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:19:41 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)) 04:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:19:41 INFO - Running setup.py (path:/tmp/pip-QUtpuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:19:41 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)) 04:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:19:41 INFO - Running setup.py (path:/tmp/pip-Zeuocj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:19:41 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)) 04:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:19:41 INFO - Running setup.py (path:/tmp/pip-AWeWXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:19:41 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)) 04:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:19:41 INFO - Running setup.py (path:/tmp/pip-zP8kA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:19:41 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)) 04:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:19:41 INFO - Running setup.py (path:/tmp/pip-z7WidD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:19:41 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)) 04:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:19:41 INFO - Running setup.py (path:/tmp/pip-tIL6_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:19:41 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)) 04:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:19:41 INFO - Running setup.py (path:/tmp/pip-hvAclW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:19:41 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)) 04:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:19:41 INFO - Running setup.py (path:/tmp/pip-erU0TE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:19:41 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)) 04:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:19:41 INFO - Running setup.py (path:/tmp/pip-MctQmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:19:41 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)) 04:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:19:41 INFO - Running setup.py (path:/tmp/pip-9MEnjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:19:41 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)) 04:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:19:41 INFO - Running setup.py (path:/tmp/pip-qNS7XI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:19:41 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)) 04:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:19:41 INFO - Running setup.py (path:/tmp/pip-HphG7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:19:41 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)) 04:19:41 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)) 04:19:41 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)) 04:19:41 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)) 04:19:41 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)) 04:19:41 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)) 04:19:41 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)) 04:19:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:19:41 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 04:19:41 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 04:19:41 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 04:19:41 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 04:19:42 INFO - Downloading blessings-1.6.tar.gz 04:19:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:19:43 INFO - Installing collected packages: blessings 04:19:43 INFO - Running setup.py install for blessings 04:19:43 INFO - Successfully installed blessings 04:19:43 INFO - Cleaning up... 04:19:43 INFO - Return code: 0 04:19:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:19:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:19:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:19:43 INFO - Reading from file tmpfile_stdout 04:19:43 INFO - Current package versions: 04:19:43 INFO - argparse == 1.2.1 04:19:43 INFO - blessings == 1.6 04:19:43 INFO - blobuploader == 1.2.4 04:19:43 INFO - docopt == 0.6.1 04:19:43 INFO - functools32 == 3.2.3-2 04:19:43 INFO - jsonschema == 2.5.1 04:19:43 INFO - manifestparser == 1.1 04:19:43 INFO - mozInstall == 1.13 04:19:43 INFO - mozcrash == 1.0 04:19:43 INFO - mozdebug == 0.1 04:19:43 INFO - mozdevice == 0.51 04:19:43 INFO - mozfile == 1.2 04:19:43 INFO - mozhttpd == 0.7 04:19:43 INFO - mozinfo == 0.10 04:19:43 INFO - mozleak == 0.1 04:19:43 INFO - mozlog == 3.5 04:19:43 INFO - moznetwork == 0.27 04:19:43 INFO - mozprocess == 0.25 04:19:43 INFO - mozprofile == 0.28 04:19:43 INFO - mozrunner == 6.13 04:19:43 INFO - mozscreenshot == 0.1 04:19:43 INFO - mozsystemmonitor == 0.3 04:19:43 INFO - moztest == 0.8 04:19:43 INFO - mozversion == 1.4 04:19:43 INFO - psutil == 3.1.1 04:19:43 INFO - requests == 1.2.3 04:19:43 INFO - wsgiref == 0.1.2 04:19:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:19:43 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')]} 04:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:43 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')]} 04:19:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:43 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 0x24041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ccb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27719c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276ed60>, '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 0x276fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276fef0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1506510008.725700-594462741', '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 04:19:43 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 04:19:43 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 04:19:43 INFO - Using env: {'DISPLAY': ':0', 04:19:43 INFO - 'HOME': '/home/cltbld', 04:19:43 INFO - 'LANG': 'en_US.UTF-8', 04:19:43 INFO - 'LANGUAGE': 'en_US:en', 04:19:43 INFO - 'LOGNAME': 'cltbld', 04:19:43 INFO - 'MAIL': '/var/mail/cltbld', 04:19:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:43 INFO - 'MOZ_NO_REMOTE': '1', 04:19:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:43 INFO - 'NO_EM_RESTART': '1', 04:19:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:43 INFO - 'PWD': '/builds/slave/test', 04:19:43 INFO - 'SHELL': '/bin/bash', 04:19:43 INFO - 'SHLVL': '1', 04:19:43 INFO - 'TERM': 'linux', 04:19:43 INFO - 'TMOUT': '86400', 04:19:43 INFO - 'USER': 'cltbld', 04:19:43 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1506510008.725700-594462741', 04:19:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:43 INFO - '_': '/tools/buildbot/bin/python'} 04:19:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:43 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)) 04:19:43 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)) 04:19:43 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)) 04:19:43 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)) 04:19:43 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)) 04:19:43 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)) 04:19:43 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)) 04:19:43 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)) 04:19:43 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)) 04:19:43 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:19:43 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 04:19:43 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 04:19:43 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 04:19:43 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 04:19:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 04:19:44 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)) 04:19:44 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)) 04:19:44 INFO - Installing collected packages: simplejson 04:19:44 INFO - Running setup.py install for simplejson 04:19:44 INFO - building 'simplejson._speedups' extension 04:19:44 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 04:19:45 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 04:19:45 INFO - Successfully installed simplejson 04:19:45 INFO - Cleaning up... 04:19:45 INFO - Return code: 0 04:19:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:19: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')]} 04:19:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19: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')]} 04:19:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ccb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27719c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276ed60>, '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 0x276fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276fef0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1506510008.725700-594462741', '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 04:19:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:19:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:19:45 INFO - Using env: {'DISPLAY': ':0', 04:19:45 INFO - 'HOME': '/home/cltbld', 04:19:45 INFO - 'LANG': 'en_US.UTF-8', 04:19:45 INFO - 'LANGUAGE': 'en_US:en', 04:19:45 INFO - 'LOGNAME': 'cltbld', 04:19:45 INFO - 'MAIL': '/var/mail/cltbld', 04:19:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:45 INFO - 'MOZ_NO_REMOTE': '1', 04:19:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:45 INFO - 'NO_EM_RESTART': '1', 04:19:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:45 INFO - 'PWD': '/builds/slave/test', 04:19:45 INFO - 'SHELL': '/bin/bash', 04:19:45 INFO - 'SHLVL': '1', 04:19:45 INFO - 'TERM': 'linux', 04:19:45 INFO - 'TMOUT': '86400', 04:19:45 INFO - 'USER': 'cltbld', 04:19:45 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1506510008.725700-594462741', 04:19:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:45 INFO - '_': '/tools/buildbot/bin/python'} 04:19:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:19:46 INFO - Cleaning up... 04:19:46 INFO - Return code: 0 04:19:46 INFO - Running post-action listener: _resource_record_post_action 04:19:46 INFO - Running post-action listener: _start_resource_monitoring 04:19:46 INFO - Starting resource monitoring. 04:19:46 INFO - [mozharness: 2017-09-27 11:19:46.166662Z] Finished create-virtualenv step (success) 04:19:46 INFO - [mozharness: 2017-09-27 11:19:46.167262Z] Running install step. 04:19:46 INFO - Running pre-action listener: _resource_record_pre_action 04:19:46 INFO - Running main action method: install 04:19:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:19:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:19:46 INFO - Reading from file tmpfile_stdout 04:19:46 INFO - Detecting whether we're running mozinstall >=1.0... 04:19:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:19:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:19:46 INFO - Reading from file tmpfile_stdout 04:19:46 INFO - Output received: 04:19:46 INFO - Usage: mozinstall [options] installer 04:19:46 INFO - Options: 04:19:46 INFO - -h, --help show this help message and exit 04:19:46 INFO - -d DEST, --destination=DEST 04:19:46 INFO - Directory to install application into. [default: 04:19:46 INFO - "/builds/slave/test"] 04:19:46 INFO - --app=APP Application being installed. [default: firefox] 04:19:46 INFO - mkdir: /builds/slave/test/build/application 04:19:46 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'] 04:19:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:20:04 INFO - Reading from file tmpfile_stdout 04:20:04 INFO - Output received: 04:20:04 INFO - /builds/slave/test/build/application/firefox/firefox 04:20:04 INFO - Running post-action listener: _resource_record_post_action 04:20:04 INFO - [mozharness: 2017-09-27 11:20:04.199887Z] Finished install step (success) 04:20:04 INFO - [mozharness: 2017-09-27 11:20:04.200145Z] Running setup-mitmproxy step. 04:20:04 INFO - Running pre-action listener: _resource_record_pre_action 04:20:04 INFO - Running main action method: setup_mitmproxy 04:20:04 INFO - Skipping: mitmproxy is not required 04:20:04 INFO - Running post-action listener: _resource_record_post_action 04:20:04 INFO - [mozharness: 2017-09-27 11:20:04.201458Z] Finished setup-mitmproxy step (success) 04:20:04 INFO - [mozharness: 2017-09-27 11:20:04.201682Z] Running run-tests step. 04:20:04 INFO - Running pre-action listener: _resource_record_pre_action 04:20:04 INFO - Running pre-action listener: _set_gcov_prefix 04:20:04 INFO - Running main action method: run_tests 04:20:04 WARNING - Try message not found. 04:20:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:20:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:20:04 INFO - Python 2.7.3 04:20:04 INFO - Return code: 0 04:20:04 INFO - grabbing minidump binary from tooltool 04:20:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:04 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 0x276ed60>, '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 0x276fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276fef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:20:04 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 04:20:04 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 04:20:04 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 04:20:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:20:04 INFO - Return code: 0 04:20:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:20:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:20:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:20:04 INFO - ENV: RUST_BACKTRACE is now full 04:20:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:20:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:20:04 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/NUZcoITBQvu1HCNBvdTH4w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 04:20:04 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/NUZcoITBQvu1HCNBvdTH4w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 04:20:04 INFO - Using env: {'DISPLAY': ':0', 04:20:04 INFO - 'HOME': '/home/cltbld', 04:20:04 INFO - 'LANG': 'en_US.UTF-8', 04:20:04 INFO - 'LANGUAGE': 'en_US:en', 04:20:04 INFO - 'LOGNAME': 'cltbld', 04:20:04 INFO - 'MAIL': '/var/mail/cltbld', 04:20:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:20:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:20:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:04 INFO - 'MOZ_NO_REMOTE': '1', 04:20:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:20:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:04 INFO - 'NO_EM_RESTART': '1', 04:20:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:04 INFO - 'PWD': '/builds/slave/test', 04:20:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:20:04 INFO - 'RUST_BACKTRACE': 'full', 04:20:04 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:20:04 INFO - 'SHELL': '/bin/bash', 04:20:04 INFO - 'SHLVL': '1', 04:20:04 INFO - 'TERM': 'linux', 04:20:04 INFO - 'TMOUT': '86400', 04:20:04 INFO - 'USER': 'cltbld', 04:20:04 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1506510008.725700-594462741', 04:20:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:04 INFO - '_': '/tools/buildbot/bin/python'} 04:20:04 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/NUZcoITBQvu1HCNBvdTH4w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 04:20:04 INFO - mozversion application_buildid: 20170927094813 04:20:04 INFO - mozversion application_changeset: 35fbf14b96a633c3f66ea13c1a163a3f3a4219b9 04:20:04 INFO - mozversion application_display_name: Nightly 04:20:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:20:04 INFO - mozversion application_name: Firefox 04:20:04 INFO - mozversion application_remotingname: firefox 04:20:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:20:04 INFO - mozversion application_vendor: Mozilla 04:20:04 INFO - mozversion application_version: 58.0a1 04:20:04 INFO - mozversion platform_buildid: 20170927094813 04:20:04 INFO - mozversion platform_changeset: 35fbf14b96a633c3f66ea13c1a163a3f3a4219b9 04:20:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:20:04 INFO - mozversion platform_version: 58.0a1 04:20:04 INFO - using testdate: 1506511204 04:20:04 INFO - actual date: 1506511204 04:20:04 INFO - starting webserver on 'localhost:55096' 04:20:04 INFO - SUITE-START | Running 2 tests 04:20:04 INFO - TEST-START | dromaeo_css 04:20:04 INFO - Initialising browser for dromaeo_css test... 04:20:04 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55096/getInfo.html -profile /tmp/tmpom_6iA/profile 04:20:04 INFO - TEST-INFO | started process 8281 (/builds/slave/test/build/application/firefox/firefox http://localhost:55096/getInfo.html) 04:20:10 INFO - TEST-INFO | 8281: exit 0 04:20:10 INFO - Browser initialized. 04:20:10 INFO - Running cycle 1/1 for dromaeo_css test... 04:20:10 INFO - Using env: {'DISPLAY': ':0', 04:20:10 INFO - 'HOME': '/home/cltbld', 04:20:10 INFO - 'JSGC_DISABLE_POISONING': '1', 04:20:10 INFO - 'LANG': 'en_US.UTF-8', 04:20:10 INFO - 'LANGUAGE': 'en_US:en', 04:20:10 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:20:10 INFO - 'LOGNAME': 'cltbld', 04:20:10 INFO - 'MAIL': '/var/mail/cltbld', 04:20:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:20:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:20:10 INFO - 'MOZ_CRASHREPORTER': '1', 04:20:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:10 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:20:10 INFO - 'MOZ_NO_REMOTE': '1', 04:20:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:20:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:10 INFO - 'NO_EM_RESTART': '1', 04:20:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:10 INFO - 'PWD': '/builds/slave/test', 04:20:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:20:10 INFO - 'RUST_BACKTRACE': 'full', 04:20:10 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:20:10 INFO - 'SHELL': '/bin/bash', 04:20:10 INFO - 'SHLVL': '1', 04:20:10 INFO - 'STYLO_FORCE_DISABLED': '1', 04:20:10 INFO - 'TERM': 'linux', 04:20:10 INFO - 'TMOUT': '86400', 04:20:10 INFO - 'USER': 'cltbld', 04:20:10 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1506510008.725700-594462741', 04:20:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:10 INFO - '_': '/tools/buildbot/bin/python'} 04:20:10 INFO - TEST-INFO | started process 8519 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpom_6iA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:20:11 INFO - PID 8519 | 04:20:11 INFO - PID 8519 | (/builds/slave/test/build/application/firefox/firefox:8569): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:20:11 INFO - PID 8519 | 04:20:21 INFO - PID 8519 | RSS: Main: 144797696 04:20:21 INFO - PID 8519 | 04:23:19 INFO - PID 8519 | Cycle 1(1): loaded http://localhost:55096/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55096/tests/dromaeo/cssquery-ext.html) 04:23:20 INFO - PID 8519 | RSS: Main: 146444288 04:23:20 INFO - PID 8519 | 04:26:22 INFO - PID 8519 | Cycle 1(1): loaded http://localhost:55096/tests/dromaeo/cssquery-ext.html (next: http://localhost:55096/tests/dromaeo/cssquery-jquery.html) 04:26:22 INFO - PID 8519 | RSS: Main: 146542592 04:26:22 INFO - PID 8519 | 04:29:24 INFO - PID 8519 | Cycle 1(1): loaded http://localhost:55096/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55096/tests/dromaeo/cssquery-mootools.html) 04:29:25 INFO - PID 8519 | RSS: Main: 148754432 04:29:25 INFO - PID 8519 | 04:32:26 INFO - PID 8519 | Cycle 1(1): loaded http://localhost:55096/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55096/tests/dromaeo/cssquery-prototype.html) 04:32:27 INFO - PID 8519 | RSS: Main: 145981440 04:32:27 INFO - PID 8519 | 04:35:30 INFO - PID 8519 | Cycle 1(1): loaded http://localhost:55096/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55096/tests/dromaeo/cssquery-yui.html) 04:35:31 INFO - PID 8519 | RSS: Main: 147886080 04:35:31 INFO - PID 8519 | 04:38:32 INFO - PID 8519 | Cycle 1(1): loaded http://localhost:55096/tests/dromaeo/cssquery-yui.html (next: http://localhost:55096/tests/dromaeo/cssquery-dojo.html) 04:38:32 INFO - PID 8519 | RSS: Main: 149925888 04:38:32 INFO - PID 8519 | 04:38:32 INFO - PID 8519 | __start_tp_report 04:38:32 INFO - PID 8519 | _x_x_mozilla_page_load 04:38:32 INFO - PID 8519 | _x_x_mozilla_page_load_details 04:38:32 INFO - PID 8519 | |i|pagename|runs| 04:38:32 INFO - PID 8519 | |0;dojo.html;3813.2945405100054;3828.4640150378937;3829.234153169366;3895.318319294123;3917.7257591968555;6250.562460627758;6307.495400367971;6331.271903731073;6352.841178970528;6361.872762544746;6292.937070629292;6315.052742088689;6394.072859435379;6429.967850160754;6434.388733070363;5734.541236701054;5753.165790960308;5786.421357864222;5804.245448091763;5824.737886795083;5677.17680936264;5731.484166425021;5781.913271300934;5810.128480727883;5852.941470585282;5608.411116832735;5630.127330263816;5688.203651488795;5702.144678298247;5790.913136302959;5672.631278966854;5719.942800571983;5739.167820666022;5750.108733146369;5793.420657934215;5644.294463192101;5688.60179787415;5718.199452076713;5790.10253410722;5792.855178620526;6415.0377443383395;6425.61446313218;6426.453751431134;6446.097546343516;6449.774257900998;6928.826779330507;6967.756128535477;6969.6166710830885;7052.964735176342;7066.152061752571;6878.793636190872;6914.343137401989;7009;7063.8587228255665;7114.039604653357;6477.384648458389;6511.934880651228;6513.739450421977;6518.641474718888;6523.543351965364;7126.643667816692;7163.462740294499;7203;7203.855922881513;7227.421806255487;6829.863402731918;6830.316968303229;6836.794896153124;6875.243723190445;6924.307569243036;6848.623325717033;6970.616616086062;6998.4751143664425;7042.647867606599;7076.221615622278;6903.033575299462;6942.687579058955;6967.477439191979;7019;7021.262767409451;6935.653217339213;6943.375096241261;7030.050943122613;7030.6484675766005;7040.542364746275;5078.111330517145;5083.69497830124;5093.363329583802;5096.745162741848;5165.811863271469;4539.72761634303;4577.954220457819;4612.400387949545;4626.074785043005;4684.648651351163;6358.523110766711;6430.0354946757425;6449.548531602836;6450.612963222222;6456.741730330828;6917.89623155653;6949.200841903245;6996.405305548984;7035.507514473938;7042.154941407064;6303.212098487689;6336.366363363627;6390.424861762371;6392.968035159887;6415.26224484181;5497.8075767348755;5543.916841247385;5580.051391263495;5617.21359009739;5666.801661941812;6999.965000174967;7001.334873187039;7100.46746494015;7106.395956343666;7203.927960720326;6843.726250950006;6924.376806087476;6929.0299358090915;6934.445244380337;6938.098047253825;7061.752838650623;7115.324044215791;7128.180259270251;7136.85726285461;7148.821279468055;6780.762673306411;6825.385715285648;6850;6886.48351373639;6893.965530172518;6794.320567943364;6803.659817009031;6890.896636550556;6894.551854129466;6902.447804175554;6584.275729669828;6588.275289718223;6602.66986650656;6683.365080317362;6732.899006515004;6694.799156025327;6721.260661327348;6727.260001399744;6735.090762747162;6737.056812046219;6605.702743376463;6663.600183988976;6669.533132680665;6677.065210870385;6686.3313668632745;6626.2379826318665;6735.831604209934;6825.249222585611;6832.350926661959;6847.965760171167;6451.806445806634;6514.902276465762;6565.277819439953;6605.801825945229;6609.603423794588 04:38:32 INFO - PID 8519 | |1;ext.html;930.5254320296651;965.4207475514688;974.298505076345;1006.6074231049892;1006.974825629359;42350.364744528815;42652.3602145968;42764.78617606908;42987;43038.784806075964;39796;40022.59977400225;40138.39792403116;40187.99530011751;40209.59790402095;7262.745803896864;7353.889691654629;7390.076240469942;7397.149327827315;7413.036305280306;7409.222031686676;7444.776656700281;7451.888221676679;7456.51532650376;7461.477696561243;6661.03415004824;6665.666716664172;6669.599824010551;6685.832854178636;6731.1922569291755;6586.209654841426;6647.50143739219;6667.033280174396;6695.732170713166;6699.464042876558;8189.22202390772;8343.749687509384;8412.369072319601;8413.579321033985;8435.662573497053;39712.60287397118;39716.801415993024;40161.39757903634;40245.59754402448;40260.39609405861;3686.189038411545;3758.605346438612;3766.8304926278383;3767.5478942526797;3770.924581508382;32730;32811.83594082014;32870.342593148;32883.3423331532;33024.50463243053;5287.814926477593;5302.787888484495;5307.310049693554;5314.282571852789;5328.120860058086;219984;221163;222261;222865;223675.8816205925;49502.50497495051;49614.75192624014;49972.50027499751;50622.493775061776;50667;51958.74020629948;52235.73882130565;52462.737686311324;52620;52648;16576.254068566945;16902.74645880313;16911.154442277835;16933.576660583585;16936.322547098225;13723.45106195761;13757.587272381845;13814.792778108336;13826.377812998438;13828.654283642989;14180.14919104857;14342.713145737027;14420.927895360455;14474.421023158955;14633.926830365994;5744.655320680772;5757.337906140848;5852.7658893643775;5864.413558644187;5979.790707325223;1082.1991726122612;1097.2757979733497;1099.5491848342301;1107.379867274329;1126.9774604508027;25054.749452505606;25113.87443062773;25143.748562514505;25415.36461588438;25499.617505737428;1197.700574856286;1199.5861427807392;1201.6815543880878;1207.3299318878107;1211.1642966353188;13199.670008249679;13217.537386191438;13342.332883355793;13419.463221471031;13481.056326057082;252537;254979;254999;255055;255096;48492;49402.50597494051;54672.72663636656;54797.72601137048;55249.72375138099;1516.9089854608537;1541.845815418449;1545.389571119379;1556.3307777655716;1556.4707999280072;29536;29786.70213297926;30313;30468.085957421314;30908.53637195399;40380.1923961525;40403.393949091376;40421.797891011534;40501.39247911343;40539.594604054764;235545;236249;236402;237816;238252;33397.49903751494;34266.31467370688;34543;34733.826330868185;34738.478922816685;43828;44426.55573444354;45579;45774.31338529858;45880.31179532243;33683;34044;34496.31007379788;34726.65273347234;34818.30363392668;33073.83463082669;33295.50056749199;33984.320313594086;34301.65698342985;34525.827370862986;39488;39646;39691.80154099211;39747.2050558993;39898.40152397774;32834.67165328316;32906.341873162884;33132.503012455316;33169;33832.66167338295;25044.499110018063;25314.114006009702;25609.359766006;25630.66801315817;25725.485490289717 04:38:32 INFO - PID 8519 | |2;jquery.html;588.5526999480396;609.1289456077807;617.8424501752055;622.5144387377845;654.5025780406891;22901.4274643134;23027.194048208316;24093.397665058383;24111.63832542509;24125.517489650218;25582.360440988985;26156.738432615715;26271.211863644072;26313.21060368192;26318.342041448974;6317.147185130006;6482.157319548475;6492.675366231693;6504.0569117477935;6519.869602607969;6348.26994895586;6349.714262858182;6408.070829729686;6641.236257830363;6653.2681405045405;6621.801345959629;6631.27056023837;6633.038209459625;6633.13769210002;6633.535652504326;6350.904736428957;6578.769743058994;6622.735090596394;6651.66741662915;6691.364320389555;6219.689015549205;6241.594296370721;6244.750209991595;6250.468710159642;6253.343398943137;29588.260293492618;29837.25406864824;29850.85074574635;30071.248218794488;30122.24694382636;2309.1571576374504;2314.271004633535;2315.629499280124;2343.8359314847967;2352.235523454884;19829.603407931903;19871.205151794056;20941.685874711893;21081.156753729832;21095.5780884383;2542.9237122886343;2588.197658725801;2603.609458581228;2613.973860261392;2641.8546979916096;139749;144952;145825;151033;156644.21677891538;15724.528264152093;15836.208189590474;16214.243578591668;16237.350505979628;16658.750118748227;26032.479350412887;26224;26239.344016399744;26264.34339141537;26283.60574591383;10087.142592879542;10207.132393746466;10238.948805255926;10307.175425965905;10438.37369757817;9088.182063614306;9215;9253.583588738524;9258.074192580689;9263.16631503168;9656.889457712312;9693.369930954465;9814.116729494379;9923.354981926295;10058.798824023479;2934.119764070813;2934.735873771328;2969.539721343195;2971.5542668599883;3046.3754930239247;1045.8378951262566;1049.239301506417;1066.4774260612398;1067.2529229539352;1073.2111897755144;20594.382168534667;20781.376558703265;21020.159193632084;21189.682154767692;21268.787312126682;1113.3486910157487;1125.2629527659396;1126.0541145437708;1131.338167172197;1133.0482394788417;11717.76564468723;11785.764284714258;11873.940630296793;11903.761924761457;11913.463894124785;618931;650035;668714;670247.5950480963;673561;127240;129444.35277823551;129785.35107324591;130574;132156.3392183033;1107.5735841701003;1164.598213616318;1189.9226550274204;1230.3786587773118;1266.5187228852976;21578;21784.34646960594;21962.560748785254;22099.33701988943;22221;62642;64385;64610.67694661496;64675;66156.33843661695;78247.60876195582;78444.21555784598;80323.3935321302;80361.19638803772;80455;15508.5347439577;15910;15915.602109947344;16062.67874642524;16083.195840208176;24370.87814560916;24496.87751561231;24500.50998980046;24639.876800615883;24672.25983220506;19776.30782922591;19788.802111978697;19875;19924.103415346053;20177.697334540288;17239.87940783845;17323.56691082733;17658.117094144985;18090.90954545219;18353.816461835744;19754;20024.498162638152;20270.79729202748;20298;20302.898485507478;15401.691966160839;15590.454334098253;15700.528984130495;15702.842971570139;15735;19275.4217373479;19372.612547748686;19445.61108777845;19817.801821981597;19845.60308793787 04:38:32 INFO - PID 8519 | |3;mootools.html;1414.7453458377493;1461.8538146185376;1471.8896082793792;1473.7347277490055;1480.2598700649671;16563.66872662546;17160;17943.37198198065;18043.639127217448;18148.455546333596;17549.824501754978;17853;17866.731999020027;17879.92720436775;17880.910595447003;2747.2719729271757;2811.3814960708664;2834.8015638905285;2842.6020357150014;2875;2902.956455653167;2908.796384253103;2937.8824847006094;2939.382729626781;2939.661938877035;2887.768978481727;2900.390917907242;2908.6509618845766;2916.3438226399103;2931.4723349797027;2793.0782841662203;2799.0623141247706;2824.138637715496;2841.8436985965764;2867.182852886928;2775.6252905857655;2820.5487122060576;2826.42058378032;2847.686754457008;2858.6283783108065;16338.101404422752;16406.343746250135;16419.343226270936;16516.669666606722;16589.336426542923;8453.704120355758;8662.350323725746;8959.462432254086;9163.08369163085;9244.95377523108;5663.971680141614;5800.651960882361;5882.999890018707;5904.143899134601;5961.612495187842;2151.7310336207975;2155.5796619659172;2167.869927804337;2192.1998470558133;2202.570498752744;29960.400791984255;30045;30195.547066794017;30210.697893021228;30477;7237.746678866214;7400;7456.308361234014;7523.3981281497345;7548.622568871535;19673.21307147727;19688.21247150098;19734.210631574577;19750.11124499401;19757.209711611664;7247.528910620793;8551.700690475804;8753.606087726068;8768.912310876936;8783.209511144029;6525;6678.599284042973;6958.304169583002;6958.338957799001;7891.723789667334;5690.4025077367105;5890.263717035371;5904.0553511437965;6027.397260273938;6133.172021777003;1621.9756703649455;1647.9423220187236;1648.175912043978;1649.7607846862377;1667.674803413347;921.5576523268868;944.7024187380953;946.947917864524;948.1656142594472;948.5778828421286;8306.08633050364;8307.376946728898;8372.372072094617;8384.58077096155;8493.44792588492;776.9883451748228;795.8328750962247;797.8643630582815;798.7883210949103;807.2492581898773;5432.864178395493;5534.52956498694;5564.499195072382;5649.12438572022;5649.774009039675;24245;24817.875910620693;25183.496330073664;25433.618495722578;25482.490350192893;23692.64461033086;24347.513049738907;24393.39016524601;24806.131785387424;24881.253562393158;12675.492980280686;12796.14016762409;12850;12854.421551030038;12869.163504372373;8779.341549383695;8800.33997450181;8809.515476648847;8953.507557084162;8989;20605.793942060987;20853.061612227182;21190.894045529672;21376.358709238746;21496.355109346743;21839.235626752987;21878.45303867416;22013.889930550245;22334.21830235934;22499.212527561456;11665.708357291136;12129.150959433107;12265.754684906073;12409.317487538272;12452.875471245534;15313.081215127128;15575.766363504783;15653.765193521878;15655.608609784846;15769.842301576837;12542.686432839251;12931.159474634118;12976.870231297944;13066.673333166367;13124.278164701032;12316.815247771112;12417.565385211474;12727.23636581808;12798.552050678181;12825.615231543068;9767.706968790948;10066.144377727682;10141.847872281774;10169.237307201842;10188.490575471049;7585.658645361083;7637.312641862259;7752.224777522202;7787.260210280015;7837.568933708472;8243.134470880472;8432.283255923316;8451.492910425393;8454.915450845412;8493.575321234037 04:38:32 INFO - PID 8519 | |4;prototype.html;558.5280438029863;568.428729127227;569.2997612936091;600.4115966352974;606.6966516741629;6181.8763624727535;6281.277653069898;6304.653244071575;6307.3692630736905;6355.872882542352;6196.69016549173;6259.405356491126;6283.120363149163;6290.748370065192;6293.716782744776;4927.556519913207;5034.82378116766;5093.2105523643895;5106.4382917879;5122.6926384416965;4987.576056035223;5015.3730783652045;5029;5036.647434679574;5059.721715305656;4998;5014.548690617862;5024.196128619422;5042.445331013604;5056.418511871127;5024.572911302544;5031.496850314976;5038.236617183975;5042.974785126087;5078;4529.705569138028;4567.109413664337;4574.542545745432;4592.609628181609;4621.399218101626;6122.693865306717;6131.321207275643;6142.84642883927;6244.469220116295;6304;5900.852478688024;5914.674692891889;5931.199288096095;5935.49548288396;5956.851078723023;6700.564463309918;6709.429698475636;6725.6973436195485;6725.899111513331;6746.571234355628;4880.682755620909;5107.463716309771;5115.411727651331;5136.383633963911;5157.7936882524655;6822.488313376517;6879.690413931385;6912;6928.44572434204;6942.479314051416;5240.292560504283;5252.842414727565;5267.71027593486;5273.44628813969;5296.099663057213;5226.869328266824;5334.253204551366;5334.733263336818;5350.571954243651;5390.757415916293;5906.940930590725;5929.10268714016;5945.494632956247;5956.7319470623925;5973.133895585116;6693.866122677519;6732.427743641845;6748.595084294958;6768.526203165731;6772;1826.7899191592871;1832.3128826689992;1835.3667984545311;1837.5498002989086;1854.9072546372627;1242.236024844714;1305.2429590837291;1314.3165553911913;1315.3620494060374;1323.6690827293178;6084.330723620398;6090.36051214625;6109.358517355614;6176.567640265138;6208.410201030985;6684.832879177962;6729.22613899398;6730.850899062221;6760.93239067603;6765;5971.28344598651;6050.2437195350585;6115.938840611626;6168.242051015439;6197.876042479125;3536.2220311531937;3551.538300020981;3558.644135586421;3567.3411863483607;3572.7499075064497;6916.688749006306;6959.164900212007;6973.198082220508;6975.79072627822;6984.685689144001;6868.175818901664;6955.513114081966;6959.408450281783;7067.505274630829;7074.787756367317;6868.793936181923;6971.54684945487;7000.439964802804;7001.474889383317;7014.5440546364325;6703.4972377070935;6757.45940324763;6797.218319893275;6825;6877.830768769421;6705.832354191184;6715.194176698632;6732.259451460433;6733.091032710521;6755.256921738506;6807.3873351398615;6941.375276225164;6962.582245065312;7027.402670773042;7033.46795153734;5220.269162317202;5231.0845602018735;5231.607629427732;5249.057848596044;5265.315508983807;6603.702833372414;6815.863682726219;6821.727130914906;6831.89752153728;6875;6377.585456945284;6608.603483790988;6659.600423974577;6665.533412661067;6665.600063996176;6480.287168411565;6628.122548309293;6632.535722499379;6645.302243264581;6650.700718467584;6305.432511074026;6438.420542151229;6476.31998640136;6488.416042556192;6542.280349161683;6558.704858281484;6622.470202383702;6663.533552651268;6667;6699.162604674416;6505.934940650533;6506.3493650634555;6532.673366331569;6536.640484773383;6564.704588293634 04:38:32 INFO - PID 8519 | |5;yui.html;984.6209209454363;997.9023074617919;1013.7972405518898;1014.3153371474253;1014.3356101753345;18882.24471021159;19170.61658766824;19182.712259316122;19201.327953521628;19638.803611963875;18488.630227395442;18503.444896653087;18594;18605.534861628432;18638.53403664909;1038.096855735511;1050.6847945616285;1050.8633877595903;1056.1234175634243;1056.1550759392455;1040.1574724473164;1046.0794500839252;1046.7592453735608;1047.1831971062584;1048.638219814163;1046.4715318764013;1068.845017472466;1079.034264333421;1080.3355936099322;1096.6490722968654;1075.3870293932462;1076.2036093290988;1076.4617691154422;1077.159815344029;1077.8975997280324;796.0646240667193;803.0804728585737;803.236924921327;805.6616221187115;806.1938061938062;20753.481162970897;21264.89367553168;21514.784852151435;21549.461263468384;21621.35135945924;22868.627882327113;23739.643905341432;23745.525089498286;23974.760252397427;24123.638145427834;18714;19087.141078651493;19388.612227755508;19390.80609193904;19393.32123375689;3713.814309284525;3727.105494681257;3742.120601658608;3744.307303148899;3753.6058713834927;128694.35652821675;142389;153790;157245.2137739304;161003;18440;18511.35210267661;18563.628727425377;18814.52963675919;18862.056897155362;34434.139146521535;35014.299714005574;35025.64974350275;35130.64869351274;35175.296494070484;10147.746306342253;10284.588616455258;10301.896981030093;10334.483275836179;10365.792684146274;4738.573528382462;4789.976050119797;4793.9280910786365;4803.3995750531185;4804.95195048045;6099;6160.383961603893;6206.937930620727;6254.3745625437095;6257;1223.8653748087704;1268.1376663868473;1276.5595869425033;1284.6146156153118;1286.2346903592347;725.8693435181613;751.9135299440525;756.8599809035346;771.6219052664154;784.5567254501188;13298.268595227355;13797.24115173655;14208.289585520683;15009.549713508612;15034;743.8995735575736;754.2796629219192;755.7657126290867;766.9846603067907;767.1254769562703;6352.523560732963;6490.1238332825405;6523.478121750249;6542.116814230113;6575.046618240328;147580.2620986888;150024.24987874992;150751;152065;155431;130175;130287;132101.35797284;136786;137554;114495;114834;115702;117402.41298793622;119191;12207.938960305142;12422.565210217599;12465.439055242354;12486.250824950168;12693.746125077261;55201.447985521234;55461.7226913879;55474.72262638661;56896.431035690766;57371.13943290771;71257.28742712506;73039;73870;74569.25430745623;74917.2508274932;17404.303827847252;17736.467905962843;17987.820121798613;18172.182251798964;18407.723884142015;19728.30950916711;19847.60304793925;20200.797992019892;20343.389698309074;20451.590968180255;18595.628087438447;18688.626227475645;18805.435836924913;18821.529461763566;19102.617947641247;18384.81615183831;18618.534536636693;18850.811491885455;18860.528486787392;19018.42944711661;16833.15834208309;17297.91351043237;17301.91349043297;17372.47882563525;17580.329868662455;11204.047655949336;11280.887191128311;11603.071754259809;11761.353125578175;11799.882001180222;13113.868861311264;13147.474101035852;13190.274534900673;13259.204447733167;13317.533886313933 04:38:32 INFO - PID 8519 | __end_tp_report 04:38:32 INFO - PID 8519 | __start_cc_report 04:38:32 INFO - PID 8519 | _x_x_mozilla_cycle_collect,272 04:38:32 INFO - PID 8519 | __end_cc_report 04:38:32 INFO - PID 8519 | __startTimestamp1506512312719__endTimestamp 04:38:32 INFO - PID 8519 | 04:38:32 INFO - PID 8519 | ------- Summary: start ------- 04:38:32 INFO - PID 8519 | Number of tests: 6 04:38:32 INFO - PID 8519 | 04:38:32 INFO - PID 8519 | [#0] dojo.html Cycles:165 Average:6376.45 Median:6605.80 stddev:766.31 (11.6%) stddev-sans-first:741.81 04:38:32 INFO - PID 8519 | Values: 3813.3 3828.5 3829.2 3895.3 3917.7 6250.6 6307.5 6331.3 6352.8 6361.9 6292.9 6315.1 6394.1 6430.0 6434.4 5734.5 5753.2 5786.4 5804.2 5824.7 5677.2 5731.5 5781.9 5810.1 5852.9 5608.4 5630.1 5688.2 5702.1 5790.9 5672.6 5719.9 5739.2 5750.1 5793.4 5644.3 5688.6 5718.2 5790.1 5792.9 6415.0 6425.6 6426.5 6446.1 6449.8 6928.8 6967.8 6969.6 7053.0 7066.2 6878.8 6914.3 7009.0 7063.9 7114.0 6477.4 6511.9 6513.7 6518.6 6523.5 7126.6 7163.5 7203.0 7203.9 7227.4 6829.9 6830.3 6836.8 6875.2 6924.3 6848.6 6970.6 6998.5 7042.6 7076.2 6903.0 6942.7 6967.5 7019.0 7021.3 6935.7 6943.4 7030.1 7030.6 7040.5 5078.1 5083.7 5093.4 5096.7 5165.8 4539.7 4578.0 4612.4 4626.1 4684.6 6358.5 6430.0 6449.5 6450.6 6456.7 6917.9 6949.2 6996.4 7035.5 7042.2 6303.2 6336.4 6390.4 6393.0 6415.3 5497.8 5543.9 5580.1 5617.2 5666.8 7000.0 7001.3 7100.5 7106.4 7203.9 6843.7 6924.4 6929.0 6934.4 6938.1 7061.8 7115.3 7128.2 7136.9 7148.8 6780.8 6825.4 6850.0 6886.5 6894.0 6794.3 6803.7 6890.9 6894.6 6902.4 6584.3 6588.3 6602.7 6683.4 6732.9 6694.8 6721.3 6727.3 6735.1 6737.1 6605.7 6663.6 6669.5 6677.1 6686.3 6626.2 6735.8 6825.2 6832.4 6848.0 6451.8 6514.9 6565.3 6605.8 6609.6 04:38:32 INFO - PID 8519 | 04:38:32 INFO - PID 8519 | [#1] ext.html Cycles:180 Average:41126.25 Median:34778.39 stddev:61788.07 (177.7%) stddev-sans-first:61887.68 04:38:32 INFO - PID 8519 | Values: 930.5 965.4 974.3 1006.6 1007.0 42350.4 42652.4 42764.8 42987.0 43038.8 39796.0 40022.6 40138.4 40188.0 40209.6 7262.7 7353.9 7390.1 7397.1 7413.0 7409.2 7444.8 7451.9 7456.5 7461.5 6661.0 6665.7 6669.6 6685.8 6731.2 6586.2 6647.5 6667.0 6695.7 6699.5 8189.2 8343.7 8412.4 8413.6 8435.7 39712.6 39716.8 40161.4 40245.6 40260.4 3686.2 3758.6 3766.8 3767.5 3770.9 32730.0 32811.8 32870.3 32883.3 33024.5 5287.8 5302.8 5307.3 5314.3 5328.1 219984.0 221163.0 222261.0 222865.0 223675.9 49502.5 49614.8 49972.5 50622.5 50667.0 51958.7 52235.7 52462.7 52620.0 52648.0 16576.3 16902.7 16911.2 16933.6 16936.3 13723.5 13757.6 13814.8 13826.4 13828.7 14180.1 14342.7 14420.9 14474.4 14633.9 5744.7 5757.3 5852.8 5864.4 5979.8 1082.2 1097.3 1099.5 1107.4 1127.0 25054.7 25113.9 25143.7 25415.4 25499.6 1197.7 1199.6 1201.7 1207.3 1211.2 13199.7 13217.5 13342.3 13419.5 13481.1 252537.0 254979.0 254999.0 255055.0 255096.0 48492.0 49402.5 54672.7 54797.7 55249.7 1516.9 1541.8 1545.4 1556.3 1556.5 29536.0 29786.7 30313.0 30468.1 30908.5 40380.2 40403.4 40421.8 40501.4 40539.6 235545.0 236249.0 236402.0 237816.0 238252.0 33397.5 34266.3 34543.0 34733.8 34738.5 43828.0 44426.6 45579.0 45774.3 45880.3 33683.0 34044.0 34496.3 34726.7 34818.3 33073.8 33295.5 33984.3 34301.7 34525.8 39488.0 39646.0 39691.8 39747.2 39898.4 32834.7 32906.3 33132.5 33169.0 33832.7 25044.5 25314.1 25609.4 25630.7 25725.5 04:38:32 INFO - PID 8519 | 04:38:32 INFO - PID 8519 | [#2] jquery.html Cycles:180 Average:41170.22 Median:2329.73 stddev:109211.89 (4687.7%) stddev-sans-first:109475.75 04:38:32 INFO - PID 8519 | Values: 588.6 609.1 617.8 622.5 654.5 22901.4 23027.2 24093.4 24111.6 24125.5 25582.4 26156.7 26271.2 26313.2 26318.3 6317.1 6482.2 6492.7 6504.1 6519.9 6348.3 6349.7 6408.1 6641.2 6653.3 6621.8 6631.3 6633.0 6633.1 6633.5 6350.9 6578.8 6622.7 6651.7 6691.4 6219.7 6241.6 6244.8 6250.5 6253.3 29588.3 29837.3 29850.9 30071.2 30122.2 2309.2 2314.3 2315.6 2343.8 2352.2 19829.6 19871.2 20941.7 21081.2 21095.6 2542.9 2588.2 2603.6 2614.0 2641.9 139749.0 144952.0 145825.0 151033.0 156644.2 15724.5 15836.2 16214.2 16237.4 16658.8 26032.5 26224.0 26239.3 26264.3 26283.6 10087.1 10207.1 10238.9 10307.2 10438.4 9088.2 9215.0 9253.6 9258.1 9263.2 9656.9 9693.4 9814.1 9923.4 10058.8 2934.1 2934.7 2969.5 2971.6 3046.4 1045.8 1049.2 1066.5 1067.3 1073.2 20594.4 20781.4 21020.2 21189.7 21268.8 1113.3 1125.3 1126.1 1131.3 1133.0 11717.8 11785.8 11873.9 11903.8 11913.5 618931.0 650035.0 668714.0 670247.6 673561.0 127240.0 129444.4 129785.4 130574.0 132156.3 1107.6 1164.6 1189.9 1230.4 1266.5 21578.0 21784.3 21962.6 22099.3 22221.0 62642.0 64385.0 64610.7 64675.0 66156.3 78247.6 78444.2 80323.4 80361.2 80455.0 15508.5 15910.0 15915.6 16062.7 16083.2 24370.9 24496.9 24500.5 24639.9 24672.3 19776.3 19788.8 19875.0 19924.1 20177.7 17239.9 17323.6 17658.1 18090.9 18353.8 19754.0 20024.5 20270.8 20298.0 20302.9 15401.7 15590.5 15700.5 15702.8 15735.0 19275.4 19372.6 19445.6 19817.8 19845.6 04:38:32 INFO - PID 8519 | 04:38:32 INFO - PID 8519 | [#3] mootools.html Cycles:180 Average:10399.88 Median:2825.28 stddev:7715.56 (273.1%) stddev-sans-first:7707.67 04:38:32 INFO - PID 8519 | Values: 1414.7 1461.9 1471.9 1473.7 1480.3 16563.7 17160.0 17943.4 18043.6 18148.5 17549.8 17853.0 17866.7 17879.9 17880.9 2747.3 2811.4 2834.8 2842.6 2875.0 2903.0 2908.8 2937.9 2939.4 2939.7 2887.8 2900.4 2908.7 2916.3 2931.5 2793.1 2799.1 2824.1 2841.8 2867.2 2775.6 2820.5 2826.4 2847.7 2858.6 16338.1 16406.3 16419.3 16516.7 16589.3 8453.7 8662.4 8959.5 9163.1 9245.0 5664.0 5800.7 5883.0 5904.1 5961.6 2151.7 2155.6 2167.9 2192.2 2202.6 29960.4 30045.0 30195.5 30210.7 30477.0 7237.7 7400.0 7456.3 7523.4 7548.6 19673.2 19688.2 19734.2 19750.1 19757.2 7247.5 8551.7 8753.6 8768.9 8783.2 6525.0 6678.6 6958.3 6958.3 7891.7 5690.4 5890.3 5904.1 6027.4 6133.2 1622.0 1647.9 1648.2 1649.8 1667.7 921.6 944.7 946.9 948.2 948.6 8306.1 8307.4 8372.4 8384.6 8493.4 777.0 795.8 797.9 798.8 807.2 5432.9 5534.5 5564.5 5649.1 5649.8 24245.0 24817.9 25183.5 25433.6 25482.5 23692.6 24347.5 24393.4 24806.1 24881.3 12675.5 12796.1 12850.0 12854.4 12869.2 8779.3 8800.3 8809.5 8953.5 8989.0 20605.8 20853.1 21190.9 21376.4 21496.4 21839.2 21878.5 22013.9 22334.2 22499.2 11665.7 12129.2 12265.8 12409.3 12452.9 15313.1 15575.8 15653.8 15655.6 15769.8 12542.7 12931.2 12976.9 13066.7 13124.3 12316.8 12417.6 12727.2 12798.6 12825.6 9767.7 10066.1 10141.8 10169.2 10188.5 7585.7 7637.3 7752.2 7787.3 7837.6 8243.1 8432.3 8451.5 8454.9 8493.6 04:38:32 INFO - PID 8519 | 04:38:32 INFO - PID 8519 | [#4] prototype.html Cycles:180 Average:5662.94 Median:6251.94 stddev:1574.02 (25.2%) stddev-sans-first:1531.10 04:38:32 INFO - PID 8519 | Values: 558.5 568.4 569.3 600.4 606.7 6181.9 6281.3 6304.7 6307.4 6355.9 6196.7 6259.4 6283.1 6290.7 6293.7 4927.6 5034.8 5093.2 5106.4 5122.7 4987.6 5015.4 5029.0 5036.6 5059.7 4998.0 5014.5 5024.2 5042.4 5056.4 5024.6 5031.5 5038.2 5043.0 5078.0 4529.7 4567.1 4574.5 4592.6 4621.4 6122.7 6131.3 6142.8 6244.5 6304.0 5900.9 5914.7 5931.2 5935.5 5956.9 6700.6 6709.4 6725.7 6725.9 6746.6 4880.7 5107.5 5115.4 5136.4 5157.8 6822.5 6879.7 6912.0 6928.4 6942.5 5240.3 5252.8 5267.7 5273.4 5296.1 5226.9 5334.3 5334.7 5350.6 5390.8 5906.9 5929.1 5945.5 5956.7 5973.1 6693.9 6732.4 6748.6 6768.5 6772.0 1826.8 1832.3 1835.4 1837.5 1854.9 1242.2 1305.2 1314.3 1315.4 1323.7 6084.3 6090.4 6109.4 6176.6 6208.4 6684.8 6729.2 6730.9 6760.9 6765.0 5971.3 6050.2 6115.9 6168.2 6197.9 3536.2 3551.5 3558.6 3567.3 3572.7 6916.7 6959.2 6973.2 6975.8 6984.7 6868.2 6955.5 6959.4 7067.5 7074.8 6868.8 6971.5 7000.4 7001.5 7014.5 6703.5 6757.5 6797.2 6825.0 6877.8 6705.8 6715.2 6732.3 6733.1 6755.3 6807.4 6941.4 6962.6 7027.4 7033.5 5220.3 5231.1 5231.6 5249.1 5265.3 6603.7 6815.9 6821.7 6831.9 6875.0 6377.6 6608.6 6659.6 6665.5 6665.6 6480.3 6628.1 6632.5 6645.3 6650.7 6305.4 6438.4 6476.3 6488.4 6542.3 6558.7 6622.5 6663.5 6667.0 6699.2 6505.9 6506.3 6532.7 6536.6 6564.7 04:38:32 INFO - PID 8519 | 04:38:32 INFO - PID 8519 | [#5] yui.html Cycles:180 Average:28316.56 Median:18600.58 stddev:41752.11 (224.5%) stddev-sans-first:41818.80 04:38:32 INFO - PID 8519 | Values: 984.6 997.9 1013.8 1014.3 1014.3 18882.2 19170.6 19182.7 19201.3 19638.8 18488.6 18503.4 18594.0 18605.5 18638.5 1038.1 1050.7 1050.9 1056.1 1056.2 1040.2 1046.1 1046.8 1047.2 1048.6 1046.5 1068.8 1079.0 1080.3 1096.6 1075.4 1076.2 1076.5 1077.2 1077.9 796.1 803.1 803.2 805.7 806.2 20753.5 21264.9 21514.8 21549.5 21621.4 22868.6 23739.6 23745.5 23974.8 24123.6 18714.0 19087.1 19388.6 19390.8 19393.3 3713.8 3727.1 3742.1 3744.3 3753.6 128694.4 142389.0 153790.0 157245.2 161003.0 18440.0 18511.4 18563.6 18814.5 18862.1 34434.1 35014.3 35025.6 35130.6 35175.3 10147.7 10284.6 10301.9 10334.5 10365.8 4738.6 4790.0 4793.9 4803.4 4805.0 6099.0 6160.4 6206.9 6254.4 6257.0 1223.9 1268.1 1276.6 1284.6 1286.2 725.9 751.9 756.9 771.6 784.6 13298.3 13797.2 14208.3 15009.5 15034.0 743.9 754.3 755.8 767.0 767.1 6352.5 6490.1 6523.5 6542.1 6575.0 147580.3 150024.2 150751.0 152065.0 155431.0 130175.0 130287.0 132101.4 136786.0 137554.0 114495.0 114834.0 115702.0 117402.4 119191.0 12207.9 12422.6 12465.4 12486.3 12693.7 55201.4 55461.7 55474.7 56896.4 57371.1 71257.3 73039.0 73870.0 74569.3 74917.3 17404.3 17736.5 17987.8 18172.2 18407.7 19728.3 19847.6 20200.8 20343.4 20451.6 18595.6 18688.6 18805.4 18821.5 19102.6 18384.8 18618.5 18850.8 18860.5 19018.4 16833.2 17297.9 17301.9 17372.5 17580.3 11204.0 11280.9 11603.1 11761.4 11799.9 13113.9 13147.5 13190.3 13259.2 13317.5 04:38:32 INFO - PID 8519 | -------- Summary: end -------- 04:38:32 INFO - PID 8519 | 04:38:33 INFO - TEST-INFO | 8519: exit 0 04:38:33 INFO - TEST-OK | dromaeo_css | took 1108825ms 04:38:33 INFO - TEST-START | kraken 04:38:33 INFO - Initialising browser for kraken test... 04:38:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55096/getInfo.html -profile /tmp/tmplZ_eJI/profile 04:38:33 INFO - TEST-INFO | started process 8889 (/builds/slave/test/build/application/firefox/firefox http://localhost:55096/getInfo.html) 04:38:38 INFO - TEST-INFO | 8889: exit 0 04:38:39 INFO - Browser initialized. 04:38:39 INFO - Running cycle 1/1 for kraken test... 04:38:39 INFO - Using env: {'DISPLAY': ':0', 04:38:39 INFO - 'HOME': '/home/cltbld', 04:38:39 INFO - 'JSGC_DISABLE_POISONING': '1', 04:38:39 INFO - 'LANG': 'en_US.UTF-8', 04:38:39 INFO - 'LANGUAGE': 'en_US:en', 04:38:39 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:38:39 INFO - 'LOGNAME': 'cltbld', 04:38:39 INFO - 'MAIL': '/var/mail/cltbld', 04:38:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:38:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:38:39 INFO - 'MOZ_CRASHREPORTER': '1', 04:38:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:39 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:38:39 INFO - 'MOZ_NO_REMOTE': '1', 04:38:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:38:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:38:39 INFO - 'NO_EM_RESTART': '1', 04:38:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:38:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:39 INFO - 'PWD': '/builds/slave/test', 04:38:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:38:39 INFO - 'RUST_BACKTRACE': 'full', 04:38:39 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:38:39 INFO - 'SHELL': '/bin/bash', 04:38:39 INFO - 'SHLVL': '1', 04:38:39 INFO - 'STYLO_FORCE_DISABLED': '1', 04:38:39 INFO - 'TERM': 'linux', 04:38:39 INFO - 'TMOUT': '86400', 04:38:39 INFO - 'USER': 'cltbld', 04:38:39 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1506510008.725700-594462741', 04:38:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:39 INFO - '_': '/tools/buildbot/bin/python'} 04:38:39 INFO - TEST-INFO | started process 9125 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplZ_eJI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:38:39 INFO - PID 9125 | 04:38:39 INFO - PID 9125 | (/builds/slave/test/build/application/firefox/firefox:9176): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:38:39 INFO - PID 9125 | 04:38:50 INFO - PID 9125 | RSS: Main: 144265216 04:38:50 INFO - PID 9125 | 04:38:52 INFO - PID 9125 | Cycle 1(1): loaded http://localhost:55096/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55096/tests/kraken/driver.html?testName=audio-beat-detection) 04:38:53 INFO - PID 9125 | RSS: Main: 151220224 04:38:53 INFO - PID 9125 | 04:38:56 INFO - PID 9125 | Cycle 1(1): loaded http://localhost:55096/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55096/tests/kraken/driver.html?testName=audio-dft) 04:38:56 INFO - PID 9125 | RSS: Main: 151392256 04:38:56 INFO - PID 9125 | 04:38:59 INFO - PID 9125 | Cycle 1(1): loaded http://localhost:55096/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55096/tests/kraken/driver.html?testName=audio-fft) 04:39:00 INFO - PID 9125 | RSS: Main: 146956288 04:39:00 INFO - PID 9125 | 04:39:02 INFO - PID 9125 | Cycle 1(1): loaded http://localhost:55096/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55096/tests/kraken/driver.html?testName=audio-oscillator) 04:39:02 INFO - PID 9125 | RSS: Main: 148078592 04:39:02 INFO - PID 9125 | 04:39:04 INFO - PID 9125 | Cycle 1(1): loaded http://localhost:55096/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55096/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:39:05 INFO - PID 9125 | RSS: Main: 147714048 04:39:05 INFO - PID 9125 | 04:39:08 INFO - PID 9125 | Cycle 1(1): loaded http://localhost:55096/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55096/tests/kraken/driver.html?testName=imaging-darkroom) 04:39:09 INFO - PID 9125 | RSS: Main: 147898368 04:39:09 INFO - PID 9125 | 04:39:12 INFO - PID 9125 | Cycle 1(1): loaded http://localhost:55096/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55096/tests/kraken/driver.html?testName=imaging-desaturate) 04:39:13 INFO - PID 9125 | RSS: Main: 149307392 04:39:13 INFO - PID 9125 | 04:39:16 INFO - PID 9125 | Cycle 1(1): loaded http://localhost:55096/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55096/tests/kraken/driver.html?testName=json-parse-financial) 04:39:16 INFO - PID 9125 | RSS: Main: 150896640 04:39:16 INFO - PID 9125 | 04:39:18 INFO - PID 9125 | Cycle 1(1): loaded http://localhost:55096/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55096/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:39:18 INFO - PID 9125 | RSS: Main: 150839296 04:39:18 INFO - PID 9125 | 04:39:20 INFO - PID 9125 | Cycle 1(1): loaded http://localhost:55096/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55096/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:39:21 INFO - PID 9125 | RSS: Main: 150843392 04:39:21 INFO - PID 9125 | 04:39:23 INFO - PID 9125 | Cycle 1(1): loaded http://localhost:55096/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55096/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:39:23 INFO - PID 9125 | RSS: Main: 147558400 04:39:23 INFO - PID 9125 | 04:39:26 INFO - PID 9125 | Cycle 1(1): loaded http://localhost:55096/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55096/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:39:26 INFO - PID 9125 | RSS: Main: 147431424 04:39:26 INFO - PID 9125 | 04:39:29 INFO - PID 9125 | Cycle 1(1): loaded http://localhost:55096/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55096/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:39:30 INFO - PID 9125 | RSS: Main: 148480000 04:39:30 INFO - PID 9125 | 04:39:31 INFO - PID 9125 | Cycle 1(1): loaded http://localhost:55096/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55096/tests/kraken/driver.html?testName=ai-astar) 04:39:32 INFO - PID 9125 | RSS: Main: 150519808 04:39:32 INFO - PID 9125 | 04:39:32 INFO - PID 9125 | __start_tp_report 04:39:32 INFO - PID 9125 | _x_x_mozilla_page_load 04:39:32 INFO - PID 9125 | _x_x_mozilla_page_load_details 04:39:32 INFO - PID 9125 | |i|pagename|runs| 04:39:32 INFO - PID 9125 | |0;ai-astar;107;107;105;104;104;107;106;106;105;106 04:39:32 INFO - PID 9125 | |1;audio-beat-detection;110;112;116;112;116;113;141;115;116;115 04:39:32 INFO - PID 9125 | |2;audio-dft;162;165;162;163;165;162;163;163;164;169 04:39:32 INFO - PID 9125 | |3;audio-fft;76;76;76;77;74;76;74;80;73;74 04:39:32 INFO - PID 9125 | |4;audio-oscillator;80;78;85;78;76;78;78;77;78;82 04:39:32 INFO - PID 9125 | |5;imaging-gaussian-blur;113;114;114;115;113;114;112;114;113;114 04:39:32 INFO - PID 9125 | |6;imaging-darkroom;149;151;156;149;151;150;153;153;152;150 04:39:32 INFO - PID 9125 | |7;imaging-desaturate;95;96;95;95;95;94;94;99;96;94 04:39:32 INFO - PID 9125 | |8;json-parse-financial;47;46;44;45;48;46;45;44;43;43 04:39:32 INFO - PID 9125 | |9;json-stringify-tinderbox;38;38;37;38;37;37;40;37;37;38 04:39:32 INFO - PID 9125 | |10;stanford-crypto-aes;71;75;73;71;72;72;71;71;72;74 04:39:32 INFO - PID 9125 | |11;stanford-crypto-ccm;111;108;104;107;108;114;107;109;107;108 04:39:32 INFO - PID 9125 | |12;stanford-crypto-pbkdf2;159;159;157;151;153;154;160;150;154;154 04:39:32 INFO - PID 9125 | |13;stanford-crypto-sha256-iterative;63;61;60;60;64;60;62;61;62;61 04:39:32 INFO - PID 9125 | __end_tp_report 04:39:32 INFO - PID 9125 | __start_cc_report 04:39:32 INFO - PID 9125 | _x_x_mozilla_cycle_collect,718 04:39:32 INFO - PID 9125 | __end_cc_report 04:39:32 INFO - PID 9125 | __startTimestamp1506512372135__endTimestamp 04:39:32 INFO - PID 9125 | 04:39:32 INFO - PID 9125 | ------- Summary: start ------- 04:39:32 INFO - PID 9125 | Number of tests: 14 04:39:32 INFO - PID 9125 | 04:39:32 INFO - PID 9125 | [#0] ai-astar Cycles:10 Average:105.70 Median:106.00 stddev:1.16 (1.1%) stddev-sans-first:1.13 04:39:32 INFO - PID 9125 | Values: 107.0 107.0 105.0 104.0 104.0 107.0 106.0 106.0 105.0 106.0 04:39:32 INFO - PID 9125 | 04:39:32 INFO - PID 9125 | [#1] audio-beat-detection Cycles:10 Average:116.60 Median:115.50 stddev:8.82 (7.6%) stddev-sans-first:9.03 04:39:32 INFO - PID 9125 | Values: 110.0 112.0 116.0 112.0 116.0 113.0 141.0 115.0 116.0 115.0 04:39:32 INFO - PID 9125 | 04:39:32 INFO - PID 9125 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.50 stddev:2.15 (1.3%) stddev-sans-first:2.18 04:39:32 INFO - PID 9125 | Values: 162.0 165.0 162.0 163.0 165.0 162.0 163.0 163.0 164.0 169.0 04:39:32 INFO - PID 9125 | 04:39:32 INFO - PID 9125 | [#3] audio-fft Cycles:10 Average:75.60 Median:76.00 stddev:2.01 (2.6%) stddev-sans-first:2.13 04:39:32 INFO - PID 9125 | Values: 76.0 76.0 76.0 77.0 74.0 76.0 74.0 80.0 73.0 74.0 04:39:32 INFO - PID 9125 | 04:39:32 INFO - PID 9125 | [#4] audio-oscillator Cycles:10 Average:79.00 Median:78.00 stddev:2.67 (3.4%) stddev-sans-first:2.80 04:39:32 INFO - PID 9125 | Values: 80.0 78.0 85.0 78.0 76.0 78.0 78.0 77.0 78.0 82.0 04:39:32 INFO - PID 9125 | 04:39:32 INFO - PID 9125 | [#5] imaging-gaussian-blur Cycles:10 Average:113.60 Median:114.00 stddev:0.84 (0.7%) stddev-sans-first:0.87 04:39:32 INFO - PID 9125 | Values: 113.0 114.0 114.0 115.0 113.0 114.0 112.0 114.0 113.0 114.0 04:39:32 INFO - PID 9125 | 04:39:32 INFO - PID 9125 | [#6] imaging-darkroom Cycles:10 Average:151.40 Median:151.50 stddev:2.17 (1.4%) stddev-sans-first:2.12 04:39:32 INFO - PID 9125 | Values: 149.0 151.0 156.0 149.0 151.0 150.0 153.0 153.0 152.0 150.0 04:39:32 INFO - PID 9125 | 04:39:32 INFO - PID 9125 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:1.49 (1.6%) stddev-sans-first:1.58 04:39:32 INFO - PID 9125 | Values: 95.0 96.0 95.0 95.0 95.0 94.0 94.0 99.0 96.0 94.0 04:39:32 INFO - PID 9125 | 04:39:32 INFO - PID 9125 | [#8] json-parse-financial Cycles:10 Average:45.10 Median:45.50 stddev:1.66 (3.7%) stddev-sans-first:1.62 04:39:32 INFO - PID 9125 | Values: 47.0 46.0 44.0 45.0 48.0 46.0 45.0 44.0 43.0 43.0 04:39:32 INFO - PID 9125 | 04:39:32 INFO - PID 9125 | [#9] json-stringify-tinderbox Cycles:10 Average:37.70 Median:38.00 stddev:0.95 (2.5%) stddev-sans-first:1.00 04:39:32 INFO - PID 9125 | Values: 38.0 38.0 37.0 38.0 37.0 37.0 40.0 37.0 37.0 38.0 04:39:32 INFO - PID 9125 | 04:39:32 INFO - PID 9125 | [#10] stanford-crypto-aes Cycles:10 Average:72.20 Median:72.00 stddev:1.40 (1.9%) stddev-sans-first:1.41 04:39:32 INFO - PID 9125 | Values: 71.0 75.0 73.0 71.0 72.0 72.0 71.0 71.0 72.0 74.0 04:39:32 INFO - PID 9125 | 04:39:32 INFO - PID 9125 | [#11] stanford-crypto-ccm Cycles:10 Average:108.30 Median:108.00 stddev:2.67 (2.5%) stddev-sans-first:2.65 04:39:32 INFO - PID 9125 | Values: 111.0 108.0 104.0 107.0 108.0 114.0 107.0 109.0 107.0 108.0 04:39:32 INFO - PID 9125 | 04:39:32 INFO - PID 9125 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.10 Median:155.50 stddev:3.48 (2.2%) stddev-sans-first:3.39 04:39:32 INFO - PID 9125 | Values: 159.0 159.0 157.0 151.0 153.0 154.0 160.0 150.0 154.0 154.0 04:39:32 INFO - PID 9125 | 04:39:32 INFO - PID 9125 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.40 Median:61.50 stddev:1.35 (2.2%) stddev-sans-first:1.30 04:39:32 INFO - PID 9125 | Values: 63.0 61.0 60.0 60.0 64.0 60.0 62.0 61.0 62.0 61.0 04:39:32 INFO - PID 9125 | -------- Summary: end -------- 04:39:32 INFO - PID 9125 | 04:39:32 INFO - PID 9125 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:39:32 INFO - TEST-INFO | 9125: exit 0 04:39:32 INFO - TEST-OK | kraken | took 59397ms 04:39:32 INFO - SUITE-END | took 1168s 04:39:32 INFO - Completed test suite (00:19:28) 04:39:32 INFO - javascript benchmark 04:39:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9064.32259135878, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3813.2945405100054, 3828.4640150378937, 3829.234153169366, 3895.318319294123, 3917.7257591968555, 6250.562460627758, 6307.495400367971, 6331.271903731073, 6352.841178970528, 6361.872762544746, 6292.937070629292, 6315.052742088689, 6394.072859435379, 6429.967850160754, 6434.388733070363, 5734.541236701054, 5753.165790960308, 5786.421357864222, 5804.245448091763, 5824.737886795083, 5677.17680936264, 5731.484166425021, 5781.913271300934, 5810.128480727883, 5852.941470585282, 5608.411116832735, 5630.127330263816, 5688.203651488795, 5702.144678298247, 5790.913136302959, 5672.631278966854, 5719.942800571983, 5739.167820666022, 5750.108733146369, 5793.420657934215, 5644.294463192101, 5688.60179787415, 5718.199452076713, 5790.10253410722, 5792.855178620526, 6415.0377443383395, 6425.61446313218, 6426.453751431134, 6446.097546343516, 6449.774257900998, 6928.826779330507, 6967.756128535477, 6969.6166710830885, 7052.964735176342, 7066.152061752571, 6878.793636190872, 6914.343137401989, 7009.0, 7063.8587228255665, 7114.039604653357, 6477.384648458389, 6511.934880651228, 6513.739450421977, 6518.641474718888, 6523.543351965364, 7126.643667816692, 7163.462740294499, 7203.0, 7203.855922881513, 7227.421806255487, 6829.863402731918, 6830.316968303229, 6836.794896153124, 6875.243723190445, 6924.307569243036, 6848.623325717033, 6970.616616086062, 6998.4751143664425, 7042.647867606599, 7076.221615622278, 6903.033575299462, 6942.687579058955, 6967.477439191979, 7019.0, 7021.262767409451, 6935.653217339213, 6943.375096241261, 7030.050943122613, 7030.6484675766005, 7040.542364746275, 5078.111330517145, 5083.69497830124, 5093.363329583802, 5096.745162741848, 5165.811863271469, 4539.72761634303, 4577.954220457819, 4612.400387949545, 4626.074785043005, 4684.648651351163, 6358.523110766711, 6430.0354946757425, 6449.548531602836, 6450.612963222222, 6456.741730330828, 6917.89623155653, 6949.200841903245, 6996.405305548984, 7035.507514473938, 7042.154941407064, 6303.212098487689, 6336.366363363627, 6390.424861762371, 6392.968035159887, 6415.26224484181, 5497.8075767348755, 5543.916841247385, 5580.051391263495, 5617.21359009739, 5666.801661941812, 6999.965000174967, 7001.334873187039, 7100.46746494015, 7106.395956343666, 7203.927960720326, 6843.726250950006, 6924.376806087476, 6929.0299358090915, 6934.445244380337, 6938.098047253825, 7061.752838650623, 7115.324044215791, 7128.180259270251, 7136.85726285461, 7148.821279468055, 6780.762673306411, 6825.385715285648, 6850.0, 6886.48351373639, 6893.965530172518, 6794.320567943364, 6803.659817009031, 6890.896636550556, 6894.551854129466, 6902.447804175554, 6584.275729669828, 6588.275289718223, 6602.66986650656, 6683.365080317362, 6732.899006515004, 6694.799156025327, 6721.260661327348, 6727.260001399744, 6735.090762747162, 6737.056812046219, 6605.702743376463, 6663.600183988976, 6669.533132680665, 6677.065210870385, 6686.3313668632745, 6626.2379826318665, 6735.831604209934, 6825.249222585611, 6832.350926661959, 6847.965760171167, 6451.806445806634, 6514.902276465762, 6565.277819439953, 6605.801825945229, 6609.603423794588], "value": 6323.330783452905, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [930.5254320296651, 965.4207475514688, 974.298505076345, 1006.6074231049892, 1006.974825629359, 42350.364744528815, 42652.3602145968, 42764.78617606908, 42987.0, 43038.784806075964, 39796.0, 40022.59977400225, 40138.39792403116, 40187.99530011751, 40209.59790402095, 7262.745803896864, 7353.889691654629, 7390.076240469942, 7397.149327827315, 7413.036305280306, 7409.222031686676, 7444.776656700281, 7451.888221676679, 7456.51532650376, 7461.477696561243, 6661.03415004824, 6665.666716664172, 6669.599824010551, 6685.832854178636, 6731.1922569291755, 6586.209654841426, 6647.50143739219, 6667.033280174396, 6695.732170713166, 6699.464042876558, 8189.22202390772, 8343.749687509384, 8412.369072319601, 8413.579321033985, 8435.662573497053, 39712.60287397118, 39716.801415993024, 40161.39757903634, 40245.59754402448, 40260.39609405861, 3686.189038411545, 3758.605346438612, 3766.8304926278383, 3767.5478942526797, 3770.924581508382, 32730.0, 32811.83594082014, 32870.342593148, 32883.3423331532, 33024.50463243053, 5287.814926477593, 5302.787888484495, 5307.310049693554, 5314.282571852789, 5328.120860058086, 219984.0, 221163.0, 222261.0, 222865.0, 223675.8816205925, 49502.50497495051, 49614.75192624014, 49972.50027499751, 50622.493775061776, 50667.0, 51958.74020629948, 52235.73882130565, 52462.737686311324, 52620.0, 52648.0, 16576.254068566945, 16902.74645880313, 16911.154442277835, 16933.576660583585, 16936.322547098225, 13723.45106195761, 13757.587272381845, 13814.792778108336, 13826.377812998438, 13828.654283642989, 14180.14919104857, 14342.713145737027, 14420.927895360455, 14474.421023158955, 14633.926830365994, 5744.655320680772, 5757.337906140848, 5852.7658893643775, 5864.413558644187, 5979.790707325223, 1082.1991726122612, 1097.2757979733497, 1099.5491848342301, 1107.379867274329, 1126.9774604508027, 25054.749452505606, 25113.87443062773, 25143.748562514505, 25415.36461588438, 25499.617505737428, 1197.700574856286, 1199.5861427807392, 1201.6815543880878, 1207.3299318878107, 1211.1642966353188, 13199.670008249679, 13217.537386191438, 13342.332883355793, 13419.463221471031, 13481.056326057082, 252537.0, 254979.0, 254999.0, 255055.0, 255096.0, 48492.0, 49402.50597494051, 54672.72663636656, 54797.72601137048, 55249.72375138099, 1516.9089854608537, 1541.845815418449, 1545.389571119379, 1556.3307777655716, 1556.4707999280072, 29536.0, 29786.70213297926, 30313.0, 30468.085957421314, 30908.53637195399, 40380.1923961525, 40403.393949091376, 40421.797891011534, 40501.39247911343, 40539.594604054764, 235545.0, 236249.0, 236402.0, 237816.0, 238252.0, 33397.49903751494, 34266.31467370688, 34543.0, 34733.826330868185, 34738.478922816685, 43828.0, 44426.55573444354, 45579.0, 45774.31338529858, 45880.31179532243, 33683.0, 34044.0, 34496.31007379788, 34726.65273347234, 34818.30363392668, 33073.83463082669, 33295.50056749199, 33984.320313594086, 34301.65698342985, 34525.827370862986, 39488.0, 39646.0, 39691.80154099211, 39747.2050558993, 39898.40152397774, 32834.67165328316, 32906.341873162884, 33132.503012455316, 33169.0, 33832.66167338295, 25044.499110018063, 25314.114006009702, 25609.359766006, 25630.66801315817, 25725.485490289717], "value": 18029.873655687443, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.5526999480396, 609.1289456077807, 617.8424501752055, 622.5144387377845, 654.5025780406891, 22901.4274643134, 23027.194048208316, 24093.397665058383, 24111.63832542509, 24125.517489650218, 25582.360440988985, 26156.738432615715, 26271.211863644072, 26313.21060368192, 26318.342041448974, 6317.147185130006, 6482.157319548475, 6492.675366231693, 6504.0569117477935, 6519.869602607969, 6348.26994895586, 6349.714262858182, 6408.070829729686, 6641.236257830363, 6653.2681405045405, 6621.801345959629, 6631.27056023837, 6633.038209459625, 6633.13769210002, 6633.535652504326, 6350.904736428957, 6578.769743058994, 6622.735090596394, 6651.66741662915, 6691.364320389555, 6219.689015549205, 6241.594296370721, 6244.750209991595, 6250.468710159642, 6253.343398943137, 29588.260293492618, 29837.25406864824, 29850.85074574635, 30071.248218794488, 30122.24694382636, 2309.1571576374504, 2314.271004633535, 2315.629499280124, 2343.8359314847967, 2352.235523454884, 19829.603407931903, 19871.205151794056, 20941.685874711893, 21081.156753729832, 21095.5780884383, 2542.9237122886343, 2588.197658725801, 2603.609458581228, 2613.973860261392, 2641.8546979916096, 139749.0, 144952.0, 145825.0, 151033.0, 156644.21677891538, 15724.528264152093, 15836.208189590474, 16214.243578591668, 16237.350505979628, 16658.750118748227, 26032.479350412887, 26224.0, 26239.344016399744, 26264.34339141537, 26283.60574591383, 10087.142592879542, 10207.132393746466, 10238.948805255926, 10307.175425965905, 10438.37369757817, 9088.182063614306, 9215.0, 9253.583588738524, 9258.074192580689, 9263.16631503168, 9656.889457712312, 9693.369930954465, 9814.116729494379, 9923.354981926295, 10058.798824023479, 2934.119764070813, 2934.735873771328, 2969.539721343195, 2971.5542668599883, 3046.3754930239247, 1045.8378951262566, 1049.239301506417, 1066.4774260612398, 1067.2529229539352, 1073.2111897755144, 20594.382168534667, 20781.376558703265, 21020.159193632084, 21189.682154767692, 21268.787312126682, 1113.3486910157487, 1125.2629527659396, 1126.0541145437708, 1131.338167172197, 1133.0482394788417, 11717.76564468723, 11785.764284714258, 11873.940630296793, 11903.761924761457, 11913.463894124785, 618931.0, 650035.0, 668714.0, 670247.5950480963, 673561.0, 127240.0, 129444.35277823551, 129785.35107324591, 130574.0, 132156.3392183033, 1107.5735841701003, 1164.598213616318, 1189.9226550274204, 1230.3786587773118, 1266.5187228852976, 21578.0, 21784.34646960594, 21962.560748785254, 22099.33701988943, 22221.0, 62642.0, 64385.0, 64610.67694661496, 64675.0, 66156.33843661695, 78247.60876195582, 78444.21555784598, 80323.3935321302, 80361.19638803772, 80455.0, 15508.5347439577, 15910.0, 15915.602109947344, 16062.67874642524, 16083.195840208176, 24370.87814560916, 24496.87751561231, 24500.50998980046, 24639.876800615883, 24672.25983220506, 19776.30782922591, 19788.802111978697, 19875.0, 19924.103415346053, 20177.697334540288, 17239.87940783845, 17323.56691082733, 17658.117094144985, 18090.90954545219, 18353.816461835744, 19754.0, 20024.498162638152, 20270.79729202748, 20298.0, 20302.898485507478, 15401.691966160839, 15590.454334098253, 15700.528984130495, 15702.842971570139, 15735.0, 19275.4217373479, 19372.612547748686, 19445.61108777845, 19817.801821981597, 19845.60308793787], "value": 12837.677556381008, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1414.7453458377493, 1461.8538146185376, 1471.8896082793792, 1473.7347277490055, 1480.2598700649671, 16563.66872662546, 17160.0, 17943.37198198065, 18043.639127217448, 18148.455546333596, 17549.824501754978, 17853.0, 17866.731999020027, 17879.92720436775, 17880.910595447003, 2747.2719729271757, 2811.3814960708664, 2834.8015638905285, 2842.6020357150014, 2875.0, 2902.956455653167, 2908.796384253103, 2937.8824847006094, 2939.382729626781, 2939.661938877035, 2887.768978481727, 2900.390917907242, 2908.6509618845766, 2916.3438226399103, 2931.4723349797027, 2793.0782841662203, 2799.0623141247706, 2824.138637715496, 2841.8436985965764, 2867.182852886928, 2775.6252905857655, 2820.5487122060576, 2826.42058378032, 2847.686754457008, 2858.6283783108065, 16338.101404422752, 16406.343746250135, 16419.343226270936, 16516.669666606722, 16589.336426542923, 8453.704120355758, 8662.350323725746, 8959.462432254086, 9163.08369163085, 9244.95377523108, 5663.971680141614, 5800.651960882361, 5882.999890018707, 5904.143899134601, 5961.612495187842, 2151.7310336207975, 2155.5796619659172, 2167.869927804337, 2192.1998470558133, 2202.570498752744, 29960.400791984255, 30045.0, 30195.547066794017, 30210.697893021228, 30477.0, 7237.746678866214, 7400.0, 7456.308361234014, 7523.3981281497345, 7548.622568871535, 19673.21307147727, 19688.21247150098, 19734.210631574577, 19750.11124499401, 19757.209711611664, 7247.528910620793, 8551.700690475804, 8753.606087726068, 8768.912310876936, 8783.209511144029, 6525.0, 6678.599284042973, 6958.304169583002, 6958.338957799001, 7891.723789667334, 5690.4025077367105, 5890.263717035371, 5904.0553511437965, 6027.397260273938, 6133.172021777003, 1621.9756703649455, 1647.9423220187236, 1648.175912043978, 1649.7607846862377, 1667.674803413347, 921.5576523268868, 944.7024187380953, 946.947917864524, 948.1656142594472, 948.5778828421286, 8306.08633050364, 8307.376946728898, 8372.372072094617, 8384.58077096155, 8493.44792588492, 776.9883451748228, 795.8328750962247, 797.8643630582815, 798.7883210949103, 807.2492581898773, 5432.864178395493, 5534.52956498694, 5564.499195072382, 5649.12438572022, 5649.774009039675, 24245.0, 24817.875910620693, 25183.496330073664, 25433.618495722578, 25482.490350192893, 23692.64461033086, 24347.513049738907, 24393.39016524601, 24806.131785387424, 24881.253562393158, 12675.492980280686, 12796.14016762409, 12850.0, 12854.421551030038, 12869.163504372373, 8779.341549383695, 8800.33997450181, 8809.515476648847, 8953.507557084162, 8989.0, 20605.793942060987, 20853.061612227182, 21190.894045529672, 21376.358709238746, 21496.355109346743, 21839.235626752987, 21878.45303867416, 22013.889930550245, 22334.21830235934, 22499.212527561456, 11665.708357291136, 12129.150959433107, 12265.754684906073, 12409.317487538272, 12452.875471245534, 15313.081215127128, 15575.766363504783, 15653.765193521878, 15655.608609784846, 15769.842301576837, 12542.686432839251, 12931.159474634118, 12976.870231297944, 13066.673333166367, 13124.278164701032, 12316.815247771112, 12417.565385211474, 12727.23636581808, 12798.552050678181, 12825.615231543068, 9767.706968790948, 10066.144377727682, 10141.847872281774, 10169.237307201842, 10188.490575471049, 7585.658645361083, 7637.312641862259, 7752.224777522202, 7787.260210280015, 7837.568933708472, 8243.134470880472, 8432.283255923316, 8451.492910425393, 8454.915450845412, 8493.575321234037], "value": 7253.613264944536, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.5280438029863, 568.428729127227, 569.2997612936091, 600.4115966352974, 606.6966516741629, 6181.8763624727535, 6281.277653069898, 6304.653244071575, 6307.3692630736905, 6355.872882542352, 6196.69016549173, 6259.405356491126, 6283.120363149163, 6290.748370065192, 6293.716782744776, 4927.556519913207, 5034.82378116766, 5093.2105523643895, 5106.4382917879, 5122.6926384416965, 4987.576056035223, 5015.3730783652045, 5029.0, 5036.647434679574, 5059.721715305656, 4998.0, 5014.548690617862, 5024.196128619422, 5042.445331013604, 5056.418511871127, 5024.572911302544, 5031.496850314976, 5038.236617183975, 5042.974785126087, 5078.0, 4529.705569138028, 4567.109413664337, 4574.542545745432, 4592.609628181609, 4621.399218101626, 6122.693865306717, 6131.321207275643, 6142.84642883927, 6244.469220116295, 6304.0, 5900.852478688024, 5914.674692891889, 5931.199288096095, 5935.49548288396, 5956.851078723023, 6700.564463309918, 6709.429698475636, 6725.6973436195485, 6725.899111513331, 6746.571234355628, 4880.682755620909, 5107.463716309771, 5115.411727651331, 5136.383633963911, 5157.7936882524655, 6822.488313376517, 6879.690413931385, 6912.0, 6928.44572434204, 6942.479314051416, 5240.292560504283, 5252.842414727565, 5267.71027593486, 5273.44628813969, 5296.099663057213, 5226.869328266824, 5334.253204551366, 5334.733263336818, 5350.571954243651, 5390.757415916293, 5906.940930590725, 5929.10268714016, 5945.494632956247, 5956.7319470623925, 5973.133895585116, 6693.866122677519, 6732.427743641845, 6748.595084294958, 6768.526203165731, 6772.0, 1826.7899191592871, 1832.3128826689992, 1835.3667984545311, 1837.5498002989086, 1854.9072546372627, 1242.236024844714, 1305.2429590837291, 1314.3165553911913, 1315.3620494060374, 1323.6690827293178, 6084.330723620398, 6090.36051214625, 6109.358517355614, 6176.567640265138, 6208.410201030985, 6684.832879177962, 6729.22613899398, 6730.850899062221, 6760.93239067603, 6765.0, 5971.28344598651, 6050.2437195350585, 6115.938840611626, 6168.242051015439, 6197.876042479125, 3536.2220311531937, 3551.538300020981, 3558.644135586421, 3567.3411863483607, 3572.7499075064497, 6916.688749006306, 6959.164900212007, 6973.198082220508, 6975.79072627822, 6984.685689144001, 6868.175818901664, 6955.513114081966, 6959.408450281783, 7067.505274630829, 7074.787756367317, 6868.793936181923, 6971.54684945487, 7000.439964802804, 7001.474889383317, 7014.5440546364325, 6703.4972377070935, 6757.45940324763, 6797.218319893275, 6825.0, 6877.830768769421, 6705.832354191184, 6715.194176698632, 6732.259451460433, 6733.091032710521, 6755.256921738506, 6807.3873351398615, 6941.375276225164, 6962.582245065312, 7027.402670773042, 7033.46795153734, 5220.269162317202, 5231.0845602018735, 5231.607629427732, 5249.057848596044, 5265.315508983807, 6603.702833372414, 6815.863682726219, 6821.727130914906, 6831.89752153728, 6875.0, 6377.585456945284, 6608.603483790988, 6659.600423974577, 6665.533412661067, 6665.600063996176, 6480.287168411565, 6628.122548309293, 6632.535722499379, 6645.302243264581, 6650.700718467584, 6305.432511074026, 6438.420542151229, 6476.31998640136, 6488.416042556192, 6542.280349161683, 6558.704858281484, 6622.470202383702, 6663.533552651268, 6667.0, 6699.162604674416, 6505.934940650533, 6506.3493650634555, 6532.673366331569, 6536.640484773383, 6564.704588293634], "value": 5213.682060928738, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [984.6209209454363, 997.9023074617919, 1013.7972405518898, 1014.3153371474253, 1014.3356101753345, 18882.24471021159, 19170.61658766824, 19182.712259316122, 19201.327953521628, 19638.803611963875, 18488.630227395442, 18503.444896653087, 18594.0, 18605.534861628432, 18638.53403664909, 1038.096855735511, 1050.6847945616285, 1050.8633877595903, 1056.1234175634243, 1056.1550759392455, 1040.1574724473164, 1046.0794500839252, 1046.7592453735608, 1047.1831971062584, 1048.638219814163, 1046.4715318764013, 1068.845017472466, 1079.034264333421, 1080.3355936099322, 1096.6490722968654, 1075.3870293932462, 1076.2036093290988, 1076.4617691154422, 1077.159815344029, 1077.8975997280324, 796.0646240667193, 803.0804728585737, 803.236924921327, 805.6616221187115, 806.1938061938062, 20753.481162970897, 21264.89367553168, 21514.784852151435, 21549.461263468384, 21621.35135945924, 22868.627882327113, 23739.643905341432, 23745.525089498286, 23974.760252397427, 24123.638145427834, 18714.0, 19087.141078651493, 19388.612227755508, 19390.80609193904, 19393.32123375689, 3713.814309284525, 3727.105494681257, 3742.120601658608, 3744.307303148899, 3753.6058713834927, 128694.35652821675, 142389.0, 153790.0, 157245.2137739304, 161003.0, 18440.0, 18511.35210267661, 18563.628727425377, 18814.52963675919, 18862.056897155362, 34434.139146521535, 35014.299714005574, 35025.64974350275, 35130.64869351274, 35175.296494070484, 10147.746306342253, 10284.588616455258, 10301.896981030093, 10334.483275836179, 10365.792684146274, 4738.573528382462, 4789.976050119797, 4793.9280910786365, 4803.3995750531185, 4804.95195048045, 6099.0, 6160.383961603893, 6206.937930620727, 6254.3745625437095, 6257.0, 1223.8653748087704, 1268.1376663868473, 1276.5595869425033, 1284.6146156153118, 1286.2346903592347, 725.8693435181613, 751.9135299440525, 756.8599809035346, 771.6219052664154, 784.5567254501188, 13298.268595227355, 13797.24115173655, 14208.289585520683, 15009.549713508612, 15034.0, 743.8995735575736, 754.2796629219192, 755.7657126290867, 766.9846603067907, 767.1254769562703, 6352.523560732963, 6490.1238332825405, 6523.478121750249, 6542.116814230113, 6575.046618240328, 147580.2620986888, 150024.24987874992, 150751.0, 152065.0, 155431.0, 130175.0, 130287.0, 132101.35797284, 136786.0, 137554.0, 114495.0, 114834.0, 115702.0, 117402.41298793622, 119191.0, 12207.938960305142, 12422.565210217599, 12465.439055242354, 12486.250824950168, 12693.746125077261, 55201.447985521234, 55461.7226913879, 55474.72262638661, 56896.431035690766, 57371.13943290771, 71257.28742712506, 73039.0, 73870.0, 74569.25430745623, 74917.2508274932, 17404.303827847252, 17736.467905962843, 17987.820121798613, 18172.182251798964, 18407.723884142015, 19728.30950916711, 19847.60304793925, 20200.797992019892, 20343.389698309074, 20451.590968180255, 18595.628087438447, 18688.626227475645, 18805.435836924913, 18821.529461763566, 19102.617947641247, 18384.81615183831, 18618.534536636693, 18850.811491885455, 18860.528486787392, 19018.42944711661, 16833.15834208309, 17297.91351043237, 17301.91349043297, 17372.47882563525, 17580.329868662455, 11204.047655949336, 11280.887191128311, 11603.071754259809, 11761.353125578175, 11799.882001180222, 13113.868861311264, 13147.474101035852, 13190.274534900673, 13259.204447733167, 13317.533886313933], "value": 10019.879501271376, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1380.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 107.0, 105.0, 104.0, 104.0, 107.0, 106.0, 106.0, 105.0, 106.0], "value": 105.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 116.0, 112.0, 116.0, 113.0, 141.0, 115.0, 116.0, 115.0], "value": 116.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 162.0, 163.0, 165.0, 162.0, 163.0, 163.0, 164.0, 169.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 77.0, 74.0, 76.0, 74.0, 80.0, 73.0, 74.0], "value": 75.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 85.0, 78.0, 76.0, 78.0, 78.0, 77.0, 78.0, 82.0], "value": 79.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 115.0, 113.0, 114.0, 112.0, 114.0, 113.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 151.0, 156.0, 149.0, 151.0, 150.0, 153.0, 153.0, 152.0, 150.0], "value": 151.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 94.0, 94.0, 99.0, 96.0, 94.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 46.0, 44.0, 45.0, 48.0, 46.0, 45.0, 44.0, 43.0, 43.0], "value": 45.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 37.0, 38.0, 37.0, 37.0, 40.0, 37.0, 37.0, 38.0], "value": 37.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 75.0, 73.0, 71.0, 72.0, 72.0, 71.0, 71.0, 72.0, 74.0], "value": 72.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 108.0, 104.0, 107.0, 108.0, 114.0, 107.0, 109.0, 107.0, 108.0], "value": 108.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 157.0, 151.0, 153.0, 154.0, 160.0, 150.0, 154.0, 154.0], "value": 155.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 60.0, 60.0, 64.0, 60.0, 62.0, 61.0, 62.0, 61.0], "value": 61.4, "unit": "score"}]}]} 04:39:32 INFO - Return code: 0 04:39:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:39:32 INFO - # TBPL SUCCESS # 04:39:32 INFO - Running post-action listener: _package_coverage_data 04:39:32 INFO - Running post-action listener: _resource_record_post_action 04:39:32 INFO - [mozharness: 2017-09-27 11:39:32.943275Z] Finished run-tests step (success) 04:39:32 INFO - Running post-run listener: _resource_record_post_run 04:39:33 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 421888; Write bytes: 397025280; Read time: 148; Write time: 281968 04:39:33 INFO - TinderboxPrint: CPU usage
13.1% 04:39:33 INFO - TinderboxPrint: I/O read bytes / time
421,888 / 148 04:39:33 INFO - TinderboxPrint: I/O write bytes / time
397,025,280 / 281,968 04:39:33 INFO - TinderboxPrint: CPU idle
8,218.0 (86.9%) 04:39:33 INFO - TinderboxPrint: CPU user
1,188.0 (12.6%) 04:39:33 INFO - TinderboxPrint: Swap in / out
0 / 0 04:39:33 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 82460672; Read time: 0; Write time: 51088 04:39:33 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:39:33 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 421888; Write bytes: 313864192; Read time: 148; Write time: 230728 04:39:33 INFO - Running post-run listener: _upload_blobber_files 04:39:33 INFO - Blob upload gear active. 04:39:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:39:33 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 04:39:33 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'] 04:39:33 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 04:39:34 INFO - (blobuploader) - INFO - Open directory for files ... 04:39:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 04:39:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:39:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:39:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 04:39:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:39:35 INFO - (blobuploader) - INFO - Done attempting. 04:39:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:39:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:39:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:39:36 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:39:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:39:36 INFO - (blobuploader) - INFO - Done attempting. 04:39:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:39:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:39:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:39:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:39:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:39:43 INFO - (blobuploader) - INFO - Done attempting. 04:39:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 04:39:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:39:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:39:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 04:39:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:39:44 INFO - (blobuploader) - INFO - Done attempting. 04:39:44 INFO - (blobuploader) - INFO - Iteration through files over. 04:39:44 INFO - Return code: 0 04:39:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:39:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:39:44 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f9f8b8c1cdbdf1e6646fcb7a98414f0f82a61c5ec7314e48f2221485e656fd4f76d911de05718babfada66b752e2213f95f4a3259fc65890e54481ea7f6bfad", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e3c4021734aa23564385ff1f81f80afee07774838c371e23c9e316c4d4080b018954bafb38f2e88ce87233520bda03a5b2e8208e34dd577a153920f3f1bc86d", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/537f4d69842e09d84a3e212b5787785e924408a307b824401786f5a365b6241441c56c029ce184e8e09b3ad418844c64562e310f9ac4d5623bfa40f4c3db1da2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d104c91e1aa3094e61d0e2266a3c6fde387d816f851d6334f7bcd7dc606a0e0a1c94cb8f36575e4c8921330917a2173dc72322cc360c856da7cbf6b13b01ac1"} 04:39:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:39:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:39:44 INFO - Contents: 04:39:44 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f9f8b8c1cdbdf1e6646fcb7a98414f0f82a61c5ec7314e48f2221485e656fd4f76d911de05718babfada66b752e2213f95f4a3259fc65890e54481ea7f6bfad", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e3c4021734aa23564385ff1f81f80afee07774838c371e23c9e316c4d4080b018954bafb38f2e88ce87233520bda03a5b2e8208e34dd577a153920f3f1bc86d", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/537f4d69842e09d84a3e212b5787785e924408a307b824401786f5a365b6241441c56c029ce184e8e09b3ad418844c64562e310f9ac4d5623bfa40f4c3db1da2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d104c91e1aa3094e61d0e2266a3c6fde387d816f851d6334f7bcd7dc606a0e0a1c94cb8f36575e4c8921330917a2173dc72322cc360c856da7cbf6b13b01ac1"} 04:39:44 INFO - Running post-run listener: copy_logs_to_upload_dir 04:39:44 INFO - Copying logs to upload dir... 04:39:44 INFO - mkdir: /builds/slave/test/build/upload/logs 04:39:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.826507 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-27 04:39:44.719076) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-27 04:39:44.722281) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1506510008.725700-594462741 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/2f9f8b8c1cdbdf1e6646fcb7a98414f0f82a61c5ec7314e48f2221485e656fd4f76d911de05718babfada66b752e2213f95f4a3259fc65890e54481ea7f6bfad", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e3c4021734aa23564385ff1f81f80afee07774838c371e23c9e316c4d4080b018954bafb38f2e88ce87233520bda03a5b2e8208e34dd577a153920f3f1bc86d", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/537f4d69842e09d84a3e212b5787785e924408a307b824401786f5a365b6241441c56c029ce184e8e09b3ad418844c64562e310f9ac4d5623bfa40f4c3db1da2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d104c91e1aa3094e61d0e2266a3c6fde387d816f851d6334f7bcd7dc606a0e0a1c94cb8f36575e4c8921330917a2173dc72322cc360c856da7cbf6b13b01ac1"} build_url:https://queue.taskcluster.net/v1/task/NUZcoITBQvu1HCNBvdTH4w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011328 build_url: 'https://queue.taskcluster.net/v1/task/NUZcoITBQvu1HCNBvdTH4w/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f9f8b8c1cdbdf1e6646fcb7a98414f0f82a61c5ec7314e48f2221485e656fd4f76d911de05718babfada66b752e2213f95f4a3259fc65890e54481ea7f6bfad", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e3c4021734aa23564385ff1f81f80afee07774838c371e23c9e316c4d4080b018954bafb38f2e88ce87233520bda03a5b2e8208e34dd577a153920f3f1bc86d", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/537f4d69842e09d84a3e212b5787785e924408a307b824401786f5a365b6241441c56c029ce184e8e09b3ad418844c64562e310f9ac4d5623bfa40f4c3db1da2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d104c91e1aa3094e61d0e2266a3c6fde387d816f851d6334f7bcd7dc606a0e0a1c94cb8f36575e4c8921330917a2173dc72322cc360c856da7cbf6b13b01ac1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-27 04:39:44.750991) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 04:39:44.751312) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1506510008.725700-594462741 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004503 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 04:39:44.835973) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-27 04:39:44.836330) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-27 04:39:44.836647) ========= ========= Total master_lag: 0.20 =========