builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-021 starttime: 1506004559.39 results: success (0) revision: 9caeafcec9982be90820e30bc699e851cb6af907 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-21 07:35:59.393046) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-21 07:35:59.393508) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-21 07:35:59.393790) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-21 07:35:59.413707) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 07:35:59.413964) ========= 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=df17445c3590ff7897617a0e00000225-1506004126.566103-59274306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-21 07:36:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2017-09-21 07:36:00 (46.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.101777 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 07:35:59.543203) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 07:35:59.543577) ========= 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=df17445c3590ff7897617a0e00000225-1506004126.566103-59274306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015672 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 07:35:59.600318) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-21 07:35:59.600670) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9caeafcec9982be90820e30bc699e851cb6af907 --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 9caeafcec9982be90820e30bc699e851cb6af907 --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=df17445c3590ff7897617a0e00000225-1506004126.566103-59274306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-21 07:36:00,367 truncating revision to first 12 chars 2017-09-21 07:36:00,367 Setting DEBUG logging. 2017-09-21 07:36:00,367 attempt 1/10 2017-09-21 07:36:00,367 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9caeafcec998?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-21 07:36:01,120 unpacking tar archive at: mozilla-central-9caeafcec998/testing/mozharness/ program finished with exit code 0 elapsedTime=1.040496 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-21 07:36:00.664049) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-21 07:36:00.664314) ========= script_repo_revision: 9caeafcec9982be90820e30bc699e851cb6af907 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-21 07:36:00.667404) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-21 07:36:00.667737) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-21 07:36:00.697419) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-09-21 07:36:00.697736) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-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-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=df17445c3590ff7897617a0e00000225-1506004126.566103-59274306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:36:01 INFO - MultiFileLogger online at 20170921 07:36:01 in /builds/slave/test 07:36:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:36:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:36:01 INFO - {'append_to_log': False, 07:36:01 INFO - 'base_work_dir': '/builds/slave/test', 07:36:01 INFO - 'blob_upload_branch': 'Firefox', 07:36:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:36:01 INFO - 'branch': 'Firefox', 07:36:01 INFO - 'buildbot_json_path': 'buildprops.json', 07:36:01 INFO - 'code_coverage': False, 07:36:01 INFO - 'config_files': ('talos/linux_config.py',), 07:36:01 INFO - 'default_actions': ('clobber', 07:36:01 INFO - 'read-buildbot-config', 07:36:01 INFO - 'download-and-extract', 07:36:01 INFO - 'populate-webroot', 07:36:01 INFO - 'create-virtualenv', 07:36:01 INFO - 'install', 07:36:01 INFO - 'setup-mitmproxy', 07:36:01 INFO - 'run-tests'), 07:36:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:36:01 INFO - 'disable_ccov_upload': False, 07:36:01 INFO - 'disable_stylo': False, 07:36:01 INFO - 'download_minidump_stackwalk': True, 07:36:01 INFO - 'download_symbols': 'ondemand', 07:36:01 INFO - 'enable_stylo': False, 07:36:01 INFO - 'enable_webrender': False, 07:36:01 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 07:36:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:36:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:36:01 INFO - 'gecko_profile': False, 07:36:01 INFO - 'gecko_profile_interval': 0, 07:36:01 INFO - 'installer_path': 'installer.exe', 07:36:01 INFO - 'log_level': 'info', 07:36:01 INFO - 'log_name': 'talos', 07:36:01 INFO - 'log_to_console': True, 07:36:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:36:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:36:01 INFO - 'opt_config_files': (), 07:36:01 INFO - 'pip_index': False, 07:36:01 INFO - 'suite': 'dromaeojs-e10s', 07:36:01 INFO - 'system_bits': '32', 07:36:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:36:01 INFO - 'title': 'talos-linux64-ix-021', 07:36:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:36:01 INFO - 'use_talos_json': True, 07:36:01 INFO - 'verify': 'False', 07:36:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:36:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:36:01 INFO - 'work_dir': 'build'} 07:36:01 INFO - [mozharness: 2017-09-21 14:36:01.598569Z] Running clobber step. 07:36:01 INFO - Running pre-action listener: _resource_record_pre_action 07:36:01 INFO - Running main action method: clobber 07:36:01 INFO - rmtree: /builds/slave/test/build 07:36:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:36:02 INFO - Running post-action listener: _resource_record_post_action 07:36:02 INFO - [mozharness: 2017-09-21 14:36:02.605495Z] Finished clobber step (success) 07:36:02 INFO - [mozharness: 2017-09-21 14:36:02.605592Z] Running read-buildbot-config step. 07:36:02 INFO - Running pre-action listener: _resource_record_pre_action 07:36:02 INFO - Running main action method: read_buildbot_config 07:36:02 INFO - Using buildbot properties: 07:36:02 INFO - { 07:36:02 INFO - "project": "", 07:36:02 INFO - "product": "firefox", 07:36:02 INFO - "who": "archaeopteryx@coole-files.de", 07:36:02 INFO - "installer_path": "public/build/target.tar.bz2", 07:36:02 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:36:02 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 07:36:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 07:36:02 INFO - "stage_platform": "linux64-pgo", 07:36:02 INFO - "basedir": "/builds/slave/test", 07:36:02 INFO - "buildnumber": 190, 07:36:02 INFO - "platform": "ubuntu64_hw", 07:36:02 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:36:02 INFO - "slavebuilddir": "test", 07:36:02 INFO - "taskId": "V8WpTlmNR06iFITzhs2euQ", 07:36:02 INFO - "branch": "mozilla-central", 07:36:02 INFO - "script_repo_revision": "production", 07:36:02 INFO - "revision": "9caeafcec9982be90820e30bc699e851cb6af907", 07:36:02 INFO - "slavename": "talos-linux64-ix-021", 07:36:02 INFO - "repo_path": "mozilla-central" 07:36:02 INFO - } 07:36:02 INFO - Finding installer, test and symbols from parent task. 07:36:02 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V8WpTlmNR06iFITzhs2euQ'}, attempt #1 07:36:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V8WpTlmNR06iFITzhs2euQ'}, attempt #1 07:36:04 INFO - Task dependencies: BMX2tL0PQCeX9uenZREPCQ 07:36:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BMX2tL0PQCeX9uenZREPCQ'}, attempt #1 07:36:05 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/BMX2tL0PQCeX9uenZREPCQ/artifacts/public/build/target.tar.bz2 07:36:05 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/BMX2tL0PQCeX9uenZREPCQ/artifacts/public/build/target.test_packages.json 07:36:05 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/BMX2tL0PQCeX9uenZREPCQ/artifacts/public/build/target.crashreporter-symbols.zip 07:36:05 INFO - Running post-action listener: _resource_record_post_action 07:36:05 INFO - [mozharness: 2017-09-21 14:36:05.157499Z] Finished read-buildbot-config step (success) 07:36:05 INFO - [mozharness: 2017-09-21 14:36:05.157808Z] Running download-and-extract step. 07:36:05 INFO - Running pre-action listener: _resource_record_pre_action 07:36:05 INFO - Running main action method: download_and_extract 07:36:05 INFO - mkdir: /builds/slave/test/build/tests 07:36:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:05 INFO - trying https://queue.taskcluster.net/v1/task/BMX2tL0PQCeX9uenZREPCQ/artifacts/public/build/target.test_packages.json 07:36:05 INFO - Downloading https://queue.taskcluster.net/v1/task/BMX2tL0PQCeX9uenZREPCQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:36:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BMX2tL0PQCeX9uenZREPCQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:36:06 INFO - Downloaded 989 bytes. 07:36:06 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:36:06 INFO - Using the following test package requirements: 07:36:06 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 07:36:06 INFO - u'common': [u'target.common.tests.zip'], 07:36:06 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:36:06 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:36:06 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:36:06 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:36:06 INFO - u'mozbase': [u'target.common.tests.zip'], 07:36:06 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:36:06 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:36:06 INFO - u'web-platform': [u'target.common.tests.zip', 07:36:06 INFO - u'target.web-platform.tests.tar.gz'], 07:36:06 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:36:06 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 07:36:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BMX2tL0PQCeX9uenZREPCQ/artifacts/public/build/target.common.tests.zip 07:36:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BMX2tL0PQCeX9uenZREPCQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:36:06 INFO - Fetch https://queue.taskcluster.net/v1/task/BMX2tL0PQCeX9uenZREPCQ/artifacts/public/build/target.common.tests.zip into memory 07:36:07 INFO - Content-Length response header: 55293494 07:36:07 INFO - Bytes received: 55293494 07:36:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BMX2tL0PQCeX9uenZREPCQ/artifacts/public/build/target.talos.tests.zip 07:36:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BMX2tL0PQCeX9uenZREPCQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:36:18 INFO - Fetch https://queue.taskcluster.net/v1/task/BMX2tL0PQCeX9uenZREPCQ/artifacts/public/build/target.talos.tests.zip into memory 07:36:19 INFO - Content-Length response header: 14509184 07:36:19 INFO - Bytes received: 14509184 07:36:20 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')]} 07:36:20 INFO - trying https://queue.taskcluster.net/v1/task/BMX2tL0PQCeX9uenZREPCQ/artifacts/public/build/target.tar.bz2 07:36:20 INFO - Downloading https://queue.taskcluster.net/v1/task/BMX2tL0PQCeX9uenZREPCQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:36:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BMX2tL0PQCeX9uenZREPCQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:36:22 INFO - Downloaded 62202566 bytes. 07:36:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BMX2tL0PQCeX9uenZREPCQ/artifacts/public/build/target.tar.bz2 07:36:22 INFO - mkdir: /builds/slave/test/properties 07:36:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:36:22 INFO - Writing to file /builds/slave/test/properties/build_url 07:36:22 INFO - Contents: 07:36:22 INFO - build_url:https://queue.taskcluster.net/v1/task/BMX2tL0PQCeX9uenZREPCQ/artifacts/public/build/target.tar.bz2 07:36:22 INFO - Running post-action listener: _resource_record_post_action 07:36:22 INFO - Running post-action listener: find_tests_for_verification 07:36:22 INFO - Running post-action listener: set_extra_try_arguments 07:36:22 INFO - [mozharness: 2017-09-21 14:36:22.530161Z] Finished download-and-extract step (success) 07:36:22 INFO - [mozharness: 2017-09-21 14:36:22.530312Z] Running populate-webroot step. 07:36:22 INFO - Running pre-action listener: _resource_record_pre_action 07:36:22 INFO - Running main action method: populate_webroot 07:36:22 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:36:22 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:36:22 INFO - 'tests': ['tresize', 07:36:22 INFO - 'tcanvasmark']}, 07:36:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:36:22 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:36:22 INFO - 'tests': ['dromaeo_css', 07:36:22 INFO - 'kraken']}, 07:36:22 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:36:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:36:22 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:36:22 INFO - 'talos_options': ['--disable-stylo'], 07:36:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:36:22 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:36:22 INFO - 'tests': ['damp', 'tps']}, 07:36:22 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:36:22 INFO - 'talos_options': ['--disable-stylo'], 07:36:22 INFO - 'tests': ['damp', 'tps']}, 07:36:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:36:22 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:36:22 INFO - 'tests': ['dromaeo_dom']}, 07:36:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 07:36:22 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:36:22 INFO - 'tests': ['basic_compositor_video', 07:36:22 INFO - 'glvideo']}, 07:36:22 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 07:36:22 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 07:36:22 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:36:22 INFO - 'talos_options': ['--disable-stylo'], 07:36:22 INFO - 'tests': ['ts_paint_webext', 07:36:22 INFO - 'tp5o_webext']}, 07:36:22 INFO - 'other-e10s': {'tests': ['a11yr', 07:36:22 INFO - 'ts_paint', 07:36:22 INFO - 'tpaint', 07:36:22 INFO - 'sessionrestore', 07:36:22 INFO - 'sessionrestore_many_windows', 07:36:22 INFO - 'sessionrestore_no_auto_restore', 07:36:22 INFO - 'tabpaint']}, 07:36:22 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:36:22 INFO - 'tests': ['a11yr', 07:36:22 INFO - 'ts_paint', 07:36:22 INFO - 'tpaint', 07:36:22 INFO - 'sessionrestore', 07:36:22 INFO - 'sessionrestore_many_windows', 07:36:22 INFO - 'sessionrestore_no_auto_restore', 07:36:22 INFO - 'tabpaint']}, 07:36:22 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 07:36:22 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 07:36:22 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:36:22 INFO - 'tests': ['perf_reftest_singletons']}, 07:36:22 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:36:22 INFO - 'tests': ['bloom_basic']}, 07:36:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:36:22 INFO - 'tsvgr_opacity', 07:36:22 INFO - 'tart', 07:36:22 INFO - 'tscrollx', 07:36:22 INFO - 'tsvg_static']}, 07:36:22 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:36:22 INFO - 'tests': ['tsvgx', 07:36:22 INFO - 'tsvgr_opacity', 07:36:22 INFO - 'tart', 07:36:22 INFO - 'tscrollx', 07:36:22 INFO - 'tsvg_static']}, 07:36:22 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:36:22 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:36:22 INFO - 'talos_options': ['--disable-stylo'], 07:36:22 INFO - 'tests': ['tp5o']}, 07:36:22 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:36:22 INFO - 'talos_options': ['--mitmproxy', 07:36:22 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:36:22 INFO - '--firstNonBlankPaint'], 07:36:22 INFO - 'tests': ['tp6_google', 07:36:22 INFO - 'tp6_youtube', 07:36:22 INFO - 'tp6_amazon', 07:36:22 INFO - 'tp6_facebook']}, 07:36:22 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:36:22 INFO - 'talos_options': ['--disable-stylo', 07:36:22 INFO - '--mitmproxy', 07:36:22 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:36:22 INFO - '--firstNonBlankPaint'], 07:36:22 INFO - 'tests': ['tp6_google', 07:36:22 INFO - 'tp6_youtube', 07:36:22 INFO - 'tp6_amazon', 07:36:22 INFO - 'tp6_facebook']}, 07:36:22 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:36:22 INFO - 'talos_options': ['--stylo-threads=1', 07:36:22 INFO - '--mitmproxy', 07:36:22 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:36:22 INFO - '--firstNonBlankPaint'], 07:36:22 INFO - 'tests': ['tp6_google', 07:36:22 INFO - 'tp6_youtube', 07:36:22 INFO - 'tp6_amazon', 07:36:22 INFO - 'tp6_facebook']}, 07:36:22 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:36:22 INFO - 'talos_options': ['--xperf_path', 07:36:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:36:22 INFO - 'tests': ['tp5n']}, 07:36:22 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:36:22 INFO - 'talos_options': ['--disable-stylo', 07:36:22 INFO - '--xperf_path', 07:36:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:36:22 INFO - 'tests': ['tp5n']}}} 07:36:22 INFO - Running post-action listener: _resource_record_post_action 07:36:22 INFO - [mozharness: 2017-09-21 14:36:22.548744Z] Finished populate-webroot step (success) 07:36:22 INFO - [mozharness: 2017-09-21 14:36:22.548855Z] Running create-virtualenv step. 07:36:22 INFO - Running pre-action listener: _resource_record_pre_action 07:36:22 INFO - Running main action method: create_virtualenv 07:36:22 INFO - Creating virtualenv /builds/slave/test/build/venv 07:36:22 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:36:22 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 07:36:22 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 07:36:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:36:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:36:23 INFO - Installing distribute.............................................................................................................................................................................................done. 07:36:23 INFO - Installing pip...............done. 07:36:23 INFO - Return code: 0 07:36:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:36:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:36:23 INFO - Reading from file tmpfile_stdout 07:36:23 INFO - Output received: 07:36:23 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 07:36:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:36:23 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')]} 07:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:23 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')]} 07:36:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:23 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 0xdb31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1123090>, '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 0x1123d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111df90>, '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': 'df17445c3590ff7897617a0e00000225-1506004126.566103-59274306', '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 07:36:23 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 07:36:23 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 07:36:23 INFO - Using env: {'DISPLAY': ':0', 07:36:23 INFO - 'HOME': '/home/cltbld', 07:36:23 INFO - 'LANG': 'en_US.UTF-8', 07:36:23 INFO - 'LANGUAGE': 'en_US:en', 07:36:23 INFO - 'LOGNAME': 'cltbld', 07:36:23 INFO - 'MAIL': '/var/mail/cltbld', 07:36:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:23 INFO - 'MOZ_NO_REMOTE': '1', 07:36:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:23 INFO - 'NO_EM_RESTART': '1', 07:36:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:23 INFO - 'PWD': '/builds/slave/test', 07:36:23 INFO - 'SHELL': '/bin/bash', 07:36:23 INFO - 'SHLVL': '1', 07:36:23 INFO - 'TERM': 'linux', 07:36:23 INFO - 'TMOUT': '86400', 07:36:23 INFO - 'USER': 'cltbld', 07:36:23 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1506004126.566103-59274306', 07:36:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:23 INFO - '_': '/tools/buildbot/bin/python'} 07:36:25 INFO - Ignoring indexes: http://pypi.python.org/simple/ 07:36:25 INFO - Downloading/unpacking pip>=1.5 07:36:25 INFO - Running setup.py egg_info for package pip 07:36:25 INFO - warning: no files found matching 'pip/cacert.pem' 07:36:25 INFO - warning: no files found matching '*.html' under directory 'docs' 07:36:25 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 07:36:25 INFO - no previously-included directories found matching 'docs/_build/_sources' 07:36:25 INFO - Installing collected packages: pip 07:36:25 INFO - Found existing installation: pip 1.1 07:36:25 INFO - Uninstalling pip: 07:36:25 INFO - Successfully uninstalled pip 07:36:25 INFO - Running setup.py install for pip 07:36:25 INFO - warning: no files found matching 'pip/cacert.pem' 07:36:25 INFO - warning: no files found matching '*.html' under directory 'docs' 07:36:25 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 07:36:25 INFO - no previously-included directories found matching 'docs/_build/_sources' 07:36:25 INFO - Installing pip script to /builds/slave/test/build/venv/bin 07:36:25 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 07:36:25 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 07:36:25 INFO - Successfully installed pip 07:36:25 INFO - Cleaning up... 07:36:25 INFO - Return code: 0 07:36:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:36:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:25 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 0xdb31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1123090>, '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 0x1123d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111df90>, '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': 'df17445c3590ff7897617a0e00000225-1506004126.566103-59274306', '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 07:36:25 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 07:36:25 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 07:36:25 INFO - Using env: {'DISPLAY': ':0', 07:36:25 INFO - 'HOME': '/home/cltbld', 07:36:25 INFO - 'LANG': 'en_US.UTF-8', 07:36:25 INFO - 'LANGUAGE': 'en_US:en', 07:36:25 INFO - 'LOGNAME': 'cltbld', 07:36:25 INFO - 'MAIL': '/var/mail/cltbld', 07:36:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:25 INFO - 'MOZ_NO_REMOTE': '1', 07:36:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:25 INFO - 'NO_EM_RESTART': '1', 07:36:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:25 INFO - 'PWD': '/builds/slave/test', 07:36:25 INFO - 'SHELL': '/bin/bash', 07:36:25 INFO - 'SHLVL': '1', 07:36:25 INFO - 'TERM': 'linux', 07:36:25 INFO - 'TMOUT': '86400', 07:36:25 INFO - 'USER': 'cltbld', 07:36:25 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1506004126.566103-59274306', 07:36:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:25 INFO - '_': '/tools/buildbot/bin/python'} 07:36:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:25 INFO - Downloading/unpacking psutil>=3.1.1 07:36:25 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 07:36:25 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 07:36:25 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 07:36:25 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 07:36:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:36:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:36:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:36:26 INFO - Installing collected packages: psutil 07:36:26 INFO - Running setup.py install for psutil 07:36:26 INFO - building 'psutil._psutil_linux' extension 07:36:26 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 07:36:26 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 07:36:26 INFO - building 'psutil._psutil_posix' extension 07:36:26 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 07:36:27 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 07:36:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:36:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:36:27 INFO - Successfully installed psutil 07:36:27 INFO - Cleaning up... 07:36:27 INFO - Return code: 0 07:36:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:36: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')]} 07:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36: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')]} 07:36:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdb31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1123090>, '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 0x1123d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111df90>, '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': 'df17445c3590ff7897617a0e00000225-1506004126.566103-59274306', '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 07:36: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:36: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 mozsystemmonitor==0.3 07:36:27 INFO - Using env: {'DISPLAY': ':0', 07:36:27 INFO - 'HOME': '/home/cltbld', 07:36:27 INFO - 'LANG': 'en_US.UTF-8', 07:36:27 INFO - 'LANGUAGE': 'en_US:en', 07:36:27 INFO - 'LOGNAME': 'cltbld', 07:36:27 INFO - 'MAIL': '/var/mail/cltbld', 07:36:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:27 INFO - 'MOZ_NO_REMOTE': '1', 07:36:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:27 INFO - 'NO_EM_RESTART': '1', 07:36:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:27 INFO - 'PWD': '/builds/slave/test', 07:36:27 INFO - 'SHELL': '/bin/bash', 07:36:27 INFO - 'SHLVL': '1', 07:36:27 INFO - 'TERM': 'linux', 07:36:27 INFO - 'TMOUT': '86400', 07:36:27 INFO - 'USER': 'cltbld', 07:36:27 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1506004126.566103-59274306', 07:36:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:27 INFO - '_': '/tools/buildbot/bin/python'} 07:36:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:36:27 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 07:36:27 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 07:36:27 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 07:36:27 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 07:36:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:36:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:36:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:36:28 INFO - Installing collected packages: mozsystemmonitor 07:36:28 INFO - Running setup.py install for mozsystemmonitor 07:36:28 INFO - Successfully installed mozsystemmonitor 07:36:28 INFO - Cleaning up... 07:36:28 INFO - Return code: 0 07:36:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:36:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:28 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 0xdb31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1123090>, '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 0x1123d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111df90>, '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': 'df17445c3590ff7897617a0e00000225-1506004126.566103-59274306', '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 07:36:28 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 07:36:28 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 07:36:28 INFO - Using env: {'DISPLAY': ':0', 07:36:28 INFO - 'HOME': '/home/cltbld', 07:36:28 INFO - 'LANG': 'en_US.UTF-8', 07:36:28 INFO - 'LANGUAGE': 'en_US:en', 07:36:28 INFO - 'LOGNAME': 'cltbld', 07:36:28 INFO - 'MAIL': '/var/mail/cltbld', 07:36:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:28 INFO - 'MOZ_NO_REMOTE': '1', 07:36:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:28 INFO - 'NO_EM_RESTART': '1', 07:36:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:28 INFO - 'PWD': '/builds/slave/test', 07:36:28 INFO - 'SHELL': '/bin/bash', 07:36:28 INFO - 'SHLVL': '1', 07:36:28 INFO - 'TERM': 'linux', 07:36:28 INFO - 'TMOUT': '86400', 07:36:28 INFO - 'USER': 'cltbld', 07:36:28 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1506004126.566103-59274306', 07:36:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:28 INFO - '_': '/tools/buildbot/bin/python'} 07:36:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:29 INFO - Downloading/unpacking jsonschema==2.5.1 07:36:29 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 07:36:29 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 07:36:29 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 07:36:29 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 07:36:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:36:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:36:30 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 07:36:30 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 07:36:30 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 07:36:30 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 07:36:30 INFO - Downloading functools32-3.2.3-2.tar.gz 07:36:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:36:30 INFO - warning: no files found matching '*.txt' 07:36:30 INFO - no previously-included directories found matching 'build' 07:36:30 INFO - no previously-included directories found matching 'dist' 07:36:30 INFO - no previously-included directories found matching '.git*' 07:36:30 INFO - Installing collected packages: jsonschema, functools32 07:36:31 INFO - Running setup.py install for functools32 07:36:31 INFO - warning: no files found matching '*.txt' 07:36:31 INFO - no previously-included directories found matching 'build' 07:36:31 INFO - no previously-included directories found matching 'dist' 07:36:31 INFO - no previously-included directories found matching '.git*' 07:36:31 INFO - Successfully installed jsonschema functools32 07:36:31 INFO - Cleaning up... 07:36:31 INFO - Return code: 0 07:36:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:36: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')]} 07:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36: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')]} 07:36:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36: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', '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 0xdb31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1123090>, '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 0x1123d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111df90>, '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': 'df17445c3590ff7897617a0e00000225-1506004126.566103-59274306', '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 07:36: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:36: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 functools32==3.2.3-2 07:36:31 INFO - Using env: {'DISPLAY': ':0', 07:36:31 INFO - 'HOME': '/home/cltbld', 07:36:31 INFO - 'LANG': 'en_US.UTF-8', 07:36:31 INFO - 'LANGUAGE': 'en_US:en', 07:36:31 INFO - 'LOGNAME': 'cltbld', 07:36:31 INFO - 'MAIL': '/var/mail/cltbld', 07:36:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:31 INFO - 'MOZ_NO_REMOTE': '1', 07:36:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:31 INFO - 'NO_EM_RESTART': '1', 07:36:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:31 INFO - 'PWD': '/builds/slave/test', 07:36:31 INFO - 'SHELL': '/bin/bash', 07:36:31 INFO - 'SHLVL': '1', 07:36:31 INFO - 'TERM': 'linux', 07:36:31 INFO - 'TMOUT': '86400', 07:36:31 INFO - 'USER': 'cltbld', 07:36:31 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1506004126.566103-59274306', 07:36:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:31 INFO - '_': '/tools/buildbot/bin/python'} 07:36:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:36:31 INFO - Cleaning up... 07:36:31 INFO - Return code: 0 07:36:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:36: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')]} 07:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36: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')]} 07:36:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36: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', '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 0xdb31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1123090>, '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 0x1123d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111df90>, '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': 'df17445c3590ff7897617a0e00000225-1506004126.566103-59274306', '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 07:36: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:36: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 blobuploader==1.2.4 07:36:31 INFO - Using env: {'DISPLAY': ':0', 07:36:31 INFO - 'HOME': '/home/cltbld', 07:36:31 INFO - 'LANG': 'en_US.UTF-8', 07:36:31 INFO - 'LANGUAGE': 'en_US:en', 07:36:31 INFO - 'LOGNAME': 'cltbld', 07:36:31 INFO - 'MAIL': '/var/mail/cltbld', 07:36:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:31 INFO - 'MOZ_NO_REMOTE': '1', 07:36:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:31 INFO - 'NO_EM_RESTART': '1', 07:36:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:31 INFO - 'PWD': '/builds/slave/test', 07:36:31 INFO - 'SHELL': '/bin/bash', 07:36:31 INFO - 'SHLVL': '1', 07:36:31 INFO - 'TERM': 'linux', 07:36:31 INFO - 'TMOUT': '86400', 07:36:31 INFO - 'USER': 'cltbld', 07:36:31 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1506004126.566103-59274306', 07:36:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:31 INFO - '_': '/tools/buildbot/bin/python'} 07:36:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:31 INFO - Downloading/unpacking blobuploader==1.2.4 07:36: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 07:36: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 07:36: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 07:36: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 07:36:33 INFO - Downloading blobuploader-1.2.4.tar.gz 07:36:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:36:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:36: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 07:36: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 07:36: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 07:36: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 07:36:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:36:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:36: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 07:36: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 07:36: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 07:36: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 07:36:33 INFO - Downloading docopt-0.6.1.tar.gz 07:36:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:36:33 INFO - Installing collected packages: blobuploader, requests, docopt 07:36:33 INFO - Running setup.py install for blobuploader 07:36:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:36:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:36:34 INFO - Running setup.py install for requests 07:36:35 INFO - Running setup.py install for docopt 07:36:37 INFO - Successfully installed blobuploader requests docopt 07:36:37 INFO - Cleaning up... 07:36:37 INFO - Return code: 0 07:36:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36: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')]} 07:36:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36: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')]} 07:36:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36: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 0xdb31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1123090>, '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 0x1123d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111df90>, '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': 'df17445c3590ff7897617a0e00000225-1506004126.566103-59274306', '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 07:36: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 07:36: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 07:36:37 INFO - Using env: {'DISPLAY': ':0', 07:36:37 INFO - 'HOME': '/home/cltbld', 07:36:37 INFO - 'LANG': 'en_US.UTF-8', 07:36:37 INFO - 'LANGUAGE': 'en_US:en', 07:36:37 INFO - 'LOGNAME': 'cltbld', 07:36:37 INFO - 'MAIL': '/var/mail/cltbld', 07:36:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:37 INFO - 'MOZ_NO_REMOTE': '1', 07:36:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:37 INFO - 'NO_EM_RESTART': '1', 07:36:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:37 INFO - 'PWD': '/builds/slave/test', 07:36:37 INFO - 'SHELL': '/bin/bash', 07:36:37 INFO - 'SHLVL': '1', 07:36:37 INFO - 'TERM': 'linux', 07:36:37 INFO - 'TMOUT': '86400', 07:36:37 INFO - 'USER': 'cltbld', 07:36:37 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1506004126.566103-59274306', 07:36:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:37 INFO - '_': '/tools/buildbot/bin/python'} 07:36:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:36:37 INFO - Running setup.py (path:/tmp/pip-EJsJEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:36:37 INFO - Running setup.py (path:/tmp/pip-CcXfTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:36:38 INFO - Running setup.py (path:/tmp/pip-T9V57O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:36:38 INFO - Running setup.py (path:/tmp/pip-gJo5R8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:36:38 INFO - Running setup.py (path:/tmp/pip-WDB4YH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:36:38 INFO - Running setup.py (path:/tmp/pip-CDtES4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:36:38 INFO - Running setup.py (path:/tmp/pip-7nX5ws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:36:38 INFO - Running setup.py (path:/tmp/pip-5ThL1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:36:38 INFO - Running setup.py (path:/tmp/pip-C2jEGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:36:38 INFO - Running setup.py (path:/tmp/pip-3VQNZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:36:38 INFO - Running setup.py (path:/tmp/pip-EIq0sE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:36:38 INFO - Running setup.py (path:/tmp/pip-n9QEcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:36:38 INFO - Running setup.py (path:/tmp/pip-t0RugY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:36:38 INFO - Running setup.py (path:/tmp/pip-tAP9wf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:38 INFO - Running setup.py (path:/tmp/pip-fUbHq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:36:38 INFO - Running setup.py (path:/tmp/pip-_ay__o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:36:39 INFO - Running setup.py (path:/tmp/pip-XgAWHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:36:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:36:39 INFO - Running setup.py install for manifestparser 07:36:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:36:39 INFO - Running setup.py install for mozcrash 07:36:39 INFO - Running setup.py install for mozdebug 07:36:39 INFO - Running setup.py install for mozdevice 07:36:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:36:39 INFO - Running setup.py install for mozfile 07:36:39 INFO - Running setup.py install for mozhttpd 07:36:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:36:39 INFO - Running setup.py install for mozinfo 07:36:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:36:39 INFO - Running setup.py install for mozInstall 07:36:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:36:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:36:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:36:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:36:39 INFO - Running setup.py install for mozleak 07:36:39 INFO - Running setup.py install for mozlog 07:36:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:36:40 INFO - Running setup.py install for moznetwork 07:36:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:36:40 INFO - Running setup.py install for mozprocess 07:36:40 INFO - Running setup.py install for mozprofile 07:36:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:36:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:36:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:36:40 INFO - Running setup.py install for mozrunner 07:36:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:36:40 INFO - Running setup.py install for mozscreenshot 07:36:40 INFO - Running setup.py install for moztest 07:36:40 INFO - Running setup.py install for mozversion 07:36:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:36:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:36:40 INFO - Cleaning up... 07:36:40 INFO - Return code: 0 07:36:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36: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')]} 07:36:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36: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')]} 07:36:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36: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 0xdb31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1123090>, '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 0x1123d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111df90>, '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': 'df17445c3590ff7897617a0e00000225-1506004126.566103-59274306', '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 07:36: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 07:36: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 07:36:40 INFO - Using env: {'DISPLAY': ':0', 07:36:40 INFO - 'HOME': '/home/cltbld', 07:36:40 INFO - 'LANG': 'en_US.UTF-8', 07:36:40 INFO - 'LANGUAGE': 'en_US:en', 07:36:40 INFO - 'LOGNAME': 'cltbld', 07:36:40 INFO - 'MAIL': '/var/mail/cltbld', 07:36:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:40 INFO - 'MOZ_NO_REMOTE': '1', 07:36:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:40 INFO - 'NO_EM_RESTART': '1', 07:36:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:40 INFO - 'PWD': '/builds/slave/test', 07:36:40 INFO - 'SHELL': '/bin/bash', 07:36:40 INFO - 'SHLVL': '1', 07:36:40 INFO - 'TERM': 'linux', 07:36:40 INFO - 'TMOUT': '86400', 07:36:40 INFO - 'USER': 'cltbld', 07:36:40 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1506004126.566103-59274306', 07:36:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:40 INFO - '_': '/tools/buildbot/bin/python'} 07:36:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:36:41 INFO - Running setup.py (path:/tmp/pip-CXzhcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:36:41 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)) 07:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:36:41 INFO - Running setup.py (path:/tmp/pip-ig3j16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:36:41 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)) 07:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:36:41 INFO - Running setup.py (path:/tmp/pip-7CRyMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:36:41 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)) 07:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:36:41 INFO - Running setup.py (path:/tmp/pip-Geh4oI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:36:41 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)) 07:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:36:41 INFO - Running setup.py (path:/tmp/pip-t7RolQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:36: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)) 07:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:36:41 INFO - Running setup.py (path:/tmp/pip-r7KlCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:36: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)) 07:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:36:41 INFO - Running setup.py (path:/tmp/pip-84Zo_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:36: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)) 07:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:36:41 INFO - Running setup.py (path:/tmp/pip-gMbLG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:36: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)) 07:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:36:41 INFO - Running setup.py (path:/tmp/pip-6rdLvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:36: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)) 07:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:36:41 INFO - Running setup.py (path:/tmp/pip-vNPqKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:36: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)) 07:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:36:41 INFO - Running setup.py (path:/tmp/pip-gXG9Ed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:36: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)) 07:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:36:41 INFO - Running setup.py (path:/tmp/pip-bZLeG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:36: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)) 07:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:36:41 INFO - Running setup.py (path:/tmp/pip-JPXWP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:36: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)) 07:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:36:41 INFO - Running setup.py (path:/tmp/pip-0q6eaf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:36:42 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)) 07:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:42 INFO - Running setup.py (path:/tmp/pip-hTNcJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:42 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)) 07:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:36:42 INFO - Running setup.py (path:/tmp/pip-eq3XWO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:36:42 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)) 07:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:36:42 INFO - Running setup.py (path:/tmp/pip-Ony082-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:36:42 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)) 07:36:42 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)) 07:36:42 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)) 07:36:42 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)) 07:36:42 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)) 07:36:42 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)) 07:36:42 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)) 07:36:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:36:42 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 07:36:42 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 07:36:42 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 07:36:42 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 07:36:43 INFO - Downloading blessings-1.6.tar.gz 07:36:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:36:43 INFO - Installing collected packages: blessings 07:36:43 INFO - Running setup.py install for blessings 07:36:43 INFO - Successfully installed blessings 07:36:43 INFO - Cleaning up... 07:36:43 INFO - Return code: 0 07:36:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:36:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:36:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:36:43 INFO - Reading from file tmpfile_stdout 07:36:43 INFO - Current package versions: 07:36:43 INFO - argparse == 1.2.1 07:36:43 INFO - blessings == 1.6 07:36:43 INFO - blobuploader == 1.2.4 07:36:43 INFO - docopt == 0.6.1 07:36:43 INFO - functools32 == 3.2.3-2 07:36:43 INFO - jsonschema == 2.5.1 07:36:43 INFO - manifestparser == 1.1 07:36:43 INFO - mozInstall == 1.13 07:36:43 INFO - mozcrash == 1.0 07:36:43 INFO - mozdebug == 0.1 07:36:43 INFO - mozdevice == 0.51 07:36:43 INFO - mozfile == 1.2 07:36:43 INFO - mozhttpd == 0.7 07:36:43 INFO - mozinfo == 0.10 07:36:43 INFO - mozleak == 0.1 07:36:43 INFO - mozlog == 3.5 07:36:43 INFO - moznetwork == 0.27 07:36:43 INFO - mozprocess == 0.25 07:36:43 INFO - mozprofile == 0.28 07:36:43 INFO - mozrunner == 6.13 07:36:43 INFO - mozscreenshot == 0.1 07:36:43 INFO - mozsystemmonitor == 0.3 07:36:43 INFO - moztest == 0.8 07:36:43 INFO - mozversion == 1.4 07:36:43 INFO - psutil == 3.1.1 07:36:43 INFO - requests == 1.2.3 07:36:43 INFO - wsgiref == 0.1.2 07:36:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36: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')]} 07:36:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36: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')]} 07:36:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36: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 0xdb31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1123090>, '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 0x1123d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111df90>, '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': 'df17445c3590ff7897617a0e00000225-1506004126.566103-59274306', '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 07:36: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 07:36: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 07:36:43 INFO - Using env: {'DISPLAY': ':0', 07:36:43 INFO - 'HOME': '/home/cltbld', 07:36:43 INFO - 'LANG': 'en_US.UTF-8', 07:36:43 INFO - 'LANGUAGE': 'en_US:en', 07:36:43 INFO - 'LOGNAME': 'cltbld', 07:36:43 INFO - 'MAIL': '/var/mail/cltbld', 07:36:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:43 INFO - 'MOZ_NO_REMOTE': '1', 07:36:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:43 INFO - 'NO_EM_RESTART': '1', 07:36:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:43 INFO - 'PWD': '/builds/slave/test', 07:36:43 INFO - 'SHELL': '/bin/bash', 07:36:43 INFO - 'SHLVL': '1', 07:36:43 INFO - 'TERM': 'linux', 07:36:43 INFO - 'TMOUT': '86400', 07:36:43 INFO - 'USER': 'cltbld', 07:36:43 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1506004126.566103-59274306', 07:36:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:43 INFO - '_': '/tools/buildbot/bin/python'} 07:36:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:44 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)) 07:36:44 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)) 07:36:44 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)) 07:36:44 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)) 07:36:44 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)) 07:36:44 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)) 07:36:44 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)) 07:36:44 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)) 07:36:44 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)) 07:36:44 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 07:36:44 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 07:36:44 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 07:36:44 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 07:36:44 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 07:36:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 07:36:45 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)) 07:36:45 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)) 07:36:45 INFO - Installing collected packages: simplejson 07:36:45 INFO - Running setup.py install for simplejson 07:36:45 INFO - building 'simplejson._speedups' extension 07:36:45 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 07:36:46 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 07:36:46 INFO - Successfully installed simplejson 07:36:46 INFO - Cleaning up... 07:36:46 INFO - Return code: 0 07:36:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:36:46 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')]} 07:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:46 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')]} 07:36:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:46 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 0xdb31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1123090>, '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 0x1123d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111df90>, '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': 'df17445c3590ff7897617a0e00000225-1506004126.566103-59274306', '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 07:36:46 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 07:36:46 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 07:36:46 INFO - Using env: {'DISPLAY': ':0', 07:36:46 INFO - 'HOME': '/home/cltbld', 07:36:46 INFO - 'LANG': 'en_US.UTF-8', 07:36:46 INFO - 'LANGUAGE': 'en_US:en', 07:36:46 INFO - 'LOGNAME': 'cltbld', 07:36:46 INFO - 'MAIL': '/var/mail/cltbld', 07:36:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:46 INFO - 'MOZ_NO_REMOTE': '1', 07:36:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:46 INFO - 'NO_EM_RESTART': '1', 07:36:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:46 INFO - 'PWD': '/builds/slave/test', 07:36:46 INFO - 'SHELL': '/bin/bash', 07:36:46 INFO - 'SHLVL': '1', 07:36:46 INFO - 'TERM': 'linux', 07:36:46 INFO - 'TMOUT': '86400', 07:36:46 INFO - 'USER': 'cltbld', 07:36:46 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1506004126.566103-59274306', 07:36:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:46 INFO - '_': '/tools/buildbot/bin/python'} 07:36:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:36:46 INFO - Cleaning up... 07:36:46 INFO - Return code: 0 07:36:46 INFO - Running post-action listener: _resource_record_post_action 07:36:46 INFO - Running post-action listener: _start_resource_monitoring 07:36:46 INFO - Starting resource monitoring. 07:36:46 INFO - [mozharness: 2017-09-21 14:36:46.526048Z] Finished create-virtualenv step (success) 07:36:46 INFO - [mozharness: 2017-09-21 14:36:46.526571Z] Running install step. 07:36:46 INFO - Running pre-action listener: _resource_record_pre_action 07:36:46 INFO - Running main action method: install 07:36:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:36:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:36:46 INFO - Reading from file tmpfile_stdout 07:36:46 INFO - Detecting whether we're running mozinstall >=1.0... 07:36:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:36:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:36:46 INFO - Reading from file tmpfile_stdout 07:36:46 INFO - Output received: 07:36:46 INFO - Usage: mozinstall [options] installer 07:36:46 INFO - Options: 07:36:46 INFO - -h, --help show this help message and exit 07:36:46 INFO - -d DEST, --destination=DEST 07:36:46 INFO - Directory to install application into. [default: 07:36:46 INFO - "/builds/slave/test"] 07:36:46 INFO - --app=APP Application being installed. [default: firefox] 07:36:46 INFO - mkdir: /builds/slave/test/build/application 07:36: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'] 07:36:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:37:04 INFO - Reading from file tmpfile_stdout 07:37:04 INFO - Output received: 07:37:04 INFO - /builds/slave/test/build/application/firefox/firefox 07:37:04 INFO - Running post-action listener: _resource_record_post_action 07:37:04 INFO - [mozharness: 2017-09-21 14:37:04.507407Z] Finished install step (success) 07:37:04 INFO - [mozharness: 2017-09-21 14:37:04.507662Z] Running setup-mitmproxy step. 07:37:04 INFO - Running pre-action listener: _resource_record_pre_action 07:37:04 INFO - Running main action method: setup_mitmproxy 07:37:04 INFO - Skipping: mitmproxy is not required 07:37:04 INFO - Running post-action listener: _resource_record_post_action 07:37:04 INFO - [mozharness: 2017-09-21 14:37:04.508780Z] Finished setup-mitmproxy step (success) 07:37:04 INFO - [mozharness: 2017-09-21 14:37:04.509051Z] Running run-tests step. 07:37:04 INFO - Running pre-action listener: _resource_record_pre_action 07:37:04 INFO - Running pre-action listener: _set_gcov_prefix 07:37:04 INFO - Running main action method: run_tests 07:37:04 WARNING - Try message not found. 07:37:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:37:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:37:04 INFO - Python 2.7.3 07:37:04 INFO - Return code: 0 07:37:04 INFO - grabbing minidump binary from tooltool 07:37: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')]} 07:37: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 0x1123090>, '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 0x1123d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111df90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:37: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 07:37: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 07:37: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 07:37:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:37:04 INFO - Return code: 0 07:37:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:37:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:37:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:37:04 INFO - ENV: RUST_BACKTRACE is now full 07:37:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:37:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:37: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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BMX2tL0PQCeX9uenZREPCQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:37: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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BMX2tL0PQCeX9uenZREPCQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:37:04 INFO - Using env: {'DISPLAY': ':0', 07:37:04 INFO - 'HOME': '/home/cltbld', 07:37:04 INFO - 'LANG': 'en_US.UTF-8', 07:37:04 INFO - 'LANGUAGE': 'en_US:en', 07:37:04 INFO - 'LOGNAME': 'cltbld', 07:37:04 INFO - 'MAIL': '/var/mail/cltbld', 07:37:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:37:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:37:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:04 INFO - 'MOZ_NO_REMOTE': '1', 07:37:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:37:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:04 INFO - 'NO_EM_RESTART': '1', 07:37:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:04 INFO - 'PWD': '/builds/slave/test', 07:37:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:37:04 INFO - 'RUST_BACKTRACE': 'full', 07:37:04 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:37:04 INFO - 'SHELL': '/bin/bash', 07:37:04 INFO - 'SHLVL': '1', 07:37:04 INFO - 'TERM': 'linux', 07:37:04 INFO - 'TMOUT': '86400', 07:37:04 INFO - 'USER': 'cltbld', 07:37:04 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1506004126.566103-59274306', 07:37:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:04 INFO - '_': '/tools/buildbot/bin/python'} 07:37:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BMX2tL0PQCeX9uenZREPCQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:37:04 INFO - mozversion application_buildid: 20170921131427 07:37:04 INFO - mozversion application_changeset: 9caeafcec9982be90820e30bc699e851cb6af907 07:37:04 INFO - mozversion application_display_name: Nightly 07:37:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:37:04 INFO - mozversion application_name: Firefox 07:37:04 INFO - mozversion application_remotingname: firefox 07:37:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:37:04 INFO - mozversion application_vendor: Mozilla 07:37:04 INFO - mozversion application_version: 57.0a1 07:37:04 INFO - mozversion platform_buildid: 20170921131427 07:37:04 INFO - mozversion platform_changeset: 9caeafcec9982be90820e30bc699e851cb6af907 07:37:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:37:04 INFO - mozversion platform_version: 57.0a1 07:37:04 INFO - using testdate: 1506004624 07:37:04 INFO - actual date: 1506004624 07:37:04 INFO - starting webserver on 'localhost:57871' 07:37:04 INFO - SUITE-START | Running 2 tests 07:37:04 INFO - TEST-START | dromaeo_css 07:37:04 INFO - Initialising browser for dromaeo_css test... 07:37:04 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57871/getInfo.html -profile /tmp/tmpPB9C66/profile 07:37:04 INFO - TEST-INFO | started process 19810 (/builds/slave/test/build/application/firefox/firefox http://localhost:57871/getInfo.html) 07:37:11 INFO - TEST-INFO | 19810: exit 0 07:37:11 INFO - Browser initialized. 07:37:11 INFO - Running cycle 1/1 for dromaeo_css test... 07:37:11 INFO - Using env: {'DISPLAY': ':0', 07:37:11 INFO - 'HOME': '/home/cltbld', 07:37:11 INFO - 'JSGC_DISABLE_POISONING': '1', 07:37:11 INFO - 'LANG': 'en_US.UTF-8', 07:37:11 INFO - 'LANGUAGE': 'en_US:en', 07:37:11 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 07:37:11 INFO - 'LOGNAME': 'cltbld', 07:37:11 INFO - 'MAIL': '/var/mail/cltbld', 07:37:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:37:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:37:11 INFO - 'MOZ_CRASHREPORTER': '1', 07:37:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:11 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 07:37:11 INFO - 'MOZ_NO_REMOTE': '1', 07:37:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:37:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:11 INFO - 'NO_EM_RESTART': '1', 07:37:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:11 INFO - 'PWD': '/builds/slave/test', 07:37:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:37:11 INFO - 'RUST_BACKTRACE': 'full', 07:37:11 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:37:11 INFO - 'SHELL': '/bin/bash', 07:37:11 INFO - 'SHLVL': '1', 07:37:11 INFO - 'TERM': 'linux', 07:37:11 INFO - 'TMOUT': '86400', 07:37:11 INFO - 'USER': 'cltbld', 07:37:11 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1506004126.566103-59274306', 07:37:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:11 INFO - '_': '/tools/buildbot/bin/python'} 07:37:11 INFO - TEST-INFO | started process 20047 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPB9C66/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:37:11 INFO - PID 20047 | 07:37:11 INFO - PID 20047 | (/builds/slave/test/build/application/firefox/firefox:20097): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:37:11 INFO - PID 20047 | 07:37:22 INFO - PID 20047 | RSS: Main: 147484672 07:37:22 INFO - PID 20047 | 07:40:20 INFO - PID 20047 | Cycle 1(1): loaded http://localhost:57871/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57871/tests/dromaeo/cssquery-ext.html) 07:40:21 INFO - PID 20047 | RSS: Main: 148082688 07:40:21 INFO - PID 20047 | 07:43:23 INFO - PID 20047 | Cycle 1(1): loaded http://localhost:57871/tests/dromaeo/cssquery-ext.html (next: http://localhost:57871/tests/dromaeo/cssquery-jquery.html) 07:43:23 INFO - PID 20047 | RSS: Main: 147091456 07:43:23 INFO - PID 20047 | 07:46:25 INFO - PID 20047 | Cycle 1(1): loaded http://localhost:57871/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57871/tests/dromaeo/cssquery-mootools.html) 07:46:25 INFO - PID 20047 | RSS: Main: 148709376 07:46:25 INFO - PID 20047 | 07:49:27 INFO - PID 20047 | Cycle 1(1): loaded http://localhost:57871/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57871/tests/dromaeo/cssquery-prototype.html) 07:49:28 INFO - PID 20047 | RSS: Main: 148766720 07:49:28 INFO - PID 20047 | 07:52:31 INFO - PID 20047 | Cycle 1(1): loaded http://localhost:57871/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57871/tests/dromaeo/cssquery-yui.html) 07:52:31 INFO - PID 20047 | RSS: Main: 150380544 07:52:31 INFO - PID 20047 | 07:55:33 INFO - PID 20047 | Cycle 1(1): loaded http://localhost:57871/tests/dromaeo/cssquery-yui.html (next: http://localhost:57871/tests/dromaeo/cssquery-dojo.html) 07:55:33 INFO - PID 20047 | RSS: Main: 152424448 07:55:33 INFO - PID 20047 | 07:55:33 INFO - PID 20047 | __start_tp_report 07:55:33 INFO - PID 20047 | _x_x_mozilla_page_load 07:55:33 INFO - PID 20047 | _x_x_mozilla_page_load_details 07:55:33 INFO - PID 20047 | |i|pagename|runs| 07:55:33 INFO - PID 20047 | |0;dojo.html;3856.691464682826;3873.7675739455635;3876.7480113792585;3884.7863367514774;3918.196769662218;6301.432871041606;6302.590331628447;6340.809775706736;6358;6385.489160867131;6356.9682151589295;6396.392342727433;6456.967715161418;6504.089427480157;6523.739050437976;5726.713664316789;5734.168545560891;5740.79907203248;5778.566607504444;5781.768729250825;5638.802641907534;5704.11586204137;5709.571782116337;5745.540356771448;5814.418558144194;5741.081426971686;5758.136279558058;5764.221830052952;5765.769369225247;5779.162021506879;5688.260526131618;5828.0966450200285;5842.123681447774;5853.180554722342;5856.560757943129;5673.035583950738;5728.112142617901;5817.970910145422;5819.272590926134;5825.417458254183;6066.939330606681;6155.107509411155;6201.906971395432;6276.558029450382;6367.98112302034;6817.250102488722;6859.897101543481;6870.587764734082;6894.724211031553;6894.724211031553;6827.761028364033;6893.276205998398;6899.724011039552;6915.377616014583;6930.61881596512;6405.231372235315;6416.101745755598;6477.514186436036;6483.675816209171;6484.383983521605;7008.404285635676;7086.574805511686;7152.356287934111;7171.497995140395;7177.856442871113;6685.465162786965;6803.251642319341;6804.183497980175;6811.148606424197;6843.931560684329;6902.378785909192;6911.550749201286;6914.896276555855;6917.273686262971;6919.6540172991145;6803.897941530881;6881.41507971818;6936.79189624312;6947.131608548932;6951.0616066830335;6886.208086070166;6896.551724137915;6908.827279318058;6997.790066298019;6999.23008469068;4863.440704319049;4970.005998800254;4971.37857767779;5028.874278143076;5034.0686972910125;4506.053728717006;4524.298733696282;4551.340055691906;4559.3844830948065;4583.381243532147;6216.378362163748;6224.9377506224355;6290.842728931813;6318.842028949313;6432.549721519449;6846.7945961621235;6862.107925969592;6864.176298844171;6961.477889158334;6978.616176110261;6222.222222222223;6280.685965701697;6320.146780184708;6385.042243663488;6385.712642931079;5563.443655634485;5578.86052848682;5588.413216612278;5589.888202235932;5605.691686957175;6983.022376867242;7148.035015272975;7156.069710937545;7177.1746249182015;7179.605121718356;6887.862242755016;6897.862042759217;6978.581285122909;6980.301969802979;6987.9301206987275;6939.201991771011;7005.474589405713;7008.983697363752;7043.436525078084;7044;6828.556143850634;6834.692438840165;6843.863122737617;6860.5540639858245;6871.244163141951;6859.794206173823;6876.484263680144;6954.165500140016;6961.512694111364;6984.79045628632;6612.537122401386;6641.900371494528;6649.2685804562425;6732.42774364165;6738.932610674026;6484.805455836333;6625.734970601122;6628;6638.53530252897;6644.867102657823;6509.837254068497;6518.511111666549;6589.868202636017;6600.570962887397;6610.8016759497295;6775.830604234933;6788.9660551696925;6814.591124532544;6832.248452670103;6834.453243740588;6362.77730279438;6506.089147519257;6515.0553169791065;6529.053287273224;6595.043718660863 07:55:33 INFO - PID 20047 | |1;ext.html;941.2093841173413;951.4719330771419;973.1971123822846;996.6810620601406;1003.5233264199511;41092;42478.787606061924;42806.785966070165;42858.35712464315;42864.78567607157;40773.18453630926;40796.59203407965;40942.59057409425;41130.58869411305;41259.174816503655;7626.580538070418;7738.187490313492;7743.806404839896;7744.225577442267;7755.573443460607;7722.961385193094;7857.646405911748;7862.882056769153;7868.842623147533;7872.055353357605;8338.83322333553;8597.699080532182;8601.182887625666;8602.053774084845;8624.827503449927;8501.95749021254;8564.3148548116;8571.185737354972;8572.099929507405;8576.69981550649;8214.83570328596;8383.45507542014;8387.790305242417;8430.072692003874;8432.915670843275;39178.21643567141;39683.80158099191;39713;39777.40333894994;39791.40312895309;3602.261536385061;3647.452882067711;3650.4159334506617;3653.8173091345593;3659.5608526976666;32618.510722339182;32754.344913101606;32760.672393276;32809.50785738216;32820;5364.892702145935;5364.892702145974;5365.624406291561;5367.597430192751;5446.645968012106;221719;221915;223730.99999999837;223943;224293;50849.745751271745;50963.490365096615;51042.48957510378;51114.488855110976;51158.23262651063;52885.735571322664;53177;53239.733801330745;53280.20079698808;53438;15479.613009674847;15804.920975395049;15811.367545298059;15905.125218113115;15906.68186636284;12696.301703406216;12697.746045079046;12705.110642255138;12705.809412858815;12735.745285094432;14770.852291476947;15018.849811501963;15090.17004064787;15244.161571113473;15249.466268680542;5939.4357536034;6084.847878803065;6097.908531372033;6110.236220472441;6110.877782444326;1090.3621381491757;1101.4492753623188;1103.8730545987314;1104.4201794058024;1115.314081839679;25434.364140896625;25478.745212547637;25499.617505737428;25741.3564660885;25797.35506612312;1185.3539820797687;1188.0792385900822;1195.1693572966706;1197.9640610781692;1203.1096988228649;13104.737905241842;13360.33198340079;13437.529686460926;13485.258310793;13527.188368697909;281819;282740;283636;284271;284983;47714.522854771705;48206.27690584644;55044;55387;55481.722591387595;1506.9246537673073;1511.2594828534159;1515.280241885118;1525.6033431307717;1537.5079974408306;29018.854905725337;29452;29951.101466956025;30189.698103019567;30344.54483182798;39620.801895990335;39920.800395998995;40025.79987100046;40026.1994760109;40059.79970100248;230374;230653;232750;232777;233063;33961.66038339684;34910.301793964485;35343;35373.29253414969;35469;45796;45959.54040459553;46096.07807843891;46284.7685761569;46339.073218534766;33187.66812331846;33433.49849752207;34036.48945265872;34305.82847085749;34375.82812085924;33392.33215335728;33879.491807623395;34195.48706769351;34276.828615856764;34325.485117722754;38208.808955956156;39972;40038.39942400924;40087.1982560353;40199.3970090443;32643.673563264063;32800.671993279764;32823.67176328206;32985.505217421276;33460.83269583636;24980.875095624404;25061;25141;25148.62277065882;25179.49641007133 07:55:33 INFO - PID 20047 | |2;jquery.html;587.2659176029961;603.1104121420905;603.8701679138984;606.420868070992;635.4947816485894;22834.88582557087;23783.405414864636;23848.76151238487;23903.641445378333;23926.28221153364;24473;26816.5977510337;27063.18810435685;27091.458170836573;27169.18492445225;6453.548251622388;6507.9023814642815;6620.271770105284;6630.403263706289;6631.801045968628;6419.35806419359;6556.442702370305;6807.897881531781;6860.34826691466;6891.1041564596535;6767.052612634235;6846.6576671166495;6847.897281540781;6848.14398200225;6848.417884479801;6440.291567927501;6686.632235227061;6736.797896063126;6836.077129587492;6867.965660171692;6261.186045814061;6284.968575157095;6285.2771931228035;6286.559940804145;6321.273053598803;30699;30873.691263087305;31043.844780776177;31127;31140;2289.885505724707;2327.325075728037;2328.906843726249;2332.976670233293;2333.6382860656627;19687.704684429744;21256.681149782766;21483.462913427134;21501.892490537448;21536.138554457804;2442.3405680466353;2475.3811547113223;2483.1557270528106;2498.5877330240487;2519.748025197484;135442;144336;154870;159923.2003839985;161048;15324.770128448083;16148.596285092966;16311.265993030342;16335.509934701979;16579.17104144788;25454;25514.362140946254;25522.872385637955;25566.616500752505;25627.231183064538;9944.602215911282;10048.79902401948;10104.343217690974;10161.4919254037;10162.898371016343;9041.321900857462;9156.130167634064;9167.404118732262;9186.908130918739;9219.262459003263;9584.616615335308;9716.174125199295;9839.195829188648;9877.901220987842;10012;2843.886244550195;2850.3016760893715;2859.8856045758353;2932.8093673911126;2958.949572901632;1039.5270152080784;1052.957881684724;1053.5943661690305;1054.9736256593646;1064.7604289034905;20730;21353.25263615766;21599.892000539898;21821.890890545445;21953;1088.1675518228562;1093.9935259561223;1111.2665640677114;1114.6934592986993;1129.316763358173;11574.305541667527;11589.014933730727;11687.240329378563;11747.765044699057;11853.703657408461;590685;593359;594779;606938;629392;124240;126211;127832.3608381952;129326.06010909844;129601;1135.2053562506278;1173.747644256489;1222.6087651951468;1226.9877301227052;1285.3637449462576;22812.42968925724;23109.65335519935;23223.535529289657;23247.3025809226;23284.53430931406;65442;66095;66252.66873665794;66939.33060669331;67850.66074669595;78241.60879195567;80319.59840200761;82797;82957.58521207355;83874;15612.765808512655;15679.843201568294;15830.60423489422;15942.123183225034;16026.839731602535;24829.379265518506;25104.12135575246;25203.36991575152;25262.115825946003;25378.619320709833;19534;19541.60916781685;20160.193592256146;20270.087846046667;20383.08276127548;17743.201555929754;17833.286668533114;18145.637087257917;18197.727034094234;18520.536986575444;20337.389878303675;20452.284170053976;20804.479888002315;20806.167753290305;20854.478638034172;15510.767338489706;15579.610509737347;15735.68528629444;15757.212139393214;15796;19751.901240493706;19814.306499272458;19949.900250498653;19981.60036799285;20211.393658190278 07:55:33 INFO - PID 20047 | |3;mootools.html;1379.8206233189687;1436.2531483628507;1442.7475191841424;1448.7175000874831;1458.8249410070794;17028.233729482174;17653.999999999985;17660.735088973644;17663.205155767988;17672.29310827567;17358.21888015039;17477;17565.560860978483;17588.64822703545;17601.55996100098;2837.8581070946475;2894.768418526513;2942;2944.175630823373;2944.263934016496;2845.4593627210866;2884.8124871883365;2895.030164894763;2896.174590241771;2902.7532659723947;2791.804573679843;2802.8878844846286;2902.1438675590753;2909.8981535646258;2914.7522460590876;2854.728800763924;2870.354170311684;2872.3250036241466;2881.4381195666747;2891.0893068683404;2759.7378249066305;2805.9158225253277;2836.0215725574644;2839.985800071007;2844.36001899573;16666.250018749186;16959.660806783795;16981.405650802288;16996.83003169965;17034.48896533106;8266.13205613408;8526.914730852735;8534.829303413897;8557.572121393905;8598.87101693475;5387;5642.520385767215;5699.943000569982;5784.479396854261;5791.768329266824;1965.3710812539994;2001.1595130045416;2029.5027718209133;2074.6369385357652;2086.791320867916;30741.38517229643;30945.845270773727;30989.22526936822;31057.534136987964;31077;7271.200167981518;7396.260373962561;7402.185759566443;7614.466987310835;7636.274553917369;20245.08897099634;20358.592828143355;20369.08339124713;20378.573499855163;20381.878996655327;8356.832863342821;8651.394402391898;8663.436876603;8667.523286219192;8673;7775.339096176888;7877.133515313311;7920.960395197987;7939.20607939213;8017.839643207103;5615.634983726045;5726.398728133569;5741.684207368635;5746.367899531048;6003.369646187088;1638.1481629552566;1669.3322670931482;1688.0293831047197;1692.5937774933927;1702.6038648308268;940.0975063938558;971.9271054670786;977.413551868873;978.4765150644371;984.4733067808688;8611.612477438404;8674;8721.694740684172;8729.869051964226;8735.039145693969;784.835184611238;786.7993661616251;787.3976408047848;790.2768966395798;800.839832033584;5437.728113594305;5986.491148252448;6374.904376434357;6470.9029364559565;6516.7719129831175;24035.27894163178;24694.382640434134;24876.5024699505;25192.496150076895;25223.11719089823;24273;24626.014959401782;25264.115755948453;25367;25544.48911021769;12445.875541244472;12468.75062498745;12557.748845023048;12568.245905245532;12571.434285457359;9632.373895696757;9929.205663546754;9997.600095996078;10002.049805268487;10007.949960250153;20805.271815486387;21072.578548429254;21523.677144843154;21886;22218;22408;22498;22667.433314167276;22760.20339288117;22943;12312.630621081382;12532;12541.435635396247;12546.623601291976;12625.621231363073;15388.461403850812;15606.609834754221;15611.063336199864;15615.45345912933;15654.982426142264;12580.811287830873;13170.80243796363;13270.933645331712;13357.933210333886;13414.262215578237;12503;12655.81016284738;12809.359532023547;12944.676383090498;12979.480820767063;10946.945265273622;11039.172062095535;11058.778824423305;11089.556417743523;11176.88823111791;8376.623051962555;8422.747317580483;8458.957705211435;8576.485410875368;8584.055753866945;8307.37694672914;8409.285210757154;8441;8476.660933562589;8494.235518803338 07:55:33 INFO - PID 20047 | |4;prototype.html;545.3946119807011;559.3092530724556;579.6695883346495;581.244382303006;587.3861814403947;5929.288485381755;6178.845528861781;6259.777778888497;6262.467690246334;6337.7464901404;6187.721552530135;6231.439170474657;6242.438180563749;6293.402126797958;6300.842478938029;4945.134601444751;5019.196928491442;5025.824096156635;5050.696958182502;5091.548908561061;4875.951240487603;4905.3132561441425;4973.229149481836;5044.092063428581;5050.873728156789;5016.949830501685;5021.096202683516;5033.622478314122;5040.319556859814;5055.51972562606;4934.777934992934;4960.875978100558;4970.279309500138;4973.229149481836;4983.825566105169;4544.045750392422;4554.8861278467975;4572.085582883404;4592.494825569184;4607;6197.628142311476;6205.565610407273;6258.780942666985;6261.342559031282;6301.243850737895;5843.5325173985975;5886.970565147147;5900.321463031763;5900.586958912878;5932.9406705932815;6592.318958665557;6617.239017512999;6630.535862489628;6632;6637.93362066378;4894.510548945077;5084.77118529667;5111.718855462948;5117;5128.102582048126;6816.897746533806;6839.62382068986;6920;6962.512624116314;7026.789196324118;5169.121249387613;5190.870228244324;5230.8169214077325;5236.24074509194;5239.170847742253;5261.842144735664;5268.762905669254;5320.042392369411;5324.946750532523;5351.892962140735;5851.882962340815;5889.1755154278435;5917.881642367129;5928.229330187048;5939.227900372924;6686.531942764057;6736.528443008942;6758.797236082925;6761.937609029195;6766.785776756002;1808.8281613246984;1826.6803309421064;1826.8721189516607;1828.8994105324334;1840.8435283000827;1230.73539189073;1289.258676261135;1291.4124073546514;1300.9609711708663;1323.7948118041718;6207.630399704223;6298.401651843067;6317.15598162576;6317.873642527124;6348.77779277723;6513.837154071186;6560.442362399154;6645.235797883305;6748.527603067836;6806.685726852894;6135.846603834851;6155.230596175478;6172.444479996821;6187.597806142587;6219.533534984895;3494.6155922848466;3499.685028347461;3510.5611798525183;3552.928941421157;3554.306910152495;6783.9145736682885;6786.337347349832;6896;6983.441324694012;7025;6780.965710286894;6822.965885170642;6917.9308206918295;6922.411595014481;6970.163580370287;6654.404782134971;6811.863762724817;6877.931220687729;6916;6929.965350173317;6531.314212007671;6653.866922661423;6656.434203092791;6661.4004739573675;6664.66676666155;6368.872622547616;6627.801165965029;6638.90041649366;6663.133792607124;6677.465802735673;6835;6892.724291028303;6947.166340039228;6970.477214209056;6994.720211191496;5187.144121219956;5195.29863468442;5207.973960130326;5229.346331708536;5235.3717553893775;6613.702383392662;6839.179298484214;6847.246802851582;6866.463771157957;6872.518923675295;6289.811305660837;6609.3060228675295;6609.834754131185;6636.13730215069;6638.933610664025;6515.706793194223;6568.259411256116;6590.604563726191;6611.966940165268;6622.768203113061;6285;6401.199850018747;6446.677666116581;6487.54587178893;6517;6578;6599.373059559526;6628.204615446178;6640.50196235294;6703.698333574904;6351.91931913031;6401.711922963571;6497.31778163305;6517.934820651923;6543.803685889431 07:55:33 INFO - PID 20047 | |5;yui.html;953.8616900549421;956.2588993530018;989.7674046599047;990.5988074829692;1006.4866917871885;18662.346817861377;19042.714359284604;19063.332783352584;19111.71332430013;19240.71138932917;17072.231749571267;17239.224234909427;17258.741118883227;17453.82546174541;17774.822251777478;969.2391472693954;1049.2393015064056;1052.936823790575;1053.7839742852698;1054.1198099586816;1053.1785207538132;1076.9892301077007;1077.5043479999172;1082.096449464694;1082.8917108289147;1059.9311044782103;1091.9617813376533;1127.6842484104423;1128.7121783945083;1130.1749722702432;1106.8837772033942;1122.141561705296;1124.0108704340128;1124.5333186727498;1124.5951457475344;807.0839597057383;818.7625588579305;820.7948012996751;825.3273582030625;830.1283652165263;17158.39945601898;17610.559736006573;17612.647747045117;17692.203850826743;17730.468085957444;22877.77122228773;22901.862013133064;23231.535369292687;23738.525229495313;23768.524629507487;18860.245590176375;18933.90533047326;18956.43130706081;19023.809761902343;19103.140358683893;3981.725847728728;3997.6801855851754;4012.879613611596;4019.658329042035;4024.8993775155564;156266;156432.21783891122;156997.99999999886;158423;159545.20227398904;17278.827211727974;17498.475045748648;17848.286068557114;18020.36928707515;18061.819381806275;32728.67271327256;33345.49981750276;33442.49836252458;33454;33580.83209583937;8292.37807164465;8298.419110662317;8342.83314333722;8372.916270837335;8417.158284171657;4395.912081758411;4433.179861725591;4460.464744230648;4461.174682683714;4467.329900514948;6183.350748171467;6200.56596038273;6275.02737075754;6282.717277722513;6287.811365659038;1035.694470131313;1068.3643232276784;1079.7840431913648;1090.8036553420302;1090.8309212072143;744.5235049568281;751.9097708274933;755.7090520149673;764.8279137194198;767.3439209475929;12376.566820161252;12543.93728031354;12635.684107897192;13055.804162937564;13307.135036222615;733.6625152429942;740.7777666699968;746.555799299416;755.0486387152228;764.9940328468047;6135.84660383494;6198.0702894565275;6213.968930155411;6243.719032643542;6317.4946004319545;146694;150121;152029;152715;154476;92585;123013.38493307655;126970;129258.4278650747;131541;112010.43994779974;112016;112693;113886;114718;14283.214423206824;14583.489577864724;14842.40630374773;14932.328045237773;15309;54163.45836541584;55108.34674959758;56290.718546407006;57131;57556.71221643865;72220;73579;73694.26305736873;73935.63032184805;75907.62046189954;18585;18986.24055037838;19023.33418330352;19262.13320400557;19538.706919395936;21130.044843049327;21597.46006349854;21945.561088777817;22049.33851984443;22121.44696382539;21251.362459126252;21298.467538311666;21328.680069799277;21497.355079347646;21550.353489395344;20481.89759051195;21094.78905210928;21266.25568105109;21340.57318853645;21444.892775536024;19170.137343819282;19196.520086997378;19512.121954511797;19517.21931122796;19599.902000489907;14924.62688432798;15258.694826103638;15292.694146116793;15342.30959606798;15422;15124.848751512343;15549.533513994598;15650.9217453912;15662.530124096294;15760 07:55:33 INFO - PID 20047 | __end_tp_report 07:55:33 INFO - PID 20047 | __start_cc_report 07:55:33 INFO - PID 20047 | _x_x_mozilla_cycle_collect,269 07:55:33 INFO - PID 20047 | __end_cc_report 07:55:33 INFO - PID 20047 | __startTimestamp1506005733506__endTimestamp 07:55:33 INFO - PID 20047 | 07:55:33 INFO - PID 20047 | ------- Summary: start ------- 07:55:33 INFO - PID 20047 | Number of tests: 6 07:55:33 INFO - PID 20047 | 07:55:33 INFO - PID 20047 | [#0] dojo.html Cycles:165 Average:6339.96 Median:6589.87 stddev:755.55 (11.5%) stddev-sans-first:732.33 07:55:33 INFO - PID 20047 | Values: 3856.7 3873.8 3876.7 3884.8 3918.2 6301.4 6302.6 6340.8 6358.0 6385.5 6357.0 6396.4 6457.0 6504.1 6523.7 5726.7 5734.2 5740.8 5778.6 5781.8 5638.8 5704.1 5709.6 5745.5 5814.4 5741.1 5758.1 5764.2 5765.8 5779.2 5688.3 5828.1 5842.1 5853.2 5856.6 5673.0 5728.1 5818.0 5819.3 5825.4 6066.9 6155.1 6201.9 6276.6 6368.0 6817.3 6859.9 6870.6 6894.7 6894.7 6827.8 6893.3 6899.7 6915.4 6930.6 6405.2 6416.1 6477.5 6483.7 6484.4 7008.4 7086.6 7152.4 7171.5 7177.9 6685.5 6803.3 6804.2 6811.1 6843.9 6902.4 6911.6 6914.9 6917.3 6919.7 6803.9 6881.4 6936.8 6947.1 6951.1 6886.2 6896.6 6908.8 6997.8 6999.2 4863.4 4970.0 4971.4 5028.9 5034.1 4506.1 4524.3 4551.3 4559.4 4583.4 6216.4 6224.9 6290.8 6318.8 6432.5 6846.8 6862.1 6864.2 6961.5 6978.6 6222.2 6280.7 6320.1 6385.0 6385.7 5563.4 5578.9 5588.4 5589.9 5605.7 6983.0 7148.0 7156.1 7177.2 7179.6 6887.9 6897.9 6978.6 6980.3 6987.9 6939.2 7005.5 7009.0 7043.4 7044.0 6828.6 6834.7 6843.9 6860.6 6871.2 6859.8 6876.5 6954.2 6961.5 6984.8 6612.5 6641.9 6649.3 6732.4 6738.9 6484.8 6625.7 6628.0 6638.5 6644.9 6509.8 6518.5 6589.9 6600.6 6610.8 6775.8 6789.0 6814.6 6832.2 6834.5 6362.8 6506.1 6515.1 6529.1 6595.0 07:55:33 INFO - PID 20047 | 07:55:33 INFO - PID 20047 | [#1] ext.html Cycles:180 Average:41967.43 Median:19535.63 stddev:64334.14 (329.3%) stddev-sans-first:64440.87 07:55:33 INFO - PID 20047 | Values: 941.2 951.5 973.2 996.7 1003.5 41092.0 42478.8 42806.8 42858.4 42864.8 40773.2 40796.6 40942.6 41130.6 41259.2 7626.6 7738.2 7743.8 7744.2 7755.6 7723.0 7857.6 7862.9 7868.8 7872.1 8338.8 8597.7 8601.2 8602.1 8624.8 8502.0 8564.3 8571.2 8572.1 8576.7 8214.8 8383.5 8387.8 8430.1 8432.9 39178.2 39683.8 39713.0 39777.4 39791.4 3602.3 3647.5 3650.4 3653.8 3659.6 32618.5 32754.3 32760.7 32809.5 32820.0 5364.9 5364.9 5365.6 5367.6 5446.6 221719.0 221915.0 223731.0 223943.0 224293.0 50849.7 50963.5 51042.5 51114.5 51158.2 52885.7 53177.0 53239.7 53280.2 53438.0 15479.6 15804.9 15811.4 15905.1 15906.7 12696.3 12697.7 12705.1 12705.8 12735.7 14770.9 15018.8 15090.2 15244.2 15249.5 5939.4 6084.8 6097.9 6110.2 6110.9 1090.4 1101.4 1103.9 1104.4 1115.3 25434.4 25478.7 25499.6 25741.4 25797.4 1185.4 1188.1 1195.2 1198.0 1203.1 13104.7 13360.3 13437.5 13485.3 13527.2 281819.0 282740.0 283636.0 284271.0 284983.0 47714.5 48206.3 55044.0 55387.0 55481.7 1506.9 1511.3 1515.3 1525.6 1537.5 29018.9 29452.0 29951.1 30189.7 30344.5 39620.8 39920.8 40025.8 40026.2 40059.8 230374.0 230653.0 232750.0 232777.0 233063.0 33961.7 34910.3 35343.0 35373.3 35469.0 45796.0 45959.5 46096.1 46284.8 46339.1 33187.7 33433.5 34036.5 34305.8 34375.8 33392.3 33879.5 34195.5 34276.8 34325.5 38208.8 39972.0 40038.4 40087.2 40199.4 32643.7 32800.7 32823.7 32985.5 33460.8 24980.9 25061.0 25141.0 25148.6 25179.5 07:55:33 INFO - PID 20047 | 07:55:33 INFO - PID 20047 | [#2] jquery.html Cycles:180 Average:39975.86 Median:13058.52 stddev:100905.92 (772.7%) stddev-sans-first:101145.65 07:55:33 INFO - PID 20047 | Values: 587.3 603.1 603.9 606.4 635.5 22834.9 23783.4 23848.8 23903.6 23926.3 24473.0 26816.6 27063.2 27091.5 27169.2 6453.5 6507.9 6620.3 6630.4 6631.8 6419.4 6556.4 6807.9 6860.3 6891.1 6767.1 6846.7 6847.9 6848.1 6848.4 6440.3 6686.6 6736.8 6836.1 6868.0 6261.2 6285.0 6285.3 6286.6 6321.3 30699.0 30873.7 31043.8 31127.0 31140.0 2289.9 2327.3 2328.9 2333.0 2333.6 19687.7 21256.7 21483.5 21501.9 21536.1 2442.3 2475.4 2483.2 2498.6 2519.7 135442.0 144336.0 154870.0 159923.2 161048.0 15324.8 16148.6 16311.3 16335.5 16579.2 25454.0 25514.4 25522.9 25566.6 25627.2 9944.6 10048.8 10104.3 10161.5 10162.9 9041.3 9156.1 9167.4 9186.9 9219.3 9584.6 9716.2 9839.2 9877.9 10012.0 2843.9 2850.3 2859.9 2932.8 2958.9 1039.5 1053.0 1053.6 1055.0 1064.8 20730.0 21353.3 21599.9 21821.9 21953.0 1088.2 1094.0 1111.3 1114.7 1129.3 11574.3 11589.0 11687.2 11747.8 11853.7 590685.0 593359.0 594779.0 606938.0 629392.0 124240.0 126211.0 127832.4 129326.1 129601.0 1135.2 1173.7 1222.6 1227.0 1285.4 22812.4 23109.7 23223.5 23247.3 23284.5 65442.0 66095.0 66252.7 66939.3 67850.7 78241.6 80319.6 82797.0 82957.6 83874.0 15612.8 15679.8 15830.6 15942.1 16026.8 24829.4 25104.1 25203.4 25262.1 25378.6 19534.0 19541.6 20160.2 20270.1 20383.1 17743.2 17833.3 18145.6 18197.7 18520.5 20337.4 20452.3 20804.5 20806.2 20854.5 15510.8 15579.6 15735.7 15757.2 15796.0 19751.9 19814.3 19949.9 19981.6 20211.4 07:55:33 INFO - PID 20047 | 07:55:33 INFO - PID 20047 | [#3] mootools.html Cycles:180 Average:10602.89 Median:2820.97 stddev:7830.74 (277.6%) stddev-sans-first:7822.04 07:55:33 INFO - PID 20047 | Values: 1379.8 1436.3 1442.7 1448.7 1458.8 17028.2 17654.0 17660.7 17663.2 17672.3 17358.2 17477.0 17565.6 17588.6 17601.6 2837.9 2894.8 2942.0 2944.2 2944.3 2845.5 2884.8 2895.0 2896.2 2902.8 2791.8 2802.9 2902.1 2909.9 2914.8 2854.7 2870.4 2872.3 2881.4 2891.1 2759.7 2805.9 2836.0 2840.0 2844.4 16666.3 16959.7 16981.4 16996.8 17034.5 8266.1 8526.9 8534.8 8557.6 8598.9 5387.0 5642.5 5699.9 5784.5 5791.8 1965.4 2001.2 2029.5 2074.6 2086.8 30741.4 30945.8 30989.2 31057.5 31077.0 7271.2 7396.3 7402.2 7614.5 7636.3 20245.1 20358.6 20369.1 20378.6 20381.9 8356.8 8651.4 8663.4 8667.5 8673.0 7775.3 7877.1 7921.0 7939.2 8017.8 5615.6 5726.4 5741.7 5746.4 6003.4 1638.1 1669.3 1688.0 1692.6 1702.6 940.1 971.9 977.4 978.5 984.5 8611.6 8674.0 8721.7 8729.9 8735.0 784.8 786.8 787.4 790.3 800.8 5437.7 5986.5 6374.9 6470.9 6516.8 24035.3 24694.4 24876.5 25192.5 25223.1 24273.0 24626.0 25264.1 25367.0 25544.5 12445.9 12468.8 12557.7 12568.2 12571.4 9632.4 9929.2 9997.6 10002.0 10007.9 20805.3 21072.6 21523.7 21886.0 22218.0 22408.0 22498.0 22667.4 22760.2 22943.0 12312.6 12532.0 12541.4 12546.6 12625.6 15388.5 15606.6 15611.1 15615.5 15655.0 12580.8 13170.8 13270.9 13357.9 13414.3 12503.0 12655.8 12809.4 12944.7 12979.5 10946.9 11039.2 11058.8 11089.6 11176.9 8376.6 8422.7 8459.0 8576.5 8584.1 8307.4 8409.3 8441.0 8476.7 8494.2 07:55:33 INFO - PID 20047 | 07:55:33 INFO - PID 20047 | [#4] prototype.html Cycles:180 Average:5630.65 Median:6261.91 stddev:1564.50 (25.0%) stddev-sans-first:1521.62 07:55:33 INFO - PID 20047 | Values: 545.4 559.3 579.7 581.2 587.4 5929.3 6178.8 6259.8 6262.5 6337.7 6187.7 6231.4 6242.4 6293.4 6300.8 4945.1 5019.2 5025.8 5050.7 5091.5 4876.0 4905.3 4973.2 5044.1 5050.9 5016.9 5021.1 5033.6 5040.3 5055.5 4934.8 4960.9 4970.3 4973.2 4983.8 4544.0 4554.9 4572.1 4592.5 4607.0 6197.6 6205.6 6258.8 6261.3 6301.2 5843.5 5887.0 5900.3 5900.6 5932.9 6592.3 6617.2 6630.5 6632.0 6637.9 4894.5 5084.8 5111.7 5117.0 5128.1 6816.9 6839.6 6920.0 6962.5 7026.8 5169.1 5190.9 5230.8 5236.2 5239.2 5261.8 5268.8 5320.0 5324.9 5351.9 5851.9 5889.2 5917.9 5928.2 5939.2 6686.5 6736.5 6758.8 6761.9 6766.8 1808.8 1826.7 1826.9 1828.9 1840.8 1230.7 1289.3 1291.4 1301.0 1323.8 6207.6 6298.4 6317.2 6317.9 6348.8 6513.8 6560.4 6645.2 6748.5 6806.7 6135.8 6155.2 6172.4 6187.6 6219.5 3494.6 3499.7 3510.6 3552.9 3554.3 6783.9 6786.3 6896.0 6983.4 7025.0 6781.0 6823.0 6917.9 6922.4 6970.2 6654.4 6811.9 6877.9 6916.0 6930.0 6531.3 6653.9 6656.4 6661.4 6664.7 6368.9 6627.8 6638.9 6663.1 6677.5 6835.0 6892.7 6947.2 6970.5 6994.7 5187.1 5195.3 5208.0 5229.3 5235.4 6613.7 6839.2 6847.2 6866.5 6872.5 6289.8 6609.3 6609.8 6636.1 6638.9 6515.7 6568.3 6590.6 6612.0 6622.8 6285.0 6401.2 6446.7 6487.5 6517.0 6578.0 6599.4 6628.2 6640.5 6703.7 6351.9 6401.7 6497.3 6517.9 6543.8 07:55:33 INFO - PID 20047 | 07:55:33 INFO - PID 20047 | [#5] yui.html Cycles:180 Average:28299.46 Median:19140.93 stddev:41439.63 (216.5%) stddev-sans-first:41505.01 07:55:33 INFO - PID 20047 | Values: 953.9 956.3 989.8 990.6 1006.5 18662.3 19042.7 19063.3 19111.7 19240.7 17072.2 17239.2 17258.7 17453.8 17774.8 969.2 1049.2 1052.9 1053.8 1054.1 1053.2 1077.0 1077.5 1082.1 1082.9 1059.9 1092.0 1127.7 1128.7 1130.2 1106.9 1122.1 1124.0 1124.5 1124.6 807.1 818.8 820.8 825.3 830.1 17158.4 17610.6 17612.6 17692.2 17730.5 22877.8 22901.9 23231.5 23738.5 23768.5 18860.2 18933.9 18956.4 19023.8 19103.1 3981.7 3997.7 4012.9 4019.7 4024.9 156266.0 156432.2 156998.0 158423.0 159545.2 17278.8 17498.5 17848.3 18020.4 18061.8 32728.7 33345.5 33442.5 33454.0 33580.8 8292.4 8298.4 8342.8 8372.9 8417.2 4395.9 4433.2 4460.5 4461.2 4467.3 6183.4 6200.6 6275.0 6282.7 6287.8 1035.7 1068.4 1079.8 1090.8 1090.8 744.5 751.9 755.7 764.8 767.3 12376.6 12543.9 12635.7 13055.8 13307.1 733.7 740.8 746.6 755.0 765.0 6135.8 6198.1 6214.0 6243.7 6317.5 146694.0 150121.0 152029.0 152715.0 154476.0 92585.0 123013.4 126970.0 129258.4 131541.0 112010.4 112016.0 112693.0 113886.0 114718.0 14283.2 14583.5 14842.4 14932.3 15309.0 54163.5 55108.3 56290.7 57131.0 57556.7 72220.0 73579.0 73694.3 73935.6 75907.6 18585.0 18986.2 19023.3 19262.1 19538.7 21130.0 21597.5 21945.6 22049.3 22121.4 21251.4 21298.5 21328.7 21497.4 21550.4 20481.9 21094.8 21266.3 21340.6 21444.9 19170.1 19196.5 19512.1 19517.2 19599.9 14924.6 15258.7 15292.7 15342.3 15422.0 15124.8 15549.5 15650.9 15662.5 15760.0 07:55:33 INFO - PID 20047 | -------- Summary: end -------- 07:55:33 INFO - PID 20047 | 07:55:34 INFO - TEST-INFO | 20047: exit 0 07:55:34 INFO - TEST-OK | dromaeo_css | took 1109401ms 07:55:34 INFO - TEST-START | kraken 07:55:34 INFO - Initialising browser for kraken test... 07:55:34 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57871/getInfo.html -profile /tmp/tmp9fPsI1/profile 07:55:34 INFO - TEST-INFO | started process 20421 (/builds/slave/test/build/application/firefox/firefox http://localhost:57871/getInfo.html) 07:55:40 INFO - TEST-INFO | 20421: exit 0 07:55:40 INFO - Browser initialized. 07:55:40 INFO - Running cycle 1/1 for kraken test... 07:55:40 INFO - Using env: {'DISPLAY': ':0', 07:55:40 INFO - 'HOME': '/home/cltbld', 07:55:40 INFO - 'JSGC_DISABLE_POISONING': '1', 07:55:40 INFO - 'LANG': 'en_US.UTF-8', 07:55:40 INFO - 'LANGUAGE': 'en_US:en', 07:55:40 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 07:55:40 INFO - 'LOGNAME': 'cltbld', 07:55:40 INFO - 'MAIL': '/var/mail/cltbld', 07:55:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:55:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:55:40 INFO - 'MOZ_CRASHREPORTER': '1', 07:55:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:40 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 07:55:40 INFO - 'MOZ_NO_REMOTE': '1', 07:55:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:55:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:40 INFO - 'NO_EM_RESTART': '1', 07:55:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:40 INFO - 'PWD': '/builds/slave/test', 07:55:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:55:40 INFO - 'RUST_BACKTRACE': 'full', 07:55:40 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:55:40 INFO - 'SHELL': '/bin/bash', 07:55:40 INFO - 'SHLVL': '1', 07:55:40 INFO - 'TERM': 'linux', 07:55:40 INFO - 'TMOUT': '86400', 07:55:40 INFO - 'USER': 'cltbld', 07:55:40 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1506004126.566103-59274306', 07:55:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:40 INFO - '_': '/tools/buildbot/bin/python'} 07:55:40 INFO - TEST-INFO | started process 20661 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9fPsI1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:55:41 INFO - PID 20661 | 07:55:41 INFO - PID 20661 | (/builds/slave/test/build/application/firefox/firefox:20712): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:55:41 INFO - PID 20661 | 07:55:51 INFO - PID 20661 | RSS: Main: 147128320 07:55:51 INFO - PID 20661 | 07:55:53 INFO - PID 20661 | Cycle 1(1): loaded http://localhost:57871/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57871/tests/kraken/driver.html?testName=audio-beat-detection) 07:55:54 INFO - PID 20661 | RSS: Main: 152453120 07:55:54 INFO - PID 20661 | 07:55:57 INFO - PID 20661 | Cycle 1(1): loaded http://localhost:57871/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57871/tests/kraken/driver.html?testName=audio-dft) 07:55:57 INFO - PID 20661 | RSS: Main: 152911872 07:55:57 INFO - PID 20661 | 07:56:00 INFO - PID 20661 | Cycle 1(1): loaded http://localhost:57871/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57871/tests/kraken/driver.html?testName=audio-fft) 07:56:01 INFO - PID 20661 | RSS: Main: 149565440 07:56:01 INFO - PID 20661 | 07:56:03 INFO - PID 20661 | Cycle 1(1): loaded http://localhost:57871/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57871/tests/kraken/driver.html?testName=audio-oscillator) 07:56:04 INFO - PID 20661 | RSS: Main: 150667264 07:56:04 INFO - PID 20661 | 07:56:06 INFO - PID 20661 | Cycle 1(1): loaded http://localhost:57871/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57871/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:56:06 INFO - PID 20661 | RSS: Main: 150507520 07:56:06 INFO - PID 20661 | 07:56:09 INFO - PID 20661 | Cycle 1(1): loaded http://localhost:57871/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57871/tests/kraken/driver.html?testName=imaging-darkroom) 07:56:10 INFO - PID 20661 | RSS: Main: 150364160 07:56:10 INFO - PID 20661 | 07:56:14 INFO - PID 20661 | Cycle 1(1): loaded http://localhost:57871/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57871/tests/kraken/driver.html?testName=imaging-desaturate) 07:56:14 INFO - PID 20661 | RSS: Main: 151678976 07:56:14 INFO - PID 20661 | 07:56:17 INFO - PID 20661 | Cycle 1(1): loaded http://localhost:57871/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57871/tests/kraken/driver.html?testName=json-parse-financial) 07:56:18 INFO - PID 20661 | RSS: Main: 153870336 07:56:18 INFO - PID 20661 | 07:56:19 INFO - PID 20661 | Cycle 1(1): loaded http://localhost:57871/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57871/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:56:20 INFO - PID 20661 | RSS: Main: 153427968 07:56:20 INFO - PID 20661 | 07:56:21 INFO - PID 20661 | Cycle 1(1): loaded http://localhost:57871/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57871/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:56:22 INFO - PID 20661 | RSS: Main: 153464832 07:56:22 INFO - PID 20661 | 07:56:24 INFO - PID 20661 | Cycle 1(1): loaded http://localhost:57871/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57871/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:56:25 INFO - PID 20661 | RSS: Main: 150355968 07:56:25 INFO - PID 20661 | 07:56:27 INFO - PID 20661 | Cycle 1(1): loaded http://localhost:57871/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57871/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:56:28 INFO - PID 20661 | RSS: Main: 150228992 07:56:28 INFO - PID 20661 | 07:56:30 INFO - PID 20661 | Cycle 1(1): loaded http://localhost:57871/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57871/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:56:31 INFO - PID 20661 | RSS: Main: 150908928 07:56:31 INFO - PID 20661 | 07:56:33 INFO - PID 20661 | Cycle 1(1): loaded http://localhost:57871/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57871/tests/kraken/driver.html?testName=ai-astar) 07:56:33 INFO - PID 20661 | RSS: Main: 152743936 07:56:33 INFO - PID 20661 | 07:56:33 INFO - PID 20661 | __start_tp_report 07:56:33 INFO - PID 20661 | _x_x_mozilla_page_load 07:56:33 INFO - PID 20661 | _x_x_mozilla_page_load_details 07:56:33 INFO - PID 20661 | |i|pagename|runs| 07:56:33 INFO - PID 20661 | |0;ai-astar;106;105;105;108;106;109;106;105;105;103 07:56:33 INFO - PID 20661 | |1;audio-beat-detection;114;113;123;113;117;115;112;117;139;115 07:56:33 INFO - PID 20661 | |2;audio-dft;162;162;162;162;162;163;162;162;167;166 07:56:33 INFO - PID 20661 | |3;audio-fft;74;73;78;74;72;81;82;74;73;75 07:56:33 INFO - PID 20661 | |4;audio-oscillator;78;79;77;78;78;78;77;79;77;80 07:56:33 INFO - PID 20661 | |5;imaging-gaussian-blur;111;113;113;114;114;110;114;114;114;114 07:56:33 INFO - PID 20661 | |6;imaging-darkroom;149;148;151;150;150;149;150;149;150;149 07:56:33 INFO - PID 20661 | |7;imaging-desaturate;94;94;94;94;96;99;94;94;94;94 07:56:33 INFO - PID 20661 | |8;json-parse-financial;43;44;45;46;46;45;44;47;44;45 07:56:33 INFO - PID 20661 | |9;json-stringify-tinderbox;37;38;37;38;38;37;38;38;37;38 07:56:33 INFO - PID 20661 | |10;stanford-crypto-aes;72;73;70;71;73;71;71;70;70;72 07:56:33 INFO - PID 20661 | |11;stanford-crypto-ccm;116;108;109;109;108;110;107;106;114;117 07:56:33 INFO - PID 20661 | |12;stanford-crypto-pbkdf2;156;152;154;149;162;149;152;158;156;152 07:56:33 INFO - PID 20661 | |13;stanford-crypto-sha256-iterative;61;60;60;59;60;61;58;64;60;62 07:56:33 INFO - PID 20661 | __end_tp_report 07:56:33 INFO - PID 20661 | __start_cc_report 07:56:33 INFO - PID 20661 | _x_x_mozilla_cycle_collect,727 07:56:33 INFO - PID 20661 | __end_cc_report 07:56:33 INFO - PID 20661 | __startTimestamp1506005793523__endTimestamp 07:56:33 INFO - PID 20661 | 07:56:33 INFO - PID 20661 | ------- Summary: start ------- 07:56:33 INFO - PID 20661 | Number of tests: 14 07:56:33 INFO - PID 20661 | 07:56:33 INFO - PID 20661 | [#0] ai-astar Cycles:10 Average:105.80 Median:106.00 stddev:1.69 (1.6%) stddev-sans-first:1.79 07:56:33 INFO - PID 20661 | Values: 106.0 105.0 105.0 108.0 106.0 109.0 106.0 105.0 105.0 103.0 07:56:33 INFO - PID 20661 | 07:56:33 INFO - PID 20661 | [#1] audio-beat-detection Cycles:10 Average:117.80 Median:116.00 stddev:8.08 (7.0%) stddev-sans-first:8.45 07:56:33 INFO - PID 20661 | Values: 114.0 113.0 123.0 113.0 117.0 115.0 112.0 117.0 139.0 115.0 07:56:33 INFO - PID 20661 | 07:56:33 INFO - PID 20661 | [#2] audio-dft Cycles:10 Average:163.00 Median:162.00 stddev:1.89 (1.2%) stddev-sans-first:1.96 07:56:33 INFO - PID 20661 | Values: 162.0 162.0 162.0 162.0 162.0 163.0 162.0 162.0 167.0 166.0 07:56:33 INFO - PID 20661 | 07:56:33 INFO - PID 20661 | [#3] audio-fft Cycles:10 Average:75.60 Median:74.50 stddev:3.50 (4.7%) stddev-sans-first:3.67 07:56:33 INFO - PID 20661 | Values: 74.0 73.0 78.0 74.0 72.0 81.0 82.0 74.0 73.0 75.0 07:56:33 INFO - PID 20661 | 07:56:33 INFO - PID 20661 | [#4] audio-oscillator Cycles:10 Average:78.10 Median:78.00 stddev:0.99 (1.3%) stddev-sans-first:1.05 07:56:33 INFO - PID 20661 | Values: 78.0 79.0 77.0 78.0 78.0 78.0 77.0 79.0 77.0 80.0 07:56:33 INFO - PID 20661 | 07:56:33 INFO - PID 20661 | [#5] imaging-gaussian-blur Cycles:10 Average:113.10 Median:114.00 stddev:1.45 (1.3%) stddev-sans-first:1.32 07:56:33 INFO - PID 20661 | Values: 111.0 113.0 113.0 114.0 114.0 110.0 114.0 114.0 114.0 114.0 07:56:33 INFO - PID 20661 | 07:56:33 INFO - PID 20661 | [#6] imaging-darkroom Cycles:10 Average:149.50 Median:150.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 07:56:33 INFO - PID 20661 | Values: 149.0 148.0 151.0 150.0 150.0 149.0 150.0 149.0 150.0 149.0 07:56:33 INFO - PID 20661 | 07:56:33 INFO - PID 20661 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:94.00 stddev:1.64 (1.7%) stddev-sans-first:1.72 07:56:33 INFO - PID 20661 | Values: 94.0 94.0 94.0 94.0 96.0 99.0 94.0 94.0 94.0 94.0 07:56:33 INFO - PID 20661 | 07:56:33 INFO - PID 20661 | [#8] json-parse-financial Cycles:10 Average:44.90 Median:45.00 stddev:1.20 (2.7%) stddev-sans-first:1.05 07:56:33 INFO - PID 20661 | Values: 43.0 44.0 45.0 46.0 46.0 45.0 44.0 47.0 44.0 45.0 07:56:33 INFO - PID 20661 | 07:56:33 INFO - PID 20661 | [#9] json-stringify-tinderbox Cycles:10 Average:37.60 Median:38.00 stddev:0.52 (1.4%) stddev-sans-first:0.50 07:56:33 INFO - PID 20661 | Values: 37.0 38.0 37.0 38.0 38.0 37.0 38.0 38.0 37.0 38.0 07:56:33 INFO - PID 20661 | 07:56:33 INFO - PID 20661 | [#10] stanford-crypto-aes Cycles:10 Average:71.30 Median:71.50 stddev:1.16 (1.6%) stddev-sans-first:1.20 07:56:33 INFO - PID 20661 | Values: 72.0 73.0 70.0 71.0 73.0 71.0 71.0 70.0 70.0 72.0 07:56:33 INFO - PID 20661 | 07:56:33 INFO - PID 20661 | [#11] stanford-crypto-ccm Cycles:10 Average:110.40 Median:109.50 stddev:3.86 (3.5%) stddev-sans-first:3.53 07:56:33 INFO - PID 20661 | Values: 116.0 108.0 109.0 109.0 108.0 110.0 107.0 106.0 114.0 117.0 07:56:33 INFO - PID 20661 | 07:56:33 INFO - PID 20661 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.00 Median:155.00 stddev:4.08 (2.6%) stddev-sans-first:4.27 07:56:33 INFO - PID 20661 | Values: 156.0 152.0 154.0 149.0 162.0 149.0 152.0 158.0 156.0 152.0 07:56:33 INFO - PID 20661 | 07:56:33 INFO - PID 20661 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.50 Median:60.50 stddev:1.65 (2.7%) stddev-sans-first:1.74 07:56:33 INFO - PID 20661 | Values: 61.0 60.0 60.0 59.0 60.0 61.0 58.0 64.0 60.0 62.0 07:56:33 INFO - PID 20661 | -------- Summary: end -------- 07:56:33 INFO - PID 20661 | 07:56:34 INFO - PID 20661 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 07:56:34 INFO - TEST-INFO | 20661: exit 0 07:56:34 INFO - TEST-OK | kraken | took 60060ms 07:56:34 INFO - SUITE-END | took 1169s 07:56:34 INFO - Completed test suite (00:19:29) 07:56:34 INFO - javascript benchmark 07:56:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9113.537430341967, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3856.691464682826, 3873.7675739455635, 3876.7480113792585, 3884.7863367514774, 3918.196769662218, 6301.432871041606, 6302.590331628447, 6340.809775706736, 6358.0, 6385.489160867131, 6356.9682151589295, 6396.392342727433, 6456.967715161418, 6504.089427480157, 6523.739050437976, 5726.713664316789, 5734.168545560891, 5740.79907203248, 5778.566607504444, 5781.768729250825, 5638.802641907534, 5704.11586204137, 5709.571782116337, 5745.540356771448, 5814.418558144194, 5741.081426971686, 5758.136279558058, 5764.221830052952, 5765.769369225247, 5779.162021506879, 5688.260526131618, 5828.0966450200285, 5842.123681447774, 5853.180554722342, 5856.560757943129, 5673.035583950738, 5728.112142617901, 5817.970910145422, 5819.272590926134, 5825.417458254183, 6066.939330606681, 6155.107509411155, 6201.906971395432, 6276.558029450382, 6367.98112302034, 6817.250102488722, 6859.897101543481, 6870.587764734082, 6894.724211031553, 6894.724211031553, 6827.761028364033, 6893.276205998398, 6899.724011039552, 6915.377616014583, 6930.61881596512, 6405.231372235315, 6416.101745755598, 6477.514186436036, 6483.675816209171, 6484.383983521605, 7008.404285635676, 7086.574805511686, 7152.356287934111, 7171.497995140395, 7177.856442871113, 6685.465162786965, 6803.251642319341, 6804.183497980175, 6811.148606424197, 6843.931560684329, 6902.378785909192, 6911.550749201286, 6914.896276555855, 6917.273686262971, 6919.6540172991145, 6803.897941530881, 6881.41507971818, 6936.79189624312, 6947.131608548932, 6951.0616066830335, 6886.208086070166, 6896.551724137915, 6908.827279318058, 6997.790066298019, 6999.23008469068, 4863.440704319049, 4970.005998800254, 4971.37857767779, 5028.874278143076, 5034.0686972910125, 4506.053728717006, 4524.298733696282, 4551.340055691906, 4559.3844830948065, 4583.381243532147, 6216.378362163748, 6224.9377506224355, 6290.842728931813, 6318.842028949313, 6432.549721519449, 6846.7945961621235, 6862.107925969592, 6864.176298844171, 6961.477889158334, 6978.616176110261, 6222.222222222223, 6280.685965701697, 6320.146780184708, 6385.042243663488, 6385.712642931079, 5563.443655634485, 5578.86052848682, 5588.413216612278, 5589.888202235932, 5605.691686957175, 6983.022376867242, 7148.035015272975, 7156.069710937545, 7177.1746249182015, 7179.605121718356, 6887.862242755016, 6897.862042759217, 6978.581285122909, 6980.301969802979, 6987.9301206987275, 6939.201991771011, 7005.474589405713, 7008.983697363752, 7043.436525078084, 7044.0, 6828.556143850634, 6834.692438840165, 6843.863122737617, 6860.5540639858245, 6871.244163141951, 6859.794206173823, 6876.484263680144, 6954.165500140016, 6961.512694111364, 6984.79045628632, 6612.537122401386, 6641.900371494528, 6649.2685804562425, 6732.42774364165, 6738.932610674026, 6484.805455836333, 6625.734970601122, 6628.0, 6638.53530252897, 6644.867102657823, 6509.837254068497, 6518.511111666549, 6589.868202636017, 6600.570962887397, 6610.8016759497295, 6775.830604234933, 6788.9660551696925, 6814.591124532544, 6832.248452670103, 6834.453243740588, 6362.77730279438, 6506.089147519257, 6515.0553169791065, 6529.053287273224, 6595.043718660863], "value": 6288.068170610293, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [941.2093841173413, 951.4719330771419, 973.1971123822846, 996.6810620601406, 1003.5233264199511, 41092.0, 42478.787606061924, 42806.785966070165, 42858.35712464315, 42864.78567607157, 40773.18453630926, 40796.59203407965, 40942.59057409425, 41130.58869411305, 41259.174816503655, 7626.580538070418, 7738.187490313492, 7743.806404839896, 7744.225577442267, 7755.573443460607, 7722.961385193094, 7857.646405911748, 7862.882056769153, 7868.842623147533, 7872.055353357605, 8338.83322333553, 8597.699080532182, 8601.182887625666, 8602.053774084845, 8624.827503449927, 8501.95749021254, 8564.3148548116, 8571.185737354972, 8572.099929507405, 8576.69981550649, 8214.83570328596, 8383.45507542014, 8387.790305242417, 8430.072692003874, 8432.915670843275, 39178.21643567141, 39683.80158099191, 39713.0, 39777.40333894994, 39791.40312895309, 3602.261536385061, 3647.452882067711, 3650.4159334506617, 3653.8173091345593, 3659.5608526976666, 32618.510722339182, 32754.344913101606, 32760.672393276, 32809.50785738216, 32820.0, 5364.892702145935, 5364.892702145974, 5365.624406291561, 5367.597430192751, 5446.645968012106, 221719.0, 221915.0, 223730.99999999837, 223943.0, 224293.0, 50849.745751271745, 50963.490365096615, 51042.48957510378, 51114.488855110976, 51158.23262651063, 52885.735571322664, 53177.0, 53239.733801330745, 53280.20079698808, 53438.0, 15479.613009674847, 15804.920975395049, 15811.367545298059, 15905.125218113115, 15906.68186636284, 12696.301703406216, 12697.746045079046, 12705.110642255138, 12705.809412858815, 12735.745285094432, 14770.852291476947, 15018.849811501963, 15090.17004064787, 15244.161571113473, 15249.466268680542, 5939.4357536034, 6084.847878803065, 6097.908531372033, 6110.236220472441, 6110.877782444326, 1090.3621381491757, 1101.4492753623188, 1103.8730545987314, 1104.4201794058024, 1115.314081839679, 25434.364140896625, 25478.745212547637, 25499.617505737428, 25741.3564660885, 25797.35506612312, 1185.3539820797687, 1188.0792385900822, 1195.1693572966706, 1197.9640610781692, 1203.1096988228649, 13104.737905241842, 13360.33198340079, 13437.529686460926, 13485.258310793, 13527.188368697909, 281819.0, 282740.0, 283636.0, 284271.0, 284983.0, 47714.522854771705, 48206.27690584644, 55044.0, 55387.0, 55481.722591387595, 1506.9246537673073, 1511.2594828534159, 1515.280241885118, 1525.6033431307717, 1537.5079974408306, 29018.854905725337, 29452.0, 29951.101466956025, 30189.698103019567, 30344.54483182798, 39620.801895990335, 39920.800395998995, 40025.79987100046, 40026.1994760109, 40059.79970100248, 230374.0, 230653.0, 232750.0, 232777.0, 233063.0, 33961.66038339684, 34910.301793964485, 35343.0, 35373.29253414969, 35469.0, 45796.0, 45959.54040459553, 46096.07807843891, 46284.7685761569, 46339.073218534766, 33187.66812331846, 33433.49849752207, 34036.48945265872, 34305.82847085749, 34375.82812085924, 33392.33215335728, 33879.491807623395, 34195.48706769351, 34276.828615856764, 34325.485117722754, 38208.808955956156, 39972.0, 40038.39942400924, 40087.1982560353, 40199.3970090443, 32643.673563264063, 32800.671993279764, 32823.67176328206, 32985.505217421276, 33460.83269583636, 24980.875095624404, 25061.0, 25141.0, 25148.62277065882, 25179.49641007133], "value": 18342.05592749945, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.2659176029961, 603.1104121420905, 603.8701679138984, 606.420868070992, 635.4947816485894, 22834.88582557087, 23783.405414864636, 23848.76151238487, 23903.641445378333, 23926.28221153364, 24473.0, 26816.5977510337, 27063.18810435685, 27091.458170836573, 27169.18492445225, 6453.548251622388, 6507.9023814642815, 6620.271770105284, 6630.403263706289, 6631.801045968628, 6419.35806419359, 6556.442702370305, 6807.897881531781, 6860.34826691466, 6891.1041564596535, 6767.052612634235, 6846.6576671166495, 6847.897281540781, 6848.14398200225, 6848.417884479801, 6440.291567927501, 6686.632235227061, 6736.797896063126, 6836.077129587492, 6867.965660171692, 6261.186045814061, 6284.968575157095, 6285.2771931228035, 6286.559940804145, 6321.273053598803, 30699.0, 30873.691263087305, 31043.844780776177, 31127.0, 31140.0, 2289.885505724707, 2327.325075728037, 2328.906843726249, 2332.976670233293, 2333.6382860656627, 19687.704684429744, 21256.681149782766, 21483.462913427134, 21501.892490537448, 21536.138554457804, 2442.3405680466353, 2475.3811547113223, 2483.1557270528106, 2498.5877330240487, 2519.748025197484, 135442.0, 144336.0, 154870.0, 159923.2003839985, 161048.0, 15324.770128448083, 16148.596285092966, 16311.265993030342, 16335.509934701979, 16579.17104144788, 25454.0, 25514.362140946254, 25522.872385637955, 25566.616500752505, 25627.231183064538, 9944.602215911282, 10048.79902401948, 10104.343217690974, 10161.4919254037, 10162.898371016343, 9041.321900857462, 9156.130167634064, 9167.404118732262, 9186.908130918739, 9219.262459003263, 9584.616615335308, 9716.174125199295, 9839.195829188648, 9877.901220987842, 10012.0, 2843.886244550195, 2850.3016760893715, 2859.8856045758353, 2932.8093673911126, 2958.949572901632, 1039.5270152080784, 1052.957881684724, 1053.5943661690305, 1054.9736256593646, 1064.7604289034905, 20730.0, 21353.25263615766, 21599.892000539898, 21821.890890545445, 21953.0, 1088.1675518228562, 1093.9935259561223, 1111.2665640677114, 1114.6934592986993, 1129.316763358173, 11574.305541667527, 11589.014933730727, 11687.240329378563, 11747.765044699057, 11853.703657408461, 590685.0, 593359.0, 594779.0, 606938.0, 629392.0, 124240.0, 126211.0, 127832.3608381952, 129326.06010909844, 129601.0, 1135.2053562506278, 1173.747644256489, 1222.6087651951468, 1226.9877301227052, 1285.3637449462576, 22812.42968925724, 23109.65335519935, 23223.535529289657, 23247.3025809226, 23284.53430931406, 65442.0, 66095.0, 66252.66873665794, 66939.33060669331, 67850.66074669595, 78241.60879195567, 80319.59840200761, 82797.0, 82957.58521207355, 83874.0, 15612.765808512655, 15679.843201568294, 15830.60423489422, 15942.123183225034, 16026.839731602535, 24829.379265518506, 25104.12135575246, 25203.36991575152, 25262.115825946003, 25378.619320709833, 19534.0, 19541.60916781685, 20160.193592256146, 20270.087846046667, 20383.08276127548, 17743.201555929754, 17833.286668533114, 18145.637087257917, 18197.727034094234, 18520.536986575444, 20337.389878303675, 20452.284170053976, 20804.479888002315, 20806.167753290305, 20854.478638034172, 15510.767338489706, 15579.610509737347, 15735.68528629444, 15757.212139393214, 15796.0, 19751.901240493706, 19814.306499272458, 19949.900250498653, 19981.60036799285, 20211.393658190278], "value": 12896.417916709937, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1379.8206233189687, 1436.2531483628507, 1442.7475191841424, 1448.7175000874831, 1458.8249410070794, 17028.233729482174, 17653.999999999985, 17660.735088973644, 17663.205155767988, 17672.29310827567, 17358.21888015039, 17477.0, 17565.560860978483, 17588.64822703545, 17601.55996100098, 2837.8581070946475, 2894.768418526513, 2942.0, 2944.175630823373, 2944.263934016496, 2845.4593627210866, 2884.8124871883365, 2895.030164894763, 2896.174590241771, 2902.7532659723947, 2791.804573679843, 2802.8878844846286, 2902.1438675590753, 2909.8981535646258, 2914.7522460590876, 2854.728800763924, 2870.354170311684, 2872.3250036241466, 2881.4381195666747, 2891.0893068683404, 2759.7378249066305, 2805.9158225253277, 2836.0215725574644, 2839.985800071007, 2844.36001899573, 16666.250018749186, 16959.660806783795, 16981.405650802288, 16996.83003169965, 17034.48896533106, 8266.13205613408, 8526.914730852735, 8534.829303413897, 8557.572121393905, 8598.87101693475, 5387.0, 5642.520385767215, 5699.943000569982, 5784.479396854261, 5791.768329266824, 1965.3710812539994, 2001.1595130045416, 2029.5027718209133, 2074.6369385357652, 2086.791320867916, 30741.38517229643, 30945.845270773727, 30989.22526936822, 31057.534136987964, 31077.0, 7271.200167981518, 7396.260373962561, 7402.185759566443, 7614.466987310835, 7636.274553917369, 20245.08897099634, 20358.592828143355, 20369.08339124713, 20378.573499855163, 20381.878996655327, 8356.832863342821, 8651.394402391898, 8663.436876603, 8667.523286219192, 8673.0, 7775.339096176888, 7877.133515313311, 7920.960395197987, 7939.20607939213, 8017.839643207103, 5615.634983726045, 5726.398728133569, 5741.684207368635, 5746.367899531048, 6003.369646187088, 1638.1481629552566, 1669.3322670931482, 1688.0293831047197, 1692.5937774933927, 1702.6038648308268, 940.0975063938558, 971.9271054670786, 977.413551868873, 978.4765150644371, 984.4733067808688, 8611.612477438404, 8674.0, 8721.694740684172, 8729.869051964226, 8735.039145693969, 784.835184611238, 786.7993661616251, 787.3976408047848, 790.2768966395798, 800.839832033584, 5437.728113594305, 5986.491148252448, 6374.904376434357, 6470.9029364559565, 6516.7719129831175, 24035.27894163178, 24694.382640434134, 24876.5024699505, 25192.496150076895, 25223.11719089823, 24273.0, 24626.014959401782, 25264.115755948453, 25367.0, 25544.48911021769, 12445.875541244472, 12468.75062498745, 12557.748845023048, 12568.245905245532, 12571.434285457359, 9632.373895696757, 9929.205663546754, 9997.600095996078, 10002.049805268487, 10007.949960250153, 20805.271815486387, 21072.578548429254, 21523.677144843154, 21886.0, 22218.0, 22408.0, 22498.0, 22667.433314167276, 22760.20339288117, 22943.0, 12312.630621081382, 12532.0, 12541.435635396247, 12546.623601291976, 12625.621231363073, 15388.461403850812, 15606.609834754221, 15611.063336199864, 15615.45345912933, 15654.982426142264, 12580.811287830873, 13170.80243796363, 13270.933645331712, 13357.933210333886, 13414.262215578237, 12503.0, 12655.81016284738, 12809.359532023547, 12944.676383090498, 12979.480820767063, 10946.945265273622, 11039.172062095535, 11058.778824423305, 11089.556417743523, 11176.88823111791, 8376.623051962555, 8422.747317580483, 8458.957705211435, 8576.485410875368, 8584.055753866945, 8307.37694672914, 8409.285210757154, 8441.0, 8476.660933562589, 8494.235518803338], "value": 7377.702150126363, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.3946119807011, 559.3092530724556, 579.6695883346495, 581.244382303006, 587.3861814403947, 5929.288485381755, 6178.845528861781, 6259.777778888497, 6262.467690246334, 6337.7464901404, 6187.721552530135, 6231.439170474657, 6242.438180563749, 6293.402126797958, 6300.842478938029, 4945.134601444751, 5019.196928491442, 5025.824096156635, 5050.696958182502, 5091.548908561061, 4875.951240487603, 4905.3132561441425, 4973.229149481836, 5044.092063428581, 5050.873728156789, 5016.949830501685, 5021.096202683516, 5033.622478314122, 5040.319556859814, 5055.51972562606, 4934.777934992934, 4960.875978100558, 4970.279309500138, 4973.229149481836, 4983.825566105169, 4544.045750392422, 4554.8861278467975, 4572.085582883404, 4592.494825569184, 4607.0, 6197.628142311476, 6205.565610407273, 6258.780942666985, 6261.342559031282, 6301.243850737895, 5843.5325173985975, 5886.970565147147, 5900.321463031763, 5900.586958912878, 5932.9406705932815, 6592.318958665557, 6617.239017512999, 6630.535862489628, 6632.0, 6637.93362066378, 4894.510548945077, 5084.77118529667, 5111.718855462948, 5117.0, 5128.102582048126, 6816.897746533806, 6839.62382068986, 6920.0, 6962.512624116314, 7026.789196324118, 5169.121249387613, 5190.870228244324, 5230.8169214077325, 5236.24074509194, 5239.170847742253, 5261.842144735664, 5268.762905669254, 5320.042392369411, 5324.946750532523, 5351.892962140735, 5851.882962340815, 5889.1755154278435, 5917.881642367129, 5928.229330187048, 5939.227900372924, 6686.531942764057, 6736.528443008942, 6758.797236082925, 6761.937609029195, 6766.785776756002, 1808.8281613246984, 1826.6803309421064, 1826.8721189516607, 1828.8994105324334, 1840.8435283000827, 1230.73539189073, 1289.258676261135, 1291.4124073546514, 1300.9609711708663, 1323.7948118041718, 6207.630399704223, 6298.401651843067, 6317.15598162576, 6317.873642527124, 6348.77779277723, 6513.837154071186, 6560.442362399154, 6645.235797883305, 6748.527603067836, 6806.685726852894, 6135.846603834851, 6155.230596175478, 6172.444479996821, 6187.597806142587, 6219.533534984895, 3494.6155922848466, 3499.685028347461, 3510.5611798525183, 3552.928941421157, 3554.306910152495, 6783.9145736682885, 6786.337347349832, 6896.0, 6983.441324694012, 7025.0, 6780.965710286894, 6822.965885170642, 6917.9308206918295, 6922.411595014481, 6970.163580370287, 6654.404782134971, 6811.863762724817, 6877.931220687729, 6916.0, 6929.965350173317, 6531.314212007671, 6653.866922661423, 6656.434203092791, 6661.4004739573675, 6664.66676666155, 6368.872622547616, 6627.801165965029, 6638.90041649366, 6663.133792607124, 6677.465802735673, 6835.0, 6892.724291028303, 6947.166340039228, 6970.477214209056, 6994.720211191496, 5187.144121219956, 5195.29863468442, 5207.973960130326, 5229.346331708536, 5235.3717553893775, 6613.702383392662, 6839.179298484214, 6847.246802851582, 6866.463771157957, 6872.518923675295, 6289.811305660837, 6609.3060228675295, 6609.834754131185, 6636.13730215069, 6638.933610664025, 6515.706793194223, 6568.259411256116, 6590.604563726191, 6611.966940165268, 6622.768203113061, 6285.0, 6401.199850018747, 6446.677666116581, 6487.54587178893, 6517.0, 6578.0, 6599.373059559526, 6628.204615446178, 6640.50196235294, 6703.698333574904, 6351.91931913031, 6401.711922963571, 6497.31778163305, 6517.934820651923, 6543.803685889431], "value": 5182.22534604874, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [953.8616900549421, 956.2588993530018, 989.7674046599047, 990.5988074829692, 1006.4866917871885, 18662.346817861377, 19042.714359284604, 19063.332783352584, 19111.71332430013, 19240.71138932917, 17072.231749571267, 17239.224234909427, 17258.741118883227, 17453.82546174541, 17774.822251777478, 969.2391472693954, 1049.2393015064056, 1052.936823790575, 1053.7839742852698, 1054.1198099586816, 1053.1785207538132, 1076.9892301077007, 1077.5043479999172, 1082.096449464694, 1082.8917108289147, 1059.9311044782103, 1091.9617813376533, 1127.6842484104423, 1128.7121783945083, 1130.1749722702432, 1106.8837772033942, 1122.141561705296, 1124.0108704340128, 1124.5333186727498, 1124.5951457475344, 807.0839597057383, 818.7625588579305, 820.7948012996751, 825.3273582030625, 830.1283652165263, 17158.39945601898, 17610.559736006573, 17612.647747045117, 17692.203850826743, 17730.468085957444, 22877.77122228773, 22901.862013133064, 23231.535369292687, 23738.525229495313, 23768.524629507487, 18860.245590176375, 18933.90533047326, 18956.43130706081, 19023.809761902343, 19103.140358683893, 3981.725847728728, 3997.6801855851754, 4012.879613611596, 4019.658329042035, 4024.8993775155564, 156266.0, 156432.21783891122, 156997.99999999886, 158423.0, 159545.20227398904, 17278.827211727974, 17498.475045748648, 17848.286068557114, 18020.36928707515, 18061.819381806275, 32728.67271327256, 33345.49981750276, 33442.49836252458, 33454.0, 33580.83209583937, 8292.37807164465, 8298.419110662317, 8342.83314333722, 8372.916270837335, 8417.158284171657, 4395.912081758411, 4433.179861725591, 4460.464744230648, 4461.174682683714, 4467.329900514948, 6183.350748171467, 6200.56596038273, 6275.02737075754, 6282.717277722513, 6287.811365659038, 1035.694470131313, 1068.3643232276784, 1079.7840431913648, 1090.8036553420302, 1090.8309212072143, 744.5235049568281, 751.9097708274933, 755.7090520149673, 764.8279137194198, 767.3439209475929, 12376.566820161252, 12543.93728031354, 12635.684107897192, 13055.804162937564, 13307.135036222615, 733.6625152429942, 740.7777666699968, 746.555799299416, 755.0486387152228, 764.9940328468047, 6135.84660383494, 6198.0702894565275, 6213.968930155411, 6243.719032643542, 6317.4946004319545, 146694.0, 150121.0, 152029.0, 152715.0, 154476.0, 92585.0, 123013.38493307655, 126970.0, 129258.4278650747, 131541.0, 112010.43994779974, 112016.0, 112693.0, 113886.0, 114718.0, 14283.214423206824, 14583.489577864724, 14842.40630374773, 14932.328045237773, 15309.0, 54163.45836541584, 55108.34674959758, 56290.718546407006, 57131.0, 57556.71221643865, 72220.0, 73579.0, 73694.26305736873, 73935.63032184805, 75907.62046189954, 18585.0, 18986.24055037838, 19023.33418330352, 19262.13320400557, 19538.706919395936, 21130.044843049327, 21597.46006349854, 21945.561088777817, 22049.33851984443, 22121.44696382539, 21251.362459126252, 21298.467538311666, 21328.680069799277, 21497.355079347646, 21550.353489395344, 20481.89759051195, 21094.78905210928, 21266.25568105109, 21340.57318853645, 21444.892775536024, 19170.137343819282, 19196.520086997378, 19512.121954511797, 19517.21931122796, 19599.902000489907, 14924.62688432798, 15258.694826103638, 15292.694146116793, 15342.30959606798, 15422.0, 15124.848751512343, 15549.533513994598, 15650.9217453912, 15662.530124096294, 15760.0], "value": 10074.50820515124, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1376.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 105.0, 105.0, 108.0, 106.0, 109.0, 106.0, 105.0, 105.0, 103.0], "value": 105.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 123.0, 113.0, 117.0, 115.0, 112.0, 117.0, 139.0, 115.0], "value": 117.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 162.0, 162.0, 163.0, 162.0, 162.0, 167.0, 166.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 78.0, 74.0, 72.0, 81.0, 82.0, 74.0, 73.0, 75.0], "value": 75.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 77.0, 78.0, 78.0, 78.0, 77.0, 79.0, 77.0, 80.0], "value": 78.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 113.0, 114.0, 114.0, 110.0, 114.0, 114.0, 114.0, 114.0], "value": 113.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 151.0, 150.0, 150.0, 149.0, 150.0, 149.0, 150.0, 149.0], "value": 149.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 96.0, 99.0, 94.0, 94.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [43.0, 44.0, 45.0, 46.0, 46.0, 45.0, 44.0, 47.0, 44.0, 45.0], "value": 44.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 38.0, 37.0, 38.0, 38.0, 37.0, 38.0, 38.0, 37.0, 38.0], "value": 37.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 70.0, 71.0, 73.0, 71.0, 71.0, 70.0, 70.0, 72.0], "value": 71.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 108.0, 109.0, 109.0, 108.0, 110.0, 107.0, 106.0, 114.0, 117.0], "value": 110.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 152.0, 154.0, 149.0, 162.0, 149.0, 152.0, 158.0, 156.0, 152.0], "value": 154.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 59.0, 60.0, 61.0, 58.0, 64.0, 60.0, 62.0], "value": 60.5, "unit": "score"}]}]} 07:56:34 INFO - Return code: 0 07:56:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:56:34 INFO - # TBPL SUCCESS # 07:56:34 INFO - Running post-action listener: _package_coverage_data 07:56:34 INFO - Running post-action listener: _resource_record_post_action 07:56:34 INFO - [mozharness: 2017-09-21 14:56:34.802064Z] Finished run-tests step (success) 07:56:34 INFO - Running post-run listener: _resource_record_post_run 07:56:34 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 334548992; Read time: 8; Write time: 316984 07:56:34 INFO - TinderboxPrint: CPU usage
13.1% 07:56:34 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 07:56:34 INFO - TinderboxPrint: I/O write bytes / time
334,548,992 / 316,984 07:56:34 INFO - TinderboxPrint: CPU idle
8,231.3 (86.9%) 07:56:34 INFO - TinderboxPrint: CPU user
1,188.0 (12.5%) 07:56:34 INFO - TinderboxPrint: Swap in / out
0 / 0 07:56:34 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13651968; Read time: 0; Write time: 3196 07:56:34 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 07:56:34 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 4096; Write bytes: 320491520; Read time: 8; Write time: 313748 07:56:35 INFO - Running post-run listener: _upload_blobber_files 07:56:35 INFO - Blob upload gear active. 07:56:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:56:35 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 07:56:35 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'] 07:56:35 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 07:56:35 INFO - (blobuploader) - INFO - Open directory for files ... 07:56:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:56:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:37 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:56:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:37 INFO - (blobuploader) - INFO - Done attempting. 07:56:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:56:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:56:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:44 INFO - (blobuploader) - INFO - Done attempting. 07:56:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:56:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:56:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:45 INFO - (blobuploader) - INFO - Done attempting. 07:56:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:56:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:56:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:46 INFO - (blobuploader) - INFO - Done attempting. 07:56:46 INFO - (blobuploader) - INFO - Iteration through files over. 07:56:46 INFO - Return code: 0 07:56:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:56:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:56:46 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2bc269fab3f937140e7bd087d621fcdc3c788bc41ba4bcaae636b4b79cd10bb00a0253f7a42fdab5ca7e302f3ef1598aa2a7aa09ca7c21153e29342e4507b4f4", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f24061e2e28365b2194406534572aa07773cfdc08eeef39d558a50578c1b40bd6ba15466dc6c0987b9431e82299e5f861a1c89cb602d114d5266cdaabf27d4e", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/16051911f2fd5c6150f38bb582dc4b59085b1cc2877374b030ab417b484a3292c1e409e8989f5940e11ce6a6467db6dcf6716477d53fc4db076c56b88ae47421", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a4707b5d84765b023f1f9ee29f51d9e0948d14e9661a4b37aa06b40c5af0fe6a7a9b28a9130f9612ed1a7dbc359a7acca59689f63ce17a683f4b68ee9a0c13a"} 07:56:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:56:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:56:46 INFO - Contents: 07:56:46 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2bc269fab3f937140e7bd087d621fcdc3c788bc41ba4bcaae636b4b79cd10bb00a0253f7a42fdab5ca7e302f3ef1598aa2a7aa09ca7c21153e29342e4507b4f4", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f24061e2e28365b2194406534572aa07773cfdc08eeef39d558a50578c1b40bd6ba15466dc6c0987b9431e82299e5f861a1c89cb602d114d5266cdaabf27d4e", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/16051911f2fd5c6150f38bb582dc4b59085b1cc2877374b030ab417b484a3292c1e409e8989f5940e11ce6a6467db6dcf6716477d53fc4db076c56b88ae47421", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a4707b5d84765b023f1f9ee29f51d9e0948d14e9661a4b37aa06b40c5af0fe6a7a9b28a9130f9612ed1a7dbc359a7acca59689f63ce17a683f4b68ee9a0c13a"} 07:56:46 INFO - Running post-run listener: copy_logs_to_upload_dir 07:56:46 INFO - Copying logs to upload dir... 07:56:46 INFO - mkdir: /builds/slave/test/build/upload/logs 07:56:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.064715 ========= master_lag: 0.83 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-09-21 07:56:46.591063) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-21 07:56:46.595940) ========= 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=df17445c3590ff7897617a0e00000225-1506004126.566103-59274306 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/2bc269fab3f937140e7bd087d621fcdc3c788bc41ba4bcaae636b4b79cd10bb00a0253f7a42fdab5ca7e302f3ef1598aa2a7aa09ca7c21153e29342e4507b4f4", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f24061e2e28365b2194406534572aa07773cfdc08eeef39d558a50578c1b40bd6ba15466dc6c0987b9431e82299e5f861a1c89cb602d114d5266cdaabf27d4e", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/16051911f2fd5c6150f38bb582dc4b59085b1cc2877374b030ab417b484a3292c1e409e8989f5940e11ce6a6467db6dcf6716477d53fc4db076c56b88ae47421", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a4707b5d84765b023f1f9ee29f51d9e0948d14e9661a4b37aa06b40c5af0fe6a7a9b28a9130f9612ed1a7dbc359a7acca59689f63ce17a683f4b68ee9a0c13a"} build_url:https://queue.taskcluster.net/v1/task/BMX2tL0PQCeX9uenZREPCQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011373 build_url: 'https://queue.taskcluster.net/v1/task/BMX2tL0PQCeX9uenZREPCQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2bc269fab3f937140e7bd087d621fcdc3c788bc41ba4bcaae636b4b79cd10bb00a0253f7a42fdab5ca7e302f3ef1598aa2a7aa09ca7c21153e29342e4507b4f4", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f24061e2e28365b2194406534572aa07773cfdc08eeef39d558a50578c1b40bd6ba15466dc6c0987b9431e82299e5f861a1c89cb602d114d5266cdaabf27d4e", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/16051911f2fd5c6150f38bb582dc4b59085b1cc2877374b030ab417b484a3292c1e409e8989f5940e11ce6a6467db6dcf6716477d53fc4db076c56b88ae47421", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a4707b5d84765b023f1f9ee29f51d9e0948d14e9661a4b37aa06b40c5af0fe6a7a9b28a9130f9612ed1a7dbc359a7acca59689f63ce17a683f4b68ee9a0c13a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-21 07:56:46.631208) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 07:56:46.631532) ========= 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=df17445c3590ff7897617a0e00000225-1506004126.566103-59274306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004619 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 07:56:46.710074) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-21 07:56:46.710356) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-21 07:56:46.713643) ========= ========= Total master_lag: 1.02 =========