builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-078 starttime: 1506594887.67 results: success (0) revision: 82c2eecf82ba820c4593aa4a9749662f7d54d9a7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-28 03:34:47.667024) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-28 03:34:47.667495) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-28 03:34:47.667768) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-28 03:34:47.684898) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 03:34:47.685273) ========= 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=dac658600622fd96716c9acf000001b3-1506594886.379905-261782927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-28 03:34:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 18.9M=0.001s 2017-09-28 03:34:47 (18.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118208 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 03:34:47.818389) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 03:34:47.818693) ========= 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=dac658600622fd96716c9acf000001b3-1506594886.379905-261782927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019436 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 03:34:47.870844) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 03:34:47.874205) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 82c2eecf82ba820c4593aa4a9749662f7d54d9a7 --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 82c2eecf82ba820c4593aa4a9749662f7d54d9a7 --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=dac658600622fd96716c9acf000001b3-1506594886.379905-261782927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-28 03:34:47,905 truncating revision to first 12 chars 2017-09-28 03:34:47,906 Setting DEBUG logging. 2017-09-28 03:34:47,906 attempt 1/10 2017-09-28 03:34:47,906 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/82c2eecf82ba?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-28 03:34:48,477 unpacking tar archive at: mozilla-central-82c2eecf82ba/testing/mozharness/ program finished with exit code 0 elapsedTime=0.857380 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 03:34:48.751005) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-28 03:34:48.751306) ========= script_repo_revision: 82c2eecf82ba820c4593aa4a9749662f7d54d9a7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-28 03:34:48.751691) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-28 03:34:48.751958) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-28 03:34:48.768527) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-09-28 03:34:48.768916) ========= /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=dac658600622fd96716c9acf000001b3-1506594886.379905-261782927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:34:48 INFO - MultiFileLogger online at 20170928 03:34:48 in /builds/slave/test 03:34:48 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 03:34:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:34:48 INFO - {'append_to_log': False, 03:34:48 INFO - 'base_work_dir': '/builds/slave/test', 03:34:48 INFO - 'blob_upload_branch': 'Firefox', 03:34:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:34:48 INFO - 'branch': 'Firefox', 03:34:48 INFO - 'buildbot_json_path': 'buildprops.json', 03:34:48 INFO - 'code_coverage': False, 03:34:48 INFO - 'config_files': ('talos/linux_config.py',), 03:34:48 INFO - 'default_actions': ('clobber', 03:34:48 INFO - 'read-buildbot-config', 03:34:48 INFO - 'download-and-extract', 03:34:48 INFO - 'populate-webroot', 03:34:48 INFO - 'create-virtualenv', 03:34:48 INFO - 'install', 03:34:48 INFO - 'setup-mitmproxy', 03:34:48 INFO - 'run-tests'), 03:34:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:34:48 INFO - 'disable_ccov_upload': False, 03:34:48 INFO - 'disable_stylo': False, 03:34:48 INFO - 'download_minidump_stackwalk': True, 03:34:48 INFO - 'download_symbols': 'ondemand', 03:34:48 INFO - 'enable_stylo': False, 03:34:48 INFO - 'enable_webrender': False, 03:34:48 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:34:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:34:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:34:48 INFO - 'gecko_profile': False, 03:34:48 INFO - 'gecko_profile_interval': 0, 03:34:48 INFO - 'installer_path': 'installer.exe', 03:34:48 INFO - 'log_level': 'info', 03:34:48 INFO - 'log_name': 'talos', 03:34:48 INFO - 'log_to_console': True, 03:34:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:34:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:34:48 INFO - 'opt_config_files': (), 03:34:48 INFO - 'pip_index': False, 03:34:48 INFO - 'suite': 'dromaeojs-e10s', 03:34:48 INFO - 'system_bits': '32', 03:34:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:34:48 INFO - 'title': 'talos-linux64-ix-078', 03:34:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:34:48 INFO - 'use_talos_json': True, 03:34:48 INFO - 'verify': 'False', 03:34:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:34:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:34:48 INFO - 'work_dir': 'build'} 03:34:48 INFO - [mozharness: 2017-09-28 10:34:48.943552Z] Running clobber step. 03:34:48 INFO - Running pre-action listener: _resource_record_pre_action 03:34:48 INFO - Running main action method: clobber 03:34:48 INFO - rmtree: /builds/slave/test/build 03:34:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:34:49 INFO - Running post-action listener: _resource_record_post_action 03:34:49 INFO - [mozharness: 2017-09-28 10:34:49.988693Z] Finished clobber step (success) 03:34:49 INFO - [mozharness: 2017-09-28 10:34:49.988791Z] Running read-buildbot-config step. 03:34:49 INFO - Running pre-action listener: _resource_record_pre_action 03:34:49 INFO - Running main action method: read_buildbot_config 03:34:49 INFO - Using buildbot properties: 03:34:49 INFO - { 03:34:49 INFO - "project": "", 03:34:49 INFO - "product": "firefox", 03:34:49 INFO - "who": "archaeopteryx@coole-files.de", 03:34:49 INFO - "installer_path": "public/build/target.tar.bz2", 03:34:49 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 03:34:49 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:34:49 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 03:34:49 INFO - "stage_platform": "linux64-qr", 03:34:49 INFO - "basedir": "/builds/slave/test", 03:34:49 INFO - "buildnumber": 103, 03:34:49 INFO - "platform": "ubuntu64_hw_qr", 03:34:49 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:34:49 INFO - "slavebuilddir": "test", 03:34:49 INFO - "taskId": "ZJW4SQYWRrareab8PIckkQ", 03:34:49 INFO - "branch": "mozilla-central", 03:34:49 INFO - "script_repo_revision": "production", 03:34:49 INFO - "revision": "82c2eecf82ba820c4593aa4a9749662f7d54d9a7", 03:34:49 INFO - "slavename": "talos-linux64-ix-078", 03:34:49 INFO - "repo_path": "mozilla-central" 03:34:49 INFO - } 03:34:49 INFO - Finding installer, test and symbols from parent task. 03:34:49 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZJW4SQYWRrareab8PIckkQ'}, attempt #1 03:34:50 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZJW4SQYWRrareab8PIckkQ'}, attempt #1 03:34:50 INFO - Task dependencies: bHRMUN3XS_OnyBl4OEvKxA 03:34:50 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA'}, attempt #1 03:34:51 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.tar.bz2 03:34:51 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.test_packages.json 03:34:51 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.crashreporter-symbols.zip 03:34:51 INFO - Running post-action listener: _resource_record_post_action 03:34:51 INFO - [mozharness: 2017-09-28 10:34:51.314887Z] Finished read-buildbot-config step (success) 03:34:51 INFO - [mozharness: 2017-09-28 10:34:51.315106Z] Running download-and-extract step. 03:34:51 INFO - Running pre-action listener: _resource_record_pre_action 03:34:51 INFO - Running main action method: download_and_extract 03:34:51 INFO - mkdir: /builds/slave/test/build/tests 03:34:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:51 INFO - trying https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.test_packages.json 03:34:51 INFO - Downloading https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:34:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:34:51 INFO - Downloaded 989 bytes. 03:34:51 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:34:51 INFO - Using the following test package requirements: 03:34:51 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:34:51 INFO - u'common': [u'target.common.tests.zip'], 03:34:51 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:34:51 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:34:51 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:34:51 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:34:51 INFO - u'mozbase': [u'target.common.tests.zip'], 03:34:51 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:34:51 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:34:51 INFO - u'web-platform': [u'target.common.tests.zip', 03:34:51 INFO - u'target.web-platform.tests.tar.gz'], 03:34:51 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:34:51 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:34:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.common.tests.zip 03:34:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:34:51 INFO - Fetch https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.common.tests.zip into memory 03:34:52 INFO - Content-Length response header: 55263113 03:34:52 INFO - Bytes received: 55263113 03:35:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.talos.tests.zip 03:35:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:35:03 INFO - Fetch https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.talos.tests.zip into memory 03:35:04 INFO - Content-Length response header: 14521162 03:35:04 INFO - Bytes received: 14521162 03:35: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')]} 03:35:04 INFO - trying https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.tar.bz2 03:35:04 INFO - Downloading https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:35:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:35:05 INFO - Downloaded 61661872 bytes. 03:35:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.tar.bz2 03:35:05 INFO - mkdir: /builds/slave/test/properties 03:35:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:35:05 INFO - Writing to file /builds/slave/test/properties/build_url 03:35:05 INFO - Contents: 03:35:05 INFO - build_url:https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.tar.bz2 03:35:05 INFO - Running post-action listener: _resource_record_post_action 03:35:05 INFO - Running post-action listener: find_tests_for_verification 03:35:05 INFO - Running post-action listener: set_extra_try_arguments 03:35:05 INFO - [mozharness: 2017-09-28 10:35:05.915935Z] Finished download-and-extract step (success) 03:35:05 INFO - [mozharness: 2017-09-28 10:35:05.916033Z] Running populate-webroot step. 03:35:05 INFO - Running pre-action listener: _resource_record_pre_action 03:35:05 INFO - Running main action method: populate_webroot 03:35:05 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:35:05 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:35:05 INFO - 'tests': ['tresize', 03:35:05 INFO - 'tcanvasmark']}, 03:35:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:35:05 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:35:05 INFO - 'tests': ['dromaeo_css', 03:35:05 INFO - 'kraken']}, 03:35:05 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:35:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:35:05 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:35:05 INFO - 'talos_options': ['--disable-stylo'], 03:35:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:35:05 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:35:05 INFO - 'tests': ['damp', 'tps']}, 03:35:05 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:35:05 INFO - 'talos_options': ['--disable-stylo'], 03:35:05 INFO - 'tests': ['damp', 'tps']}, 03:35:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:35:05 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:35:05 INFO - 'tests': ['dromaeo_dom']}, 03:35:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:35:05 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:35:05 INFO - 'tests': ['basic_compositor_video', 03:35:05 INFO - 'glvideo']}, 03:35:05 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:35:05 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:35:05 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:35:05 INFO - 'talos_options': ['--disable-stylo'], 03:35:05 INFO - 'tests': ['ts_paint_webext', 03:35:05 INFO - 'tp5o_webext']}, 03:35:05 INFO - 'other-e10s': {'tests': ['a11yr', 03:35:05 INFO - 'ts_paint', 03:35:05 INFO - 'tpaint', 03:35:05 INFO - 'sessionrestore', 03:35:05 INFO - 'sessionrestore_many_windows', 03:35:05 INFO - 'sessionrestore_no_auto_restore', 03:35:05 INFO - 'tabpaint', 03:35:05 INFO - 'cpstartup']}, 03:35:05 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:35:05 INFO - 'tests': ['a11yr', 03:35:05 INFO - 'ts_paint', 03:35:05 INFO - 'tpaint', 03:35:05 INFO - 'sessionrestore', 03:35:05 INFO - 'sessionrestore_many_windows', 03:35:05 INFO - 'sessionrestore_no_auto_restore', 03:35:05 INFO - 'tabpaint', 03:35:05 INFO - 'cpstartup']}, 03:35:05 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 03:35:05 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 03:35:05 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:35:05 INFO - 'tests': ['perf_reftest_singletons']}, 03:35:05 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:35:05 INFO - 'tests': ['perf_reftest']}, 03:35:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:35:05 INFO - 'tsvgr_opacity', 03:35:05 INFO - 'tart', 03:35:05 INFO - 'tscrollx', 03:35:05 INFO - 'tsvg_static']}, 03:35:05 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:35:05 INFO - 'tests': ['tsvgx', 03:35:05 INFO - 'tsvgr_opacity', 03:35:05 INFO - 'tart', 03:35:05 INFO - 'tscrollx', 03:35:05 INFO - 'tsvg_static']}, 03:35:05 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:35:05 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:35:05 INFO - 'talos_options': ['--disable-stylo'], 03:35:05 INFO - 'tests': ['tp5o']}, 03:35:05 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:35:05 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:35:05 INFO - 'talos_options': ['--mitmproxy', 03:35:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:35:05 INFO - '--firstNonBlankPaint'], 03:35:05 INFO - 'tests': ['tp6_google', 03:35:05 INFO - 'tp6_youtube', 03:35:05 INFO - 'tp6_amazon', 03:35:05 INFO - 'tp6_facebook']}, 03:35:05 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:35:05 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:35:05 INFO - 'talos_options': ['--disable-stylo', 03:35:05 INFO - '--mitmproxy', 03:35:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:35:05 INFO - '--firstNonBlankPaint'], 03:35:05 INFO - 'tests': ['tp6_google', 03:35:05 INFO - 'tp6_youtube', 03:35:05 INFO - 'tp6_amazon', 03:35:05 INFO - 'tp6_facebook']}, 03:35:05 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:35:05 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:35:05 INFO - 'talos_options': ['--stylo-threads=1', 03:35:05 INFO - '--mitmproxy', 03:35:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:35:05 INFO - '--firstNonBlankPaint'], 03:35:05 INFO - 'tests': ['tp6_google', 03:35:05 INFO - 'tp6_youtube', 03:35:05 INFO - 'tp6_amazon', 03:35:05 INFO - 'tp6_facebook']}, 03:35:05 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:35:05 INFO - 'talos_options': ['--xperf_path', 03:35:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:35:05 INFO - 'tests': ['tp5n']}, 03:35:05 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:35:05 INFO - 'talos_options': ['--disable-stylo', 03:35:05 INFO - '--xperf_path', 03:35:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:35:05 INFO - 'tests': ['tp5n']}}} 03:35:05 INFO - Running post-action listener: _resource_record_post_action 03:35:05 INFO - [mozharness: 2017-09-28 10:35:05.931555Z] Finished populate-webroot step (success) 03:35:05 INFO - [mozharness: 2017-09-28 10:35:05.931644Z] Running create-virtualenv step. 03:35:05 INFO - Running pre-action listener: _resource_record_pre_action 03:35:05 INFO - Running main action method: create_virtualenv 03:35:05 INFO - Creating virtualenv /builds/slave/test/build/venv 03:35:05 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:35:05 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:35:05 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:35:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:35:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:35:06 INFO - Installing distribute.............................................................................................................................................................................................done. 03:35:06 INFO - Installing pip...............done. 03:35:06 INFO - Return code: 0 03:35:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:35:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:35:06 INFO - Reading from file tmpfile_stdout 03:35:06 INFO - Output received: 03:35:06 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:35:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:35:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:06 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 0xba91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd71b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf169c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf13d60>, '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 0xf14a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf14ef0>, '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': 'dac658600622fd96716c9acf000001b3-1506594886.379905-261782927', '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 03:35:06 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 03:35:06 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 03:35:06 INFO - Using env: {'DISPLAY': ':0', 03:35:06 INFO - 'HOME': '/home/cltbld', 03:35:06 INFO - 'LANG': 'en_US.UTF-8', 03:35:06 INFO - 'LANGUAGE': 'en_US:en', 03:35:06 INFO - 'LOGNAME': 'cltbld', 03:35:06 INFO - 'MAIL': '/var/mail/cltbld', 03:35:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:06 INFO - 'MOZ_NO_REMOTE': '1', 03:35:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:06 INFO - 'NO_EM_RESTART': '1', 03:35:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:06 INFO - 'PWD': '/builds/slave/test', 03:35:06 INFO - 'SHELL': '/bin/bash', 03:35:06 INFO - 'SHLVL': '1', 03:35:06 INFO - 'TERM': 'linux', 03:35:06 INFO - 'TMOUT': '86400', 03:35:06 INFO - 'USER': 'cltbld', 03:35:06 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1506594886.379905-261782927', 03:35:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:06 INFO - '_': '/tools/buildbot/bin/python'} 03:35:09 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:35:09 INFO - Downloading/unpacking pip>=1.5 03:35:09 INFO - Running setup.py egg_info for package pip 03:35:09 INFO - warning: no files found matching 'pip/cacert.pem' 03:35:09 INFO - warning: no files found matching '*.html' under directory 'docs' 03:35:09 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:35:09 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:35:09 INFO - Installing collected packages: pip 03:35:09 INFO - Found existing installation: pip 1.1 03:35:09 INFO - Uninstalling pip: 03:35:09 INFO - Successfully uninstalled pip 03:35:09 INFO - Running setup.py install for pip 03:35:09 INFO - warning: no files found matching 'pip/cacert.pem' 03:35:09 INFO - warning: no files found matching '*.html' under directory 'docs' 03:35:09 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:35:09 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:35:09 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:35:09 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:35:09 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:35:09 INFO - Successfully installed pip 03:35:09 INFO - Cleaning up... 03:35:09 INFO - Return code: 0 03:35:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:35:09 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')]} 03:35:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:09 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')]} 03:35:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:09 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 0xba91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd71b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf169c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf13d60>, '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 0xf14a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf14ef0>, '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': 'dac658600622fd96716c9acf000001b3-1506594886.379905-261782927', '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 03:35:09 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 03:35:09 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 03:35:09 INFO - Using env: {'DISPLAY': ':0', 03:35:09 INFO - 'HOME': '/home/cltbld', 03:35:09 INFO - 'LANG': 'en_US.UTF-8', 03:35:09 INFO - 'LANGUAGE': 'en_US:en', 03:35:09 INFO - 'LOGNAME': 'cltbld', 03:35:09 INFO - 'MAIL': '/var/mail/cltbld', 03:35:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:09 INFO - 'MOZ_NO_REMOTE': '1', 03:35:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:09 INFO - 'NO_EM_RESTART': '1', 03:35:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:09 INFO - 'PWD': '/builds/slave/test', 03:35:09 INFO - 'SHELL': '/bin/bash', 03:35:09 INFO - 'SHLVL': '1', 03:35:09 INFO - 'TERM': 'linux', 03:35:09 INFO - 'TMOUT': '86400', 03:35:09 INFO - 'USER': 'cltbld', 03:35:09 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1506594886.379905-261782927', 03:35:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:09 INFO - '_': '/tools/buildbot/bin/python'} 03:35:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:10 INFO - Downloading/unpacking psutil>=3.1.1 03:35:10 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 03:35:10 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 03:35:10 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 03:35:10 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 03:35:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:35:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:35:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:35:18 INFO - Installing collected packages: psutil 03:35:18 INFO - Running setup.py install for psutil 03:35:18 INFO - building 'psutil._psutil_linux' extension 03:35:18 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 03:35:18 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 03:35:18 INFO - building 'psutil._psutil_posix' extension 03:35:18 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 03:35:18 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 03:35:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:35:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:35:18 INFO - Successfully installed psutil 03:35:18 INFO - Cleaning up... 03:35:18 INFO - Return code: 0 03:35:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:35:18 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')]} 03:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:18 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')]} 03:35:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:18 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 0xba91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd71b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf169c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf13d60>, '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 0xf14a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf14ef0>, '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': 'dac658600622fd96716c9acf000001b3-1506594886.379905-261782927', '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 03:35:18 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 03:35:18 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 03:35:18 INFO - Using env: {'DISPLAY': ':0', 03:35:18 INFO - 'HOME': '/home/cltbld', 03:35:18 INFO - 'LANG': 'en_US.UTF-8', 03:35:18 INFO - 'LANGUAGE': 'en_US:en', 03:35:18 INFO - 'LOGNAME': 'cltbld', 03:35:18 INFO - 'MAIL': '/var/mail/cltbld', 03:35:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:18 INFO - 'MOZ_NO_REMOTE': '1', 03:35:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:18 INFO - 'NO_EM_RESTART': '1', 03:35:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:18 INFO - 'PWD': '/builds/slave/test', 03:35:18 INFO - 'SHELL': '/bin/bash', 03:35:18 INFO - 'SHLVL': '1', 03:35:18 INFO - 'TERM': 'linux', 03:35:18 INFO - 'TMOUT': '86400', 03:35:18 INFO - 'USER': 'cltbld', 03:35:18 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1506594886.379905-261782927', 03:35:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:18 INFO - '_': '/tools/buildbot/bin/python'} 03:35:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:35:19 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 03:35:19 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 03:35:19 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 03:35:19 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 03:35:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:35:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:35:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:35:20 INFO - Installing collected packages: mozsystemmonitor 03:35:20 INFO - Running setup.py install for mozsystemmonitor 03:35:20 INFO - Successfully installed mozsystemmonitor 03:35:20 INFO - Cleaning up... 03:35:20 INFO - Return code: 0 03:35:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:35: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')]} 03:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35: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')]} 03:35:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:20 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 0xba91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd71b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf169c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf13d60>, '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 0xf14a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf14ef0>, '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': 'dac658600622fd96716c9acf000001b3-1506594886.379905-261782927', '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 03:35:20 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 03:35:20 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 03:35:20 INFO - Using env: {'DISPLAY': ':0', 03:35:20 INFO - 'HOME': '/home/cltbld', 03:35:20 INFO - 'LANG': 'en_US.UTF-8', 03:35:20 INFO - 'LANGUAGE': 'en_US:en', 03:35:20 INFO - 'LOGNAME': 'cltbld', 03:35:20 INFO - 'MAIL': '/var/mail/cltbld', 03:35:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:20 INFO - 'MOZ_NO_REMOTE': '1', 03:35:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:20 INFO - 'NO_EM_RESTART': '1', 03:35:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:20 INFO - 'PWD': '/builds/slave/test', 03:35:20 INFO - 'SHELL': '/bin/bash', 03:35:20 INFO - 'SHLVL': '1', 03:35:20 INFO - 'TERM': 'linux', 03:35:20 INFO - 'TMOUT': '86400', 03:35:20 INFO - 'USER': 'cltbld', 03:35:20 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1506594886.379905-261782927', 03:35:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:20 INFO - '_': '/tools/buildbot/bin/python'} 03:35:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:20 INFO - Downloading/unpacking jsonschema==2.5.1 03:35:20 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 03:35:20 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 03:35:20 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 03:35:20 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 03:35:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:35:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:35:21 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 03:35:21 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 03:35:21 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 03:35:21 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 03:35:21 INFO - Downloading functools32-3.2.3-2.tar.gz 03:35:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:35:21 INFO - warning: no files found matching '*.txt' 03:35:21 INFO - no previously-included directories found matching 'build' 03:35:21 INFO - no previously-included directories found matching 'dist' 03:35:21 INFO - no previously-included directories found matching '.git*' 03:35:21 INFO - Installing collected packages: jsonschema, functools32 03:35:21 INFO - Running setup.py install for functools32 03:35:21 INFO - warning: no files found matching '*.txt' 03:35:21 INFO - no previously-included directories found matching 'build' 03:35:21 INFO - no previously-included directories found matching 'dist' 03:35:21 INFO - no previously-included directories found matching '.git*' 03:35:22 INFO - Successfully installed jsonschema functools32 03:35:22 INFO - Cleaning up... 03:35:22 INFO - Return code: 0 03:35:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:35:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:22 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 0xba91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd71b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf169c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf13d60>, '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 0xf14a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf14ef0>, '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': 'dac658600622fd96716c9acf000001b3-1506594886.379905-261782927', '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 03:35:22 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 03:35:22 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 03:35:22 INFO - Using env: {'DISPLAY': ':0', 03:35:22 INFO - 'HOME': '/home/cltbld', 03:35:22 INFO - 'LANG': 'en_US.UTF-8', 03:35:22 INFO - 'LANGUAGE': 'en_US:en', 03:35:22 INFO - 'LOGNAME': 'cltbld', 03:35:22 INFO - 'MAIL': '/var/mail/cltbld', 03:35:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:22 INFO - 'MOZ_NO_REMOTE': '1', 03:35:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:22 INFO - 'NO_EM_RESTART': '1', 03:35:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:22 INFO - 'PWD': '/builds/slave/test', 03:35:22 INFO - 'SHELL': '/bin/bash', 03:35:22 INFO - 'SHLVL': '1', 03:35:22 INFO - 'TERM': 'linux', 03:35:22 INFO - 'TMOUT': '86400', 03:35:22 INFO - 'USER': 'cltbld', 03:35:22 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1506594886.379905-261782927', 03:35:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:22 INFO - '_': '/tools/buildbot/bin/python'} 03:35:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:35:22 INFO - Cleaning up... 03:35:22 INFO - Return code: 0 03:35:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:35:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:22 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 0xba91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd71b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf169c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf13d60>, '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 0xf14a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf14ef0>, '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': 'dac658600622fd96716c9acf000001b3-1506594886.379905-261782927', '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 03:35:22 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 03:35:22 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 03:35:22 INFO - Using env: {'DISPLAY': ':0', 03:35:22 INFO - 'HOME': '/home/cltbld', 03:35:22 INFO - 'LANG': 'en_US.UTF-8', 03:35:22 INFO - 'LANGUAGE': 'en_US:en', 03:35:22 INFO - 'LOGNAME': 'cltbld', 03:35:22 INFO - 'MAIL': '/var/mail/cltbld', 03:35:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:22 INFO - 'MOZ_NO_REMOTE': '1', 03:35:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:22 INFO - 'NO_EM_RESTART': '1', 03:35:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:22 INFO - 'PWD': '/builds/slave/test', 03:35:22 INFO - 'SHELL': '/bin/bash', 03:35:22 INFO - 'SHLVL': '1', 03:35:22 INFO - 'TERM': 'linux', 03:35:22 INFO - 'TMOUT': '86400', 03:35:22 INFO - 'USER': 'cltbld', 03:35:22 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1506594886.379905-261782927', 03:35:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:22 INFO - '_': '/tools/buildbot/bin/python'} 03:35:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:22 INFO - Downloading/unpacking blobuploader==1.2.4 03:35:22 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 03:35:22 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 03:35:22 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 03:35:22 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 03:35:23 INFO - Downloading blobuploader-1.2.4.tar.gz 03:35:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:35:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:35:23 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 03:35:23 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 03:35:23 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 03:35:23 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 03:35:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:35:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:35:23 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 03:35:23 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 03:35:23 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 03:35:23 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 03:35:24 INFO - Downloading docopt-0.6.1.tar.gz 03:35:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:35:24 INFO - Installing collected packages: blobuploader, requests, docopt 03:35:24 INFO - Running setup.py install for blobuploader 03:35:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:35:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:35:24 INFO - Running setup.py install for requests 03:35:24 INFO - Running setup.py install for docopt 03:35:24 INFO - Successfully installed blobuploader requests docopt 03:35:24 INFO - Cleaning up... 03:35:24 INFO - Return code: 0 03:35:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:35:24 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')]} 03:35:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:24 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')]} 03:35:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:24 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 0xba91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd71b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf169c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf13d60>, '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 0xf14a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf14ef0>, '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': 'dac658600622fd96716c9acf000001b3-1506594886.379905-261782927', '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 03:35:24 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 03:35:24 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 03:35:24 INFO - Using env: {'DISPLAY': ':0', 03:35:24 INFO - 'HOME': '/home/cltbld', 03:35:24 INFO - 'LANG': 'en_US.UTF-8', 03:35:24 INFO - 'LANGUAGE': 'en_US:en', 03:35:24 INFO - 'LOGNAME': 'cltbld', 03:35:24 INFO - 'MAIL': '/var/mail/cltbld', 03:35:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:24 INFO - 'MOZ_NO_REMOTE': '1', 03:35:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:24 INFO - 'NO_EM_RESTART': '1', 03:35:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:24 INFO - 'PWD': '/builds/slave/test', 03:35:24 INFO - 'SHELL': '/bin/bash', 03:35:24 INFO - 'SHLVL': '1', 03:35:24 INFO - 'TERM': 'linux', 03:35:24 INFO - 'TMOUT': '86400', 03:35:24 INFO - 'USER': 'cltbld', 03:35:24 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1506594886.379905-261782927', 03:35:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:24 INFO - '_': '/tools/buildbot/bin/python'} 03:35:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:35:24 INFO - Running setup.py (path:/tmp/pip-mBP1it-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:35:25 INFO - Running setup.py (path:/tmp/pip-cTBIPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:35:25 INFO - Running setup.py (path:/tmp/pip-2L1wB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:35:25 INFO - Running setup.py (path:/tmp/pip-GV65Uc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:35:25 INFO - Running setup.py (path:/tmp/pip-no57Sw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:35:25 INFO - Running setup.py (path:/tmp/pip-5f8Dct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:35:25 INFO - Running setup.py (path:/tmp/pip-554XDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:35:25 INFO - Running setup.py (path:/tmp/pip-namsij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:35:25 INFO - Running setup.py (path:/tmp/pip-K1n4Cs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:35:25 INFO - Running setup.py (path:/tmp/pip-Hc8ldV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:35:25 INFO - Running setup.py (path:/tmp/pip-TOS0Zm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:35:25 INFO - Running setup.py (path:/tmp/pip-mledJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:35:25 INFO - Running setup.py (path:/tmp/pip-XA2m_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:35:25 INFO - Running setup.py (path:/tmp/pip-LW0UDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:35:25 INFO - Running setup.py (path:/tmp/pip-2Jh4nm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:35:26 INFO - Running setup.py (path:/tmp/pip-Pricma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:35:26 INFO - Running setup.py (path:/tmp/pip-LHppHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:35:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:35:26 INFO - Running setup.py install for manifestparser 03:35:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:35:26 INFO - Running setup.py install for mozcrash 03:35:26 INFO - Running setup.py install for mozdebug 03:35:26 INFO - Running setup.py install for mozdevice 03:35:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:35:26 INFO - Running setup.py install for mozfile 03:35:26 INFO - Running setup.py install for mozhttpd 03:35:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:35:26 INFO - Running setup.py install for mozinfo 03:35:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:35:26 INFO - Running setup.py install for mozInstall 03:35:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:35:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:35:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:35:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:35:26 INFO - Running setup.py install for mozleak 03:35:27 INFO - Running setup.py install for mozlog 03:35:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:35:27 INFO - Running setup.py install for moznetwork 03:35:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:35:27 INFO - Running setup.py install for mozprocess 03:35:27 INFO - Running setup.py install for mozprofile 03:35:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:35:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:35:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:35:27 INFO - Running setup.py install for mozrunner 03:35:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:35:27 INFO - Running setup.py install for mozscreenshot 03:35:27 INFO - Running setup.py install for moztest 03:35:27 INFO - Running setup.py install for mozversion 03:35:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:35:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:35:27 INFO - Cleaning up... 03:35:27 INFO - Return code: 0 03:35:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:35: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')]} 03:35:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35: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')]} 03:35:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:27 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 0xba91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd71b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf169c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf13d60>, '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 0xf14a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf14ef0>, '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': 'dac658600622fd96716c9acf000001b3-1506594886.379905-261782927', '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 03:35:27 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 03:35:27 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 03:35:27 INFO - Using env: {'DISPLAY': ':0', 03:35:27 INFO - 'HOME': '/home/cltbld', 03:35:27 INFO - 'LANG': 'en_US.UTF-8', 03:35:27 INFO - 'LANGUAGE': 'en_US:en', 03:35:27 INFO - 'LOGNAME': 'cltbld', 03:35:27 INFO - 'MAIL': '/var/mail/cltbld', 03:35:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:27 INFO - 'MOZ_NO_REMOTE': '1', 03:35:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:27 INFO - 'NO_EM_RESTART': '1', 03:35:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:27 INFO - 'PWD': '/builds/slave/test', 03:35:27 INFO - 'SHELL': '/bin/bash', 03:35:27 INFO - 'SHLVL': '1', 03:35:27 INFO - 'TERM': 'linux', 03:35:27 INFO - 'TMOUT': '86400', 03:35:27 INFO - 'USER': 'cltbld', 03:35:27 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1506594886.379905-261782927', 03:35:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:27 INFO - '_': '/tools/buildbot/bin/python'} 03:35:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:35:28 INFO - Running setup.py (path:/tmp/pip-N5O6En-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:35:28 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)) 03:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:35:28 INFO - Running setup.py (path:/tmp/pip-CsCceB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:35:28 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)) 03:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:35:28 INFO - Running setup.py (path:/tmp/pip-vUt1Xa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:35:28 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)) 03:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:35:28 INFO - Running setup.py (path:/tmp/pip-X9j9xy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:35:28 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)) 03:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:35:28 INFO - Running setup.py (path:/tmp/pip-XTvY31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:35:28 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)) 03:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:35:28 INFO - Running setup.py (path:/tmp/pip-IsnA3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:35:28 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)) 03:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:35:28 INFO - Running setup.py (path:/tmp/pip-PqkSDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:35:28 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)) 03:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:35:28 INFO - Running setup.py (path:/tmp/pip-zeQSfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:35:28 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)) 03:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:35:28 INFO - Running setup.py (path:/tmp/pip-y7j16r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:35:28 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)) 03:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:35:28 INFO - Running setup.py (path:/tmp/pip-wE5dkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:35:28 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)) 03:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:35:28 INFO - Running setup.py (path:/tmp/pip-gp1fmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:35:28 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)) 03:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:35:28 INFO - Running setup.py (path:/tmp/pip-pvLBge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:35:29 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)) 03:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:35:29 INFO - Running setup.py (path:/tmp/pip-QyjWQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:35:29 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)) 03:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:35:29 INFO - Running setup.py (path:/tmp/pip-Zw0XpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:35:29 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)) 03:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:35:29 INFO - Running setup.py (path:/tmp/pip-Mb41cm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:35:29 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)) 03:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:35:29 INFO - Running setup.py (path:/tmp/pip-h4jjE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:35:29 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)) 03:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:35:29 INFO - Running setup.py (path:/tmp/pip-CAlY_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:35:29 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)) 03:35:29 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)) 03:35:29 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)) 03:35:29 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)) 03:35:29 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)) 03:35:29 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)) 03:35:29 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)) 03:35:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:35: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 03:35: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 03:35: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 03:35: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 03:35:30 INFO - Downloading blessings-1.6.tar.gz 03:35:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:35:30 INFO - Installing collected packages: blessings 03:35:30 INFO - Running setup.py install for blessings 03:35:30 INFO - Successfully installed blessings 03:35:30 INFO - Cleaning up... 03:35:30 INFO - Return code: 0 03:35:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:35:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:35:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:35:30 INFO - Reading from file tmpfile_stdout 03:35:30 INFO - Current package versions: 03:35:30 INFO - argparse == 1.2.1 03:35:30 INFO - blessings == 1.6 03:35:30 INFO - blobuploader == 1.2.4 03:35:30 INFO - docopt == 0.6.1 03:35:30 INFO - functools32 == 3.2.3-2 03:35:30 INFO - jsonschema == 2.5.1 03:35:30 INFO - manifestparser == 1.1 03:35:30 INFO - mozInstall == 1.13 03:35:30 INFO - mozcrash == 1.0 03:35:30 INFO - mozdebug == 0.1 03:35:30 INFO - mozdevice == 0.51 03:35:30 INFO - mozfile == 1.2 03:35:30 INFO - mozhttpd == 0.7 03:35:30 INFO - mozinfo == 0.10 03:35:30 INFO - mozleak == 0.1 03:35:30 INFO - mozlog == 3.5 03:35:30 INFO - moznetwork == 0.27 03:35:30 INFO - mozprocess == 0.25 03:35:30 INFO - mozprofile == 0.28 03:35:30 INFO - mozrunner == 6.13 03:35:30 INFO - mozscreenshot == 0.1 03:35:30 INFO - mozsystemmonitor == 0.3 03:35:30 INFO - moztest == 0.8 03:35:30 INFO - mozversion == 1.4 03:35:30 INFO - psutil == 3.1.1 03:35:30 INFO - requests == 1.2.3 03:35:30 INFO - wsgiref == 0.1.2 03:35:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:35:30 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')]} 03:35:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:30 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')]} 03:35:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:30 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 0xba91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd71b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf169c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf13d60>, '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 0xf14a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf14ef0>, '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': 'dac658600622fd96716c9acf000001b3-1506594886.379905-261782927', '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 03:35:30 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 03:35:30 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 03:35:30 INFO - Using env: {'DISPLAY': ':0', 03:35:30 INFO - 'HOME': '/home/cltbld', 03:35:30 INFO - 'LANG': 'en_US.UTF-8', 03:35:30 INFO - 'LANGUAGE': 'en_US:en', 03:35:30 INFO - 'LOGNAME': 'cltbld', 03:35:30 INFO - 'MAIL': '/var/mail/cltbld', 03:35:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:30 INFO - 'MOZ_NO_REMOTE': '1', 03:35:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:30 INFO - 'NO_EM_RESTART': '1', 03:35:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:30 INFO - 'PWD': '/builds/slave/test', 03:35:30 INFO - 'SHELL': '/bin/bash', 03:35:30 INFO - 'SHLVL': '1', 03:35:30 INFO - 'TERM': 'linux', 03:35:30 INFO - 'TMOUT': '86400', 03:35:30 INFO - 'USER': 'cltbld', 03:35:30 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1506594886.379905-261782927', 03:35:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:30 INFO - '_': '/tools/buildbot/bin/python'} 03:35:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:31 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)) 03:35:31 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)) 03:35:31 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)) 03:35:31 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)) 03:35:31 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)) 03:35:31 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)) 03:35:31 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)) 03:35:31 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)) 03:35:31 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)) 03:35:31 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:35: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 03:35: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 03:35: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 03:35: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 03:35:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:35:32 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)) 03:35:32 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)) 03:35:32 INFO - Installing collected packages: simplejson 03:35:32 INFO - Running setup.py install for simplejson 03:35:32 INFO - building 'simplejson._speedups' extension 03:35:32 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 03:35:33 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 03:35:33 INFO - Successfully installed simplejson 03:35:33 INFO - Cleaning up... 03:35:33 INFO - Return code: 0 03:35:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:35:33 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')]} 03:35:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:33 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')]} 03:35:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:33 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 0xba91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd71b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf169c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf13d60>, '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 0xf14a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf14ef0>, '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': 'dac658600622fd96716c9acf000001b3-1506594886.379905-261782927', '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 03:35:33 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 03:35:33 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 03:35:33 INFO - Using env: {'DISPLAY': ':0', 03:35:33 INFO - 'HOME': '/home/cltbld', 03:35:33 INFO - 'LANG': 'en_US.UTF-8', 03:35:33 INFO - 'LANGUAGE': 'en_US:en', 03:35:33 INFO - 'LOGNAME': 'cltbld', 03:35:33 INFO - 'MAIL': '/var/mail/cltbld', 03:35:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:33 INFO - 'MOZ_NO_REMOTE': '1', 03:35:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:33 INFO - 'NO_EM_RESTART': '1', 03:35:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:33 INFO - 'PWD': '/builds/slave/test', 03:35:33 INFO - 'SHELL': '/bin/bash', 03:35:33 INFO - 'SHLVL': '1', 03:35:33 INFO - 'TERM': 'linux', 03:35:33 INFO - 'TMOUT': '86400', 03:35:33 INFO - 'USER': 'cltbld', 03:35:33 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1506594886.379905-261782927', 03:35:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:33 INFO - '_': '/tools/buildbot/bin/python'} 03:35:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:35:33 INFO - Cleaning up... 03:35:33 INFO - Return code: 0 03:35:33 INFO - Running post-action listener: _resource_record_post_action 03:35:33 INFO - Running post-action listener: _start_resource_monitoring 03:35:33 INFO - Starting resource monitoring. 03:35:33 INFO - [mozharness: 2017-09-28 10:35:33.641636Z] Finished create-virtualenv step (success) 03:35:33 INFO - [mozharness: 2017-09-28 10:35:33.642155Z] Running install step. 03:35:33 INFO - Running pre-action listener: _resource_record_pre_action 03:35:33 INFO - Running main action method: install 03:35:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:35:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:35:33 INFO - Reading from file tmpfile_stdout 03:35:33 INFO - Detecting whether we're running mozinstall >=1.0... 03:35:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:35:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:35:33 INFO - Reading from file tmpfile_stdout 03:35:33 INFO - Output received: 03:35:33 INFO - Usage: mozinstall [options] installer 03:35:33 INFO - Options: 03:35:33 INFO - -h, --help show this help message and exit 03:35:33 INFO - -d DEST, --destination=DEST 03:35:33 INFO - Directory to install application into. [default: 03:35:33 INFO - "/builds/slave/test"] 03:35:33 INFO - --app=APP Application being installed. [default: firefox] 03:35:33 INFO - mkdir: /builds/slave/test/build/application 03:35:33 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'] 03:35:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:35:51 INFO - Reading from file tmpfile_stdout 03:35:51 INFO - Output received: 03:35:51 INFO - /builds/slave/test/build/application/firefox/firefox 03:35:51 INFO - Running post-action listener: _resource_record_post_action 03:35:51 INFO - [mozharness: 2017-09-28 10:35:51.748203Z] Finished install step (success) 03:35:51 INFO - [mozharness: 2017-09-28 10:35:51.748457Z] Running setup-mitmproxy step. 03:35:51 INFO - Running pre-action listener: _resource_record_pre_action 03:35:51 INFO - Running main action method: setup_mitmproxy 03:35:51 INFO - Skipping: mitmproxy is not required 03:35:51 INFO - Running post-action listener: _resource_record_post_action 03:35:51 INFO - [mozharness: 2017-09-28 10:35:51.749662Z] Finished setup-mitmproxy step (success) 03:35:51 INFO - [mozharness: 2017-09-28 10:35:51.749882Z] Running run-tests step. 03:35:51 INFO - Running pre-action listener: _resource_record_pre_action 03:35:51 INFO - Running pre-action listener: _set_gcov_prefix 03:35:51 INFO - Running main action method: run_tests 03:35:51 WARNING - Try message not found. 03:35:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:35:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:35:51 INFO - Python 2.7.3 03:35:51 INFO - Return code: 0 03:35:51 INFO - grabbing minidump binary from tooltool 03:35:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:51 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 0xf13d60>, '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 0xf14a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf14ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:35:51 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 03:35:51 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 03:35:51 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 03:35:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:35:51 INFO - Return code: 0 03:35:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:35:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:35:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:35:51 INFO - ENV: RUST_BACKTRACE is now full 03:35:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:35:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:35:51 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/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-078', '--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 03:35:51 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/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-078 --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 03:35:51 INFO - Using env: {'DISPLAY': ':0', 03:35:51 INFO - 'HOME': '/home/cltbld', 03:35:51 INFO - 'LANG': 'en_US.UTF-8', 03:35:51 INFO - 'LANGUAGE': 'en_US:en', 03:35:51 INFO - 'LOGNAME': 'cltbld', 03:35:51 INFO - 'MAIL': '/var/mail/cltbld', 03:35:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:35:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:35:51 INFO - 'MOZ_ACCELERATED': '1', 03:35:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:51 INFO - 'MOZ_NO_REMOTE': '1', 03:35:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:35:51 INFO - 'MOZ_WEBRENDER': '1', 03:35:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:51 INFO - 'NO_EM_RESTART': '1', 03:35:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:51 INFO - 'PWD': '/builds/slave/test', 03:35:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:35:51 INFO - 'RUST_BACKTRACE': 'full', 03:35:51 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:35:51 INFO - 'SHELL': '/bin/bash', 03:35:51 INFO - 'SHLVL': '1', 03:35:51 INFO - 'TERM': 'linux', 03:35:51 INFO - 'TMOUT': '86400', 03:35:51 INFO - 'USER': 'cltbld', 03:35:51 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1506594886.379905-261782927', 03:35:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:51 INFO - '_': '/tools/buildbot/bin/python'} 03:35:51 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/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-078', '--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 03:35:52 INFO - mozversion application_buildid: 20170928094239 03:35:52 INFO - mozversion application_changeset: 82c2eecf82ba820c4593aa4a9749662f7d54d9a7 03:35:52 INFO - mozversion application_display_name: Nightly 03:35:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:35:52 INFO - mozversion application_name: Firefox 03:35:52 INFO - mozversion application_remotingname: firefox 03:35:52 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:35:52 INFO - mozversion application_vendor: Mozilla 03:35:52 INFO - mozversion application_version: 58.0a1 03:35:52 INFO - mozversion platform_buildid: 20170928094239 03:35:52 INFO - mozversion platform_changeset: 82c2eecf82ba820c4593aa4a9749662f7d54d9a7 03:35:52 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:35:52 INFO - mozversion platform_version: 58.0a1 03:35:52 INFO - using testdate: 1506594952 03:35:52 INFO - actual date: 1506594952 03:35:52 INFO - starting webserver on 'localhost:59886' 03:35:52 INFO - SUITE-START | Running 2 tests 03:35:52 INFO - TEST-START | dromaeo_css 03:35:52 INFO - Initialising browser for dromaeo_css test... 03:35:52 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59886/getInfo.html -profile /tmp/tmplkdY9Y/profile 03:35:52 INFO - TEST-INFO | started process 5806 (/builds/slave/test/build/application/firefox/firefox http://localhost:59886/getInfo.html) 03:35:57 INFO - TEST-INFO | 5806: exit 0 03:35:58 INFO - Browser initialized. 03:35:58 INFO - Running cycle 1/1 for dromaeo_css test... 03:35:58 INFO - Using env: {'DISPLAY': ':0', 03:35:58 INFO - 'HOME': '/home/cltbld', 03:35:58 INFO - 'JSGC_DISABLE_POISONING': '1', 03:35:58 INFO - 'LANG': 'en_US.UTF-8', 03:35:58 INFO - 'LANGUAGE': 'en_US:en', 03:35:58 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:35:58 INFO - 'LOGNAME': 'cltbld', 03:35:58 INFO - 'MAIL': '/var/mail/cltbld', 03:35:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:35:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:35:58 INFO - 'MOZ_ACCELERATED': '1', 03:35:58 INFO - 'MOZ_CRASHREPORTER': '1', 03:35:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:58 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:35:58 INFO - 'MOZ_NO_REMOTE': '1', 03:35:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:35:58 INFO - 'MOZ_WEBRENDER': '1', 03:35:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:58 INFO - 'NO_EM_RESTART': '1', 03:35:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:58 INFO - 'PWD': '/builds/slave/test', 03:35:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:35:58 INFO - 'RUST_BACKTRACE': 'full', 03:35:58 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:35:58 INFO - 'SHELL': '/bin/bash', 03:35:58 INFO - 'SHLVL': '1', 03:35:58 INFO - 'TERM': 'linux', 03:35:58 INFO - 'TMOUT': '86400', 03:35:58 INFO - 'USER': 'cltbld', 03:35:58 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1506594886.379905-261782927', 03:35:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:58 INFO - '_': '/tools/buildbot/bin/python'} 03:35:58 INFO - TEST-INFO | started process 6052 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplkdY9Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:35:58 INFO - PID 6052 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:35:59 INFO - PID 6052 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:35:59 INFO - PID 6052 | 03:35:59 INFO - PID 6052 | (/builds/slave/test/build/application/firefox/firefox:6110): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:35:59 INFO - PID 6052 | 03:36:09 INFO - PID 6052 | RSS: Main: 196214784 03:36:09 INFO - PID 6052 | 03:39:06 INFO - PID 6052 | Cycle 1(1): loaded http://localhost:59886/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59886/tests/dromaeo/cssquery-ext.html) 03:39:08 INFO - PID 6052 | RSS: Main: 190603264 03:39:08 INFO - PID 6052 | 03:42:10 INFO - PID 6052 | Cycle 1(1): loaded http://localhost:59886/tests/dromaeo/cssquery-ext.html (next: http://localhost:59886/tests/dromaeo/cssquery-jquery.html) 03:42:11 INFO - PID 6052 | RSS: Main: 190218240 03:42:11 INFO - PID 6052 | 03:45:13 INFO - PID 6052 | Cycle 1(1): loaded http://localhost:59886/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59886/tests/dromaeo/cssquery-mootools.html) 03:45:13 INFO - PID 6052 | RSS: Main: 192114688 03:45:13 INFO - PID 6052 | 03:48:15 INFO - PID 6052 | Cycle 1(1): loaded http://localhost:59886/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59886/tests/dromaeo/cssquery-prototype.html) 03:48:16 INFO - PID 6052 | RSS: Main: 190668800 03:48:16 INFO - PID 6052 | 03:51:20 INFO - PID 6052 | Cycle 1(1): loaded http://localhost:59886/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59886/tests/dromaeo/cssquery-yui.html) 03:51:20 INFO - PID 6052 | RSS: Main: 193404928 03:51:20 INFO - PID 6052 | 03:54:22 INFO - PID 6052 | Cycle 1(1): loaded http://localhost:59886/tests/dromaeo/cssquery-yui.html (next: http://localhost:59886/tests/dromaeo/cssquery-dojo.html) 03:54:22 INFO - PID 6052 | RSS: Main: 194379776 03:54:22 INFO - PID 6052 | 03:54:22 INFO - PID 6052 | __start_tp_report 03:54:22 INFO - PID 6052 | _x_x_mozilla_page_load 03:54:22 INFO - PID 6052 | _x_x_mozilla_page_load_details 03:54:22 INFO - PID 6052 | |i|pagename|runs| 03:54:23 INFO - PID 6052 | |0;dojo.html;3126.437241296567;3144.9842750786247;3203.6636153203913;3212.9357412851746;3219.790713603614;6185.0722391641275;6287.654179020158;6293.30773614902;6365.236171659401;6368.140301059356;6091.756329746816;6215.254169499666;6235.906461403071;6269.49844012479;6289.905651415233;5699.316082070158;5770.076787713967;5781;5801.419858014186;5814.069748840187;5859.7656093756195;5862.794802181925;5912.4974377178;5925.081612350093;5946.643201407929;5602.579806514527;5798.971005144968;5825.097109947986;5842;5859.79490717825;5722.685252311121;5723.112917497794;5768.134779783066;5778.988676981511;5882.764689412418;5755.625884317547;5759.280089988752;5762.654240745527;5852.092925596539;5852.67810270435;6182.350853160443;6233.283172435137;6301.40136687014;6321.051842223703;6409.583377080521;6553.541252112354;6612.2726500084955;6624.503162262849;6656.667166641697;6691.063251144795;6730.966345168292;6733.4276586490205;6751.392374686302;6863.725450981955;6865.450763938923;6283.120363149163;6342.207224096988;6357.809265722036;6364.554481186273;6365.872682546323;6883;6935.202451718016;6940.583564986117;6960.512764106566;7002.159740831133;6424.775132870327;6578.210614726264;6615.040819081302;6718.126643536309;6728.9570116632;6715.597064176165;6722.428593569602;6726.697298621574;6762.594244345355;6837.179538455417;6690.59856408617;6748.831279218059;6763.391294783493;6783.084283621648;6793;6721.966390168018;6776.966115169491;6836.93163068363;6839.555428897106;6874.450043996569;5281.683099013994;5297.5232229099565;5309.805293808862;5343.3587969443915;5398.13629819227;4471.329300604935;4596.195665758479;4604.286335617984;4606.976965115153;4614.054118905617;5692.6299790513485;5732.054211055212;5758.078707406795;5759.222504961776;5768.509676677446;6767.323267673291;6795.18457785059;6833.111695479556;6862.897056544156;6865.691043903036;5808.332041815161;5808.361080281165;5829.795957141479;5840.3575606683235;5861.794837180678;5742.799002034993;5763.221965034667;5854.502367298827;5869.325027621793;5876.941230587725;6383.457406120532;6507.6746162692625;6527.379898909596;6542.607443553402;6641.203055633355;6700.430463410567;6789.219239787389;6792.864142717019;6801.217859945971;6811.625360605214;6537.378948999837;6579.703913323816;6639.070530125883;6658.83352916181;6660.467162627075;6360.522960777867;6624.701888414937;6653.868842296918;6661.433778128913;6685.933140668531;6716.597004179765;6750.6624668767345;6752.797416077526;6790.151231096113;6795.354441328066;6424.807255782334;6470.773522926675;6474.125992991075;6492.64290464029;6522.412982831378;6451.612903225821;6484.221893372825;6551.082848401133;6551.80344589663;6577.309382514767;6475.3200913903365;6501.4798816095545;6520.934790652223;6552.508561857784;6591.373819487141;6593.439557637655;6607.933920660732;6668.233153187445;6678.666066696548;6686.83282917931;6216.409441103088;6340.4293613575;6359.459445947146;6416.7754128605275;6447.806565803034 03:54:23 INFO - PID 6052 | |1;ext.html;880.7225723896972;893.6916763716515;897.1073781587321;903.0788595632459;905.1536813079771;37694.434583481234;38530.61469385309;41053.384199237;41791.58208417922;41961.37057944133;37629.43555846665;38281;38454.61545384545;38479.23041539168;38617.42073868894;7241;7356.080489938758;7372.74195403161;7373.004644373022;7379.225181355961;7777.222277772205;7970.721024764134;8007.279344858962;8018.9198108019045;8056.154103819103;7941.682332706685;7973.521588704667;8016.238457346542;8021.358291336679;8043.638036288381;7758.456908016441;7928.326092282163;7984.321332686729;8047.436679432412;8079.434439589231;7742.341900938427;7944.880826787603;7956.085050219241;7967.880481792778;7983.5209887406945;37475.62524374776;38233.61766382329;38237.61762382368;38372.616273837186;38418.42372364417;3524.365614189445;3603.9908825528632;3606.801625910574;3612.9638703613155;3623.800690961996;30465.847670761505;30957.380852383052;30963.690363096306;31135.22161945947;31300.686993130006;5147.974260128713;5173.948260517422;5189.844304670866;5220.9738951305;5221.921671174935;186211;186389;186780;187254.99999999863;187638;42020;42856.78571607122;47097.29354059692;47698;47851.76074119677;45093;51363.743181284604;51751.74124129355;51835.48164518306;52346.47653523492;15031.323590438456;15084.698306033817;15130.848691513163;15200.087994720352;15292.694146117237;12090.214136081127;12117.333546655018;12182.634520964386;12202.084843636763;12250.019998400106;13950.93024534891;14131.293435328193;14203.715925681428;14220;14259;5787.681677507693;5829.271341082364;5874.823755287348;5941.168236446901;5974.2233509643465;990.8018396320765;1009.6264382178641;1023.7747695506977;1027.547878933282;1027.6043723166486;22652.773472265068;22701.09195632156;22896.771032289464;23011.309660710205;23037.7696223039;1129.1587767113554;1131.8868113188614;1132.9660110196708;1136.9943150284196;1145.6104924325602;12004.399780010965;12168.81746773799;12298.508059677692;12309.322987235788;12397.318147501974;213407;213963.79054314198;214341;216638;216712;52174.73912630413;52649.2102618461;52669.47330526646;52675;52753;1450.2168828832523;1476.8690376402096;1477.6749115194425;1484.621421537501;1492.1121932450176;22192;22235.665255147975;22356.105755769586;22456.326310210065;22622.66066009044;37207.25585488329;37539.43690844585;37584.24831503409;37604.623953761205;37800.81099594484;183046;183944;185215;186193;186252;30627.54058689077;31180;31197.8440107798;31312.843435782674;34071.48892766561;37423.812880935424;37490.062748431505;37629.247415050995;41390;42945;32028;32028.5195722069;32175.678243218204;32248.83875580607;32357.676423235465;31437.528437073004;31441.21396965094;31583.684163158076;32002.83998579992;32319.192020199684;35410;35686.464703028956;35856.10359741027;36128.4580731284;36348.45477317895;30642.693573063985;30897.691023089483;31013.689863101983;31397.372052559276;31559;22909;22965.88517057404;22981.965811538186;23026.76973230313;23347.182848600216 03:54:23 INFO - PID 6052 | |2;jquery.html;582.551435394746;589.4812564942853;595.2737660054731;600.8618017855894;620.7703149834562;22364.88817555912;23162.42093947652;23281.417964550896;23308.300750977498;23309.067637294487;23555.057797688114;24326.391840204004;24857.751422485813;24892.87553562234;24947.50104997899;6558.409743123118;6608.2070151581875;6628.536002479828;6681.064650948871;6683.966580167093;6426.357364263583;6567.113439685629;6699.765508207213;6710.664466776666;6725.798226053226;6604.834879128036;6611.272759996396;6634.5024123190715;6649.168853893263;6692.732290708366;6618.569792963466;6624.53628246023;6639.502037347218;6642.501812364092;6677.165354330708;6142.723577439026;6170.81487555374;6180.84547886302;6203.100550420164;6204.255489341308;27963;28218.976862237763;28511.57232641512;28630.570541441895;29084.854575727197;2064.6799746039387;2104.053176070759;2112.039022244875;2118.078635793435;2118.798714122156;18568;18968.336108236144;19154.616907661908;19179.136938837786;19194.712079318822;2382.571166750432;2407.7231118421255;2443.6701045358827;2460.8892599833052;2462.101333013455;118906;124616;124652.37673811664;137858;143041;14569.053011554215;14743.96792224534;14894.510548945018;14903.175678367863;15055.473058442902;23105.3068407948;23413.180538681405;23447.765522344558;23499.647505287434;23546.293611191693;9359.34484586086;9446.811063778687;9482.668106616235;9564.18704410119;9573.18627916635;8369;8373.665053397917;8524;8547.572621368907;8600.827983440297;8658.87011694825;8791.164839340252;8797.956010220036;8901.955490222508;8938.86591701125;2659.4814011268004;2686.6238726578295;2728.9044883428983;2741.6572928383953;2901.405211931549;963.3882484622176;970.7962126962516;983.8130755156498;985.019905194322;986.9259805514615;18760.906195468935;18890.905545472186;19090.2363905445;19498.70751938722;19724.211031558578;1019.0471908765328;1031.5564307347763;1043.0768769638773;1044.0864243786687;1049.1397054415459;10270.281080324456;10331.431771252503;10811.297265677706;10877;10975;446708;467237;471665;474225;483681;110793.44603277094;111113;111977.44011279891;112945;116118;1162.3723189477587;1165.4289398194824;1172.4196522721309;1179.8525184351784;1185.3065956415421;17119.57201069983;17230.483085507454;17274.309027638752;17485.21316540733;17695.02677352758;53059.63323387013;55182;55772.163417547956;56076.43923560712;56913.43086569081;72061;72132;73258;73553.26446735465;73603;14232.573022809333;14412;14458.855411446171;14494.637634059232;14567.417303308173;22086.558268834855;22364.664530031736;22577.983990720786;22609.886950565142;23022.07911683581;18198.36305729346;18271;18310.35913743066;18410.723839142156;18437.354692585694;16146.919265403598;16169.353225870833;16427.753583696493;16547.917260413622;17083.91458042702;18135.546611334295;18190.090495475437;18190.90904545469;18211.54471138232;18404.26382944667;14077.859221408065;14115.717685646436;14222.928885355506;14253.35859886287;14302;17716.11419429049;17745.822541774418;17795;17806.554836129202;17980.91009544944 03:54:23 INFO - PID 6052 | |3;mootools.html;1314.7041915568996;1356.226950638136;1364.6861221918964;1365.0922136779036;1386.1960063163367;15175.620609484768;15774.605634859134;15906.443274485395;15924.442644507459;15925.44260950867;15549.144797036186;15674.608134796636;15675.372985080612;15685.372585096582;15701.764473532907;2645.907393241232;2723.9591406128925;2733.4669739400824;2756.54517004694;2784.6379970603793;2756.145594865598;2798.8880444782185;2820.4218135282217;2822.2238884306776;2823.68939416664;2644.9471010579778;2675.973240267602;2762.047093752662;2769.3353595137223;2785.2897511134634;2629.18495266468;2648.72188420216;2660.1221596873083;2663.5605125154325;2664.5070661927607;2589.2750029991635;2661.4144888124583;2662.2811840802874;2691.1119330621045;2693.111273279813;14905.105693658415;14964.326605302787;14972;15031.248437578077;15031.774523382159;8185.017797864294;8529.65881364751;8535.061143274235;8540.44487108336;8549.059603443617;5364.785408583691;5452.482014208644;5461.781528738846;5596.356419011825;5603.215549823028;1970.4187264756931;1971.7633883933877;2027.4221846773598;2034.735484387035;2060.81452669259;26842.328941776417;26849;26957.32606684829;26959.191224263304;27055.86472067647;6914.9308506915295;7353.669084891193;7624.58064806441;7636.274553917369;7693.846123077507;17701.114944252735;17801.287948482175;17876.19557119933;17944;17986.730199047026;7948.205179482005;8032.839343213103;8072.515649060958;8076.515409075474;8134;7565.356944659766;7589.089309282811;7666.080070391588;7674.53952762836;7734.961325193338;5252.684838909678;5275.973620131875;5360.91958620621;5366.946330536723;5394.973025134849;1454.5854431486975;1483.6216764724927;1492.5895378770924;1493.6340596553914;1505.111983929465;863.6631713631689;873.7640836973982;880.6257340630207;896.0457113174448;897.5915958238986;7543.47195696296;7547.8113047173165;7658.693652253847;7659.310662040443;7669.174434753074;728.7813655903208;732.3591857125016;741.4661443760484;743.3904198557132;755.758157389641;4662.6269898408045;4783.832565860248;4794.520547945178;4850.708957462563;5077.746112694351;19661;20047.59904801925;20315.288964886156;21165.89417052905;21855.781442185693;21001.579968400547;21823.67264491034;21913.233036843954;22569.548609028057;22597.887010564842;11097.778044439066;11215.66353009411;11282.717932051764;11387.544498220144;11542.884571154349;7837.373010159287;8591.527465989431;8652.697155599524;8702.521361325187;8745.781355466164;18644.161012754186;18835.340763073225;19379.709304360727;19710.310139145062;20018.19927202954;19606.60786784285;19845.30541431043;20128.899355503716;20294.289699860434;20477.283295084602;10582.947085264525;11318.60384886558;11401.885981140082;11439.970402663801;11504.424778761197;14128.50550230737;14281;14310.785338219726;14312.284385780878;14401;11566.537338506365;11887.583934562248;11957.820632690342;11962.282263064244;11991.460384282555;10988.120950323795;11488.655340339803;11535.192536522363;11586.073114150679;11833.881661183277;10149.64476243328;10287.43419111926;10364.481775911325;10367.377957322586;10441.955804419802;7401.5189012714;7574.394048476219;7584.2794934481135;7650.158482567024;7700.383969282556;7505.286997735207;7518.661660225413;7545.50954187976;7605.505642133244;7637.159912409519 03:54:23 INFO - PID 6052 | |4;prototype.html;503.700298322498;522.2583930818238;537.2746791831029;541.7589172818098;543.1120118606078;6158.538109641778;6192.845178870531;6223.1598734170875;6236.9085410053285;6285.994240921442;6055.666938318391;6057.303410107839;6075.4458641694555;6124;6164.167837341957;5069.594432445396;5115.514026167527;5126.385188665577;5161.509656582619;5161.5870730341485;4846.9030619387595;5132.332796736419;5155.639105262633;5199.922001169985;5205.297284866532;4880.243562247857;4922.409310882681;4942.604591632661;4949.50504949504;4989.276554899538;4942.456329803718;4959;4973.3286006389035;4997.075541024904;5005.749712514396;4412.867613971586;4437.866863994085;4504.864854054384;4506.752128632924;4516;5801.53587712982;5968;6023.518118550505;6098.573099882966;6148.44663980244;5619.4099619540175;5661.5187709044785;5707.229524014247;5755.618651523604;5764.798232061858;6323.841903952438;6481.513886458534;6496.733137038279;6524.543281970264;6587.703553340111;4697.3893393858925;4877.780499877514;4898.657094003421;4916.532929371704;4920.581750551208;6633.7346506140175;6778.169894128558;6790.422814060811;6827.351401616838;6833.111695479605;5419.972900135474;5458.6330935251635;5489.725513724298;5492.368377636543;5513.61404701667;5490.670559766427;5561.998840208801;5567.777288908398;5585.3297604287745;5589.441055894378;5873;5896.49639341965;5929.288485381781;5972.462478376967;5973.701314934236;6531.967340163269;6587.6047437152965;6607.753363856312;6618.768343107968;6627.1716035495565;1913.3016448996016;1925.6245032218862;1941.553442708185;1941.679622862212;1943.6112777444569;1393.8188035555313;1410.6598731205395;1416.3201663201721;1443.5669299210194;1464.2678660669665;5559.6664200148125;5607.009511623397;5639.436056394327;5658.405867383948;5659.518940890071;6447.742090316335;6542.476601871934;6550.213974323112;6575.375339342755;6627.86744265112;5577.972110139504;5596.132599447093;5597;5619.960307343154;5661.858453538694;3350.2461946062426;3398.065531978676;3410.437277849127;3455.7926524408617;3487.337405892872;6337.429631333202;6371.267304259976;6421.5825971311715;6442.452391546677;6449.96775016122;6594.670266486656;6653.600783952978;6683.128723957299;6753.797386078426;6785;6370.662160946254;6426.74293028283;6431.614103153825;6461.643054958417;6480.287168411471;6632.867342653023;6664.83337916556;6690.431313338226;6692;6692.431143352869;6453.901772374482;6506.397441023629;6591.439727623206;6624.370684784938;6629.2044954603825;6261.592996455216;6436.499135872896;6446.194225721785;6475.805725828232;6533.575317604341;5343.385510666323;5359.249705041219;5385.2460655507475;5432.18517222404;5469.2616496772425;6229.345918678655;6359.332270111571;6505.154329937078;6624.536282460182;6724.327567243236;6375.330590288138;6377;6404.359564043559;6458.709358078804;6511.544191906521;6375.489960803217;6403.231612206565;6473.676316184078;6527.9020814688765;6546.18172728409;6339.541905361885;6388.1695379602215;6404.263509696259;6421.197350331208;6455.515836312389;6410.846047711457;6560.770373036921;6567.802965911031;6569.671516424064;6635.369639884203;6261.154744109487;6340.619562826245;6345.238571371465;6351.333110023381;6443.2590252119735 03:54:23 INFO - PID 6052 | |5;yui.html;888.8577827547591;904.3127223310282;926.4348747264168;927.2998885841189;933.9159475647192;19579.216831326747;20412.183512659496;20458;20536.486587835312;20643.380698579065;18251.36120235792;18429;18672.62654746904;19224.61550768984;19323.516912077204;962.7833737409079;980.8234517786796;983.1348413396237;984.0749695286444;989.7921436498344;989.7723523589578;990.7572644702058;997.6857289953678;999.48526508848;999.9700308682033;1005.140604782911;1029.7065336379133;1034.3690348887174;1035.30634474902;1037.1288117980932;1012.5342342522448;1022.6420752736557;1025.2208321675544;1026.856240126383;1026.8613737145502;731;757.1822431773671;762.0702742653954;762.7559181062062;762.8436170585016;20589.897050514803;20654.58690826175;20666.276680316118;20690;20827.479313017146;21236.893815530977;21436.03537840801;21914;22297.44256393587;22413.103475860946;16197.91901040499;16265;16363.918180409022;16440.83559164405;16545.25546350417;3569.1969306906;3571.2678900825267;3571.4285714285847;3615.1504396466808;3616.981915090434;137591.31204344015;137929;140435;142230;143777;16821.327146913987;16830.983813683288;16896.662066758596;17013.659726805643;17104.657906841792;30665.540016899766;31612.209694757814;31621;31943.840280798446;32107.83946080255;8722.738317850475;8735.563221838882;8749.737507874774;8778.429402088972;8781.648734050694;4027.718059735849;4049.8582549610624;4065.1463192729266;4100;4100.5489396166395;5242.68543887368;5324.973375133177;5336.546393556514;5364.061289274361;5368.302120724281;988.545269176187;1013.4476710192963;1021.2748948246827;1032.7624646331385;1035.0270745499206;635.3487675133026;640.9743610255631;644.8581312111328;659.8449364399362;666.0375757031044;10896.291741036806;11054.834177487344;11386.886131138748;11485.827712584318;11995.100367472474;670.5272782688193;672.8015235505537;686.993130068693;687.2680595166132;696.6481926627021;5385.461453854661;5396.19057141424;5396.946030539723;5413.431589683105;5548.361938377138;111756.59610178114;114879;115035.42482287536;118719.40640296743;119859.40070299768;102419;103834;104645.47677261717;105989.47005264924;106429.46785266024;88086;92041;92301.53849230711;92531;95025.99999999862;9918.900810992087;10025.598976041168;10034.397936123856;10099.94950025245;10263.640772572924;43384.783076084415;44180.558194417645;44421.33367999547;44492.33261501145;45766.084678306914;57363.42636573581;57821.132683010626;58688.119678204006;58948.41051589601;59508.10737838849;14897.106173629616;15013.17427541452;15107.093574385133;15124.848751512343;15334.233288335316;17243.7413438796;17249.223784929458;17350.5662358437;17484.650306993535;17809.46571602854;15398.230088495306;15427.691446171239;15431.922840385727;15458.227088645748;15671.451499197474;15888.92055539715;16314.510564683078;16387.098709571088;16393.59016024609;16613.169341532634;15330.616734581725;15335.923320383326;15349.309281082154;15357.84642153609;15537.84462155364;12180.756384872077;12330.205818670587;12388;12646.936765316115;12670.049746269251;11674.824877627012;11780.410979451164;11838.881611183779;11890.167688262085;11981.700457488632 03:54:23 INFO - PID 6052 | __end_tp_report 03:54:23 INFO - PID 6052 | __start_cc_report 03:54:23 INFO - PID 6052 | _x_x_mozilla_cycle_collect,291 03:54:23 INFO - PID 6052 | __end_cc_report 03:54:23 INFO - PID 6052 | __startTimestamp1506596062993__endTimestamp 03:54:23 INFO - PID 6052 | 03:54:23 INFO - PID 6052 | ------- Summary: start ------- 03:54:23 INFO - PID 6052 | Number of tests: 6 03:54:23 INFO - PID 6052 | 03:54:23 INFO - PID 6052 | [#0] dojo.html Cycles:165 Average:6199.57 Median:6424.81 stddev:744.01 (11.6%) stddev-sans-first:706.16 03:54:23 INFO - PID 6052 | Values: 3126.4 3145.0 3203.7 3212.9 3219.8 6185.1 6287.7 6293.3 6365.2 6368.1 6091.8 6215.3 6235.9 6269.5 6289.9 5699.3 5770.1 5781.0 5801.4 5814.1 5859.8 5862.8 5912.5 5925.1 5946.6 5602.6 5799.0 5825.1 5842.0 5859.8 5722.7 5723.1 5768.1 5779.0 5882.8 5755.6 5759.3 5762.7 5852.1 5852.7 6182.4 6233.3 6301.4 6321.1 6409.6 6553.5 6612.3 6624.5 6656.7 6691.1 6731.0 6733.4 6751.4 6863.7 6865.5 6283.1 6342.2 6357.8 6364.6 6365.9 6883.0 6935.2 6940.6 6960.5 7002.2 6424.8 6578.2 6615.0 6718.1 6729.0 6715.6 6722.4 6726.7 6762.6 6837.2 6690.6 6748.8 6763.4 6783.1 6793.0 6722.0 6777.0 6836.9 6839.6 6874.5 5281.7 5297.5 5309.8 5343.4 5398.1 4471.3 4596.2 4604.3 4607.0 4614.1 5692.6 5732.1 5758.1 5759.2 5768.5 6767.3 6795.2 6833.1 6862.9 6865.7 5808.3 5808.4 5829.8 5840.4 5861.8 5742.8 5763.2 5854.5 5869.3 5876.9 6383.5 6507.7 6527.4 6542.6 6641.2 6700.4 6789.2 6792.9 6801.2 6811.6 6537.4 6579.7 6639.1 6658.8 6660.5 6360.5 6624.7 6653.9 6661.4 6685.9 6716.6 6750.7 6752.8 6790.2 6795.4 6424.8 6470.8 6474.1 6492.6 6522.4 6451.6 6484.2 6551.1 6551.8 6577.3 6475.3 6501.5 6520.9 6552.5 6591.4 6593.4 6607.9 6668.2 6678.7 6686.8 6216.4 6340.4 6359.5 6416.8 6447.8 03:54:23 INFO - PID 6052 | 03:54:23 INFO - PID 6052 | [#1] ext.html Cycles:180 Average:36190.29 Median:35548.23 stddev:50702.84 (142.6%) stddev-sans-first:50775.75 03:54:23 INFO - PID 6052 | Values: 880.7 893.7 897.1 903.1 905.2 37694.4 38530.6 41053.4 41791.6 41961.4 37629.4 38281.0 38454.6 38479.2 38617.4 7241.0 7356.1 7372.7 7373.0 7379.2 7777.2 7970.7 8007.3 8018.9 8056.2 7941.7 7973.5 8016.2 8021.4 8043.6 7758.5 7928.3 7984.3 8047.4 8079.4 7742.3 7944.9 7956.1 7967.9 7983.5 37475.6 38233.6 38237.6 38372.6 38418.4 3524.4 3604.0 3606.8 3613.0 3623.8 30465.8 30957.4 30963.7 31135.2 31300.7 5148.0 5173.9 5189.8 5221.0 5221.9 186211.0 186389.0 186780.0 187255.0 187638.0 42020.0 42856.8 47097.3 47698.0 47851.8 45093.0 51363.7 51751.7 51835.5 52346.5 15031.3 15084.7 15130.8 15200.1 15292.7 12090.2 12117.3 12182.6 12202.1 12250.0 13950.9 14131.3 14203.7 14220.0 14259.0 5787.7 5829.3 5874.8 5941.2 5974.2 990.8 1009.6 1023.8 1027.5 1027.6 22652.8 22701.1 22896.8 23011.3 23037.8 1129.2 1131.9 1133.0 1137.0 1145.6 12004.4 12168.8 12298.5 12309.3 12397.3 213407.0 213963.8 214341.0 216638.0 216712.0 52174.7 52649.2 52669.5 52675.0 52753.0 1450.2 1476.9 1477.7 1484.6 1492.1 22192.0 22235.7 22356.1 22456.3 22622.7 37207.3 37539.4 37584.2 37604.6 37800.8 183046.0 183944.0 185215.0 186193.0 186252.0 30627.5 31180.0 31197.8 31312.8 34071.5 37423.8 37490.1 37629.2 41390.0 42945.0 32028.0 32028.5 32175.7 32248.8 32357.7 31437.5 31441.2 31583.7 32002.8 32319.2 35410.0 35686.5 35856.1 36128.5 36348.5 30642.7 30897.7 31013.7 31397.4 31559.0 22909.0 22965.9 22982.0 23026.8 23347.2 03:54:23 INFO - PID 6052 | 03:54:23 INFO - PID 6052 | [#2] jquery.html Cycles:180 Average:33681.44 Median:23361.12 stddev:79013.58 (338.2%) stddev-sans-first:79196.15 03:54:23 INFO - PID 6052 | Values: 582.6 589.5 595.3 600.9 620.8 22364.9 23162.4 23281.4 23308.3 23309.1 23555.1 24326.4 24857.8 24892.9 24947.5 6558.4 6608.2 6628.5 6681.1 6684.0 6426.4 6567.1 6699.8 6710.7 6725.8 6604.8 6611.3 6634.5 6649.2 6692.7 6618.6 6624.5 6639.5 6642.5 6677.2 6142.7 6170.8 6180.8 6203.1 6204.3 27963.0 28219.0 28511.6 28630.6 29084.9 2064.7 2104.1 2112.0 2118.1 2118.8 18568.0 18968.3 19154.6 19179.1 19194.7 2382.6 2407.7 2443.7 2460.9 2462.1 118906.0 124616.0 124652.4 137858.0 143041.0 14569.1 14744.0 14894.5 14903.2 15055.5 23105.3 23413.2 23447.8 23499.6 23546.3 9359.3 9446.8 9482.7 9564.2 9573.2 8369.0 8373.7 8524.0 8547.6 8600.8 8658.9 8791.2 8798.0 8902.0 8938.9 2659.5 2686.6 2728.9 2741.7 2901.4 963.4 970.8 983.8 985.0 986.9 18760.9 18890.9 19090.2 19498.7 19724.2 1019.0 1031.6 1043.1 1044.1 1049.1 10270.3 10331.4 10811.3 10877.0 10975.0 446708.0 467237.0 471665.0 474225.0 483681.0 110793.4 111113.0 111977.4 112945.0 116118.0 1162.4 1165.4 1172.4 1179.9 1185.3 17119.6 17230.5 17274.3 17485.2 17695.0 53059.6 55182.0 55772.2 56076.4 56913.4 72061.0 72132.0 73258.0 73553.3 73603.0 14232.6 14412.0 14458.9 14494.6 14567.4 22086.6 22364.7 22578.0 22609.9 23022.1 18198.4 18271.0 18310.4 18410.7 18437.4 16146.9 16169.4 16427.8 16547.9 17083.9 18135.5 18190.1 18190.9 18211.5 18404.3 14077.9 14115.7 14222.9 14253.4 14302.0 17716.1 17745.8 17795.0 17806.6 17980.9 03:54:23 INFO - PID 6052 | 03:54:23 INFO - PID 6052 | [#3] mootools.html Cycles:180 Average:9507.38 Median:2660.77 stddev:6799.79 (255.6%) stddev-sans-first:6791.00 03:54:23 INFO - PID 6052 | Values: 1314.7 1356.2 1364.7 1365.1 1386.2 15175.6 15774.6 15906.4 15924.4 15925.4 15549.1 15674.6 15675.4 15685.4 15701.8 2645.9 2724.0 2733.5 2756.5 2784.6 2756.1 2798.9 2820.4 2822.2 2823.7 2644.9 2676.0 2762.0 2769.3 2785.3 2629.2 2648.7 2660.1 2663.6 2664.5 2589.3 2661.4 2662.3 2691.1 2693.1 14905.1 14964.3 14972.0 15031.2 15031.8 8185.0 8529.7 8535.1 8540.4 8549.1 5364.8 5452.5 5461.8 5596.4 5603.2 1970.4 1971.8 2027.4 2034.7 2060.8 26842.3 26849.0 26957.3 26959.2 27055.9 6914.9 7353.7 7624.6 7636.3 7693.8 17701.1 17801.3 17876.2 17944.0 17986.7 7948.2 8032.8 8072.5 8076.5 8134.0 7565.4 7589.1 7666.1 7674.5 7735.0 5252.7 5276.0 5360.9 5366.9 5395.0 1454.6 1483.6 1492.6 1493.6 1505.1 863.7 873.8 880.6 896.0 897.6 7543.5 7547.8 7658.7 7659.3 7669.2 728.8 732.4 741.5 743.4 755.8 4662.6 4783.8 4794.5 4850.7 5077.7 19661.0 20047.6 20315.3 21165.9 21855.8 21001.6 21823.7 21913.2 22569.5 22597.9 11097.8 11215.7 11282.7 11387.5 11542.9 7837.4 8591.5 8652.7 8702.5 8745.8 18644.2 18835.3 19379.7 19710.3 20018.2 19606.6 19845.3 20128.9 20294.3 20477.3 10582.9 11318.6 11401.9 11440.0 11504.4 14128.5 14281.0 14310.8 14312.3 14401.0 11566.5 11887.6 11957.8 11962.3 11991.5 10988.1 11488.7 11535.2 11586.1 11833.9 10149.6 10287.4 10364.5 10367.4 10442.0 7401.5 7574.4 7584.3 7650.2 7700.4 7505.3 7518.7 7545.5 7605.5 7637.2 03:54:23 INFO - PID 6052 | 03:54:23 INFO - PID 6052 | [#4] prototype.html Cycles:180 Average:5519.19 Median:6087.01 stddev:1485.47 (24.4%) stddev-sans-first:1441.15 03:54:23 INFO - PID 6052 | Values: 503.7 522.3 537.3 541.8 543.1 6158.5 6192.8 6223.2 6236.9 6286.0 6055.7 6057.3 6075.4 6124.0 6164.2 5069.6 5115.5 5126.4 5161.5 5161.6 4846.9 5132.3 5155.6 5199.9 5205.3 4880.2 4922.4 4942.6 4949.5 4989.3 4942.5 4959.0 4973.3 4997.1 5005.7 4412.9 4437.9 4504.9 4506.8 4516.0 5801.5 5968.0 6023.5 6098.6 6148.4 5619.4 5661.5 5707.2 5755.6 5764.8 6323.8 6481.5 6496.7 6524.5 6587.7 4697.4 4877.8 4898.7 4916.5 4920.6 6633.7 6778.2 6790.4 6827.4 6833.1 5420.0 5458.6 5489.7 5492.4 5513.6 5490.7 5562.0 5567.8 5585.3 5589.4 5873.0 5896.5 5929.3 5972.5 5973.7 6532.0 6587.6 6607.8 6618.8 6627.2 1913.3 1925.6 1941.6 1941.7 1943.6 1393.8 1410.7 1416.3 1443.6 1464.3 5559.7 5607.0 5639.4 5658.4 5659.5 6447.7 6542.5 6550.2 6575.4 6627.9 5578.0 5596.1 5597.0 5620.0 5661.9 3350.2 3398.1 3410.4 3455.8 3487.3 6337.4 6371.3 6421.6 6442.5 6450.0 6594.7 6653.6 6683.1 6753.8 6785.0 6370.7 6426.7 6431.6 6461.6 6480.3 6632.9 6664.8 6690.4 6692.0 6692.4 6453.9 6506.4 6591.4 6624.4 6629.2 6261.6 6436.5 6446.2 6475.8 6533.6 5343.4 5359.2 5385.2 5432.2 5469.3 6229.3 6359.3 6505.2 6624.5 6724.3 6375.3 6377.0 6404.4 6458.7 6511.5 6375.5 6403.2 6473.7 6527.9 6546.2 6339.5 6388.2 6404.3 6421.2 6455.5 6410.8 6560.8 6567.8 6569.7 6635.4 6261.2 6340.6 6345.2 6351.3 6443.3 03:54:23 INFO - PID 6052 | 03:54:23 INFO - PID 6052 | [#5] yui.html Cycles:180 Average:23977.25 Median:20497.24 stddev:34459.61 (168.1%) stddev-sans-first:34512.67 03:54:23 INFO - PID 6052 | Values: 888.9 904.3 926.4 927.3 933.9 19579.2 20412.2 20458.0 20536.5 20643.4 18251.4 18429.0 18672.6 19224.6 19323.5 962.8 980.8 983.1 984.1 989.8 989.8 990.8 997.7 999.5 1000.0 1005.1 1029.7 1034.4 1035.3 1037.1 1012.5 1022.6 1025.2 1026.9 1026.9 731.0 757.2 762.1 762.8 762.8 20589.9 20654.6 20666.3 20690.0 20827.5 21236.9 21436.0 21914.0 22297.4 22413.1 16197.9 16265.0 16363.9 16440.8 16545.3 3569.2 3571.3 3571.4 3615.2 3617.0 137591.3 137929.0 140435.0 142230.0 143777.0 16821.3 16831.0 16896.7 17013.7 17104.7 30665.5 31612.2 31621.0 31943.8 32107.8 8722.7 8735.6 8749.7 8778.4 8781.6 4027.7 4049.9 4065.1 4100.0 4100.5 5242.7 5325.0 5336.5 5364.1 5368.3 988.5 1013.4 1021.3 1032.8 1035.0 635.3 641.0 644.9 659.8 666.0 10896.3 11054.8 11386.9 11485.8 11995.1 670.5 672.8 687.0 687.3 696.6 5385.5 5396.2 5396.9 5413.4 5548.4 111756.6 114879.0 115035.4 118719.4 119859.4 102419.0 103834.0 104645.5 105989.5 106429.5 88086.0 92041.0 92301.5 92531.0 95026.0 9918.9 10025.6 10034.4 10099.9 10263.6 43384.8 44180.6 44421.3 44492.3 45766.1 57363.4 57821.1 58688.1 58948.4 59508.1 14897.1 15013.2 15107.1 15124.8 15334.2 17243.7 17249.2 17350.6 17484.7 17809.5 15398.2 15427.7 15431.9 15458.2 15671.5 15888.9 16314.5 16387.1 16393.6 16613.2 15330.6 15335.9 15349.3 15357.8 15537.8 12180.8 12330.2 12388.0 12646.9 12670.0 11674.8 11780.4 11838.9 11890.2 11981.7 03:54:23 INFO - PID 6052 | -------- Summary: end -------- 03:54:23 INFO - PID 6052 | 03:54:23 INFO - TEST-INFO | 6052: exit 0 03:54:23 INFO - TEST-OK | dromaeo_css | took 1111579ms 03:54:23 INFO - TEST-START | kraken 03:54:23 INFO - Initialising browser for kraken test... 03:54:23 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59886/getInfo.html -profile /tmp/tmppgb2ri/profile 03:54:23 INFO - TEST-INFO | started process 6427 (/builds/slave/test/build/application/firefox/firefox http://localhost:59886/getInfo.html) 03:54:29 INFO - TEST-INFO | 6427: exit 0 03:54:29 INFO - Browser initialized. 03:54:29 INFO - Running cycle 1/1 for kraken test... 03:54:29 INFO - Using env: {'DISPLAY': ':0', 03:54:29 INFO - 'HOME': '/home/cltbld', 03:54:29 INFO - 'JSGC_DISABLE_POISONING': '1', 03:54:29 INFO - 'LANG': 'en_US.UTF-8', 03:54:29 INFO - 'LANGUAGE': 'en_US:en', 03:54:29 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:54:29 INFO - 'LOGNAME': 'cltbld', 03:54:29 INFO - 'MAIL': '/var/mail/cltbld', 03:54:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:54:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:54:29 INFO - 'MOZ_ACCELERATED': '1', 03:54:29 INFO - 'MOZ_CRASHREPORTER': '1', 03:54:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:29 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:54:29 INFO - 'MOZ_NO_REMOTE': '1', 03:54:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:54:29 INFO - 'MOZ_WEBRENDER': '1', 03:54:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:54:29 INFO - 'NO_EM_RESTART': '1', 03:54:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:54:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:29 INFO - 'PWD': '/builds/slave/test', 03:54:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:54:29 INFO - 'RUST_BACKTRACE': 'full', 03:54:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:54:29 INFO - 'SHELL': '/bin/bash', 03:54:29 INFO - 'SHLVL': '1', 03:54:29 INFO - 'TERM': 'linux', 03:54:29 INFO - 'TMOUT': '86400', 03:54:29 INFO - 'USER': 'cltbld', 03:54:29 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1506594886.379905-261782927', 03:54:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:29 INFO - '_': '/tools/buildbot/bin/python'} 03:54:29 INFO - TEST-INFO | started process 6671 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppgb2ri/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:54:30 INFO - PID 6671 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:54:30 INFO - PID 6671 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:54:30 INFO - PID 6671 | 03:54:30 INFO - PID 6671 | (/builds/slave/test/build/application/firefox/firefox:6729): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:54:30 INFO - PID 6671 | 03:54:40 INFO - PID 6671 | RSS: Main: 194400256 03:54:40 INFO - PID 6671 | 03:54:43 INFO - PID 6671 | Cycle 1(1): loaded http://localhost:59886/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59886/tests/kraken/driver.html?testName=audio-beat-detection) 03:54:44 INFO - PID 6671 | RSS: Main: 191082496 03:54:44 INFO - PID 6671 | 03:54:47 INFO - PID 6671 | Cycle 1(1): loaded http://localhost:59886/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59886/tests/kraken/driver.html?testName=audio-dft) 03:54:47 INFO - PID 6671 | RSS: Main: 190799872 03:54:47 INFO - PID 6671 | 03:54:50 INFO - PID 6671 | Cycle 1(1): loaded http://localhost:59886/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59886/tests/kraken/driver.html?testName=audio-fft) 03:54:51 INFO - PID 6671 | RSS: Main: 187977728 03:54:51 INFO - PID 6671 | 03:54:53 INFO - PID 6671 | Cycle 1(1): loaded http://localhost:59886/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59886/tests/kraken/driver.html?testName=audio-oscillator) 03:54:54 INFO - PID 6671 | RSS: Main: 188809216 03:54:54 INFO - PID 6671 | 03:54:56 INFO - PID 6671 | Cycle 1(1): loaded http://localhost:59886/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59886/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:54:57 INFO - PID 6671 | RSS: Main: 189018112 03:54:57 INFO - PID 6671 | 03:55:00 INFO - PID 6671 | Cycle 1(1): loaded http://localhost:59886/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59886/tests/kraken/driver.html?testName=imaging-darkroom) 03:55:01 INFO - PID 6671 | RSS: Main: 191528960 03:55:01 INFO - PID 6671 | 03:55:04 INFO - PID 6671 | Cycle 1(1): loaded http://localhost:59886/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59886/tests/kraken/driver.html?testName=imaging-desaturate) 03:55:05 INFO - PID 6671 | RSS: Main: 190791680 03:55:05 INFO - PID 6671 | 03:55:08 INFO - PID 6671 | Cycle 1(1): loaded http://localhost:59886/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59886/tests/kraken/driver.html?testName=json-parse-financial) 03:55:08 INFO - PID 6671 | RSS: Main: 191524864 03:55:08 INFO - PID 6671 | 03:55:10 INFO - PID 6671 | Cycle 1(1): loaded http://localhost:59886/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59886/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:55:11 INFO - PID 6671 | RSS: Main: 191303680 03:55:11 INFO - PID 6671 | 03:55:12 INFO - PID 6671 | Cycle 1(1): loaded http://localhost:59886/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59886/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:55:13 INFO - PID 6671 | RSS: Main: 188276736 03:55:13 INFO - PID 6671 | 03:55:15 INFO - PID 6671 | Cycle 1(1): loaded http://localhost:59886/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59886/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:55:16 INFO - PID 6671 | RSS: Main: 188764160 03:55:16 INFO - PID 6671 | 03:55:18 INFO - PID 6671 | Cycle 1(1): loaded http://localhost:59886/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59886/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:55:19 INFO - PID 6671 | RSS: Main: 188915712 03:55:19 INFO - PID 6671 | 03:55:22 INFO - PID 6671 | Cycle 1(1): loaded http://localhost:59886/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59886/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:55:23 INFO - PID 6671 | RSS: Main: 188981248 03:55:23 INFO - PID 6671 | 03:55:24 INFO - PID 6671 | Cycle 1(1): loaded http://localhost:59886/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59886/tests/kraken/driver.html?testName=ai-astar) 03:55:25 INFO - PID 6671 | RSS: Main: 190410752 03:55:25 INFO - PID 6671 | 03:55:25 INFO - PID 6671 | __start_tp_report 03:55:25 INFO - PID 6671 | _x_x_mozilla_page_load 03:55:25 INFO - PID 6671 | _x_x_mozilla_page_load_details 03:55:25 INFO - PID 6671 | |i|pagename|runs| 03:55:25 INFO - PID 6671 | |0;ai-astar;112;114;110;108;107;106;110;114;107;106 03:55:25 INFO - PID 6671 | |1;audio-beat-detection;132;127;127;127;124;125;125;122;116;119 03:55:25 INFO - PID 6671 | |2;audio-dft;163;161;167;172;164;163;166;167;166;173 03:55:25 INFO - PID 6671 | |3;audio-fft;75;74;74;76;77;76;77;73;73;80 03:55:25 INFO - PID 6671 | |4;audio-oscillator;87;86;80;89;78;78;79;80;79;85 03:55:25 INFO - PID 6671 | |5;imaging-gaussian-blur;115;115;127;120;113;114;118;113;115;116 03:55:25 INFO - PID 6671 | |6;imaging-darkroom;158;153;151;149;153;149;150;150;153;151 03:55:25 INFO - PID 6671 | |7;imaging-desaturate;98;98;100;93;96;95;97;97;94;102 03:55:25 INFO - PID 6671 | |8;json-parse-financial;62;54;60;52;52;61;51;56;52;52 03:55:25 INFO - PID 6671 | |9;json-stringify-tinderbox;44;47;45;45;40;42;41;37;39;48 03:55:25 INFO - PID 6671 | |10;stanford-crypto-aes;74;80;76;80;72;81;78;76;72;73 03:55:25 INFO - PID 6671 | |11;stanford-crypto-ccm;121;112;119;112;116;113;124;116;111;111 03:55:25 INFO - PID 6671 | |12;stanford-crypto-pbkdf2;166;168;172;166;187;167;162;161;168;165 03:55:25 INFO - PID 6671 | |13;stanford-crypto-sha256-iterative;71;64;64;63;62;64;65;63;69;63 03:55:25 INFO - PID 6671 | __end_tp_report 03:55:25 INFO - PID 6671 | __start_cc_report 03:55:25 INFO - PID 6671 | _x_x_mozilla_cycle_collect,745 03:55:25 INFO - PID 6671 | __end_cc_report 03:55:25 INFO - PID 6671 | __startTimestamp1506596125174__endTimestamp 03:55:25 INFO - PID 6671 | 03:55:25 INFO - PID 6671 | ------- Summary: start ------- 03:55:25 INFO - PID 6671 | Number of tests: 14 03:55:25 INFO - PID 6671 | 03:55:25 INFO - PID 6671 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:3.10 (2.8%) stddev-sans-first:3.14 03:55:25 INFO - PID 6671 | Values: 112.0 114.0 110.0 108.0 107.0 106.0 110.0 114.0 107.0 106.0 03:55:25 INFO - PID 6671 | 03:55:25 INFO - PID 6671 | [#1] audio-beat-detection Cycles:10 Average:124.40 Median:126.00 stddev:4.53 (3.6%) stddev-sans-first:3.88 03:55:25 INFO - PID 6671 | Values: 132.0 127.0 127.0 127.0 124.0 125.0 125.0 122.0 116.0 119.0 03:55:25 INFO - PID 6671 | 03:55:25 INFO - PID 6671 | [#2] audio-dft Cycles:10 Average:166.20 Median:166.50 stddev:3.85 (2.3%) stddev-sans-first:3.91 03:55:25 INFO - PID 6671 | Values: 163.0 161.0 167.0 172.0 164.0 163.0 166.0 167.0 166.0 173.0 03:55:25 INFO - PID 6671 | 03:55:25 INFO - PID 6671 | [#3] audio-fft Cycles:10 Average:75.50 Median:76.00 stddev:2.17 (2.9%) stddev-sans-first:2.30 03:55:25 INFO - PID 6671 | Values: 75.0 74.0 74.0 76.0 77.0 76.0 77.0 73.0 73.0 80.0 03:55:25 INFO - PID 6671 | 03:55:25 INFO - PID 6671 | [#4] audio-oscillator Cycles:10 Average:82.10 Median:82.50 stddev:4.18 (5.1%) stddev-sans-first:4.03 03:55:25 INFO - PID 6671 | Values: 87.0 86.0 80.0 89.0 78.0 78.0 79.0 80.0 79.0 85.0 03:55:25 INFO - PID 6671 | 03:55:25 INFO - PID 6671 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:115.50 stddev:4.25 (3.7%) stddev-sans-first:4.47 03:55:25 INFO - PID 6671 | Values: 115.0 115.0 127.0 120.0 113.0 114.0 118.0 113.0 115.0 116.0 03:55:25 INFO - PID 6671 | 03:55:25 INFO - PID 6671 | [#6] imaging-darkroom Cycles:10 Average:151.70 Median:152.00 stddev:2.71 (1.8%) stddev-sans-first:1.66 03:55:25 INFO - PID 6671 | Values: 158.0 153.0 151.0 149.0 153.0 149.0 150.0 150.0 153.0 151.0 03:55:25 INFO - PID 6671 | 03:55:25 INFO - PID 6671 | [#7] imaging-desaturate Cycles:10 Average:97.00 Median:96.50 stddev:2.71 (2.8%) stddev-sans-first:2.85 03:55:25 INFO - PID 6671 | Values: 98.0 98.0 100.0 93.0 96.0 95.0 97.0 97.0 94.0 102.0 03:55:25 INFO - PID 6671 | 03:55:25 INFO - PID 6671 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.00 stddev:4.26 (7.8%) stddev-sans-first:3.75 03:55:25 INFO - PID 6671 | Values: 62.0 54.0 60.0 52.0 52.0 61.0 51.0 56.0 52.0 52.0 03:55:25 INFO - PID 6671 | 03:55:25 INFO - PID 6671 | [#9] json-stringify-tinderbox Cycles:10 Average:42.80 Median:44.50 stddev:3.58 (8.1%) stddev-sans-first:3.77 03:55:25 INFO - PID 6671 | Values: 44.0 47.0 45.0 45.0 40.0 42.0 41.0 37.0 39.0 48.0 03:55:25 INFO - PID 6671 | 03:55:25 INFO - PID 6671 | [#10] stanford-crypto-aes Cycles:10 Average:76.20 Median:77.00 stddev:3.43 (4.4%) stddev-sans-first:3.54 03:55:25 INFO - PID 6671 | Values: 74.0 80.0 76.0 80.0 72.0 81.0 78.0 76.0 72.0 73.0 03:55:25 INFO - PID 6671 | 03:55:25 INFO - PID 6671 | [#11] stanford-crypto-ccm Cycles:10 Average:115.50 Median:116.00 stddev:4.55 (3.9%) stddev-sans-first:4.37 03:55:25 INFO - PID 6671 | Values: 121.0 112.0 119.0 112.0 116.0 113.0 124.0 116.0 111.0 111.0 03:55:25 INFO - PID 6671 | 03:55:25 INFO - PID 6671 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.20 Median:167.50 stddev:7.30 (4.4%) stddev-sans-first:7.70 03:55:25 INFO - PID 6671 | Values: 166.0 168.0 172.0 166.0 187.0 167.0 162.0 161.0 168.0 165.0 03:55:25 INFO - PID 6671 | 03:55:25 INFO - PID 6671 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:64.00 stddev:2.90 (4.5%) stddev-sans-first:2.03 03:55:25 INFO - PID 6671 | Values: 71.0 64.0 64.0 63.0 62.0 64.0 65.0 63.0 69.0 63.0 03:55:25 INFO - PID 6671 | -------- Summary: end -------- 03:55:25 INFO - PID 6671 | 03:55:25 INFO - PID 6671 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:55:25 INFO - TEST-INFO | 6671: exit 0 03:55:26 INFO - TEST-OK | kraken | took 62311ms 03:55:26 INFO - SUITE-END | took 1173s 03:55:26 INFO - Completed test suite (00:19:34) 03:55:26 INFO - javascript benchmark 03:55:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8483.930738279514, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3126.437241296567, 3144.9842750786247, 3203.6636153203913, 3212.9357412851746, 3219.790713603614, 6185.0722391641275, 6287.654179020158, 6293.30773614902, 6365.236171659401, 6368.140301059356, 6091.756329746816, 6215.254169499666, 6235.906461403071, 6269.49844012479, 6289.905651415233, 5699.316082070158, 5770.076787713967, 5781.0, 5801.419858014186, 5814.069748840187, 5859.7656093756195, 5862.794802181925, 5912.4974377178, 5925.081612350093, 5946.643201407929, 5602.579806514527, 5798.971005144968, 5825.097109947986, 5842.0, 5859.79490717825, 5722.685252311121, 5723.112917497794, 5768.134779783066, 5778.988676981511, 5882.764689412418, 5755.625884317547, 5759.280089988752, 5762.654240745527, 5852.092925596539, 5852.67810270435, 6182.350853160443, 6233.283172435137, 6301.40136687014, 6321.051842223703, 6409.583377080521, 6553.541252112354, 6612.2726500084955, 6624.503162262849, 6656.667166641697, 6691.063251144795, 6730.966345168292, 6733.4276586490205, 6751.392374686302, 6863.725450981955, 6865.450763938923, 6283.120363149163, 6342.207224096988, 6357.809265722036, 6364.554481186273, 6365.872682546323, 6883.0, 6935.202451718016, 6940.583564986117, 6960.512764106566, 7002.159740831133, 6424.775132870327, 6578.210614726264, 6615.040819081302, 6718.126643536309, 6728.9570116632, 6715.597064176165, 6722.428593569602, 6726.697298621574, 6762.594244345355, 6837.179538455417, 6690.59856408617, 6748.831279218059, 6763.391294783493, 6783.084283621648, 6793.0, 6721.966390168018, 6776.966115169491, 6836.93163068363, 6839.555428897106, 6874.450043996569, 5281.683099013994, 5297.5232229099565, 5309.805293808862, 5343.3587969443915, 5398.13629819227, 4471.329300604935, 4596.195665758479, 4604.286335617984, 4606.976965115153, 4614.054118905617, 5692.6299790513485, 5732.054211055212, 5758.078707406795, 5759.222504961776, 5768.509676677446, 6767.323267673291, 6795.18457785059, 6833.111695479556, 6862.897056544156, 6865.691043903036, 5808.332041815161, 5808.361080281165, 5829.795957141479, 5840.3575606683235, 5861.794837180678, 5742.799002034993, 5763.221965034667, 5854.502367298827, 5869.325027621793, 5876.941230587725, 6383.457406120532, 6507.6746162692625, 6527.379898909596, 6542.607443553402, 6641.203055633355, 6700.430463410567, 6789.219239787389, 6792.864142717019, 6801.217859945971, 6811.625360605214, 6537.378948999837, 6579.703913323816, 6639.070530125883, 6658.83352916181, 6660.467162627075, 6360.522960777867, 6624.701888414937, 6653.868842296918, 6661.433778128913, 6685.933140668531, 6716.597004179765, 6750.6624668767345, 6752.797416077526, 6790.151231096113, 6795.354441328066, 6424.807255782334, 6470.773522926675, 6474.125992991075, 6492.64290464029, 6522.412982831378, 6451.612903225821, 6484.221893372825, 6551.082848401133, 6551.80344589663, 6577.309382514767, 6475.3200913903365, 6501.4798816095545, 6520.934790652223, 6552.508561857784, 6591.373819487141, 6593.439557637655, 6607.933920660732, 6668.233153187445, 6678.666066696548, 6686.83282917931, 6216.409441103088, 6340.4293613575, 6359.459445947146, 6416.7754128605275, 6447.806565803034], "value": 6142.961283526678, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [880.7225723896972, 893.6916763716515, 897.1073781587321, 903.0788595632459, 905.1536813079771, 37694.434583481234, 38530.61469385309, 41053.384199237, 41791.58208417922, 41961.37057944133, 37629.43555846665, 38281.0, 38454.61545384545, 38479.23041539168, 38617.42073868894, 7241.0, 7356.080489938758, 7372.74195403161, 7373.004644373022, 7379.225181355961, 7777.222277772205, 7970.721024764134, 8007.279344858962, 8018.9198108019045, 8056.154103819103, 7941.682332706685, 7973.521588704667, 8016.238457346542, 8021.358291336679, 8043.638036288381, 7758.456908016441, 7928.326092282163, 7984.321332686729, 8047.436679432412, 8079.434439589231, 7742.341900938427, 7944.880826787603, 7956.085050219241, 7967.880481792778, 7983.5209887406945, 37475.62524374776, 38233.61766382329, 38237.61762382368, 38372.616273837186, 38418.42372364417, 3524.365614189445, 3603.9908825528632, 3606.801625910574, 3612.9638703613155, 3623.800690961996, 30465.847670761505, 30957.380852383052, 30963.690363096306, 31135.22161945947, 31300.686993130006, 5147.974260128713, 5173.948260517422, 5189.844304670866, 5220.9738951305, 5221.921671174935, 186211.0, 186389.0, 186780.0, 187254.99999999863, 187638.0, 42020.0, 42856.78571607122, 47097.29354059692, 47698.0, 47851.76074119677, 45093.0, 51363.743181284604, 51751.74124129355, 51835.48164518306, 52346.47653523492, 15031.323590438456, 15084.698306033817, 15130.848691513163, 15200.087994720352, 15292.694146117237, 12090.214136081127, 12117.333546655018, 12182.634520964386, 12202.084843636763, 12250.019998400106, 13950.93024534891, 14131.293435328193, 14203.715925681428, 14220.0, 14259.0, 5787.681677507693, 5829.271341082364, 5874.823755287348, 5941.168236446901, 5974.2233509643465, 990.8018396320765, 1009.6264382178641, 1023.7747695506977, 1027.547878933282, 1027.6043723166486, 22652.773472265068, 22701.09195632156, 22896.771032289464, 23011.309660710205, 23037.7696223039, 1129.1587767113554, 1131.8868113188614, 1132.9660110196708, 1136.9943150284196, 1145.6104924325602, 12004.399780010965, 12168.81746773799, 12298.508059677692, 12309.322987235788, 12397.318147501974, 213407.0, 213963.79054314198, 214341.0, 216638.0, 216712.0, 52174.73912630413, 52649.2102618461, 52669.47330526646, 52675.0, 52753.0, 1450.2168828832523, 1476.8690376402096, 1477.6749115194425, 1484.621421537501, 1492.1121932450176, 22192.0, 22235.665255147975, 22356.105755769586, 22456.326310210065, 22622.66066009044, 37207.25585488329, 37539.43690844585, 37584.24831503409, 37604.623953761205, 37800.81099594484, 183046.0, 183944.0, 185215.0, 186193.0, 186252.0, 30627.54058689077, 31180.0, 31197.8440107798, 31312.843435782674, 34071.48892766561, 37423.812880935424, 37490.062748431505, 37629.247415050995, 41390.0, 42945.0, 32028.0, 32028.5195722069, 32175.678243218204, 32248.83875580607, 32357.676423235465, 31437.528437073004, 31441.21396965094, 31583.684163158076, 32002.83998579992, 32319.192020199684, 35410.0, 35686.464703028956, 35856.10359741027, 36128.4580731284, 36348.45477317895, 30642.693573063985, 30897.691023089483, 31013.689863101983, 31397.372052559276, 31559.0, 22909.0, 22965.88517057404, 22981.965811538186, 23026.76973230313, 23347.182848600216], "value": 16907.51678410024, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.551435394746, 589.4812564942853, 595.2737660054731, 600.8618017855894, 620.7703149834562, 22364.88817555912, 23162.42093947652, 23281.417964550896, 23308.300750977498, 23309.067637294487, 23555.057797688114, 24326.391840204004, 24857.751422485813, 24892.87553562234, 24947.50104997899, 6558.409743123118, 6608.2070151581875, 6628.536002479828, 6681.064650948871, 6683.966580167093, 6426.357364263583, 6567.113439685629, 6699.765508207213, 6710.664466776666, 6725.798226053226, 6604.834879128036, 6611.272759996396, 6634.5024123190715, 6649.168853893263, 6692.732290708366, 6618.569792963466, 6624.53628246023, 6639.502037347218, 6642.501812364092, 6677.165354330708, 6142.723577439026, 6170.81487555374, 6180.84547886302, 6203.100550420164, 6204.255489341308, 27963.0, 28218.976862237763, 28511.57232641512, 28630.570541441895, 29084.854575727197, 2064.6799746039387, 2104.053176070759, 2112.039022244875, 2118.078635793435, 2118.798714122156, 18568.0, 18968.336108236144, 19154.616907661908, 19179.136938837786, 19194.712079318822, 2382.571166750432, 2407.7231118421255, 2443.6701045358827, 2460.8892599833052, 2462.101333013455, 118906.0, 124616.0, 124652.37673811664, 137858.0, 143041.0, 14569.053011554215, 14743.96792224534, 14894.510548945018, 14903.175678367863, 15055.473058442902, 23105.3068407948, 23413.180538681405, 23447.765522344558, 23499.647505287434, 23546.293611191693, 9359.34484586086, 9446.811063778687, 9482.668106616235, 9564.18704410119, 9573.18627916635, 8369.0, 8373.665053397917, 8524.0, 8547.572621368907, 8600.827983440297, 8658.87011694825, 8791.164839340252, 8797.956010220036, 8901.955490222508, 8938.86591701125, 2659.4814011268004, 2686.6238726578295, 2728.9044883428983, 2741.6572928383953, 2901.405211931549, 963.3882484622176, 970.7962126962516, 983.8130755156498, 985.019905194322, 986.9259805514615, 18760.906195468935, 18890.905545472186, 19090.2363905445, 19498.70751938722, 19724.211031558578, 1019.0471908765328, 1031.5564307347763, 1043.0768769638773, 1044.0864243786687, 1049.1397054415459, 10270.281080324456, 10331.431771252503, 10811.297265677706, 10877.0, 10975.0, 446708.0, 467237.0, 471665.0, 474225.0, 483681.0, 110793.44603277094, 111113.0, 111977.44011279891, 112945.0, 116118.0, 1162.3723189477587, 1165.4289398194824, 1172.4196522721309, 1179.8525184351784, 1185.3065956415421, 17119.57201069983, 17230.483085507454, 17274.309027638752, 17485.21316540733, 17695.02677352758, 53059.63323387013, 55182.0, 55772.163417547956, 56076.43923560712, 56913.43086569081, 72061.0, 72132.0, 73258.0, 73553.26446735465, 73603.0, 14232.573022809333, 14412.0, 14458.855411446171, 14494.637634059232, 14567.417303308173, 22086.558268834855, 22364.664530031736, 22577.983990720786, 22609.886950565142, 23022.07911683581, 18198.36305729346, 18271.0, 18310.35913743066, 18410.723839142156, 18437.354692585694, 16146.919265403598, 16169.353225870833, 16427.753583696493, 16547.917260413622, 17083.91458042702, 18135.546611334295, 18190.090495475437, 18190.90904545469, 18211.54471138232, 18404.26382944667, 14077.859221408065, 14115.717685646436, 14222.928885355506, 14253.35859886287, 14302.0, 17716.11419429049, 17745.822541774418, 17795.0, 17806.554836129202, 17980.91009544944], "value": 11813.139193835947, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1314.7041915568996, 1356.226950638136, 1364.6861221918964, 1365.0922136779036, 1386.1960063163367, 15175.620609484768, 15774.605634859134, 15906.443274485395, 15924.442644507459, 15925.44260950867, 15549.144797036186, 15674.608134796636, 15675.372985080612, 15685.372585096582, 15701.764473532907, 2645.907393241232, 2723.9591406128925, 2733.4669739400824, 2756.54517004694, 2784.6379970603793, 2756.145594865598, 2798.8880444782185, 2820.4218135282217, 2822.2238884306776, 2823.68939416664, 2644.9471010579778, 2675.973240267602, 2762.047093752662, 2769.3353595137223, 2785.2897511134634, 2629.18495266468, 2648.72188420216, 2660.1221596873083, 2663.5605125154325, 2664.5070661927607, 2589.2750029991635, 2661.4144888124583, 2662.2811840802874, 2691.1119330621045, 2693.111273279813, 14905.105693658415, 14964.326605302787, 14972.0, 15031.248437578077, 15031.774523382159, 8185.017797864294, 8529.65881364751, 8535.061143274235, 8540.44487108336, 8549.059603443617, 5364.785408583691, 5452.482014208644, 5461.781528738846, 5596.356419011825, 5603.215549823028, 1970.4187264756931, 1971.7633883933877, 2027.4221846773598, 2034.735484387035, 2060.81452669259, 26842.328941776417, 26849.0, 26957.32606684829, 26959.191224263304, 27055.86472067647, 6914.9308506915295, 7353.669084891193, 7624.58064806441, 7636.274553917369, 7693.846123077507, 17701.114944252735, 17801.287948482175, 17876.19557119933, 17944.0, 17986.730199047026, 7948.205179482005, 8032.839343213103, 8072.515649060958, 8076.515409075474, 8134.0, 7565.356944659766, 7589.089309282811, 7666.080070391588, 7674.53952762836, 7734.961325193338, 5252.684838909678, 5275.973620131875, 5360.91958620621, 5366.946330536723, 5394.973025134849, 1454.5854431486975, 1483.6216764724927, 1492.5895378770924, 1493.6340596553914, 1505.111983929465, 863.6631713631689, 873.7640836973982, 880.6257340630207, 896.0457113174448, 897.5915958238986, 7543.47195696296, 7547.8113047173165, 7658.693652253847, 7659.310662040443, 7669.174434753074, 728.7813655903208, 732.3591857125016, 741.4661443760484, 743.3904198557132, 755.758157389641, 4662.6269898408045, 4783.832565860248, 4794.520547945178, 4850.708957462563, 5077.746112694351, 19661.0, 20047.59904801925, 20315.288964886156, 21165.89417052905, 21855.781442185693, 21001.579968400547, 21823.67264491034, 21913.233036843954, 22569.548609028057, 22597.887010564842, 11097.778044439066, 11215.66353009411, 11282.717932051764, 11387.544498220144, 11542.884571154349, 7837.373010159287, 8591.527465989431, 8652.697155599524, 8702.521361325187, 8745.781355466164, 18644.161012754186, 18835.340763073225, 19379.709304360727, 19710.310139145062, 20018.19927202954, 19606.60786784285, 19845.30541431043, 20128.899355503716, 20294.289699860434, 20477.283295084602, 10582.947085264525, 11318.60384886558, 11401.885981140082, 11439.970402663801, 11504.424778761197, 14128.50550230737, 14281.0, 14310.785338219726, 14312.284385780878, 14401.0, 11566.537338506365, 11887.583934562248, 11957.820632690342, 11962.282263064244, 11991.460384282555, 10988.120950323795, 11488.655340339803, 11535.192536522363, 11586.073114150679, 11833.881661183277, 10149.64476243328, 10287.43419111926, 10364.481775911325, 10367.377957322586, 10441.955804419802, 7401.5189012714, 7574.394048476219, 7584.2794934481135, 7650.158482567024, 7700.383969282556, 7505.286997735207, 7518.661660225413, 7545.50954187976, 7605.505642133244, 7637.159912409519], "value": 6728.569574814276, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [503.700298322498, 522.2583930818238, 537.2746791831029, 541.7589172818098, 543.1120118606078, 6158.538109641778, 6192.845178870531, 6223.1598734170875, 6236.9085410053285, 6285.994240921442, 6055.666938318391, 6057.303410107839, 6075.4458641694555, 6124.0, 6164.167837341957, 5069.594432445396, 5115.514026167527, 5126.385188665577, 5161.509656582619, 5161.5870730341485, 4846.9030619387595, 5132.332796736419, 5155.639105262633, 5199.922001169985, 5205.297284866532, 4880.243562247857, 4922.409310882681, 4942.604591632661, 4949.50504949504, 4989.276554899538, 4942.456329803718, 4959.0, 4973.3286006389035, 4997.075541024904, 5005.749712514396, 4412.867613971586, 4437.866863994085, 4504.864854054384, 4506.752128632924, 4516.0, 5801.53587712982, 5968.0, 6023.518118550505, 6098.573099882966, 6148.44663980244, 5619.4099619540175, 5661.5187709044785, 5707.229524014247, 5755.618651523604, 5764.798232061858, 6323.841903952438, 6481.513886458534, 6496.733137038279, 6524.543281970264, 6587.703553340111, 4697.3893393858925, 4877.780499877514, 4898.657094003421, 4916.532929371704, 4920.581750551208, 6633.7346506140175, 6778.169894128558, 6790.422814060811, 6827.351401616838, 6833.111695479605, 5419.972900135474, 5458.6330935251635, 5489.725513724298, 5492.368377636543, 5513.61404701667, 5490.670559766427, 5561.998840208801, 5567.777288908398, 5585.3297604287745, 5589.441055894378, 5873.0, 5896.49639341965, 5929.288485381781, 5972.462478376967, 5973.701314934236, 6531.967340163269, 6587.6047437152965, 6607.753363856312, 6618.768343107968, 6627.1716035495565, 1913.3016448996016, 1925.6245032218862, 1941.553442708185, 1941.679622862212, 1943.6112777444569, 1393.8188035555313, 1410.6598731205395, 1416.3201663201721, 1443.5669299210194, 1464.2678660669665, 5559.6664200148125, 5607.009511623397, 5639.436056394327, 5658.405867383948, 5659.518940890071, 6447.742090316335, 6542.476601871934, 6550.213974323112, 6575.375339342755, 6627.86744265112, 5577.972110139504, 5596.132599447093, 5597.0, 5619.960307343154, 5661.858453538694, 3350.2461946062426, 3398.065531978676, 3410.437277849127, 3455.7926524408617, 3487.337405892872, 6337.429631333202, 6371.267304259976, 6421.5825971311715, 6442.452391546677, 6449.96775016122, 6594.670266486656, 6653.600783952978, 6683.128723957299, 6753.797386078426, 6785.0, 6370.662160946254, 6426.74293028283, 6431.614103153825, 6461.643054958417, 6480.287168411471, 6632.867342653023, 6664.83337916556, 6690.431313338226, 6692.0, 6692.431143352869, 6453.901772374482, 6506.397441023629, 6591.439727623206, 6624.370684784938, 6629.2044954603825, 6261.592996455216, 6436.499135872896, 6446.194225721785, 6475.805725828232, 6533.575317604341, 5343.385510666323, 5359.249705041219, 5385.2460655507475, 5432.18517222404, 5469.2616496772425, 6229.345918678655, 6359.332270111571, 6505.154329937078, 6624.536282460182, 6724.327567243236, 6375.330590288138, 6377.0, 6404.359564043559, 6458.709358078804, 6511.544191906521, 6375.489960803217, 6403.231612206565, 6473.676316184078, 6527.9020814688765, 6546.18172728409, 6339.541905361885, 6388.1695379602215, 6404.263509696259, 6421.197350331208, 6455.515836312389, 6410.846047711457, 6560.770373036921, 6567.802965911031, 6569.671516424064, 6635.369639884203, 6261.154744109487, 6340.619562826245, 6345.238571371465, 6351.333110023381, 6443.2590252119735], "value": 5099.280381529992, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [888.8577827547591, 904.3127223310282, 926.4348747264168, 927.2998885841189, 933.9159475647192, 19579.216831326747, 20412.183512659496, 20458.0, 20536.486587835312, 20643.380698579065, 18251.36120235792, 18429.0, 18672.62654746904, 19224.61550768984, 19323.516912077204, 962.7833737409079, 980.8234517786796, 983.1348413396237, 984.0749695286444, 989.7921436498344, 989.7723523589578, 990.7572644702058, 997.6857289953678, 999.48526508848, 999.9700308682033, 1005.140604782911, 1029.7065336379133, 1034.3690348887174, 1035.30634474902, 1037.1288117980932, 1012.5342342522448, 1022.6420752736557, 1025.2208321675544, 1026.856240126383, 1026.8613737145502, 731.0, 757.1822431773671, 762.0702742653954, 762.7559181062062, 762.8436170585016, 20589.897050514803, 20654.58690826175, 20666.276680316118, 20690.0, 20827.479313017146, 21236.893815530977, 21436.03537840801, 21914.0, 22297.44256393587, 22413.103475860946, 16197.91901040499, 16265.0, 16363.918180409022, 16440.83559164405, 16545.25546350417, 3569.1969306906, 3571.2678900825267, 3571.4285714285847, 3615.1504396466808, 3616.981915090434, 137591.31204344015, 137929.0, 140435.0, 142230.0, 143777.0, 16821.327146913987, 16830.983813683288, 16896.662066758596, 17013.659726805643, 17104.657906841792, 30665.540016899766, 31612.209694757814, 31621.0, 31943.840280798446, 32107.83946080255, 8722.738317850475, 8735.563221838882, 8749.737507874774, 8778.429402088972, 8781.648734050694, 4027.718059735849, 4049.8582549610624, 4065.1463192729266, 4100.0, 4100.5489396166395, 5242.68543887368, 5324.973375133177, 5336.546393556514, 5364.061289274361, 5368.302120724281, 988.545269176187, 1013.4476710192963, 1021.2748948246827, 1032.7624646331385, 1035.0270745499206, 635.3487675133026, 640.9743610255631, 644.8581312111328, 659.8449364399362, 666.0375757031044, 10896.291741036806, 11054.834177487344, 11386.886131138748, 11485.827712584318, 11995.100367472474, 670.5272782688193, 672.8015235505537, 686.993130068693, 687.2680595166132, 696.6481926627021, 5385.461453854661, 5396.19057141424, 5396.946030539723, 5413.431589683105, 5548.361938377138, 111756.59610178114, 114879.0, 115035.42482287536, 118719.40640296743, 119859.40070299768, 102419.0, 103834.0, 104645.47677261717, 105989.47005264924, 106429.46785266024, 88086.0, 92041.0, 92301.53849230711, 92531.0, 95025.99999999862, 9918.900810992087, 10025.598976041168, 10034.397936123856, 10099.94950025245, 10263.640772572924, 43384.783076084415, 44180.558194417645, 44421.33367999547, 44492.33261501145, 45766.084678306914, 57363.42636573581, 57821.132683010626, 58688.119678204006, 58948.41051589601, 59508.10737838849, 14897.106173629616, 15013.17427541452, 15107.093574385133, 15124.848751512343, 15334.233288335316, 17243.7413438796, 17249.223784929458, 17350.5662358437, 17484.650306993535, 17809.46571602854, 15398.230088495306, 15427.691446171239, 15431.922840385727, 15458.227088645748, 15671.451499197474, 15888.92055539715, 16314.510564683078, 16387.098709571088, 16393.59016024609, 16613.169341532634, 15330.616734581725, 15335.923320383326, 15349.309281082154, 15357.84642153609, 15537.84462155364, 12180.756384872077, 12330.205818670587, 12388.0, 12646.936765316115, 12670.049746269251, 11674.824877627012, 11780.410979451164, 11838.881611183779, 11890.167688262085, 11981.700457488632], "value": 8857.341190175555, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1445.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 110.0, 108.0, 107.0, 106.0, 110.0, 114.0, 107.0, 106.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 127.0, 127.0, 127.0, 124.0, 125.0, 125.0, 122.0, 116.0, 119.0], "value": 124.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 167.0, 172.0, 164.0, 163.0, 166.0, 167.0, 166.0, 173.0], "value": 166.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 76.0, 77.0, 76.0, 77.0, 73.0, 73.0, 80.0], "value": 75.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 80.0, 89.0, 78.0, 78.0, 79.0, 80.0, 79.0, 85.0], "value": 82.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 127.0, 120.0, 113.0, 114.0, 118.0, 113.0, 115.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 153.0, 151.0, 149.0, 153.0, 149.0, 150.0, 150.0, 153.0, 151.0], "value": 151.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 98.0, 100.0, 93.0, 96.0, 95.0, 97.0, 97.0, 94.0, 102.0], "value": 97.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 54.0, 60.0, 52.0, 52.0, 61.0, 51.0, 56.0, 52.0, 52.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 47.0, 45.0, 45.0, 40.0, 42.0, 41.0, 37.0, 39.0, 48.0], "value": 42.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 80.0, 76.0, 80.0, 72.0, 81.0, 78.0, 76.0, 72.0, 73.0], "value": 76.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 112.0, 119.0, 112.0, 116.0, 113.0, 124.0, 116.0, 111.0, 111.0], "value": 115.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 168.0, 172.0, 166.0, 187.0, 167.0, 162.0, 161.0, 168.0, 165.0], "value": 168.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 64.0, 64.0, 63.0, 62.0, 64.0, 65.0, 63.0, 69.0, 63.0], "value": 64.8, "unit": "score"}]}]} 03:55:26 INFO - Return code: 0 03:55:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:55:26 INFO - # TBPL SUCCESS # 03:55:26 INFO - Running post-action listener: _package_coverage_data 03:55:26 INFO - Running post-action listener: _resource_record_post_action 03:55:26 INFO - [mozharness: 2017-09-28 10:55:26.481960Z] Finished run-tests step (success) 03:55:26 INFO - Running post-run listener: _resource_record_post_run 03:55:26 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 430080; Write bytes: 331894784; Read time: 92; Write time: 224716 03:55:26 INFO - TinderboxPrint: CPU usage
13.2% 03:55:26 INFO - TinderboxPrint: I/O read bytes / time
430,080 / 92 03:55:26 INFO - TinderboxPrint: I/O write bytes / time
331,894,784 / 224,716 03:55:26 INFO - TinderboxPrint: CPU idle
8,242.3 (86.8%) 03:55:26 INFO - TinderboxPrint: CPU user
1,198.4 (12.6%) 03:55:26 INFO - TinderboxPrint: Swap in / out
0 / 0 03:55:26 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 10510336; Read time: 0; Write time: 6528 03:55:26 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:55:26 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 425984; Write bytes: 320942080; Read time: 72; Write time: 218164 03:55:27 INFO - Running post-run listener: _upload_blobber_files 03:55:27 INFO - Blob upload gear active. 03:55:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:55:27 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 03:55:27 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'] 03:55:27 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 03:55:27 INFO - (blobuploader) - INFO - Open directory for files ... 03:55:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:55:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:55:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:30 INFO - (blobuploader) - INFO - Done attempting. 03:55:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:55:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:55:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:31 INFO - (blobuploader) - INFO - Done attempting. 03:55:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:55:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:55:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:32 INFO - (blobuploader) - INFO - Done attempting. 03:55:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:55:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:33 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:55:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:33 INFO - (blobuploader) - INFO - Done attempting. 03:55:33 INFO - (blobuploader) - INFO - Iteration through files over. 03:55:33 INFO - Return code: 0 03:55:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:55:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:55:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32f68bd5a43ae2701f4b3e67221b93336aa86c078f7dada3efa1ddc2ef345bd538b3828d869509d23e768978bd74715811a21c9be07a4da94a014986be85f334", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/074a827d170cd2f54f5c6a4738a190e22b619f88ede85d5dc2204db031660bbd006d2a896beb854c3be31577c34439daff0c121491a70bf4cd737e0188742080", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e31f0a780bf094cf612dbbf325c535cf895cb41a2bcaf8359c42b444c6e845a3fd84d9a656151e93ef977f6f00b51f434a6cac48a4465bf481ac37636694b5f4", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b3691d8726f7ffb606aa3ab46ef2694d25e5aab74116ad460350b8a618da5c6ba97ba606891e25bff6f656af877cf52b995ceedb3a349a504889d20de1fbce49"} 03:55:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:55:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:55:33 INFO - Contents: 03:55:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32f68bd5a43ae2701f4b3e67221b93336aa86c078f7dada3efa1ddc2ef345bd538b3828d869509d23e768978bd74715811a21c9be07a4da94a014986be85f334", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/074a827d170cd2f54f5c6a4738a190e22b619f88ede85d5dc2204db031660bbd006d2a896beb854c3be31577c34439daff0c121491a70bf4cd737e0188742080", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e31f0a780bf094cf612dbbf325c535cf895cb41a2bcaf8359c42b444c6e845a3fd84d9a656151e93ef977f6f00b51f434a6cac48a4465bf481ac37636694b5f4", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b3691d8726f7ffb606aa3ab46ef2694d25e5aab74116ad460350b8a618da5c6ba97ba606891e25bff6f656af877cf52b995ceedb3a349a504889d20de1fbce49"} 03:55:33 INFO - Running post-run listener: copy_logs_to_upload_dir 03:55:33 INFO - Copying logs to upload dir... 03:55:33 INFO - mkdir: /builds/slave/test/build/upload/logs 03:55:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.035927 ========= master_lag: 0.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-09-28 03:55:33.905183) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-28 03:55:33.911430) ========= 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=dac658600622fd96716c9acf000001b3-1506594886.379905-261782927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32f68bd5a43ae2701f4b3e67221b93336aa86c078f7dada3efa1ddc2ef345bd538b3828d869509d23e768978bd74715811a21c9be07a4da94a014986be85f334", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/074a827d170cd2f54f5c6a4738a190e22b619f88ede85d5dc2204db031660bbd006d2a896beb854c3be31577c34439daff0c121491a70bf4cd737e0188742080", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e31f0a780bf094cf612dbbf325c535cf895cb41a2bcaf8359c42b444c6e845a3fd84d9a656151e93ef977f6f00b51f434a6cac48a4465bf481ac37636694b5f4", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b3691d8726f7ffb606aa3ab46ef2694d25e5aab74116ad460350b8a618da5c6ba97ba606891e25bff6f656af877cf52b995ceedb3a349a504889d20de1fbce49"} build_url:https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011309 build_url: 'https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32f68bd5a43ae2701f4b3e67221b93336aa86c078f7dada3efa1ddc2ef345bd538b3828d869509d23e768978bd74715811a21c9be07a4da94a014986be85f334", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/074a827d170cd2f54f5c6a4738a190e22b619f88ede85d5dc2204db031660bbd006d2a896beb854c3be31577c34439daff0c121491a70bf4cd737e0188742080", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e31f0a780bf094cf612dbbf325c535cf895cb41a2bcaf8359c42b444c6e845a3fd84d9a656151e93ef977f6f00b51f434a6cac48a4465bf481ac37636694b5f4", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b3691d8726f7ffb606aa3ab46ef2694d25e5aab74116ad460350b8a618da5c6ba97ba606891e25bff6f656af877cf52b995ceedb3a349a504889d20de1fbce49"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-28 03:55:33.945411) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 03:55:33.945828) ========= 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=dac658600622fd96716c9acf000001b3-1506594886.379905-261782927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004652 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 03:55:34.003535) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-28 03:55:34.003908) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-28 03:55:34.004317) ========= ========= Total master_lag: 0.24 =========