builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-021 starttime: 1503484265.27 results: success (0) revision: b911a4c97fde5d8bdeebfd5d0266ee9f7b9e59b2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-23 03:31:05.271404) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-23 03:31:05.271852) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-23 03:31:05.272136) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-23 03:31:05.294953) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 03:31:05.295353) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1503484264.192027-1359262871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-23 03:31:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 92.6M=0s 2017-08-23 03:31:05 (92.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.076682 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 03:31:05.390670) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 03:31:05.391048) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1503484264.192027-1359262871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016234 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 03:31:05.441277) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-23 03:31:05.441615) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b911a4c97fde5d8bdeebfd5d0266ee9f7b9e59b2 --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 b911a4c97fde5d8bdeebfd5d0266ee9f7b9e59b2 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1503484264.192027-1359262871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-23 03:31:05,669 truncating revision to first 12 chars 2017-08-23 03:31:05,669 Setting DEBUG logging. 2017-08-23 03:31:05,669 attempt 1/10 2017-08-23 03:31:05,669 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b911a4c97fde?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-23 03:31:06,445 unpacking tar archive at: mozilla-central-b911a4c97fde/testing/mozharness/ program finished with exit code 0 elapsedTime=1.099491 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-23 03:31:06.562158) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-23 03:31:06.562557) ========= script_repo_revision: b911a4c97fde5d8bdeebfd5d0266ee9f7b9e59b2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-23 03:31:06.563002) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-23 03:31:06.563281) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-23 03:31:06.574854) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-23 03:31:06.575261) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1503484264.192027-1359262871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:31:06 INFO - MultiFileLogger online at 20170823 03:31:06 in /builds/slave/test 03:31:06 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:31:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:31:06 INFO - {'append_to_log': False, 03:31:06 INFO - 'base_work_dir': '/builds/slave/test', 03:31:06 INFO - 'blob_upload_branch': 'Firefox', 03:31:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:31:06 INFO - 'branch': 'Firefox', 03:31:06 INFO - 'buildbot_json_path': 'buildprops.json', 03:31:06 INFO - 'code_coverage': False, 03:31:06 INFO - 'config_files': ('talos/linux_config.py',), 03:31:06 INFO - 'default_actions': ('clobber', 03:31:06 INFO - 'read-buildbot-config', 03:31:06 INFO - 'download-and-extract', 03:31:06 INFO - 'populate-webroot', 03:31:06 INFO - 'create-virtualenv', 03:31:06 INFO - 'install', 03:31:06 INFO - 'setup-mitmproxy', 03:31:06 INFO - 'run-tests'), 03:31:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:31:06 INFO - 'disable_ccov_upload': False, 03:31:06 INFO - 'download_minidump_stackwalk': True, 03:31:06 INFO - 'download_symbols': 'ondemand', 03:31:06 INFO - 'enable_stylo': False, 03:31:06 INFO - 'enable_webrender': False, 03:31:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:31:06 INFO - 'tooltool.py': '/tools/tooltool.py', 03:31:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:31:06 INFO - '/tools/misc-python/virtualenv.py')}, 03:31:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:31:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:31:06 INFO - 'gecko_profile': False, 03:31:06 INFO - 'gecko_profile_interval': 0, 03:31:06 INFO - 'installer_path': 'installer.exe', 03:31:06 INFO - 'log_level': 'info', 03:31:06 INFO - 'log_name': 'talos', 03:31:06 INFO - 'log_to_console': True, 03:31:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:31:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:31:06 INFO - 'opt_config_files': (), 03:31:06 INFO - 'pip_index': False, 03:31:06 INFO - 'suite': 'dromaeojs-e10s', 03:31:06 INFO - 'system_bits': '32', 03:31:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:31:06 INFO - 'title': 'talos-linux64-ix-021', 03:31:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:31:06 INFO - 'use_talos_json': True, 03:31:06 INFO - 'verify': 'False', 03:31:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:31:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:31:06 INFO - 'work_dir': 'build'} 03:31:06 INFO - [mozharness: 2017-08-23 10:31:06.939803Z] Running clobber step. 03:31:06 INFO - Running pre-action listener: _resource_record_pre_action 03:31:06 INFO - Running main action method: clobber 03:31:06 INFO - rmtree: /builds/slave/test/build 03:31:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:31:08 INFO - Running post-action listener: _resource_record_post_action 03:31:08 INFO - [mozharness: 2017-08-23 10:31:08.024871Z] Finished clobber step (success) 03:31:08 INFO - [mozharness: 2017-08-23 10:31:08.024969Z] Running read-buildbot-config step. 03:31:08 INFO - Running pre-action listener: _resource_record_pre_action 03:31:08 INFO - Running main action method: read_buildbot_config 03:31:08 INFO - Using buildbot properties: 03:31:08 INFO - { 03:31:08 INFO - "project": "", 03:31:08 INFO - "product": "firefox", 03:31:08 INFO - "who": "archaeopteryx@coole-files.de", 03:31:08 INFO - "installer_path": "public/build/target.tar.bz2", 03:31:08 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 03:31:08 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:31:08 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 03:31:08 INFO - "stage_platform": "linux64-stylo", 03:31:08 INFO - "basedir": "/builds/slave/test", 03:31:08 INFO - "buildnumber": 99, 03:31:08 INFO - "platform": "ubuntu64_hw_stylo", 03:31:08 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:31:08 INFO - "slavebuilddir": "test", 03:31:08 INFO - "taskId": "AdCONtMTSTymzU1wagX_VQ", 03:31:08 INFO - "branch": "mozilla-central", 03:31:08 INFO - "script_repo_revision": "production", 03:31:08 INFO - "revision": "b911a4c97fde5d8bdeebfd5d0266ee9f7b9e59b2", 03:31:08 INFO - "slavename": "talos-linux64-ix-021", 03:31:08 INFO - "repo_path": "mozilla-central" 03:31:08 INFO - } 03:31:08 INFO - Finding installer, test and symbols from parent task. 03:31:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AdCONtMTSTymzU1wagX_VQ'}, attempt #1 03:31:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AdCONtMTSTymzU1wagX_VQ'}, attempt #1 03:31:08 INFO - Task dependencies: Fvl1I_gnToGP5nRGmDBdyw 03:31:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw'}, attempt #1 03:31:09 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.tar.bz2 03:31:09 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.test_packages.json 03:31:09 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.crashreporter-symbols.zip 03:31:09 INFO - Running post-action listener: _resource_record_post_action 03:31:09 INFO - [mozharness: 2017-08-23 10:31:09.398280Z] Finished read-buildbot-config step (success) 03:31:09 INFO - [mozharness: 2017-08-23 10:31:09.398497Z] Running download-and-extract step. 03:31:09 INFO - Running pre-action listener: _resource_record_pre_action 03:31:09 INFO - Running main action method: download_and_extract 03:31:09 INFO - mkdir: /builds/slave/test/build/tests 03:31: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:31:09 INFO - trying https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.test_packages.json 03:31:09 INFO - Downloading https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:31:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:31:09 INFO - Downloaded 989 bytes. 03:31:09 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:31:09 INFO - Using the following test package requirements: 03:31:09 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:31:09 INFO - u'common': [u'target.common.tests.zip'], 03:31:09 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:31:09 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:31:09 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:31:09 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:31:09 INFO - u'mozbase': [u'target.common.tests.zip'], 03:31:09 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:31:09 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:31:09 INFO - u'web-platform': [u'target.common.tests.zip', 03:31:09 INFO - u'target.web-platform.tests.tar.gz'], 03:31:09 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:31:09 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:31:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.common.tests.zip 03:31:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:31:09 INFO - Fetch https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.common.tests.zip into memory 03:31:11 INFO - Content-Length response header: 54949653 03:31:11 INFO - Bytes received: 54949653 03:31:22 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:31:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.common.tests.zip 03:31:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:31:22 INFO - Fetch https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.common.tests.zip into memory 03:31:23 INFO - Content-Length response header: 54949653 03:31:23 INFO - Bytes received: 54949653 03:31:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.talos.tests.zip 03:31:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:31:35 INFO - Fetch https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.talos.tests.zip into memory 03:31:36 INFO - Content-Length response header: 14496256 03:31:36 INFO - Bytes received: 14496256 03:31:36 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:31:36 INFO - trying https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.tar.bz2 03:31:36 INFO - Downloading https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:31:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:31:37 INFO - Downloaded 61202624 bytes. 03:31:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.tar.bz2 03:31:37 INFO - mkdir: /builds/slave/test/properties 03:31:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:31:37 INFO - Writing to file /builds/slave/test/properties/build_url 03:31:37 INFO - Contents: 03:31:37 INFO - build_url:https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.tar.bz2 03:31:37 INFO - Running post-action listener: _resource_record_post_action 03:31:37 INFO - Running post-action listener: find_tests_for_verification 03:31:37 INFO - Running post-action listener: set_extra_try_arguments 03:31:37 INFO - [mozharness: 2017-08-23 10:31:37.475875Z] Finished download-and-extract step (success) 03:31:37 INFO - [mozharness: 2017-08-23 10:31:37.475971Z] Running populate-webroot step. 03:31:37 INFO - Running pre-action listener: _resource_record_pre_action 03:31:37 INFO - Running main action method: populate_webroot 03:31:37 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:31:37 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 03:31:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:31:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:31:37 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 03:31:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:31:37 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:31:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:31:37 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 03:31:37 INFO - 'talos_options': ['--stylo'], 03:31:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:31:37 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:31:37 INFO - 'tests': ['damp', 'tps']}, 03:31:37 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 03:31:37 INFO - 'talos_options': ['--stylo'], 03:31:37 INFO - 'tests': ['damp', 'tps']}, 03:31:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:31:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:31:37 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 03:31:37 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 03:31:37 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:31:37 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:31:37 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 03:31:37 INFO - 'talos_options': ['--stylo'], 03:31:37 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:31:37 INFO - 'other-e10s': {'tests': ['a11yr', 03:31:37 INFO - 'ts_paint', 03:31:37 INFO - 'tpaint', 03:31:37 INFO - 'sessionrestore', 03:31:37 INFO - 'sessionrestore_many_windows', 03:31:37 INFO - 'sessionrestore_no_auto_restore', 03:31:37 INFO - 'tabpaint']}, 03:31:37 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 03:31:37 INFO - 'tests': ['a11yr', 03:31:37 INFO - 'ts_paint', 03:31:37 INFO - 'tpaint', 03:31:37 INFO - 'sessionrestore', 03:31:37 INFO - 'sessionrestore_many_windows', 03:31:37 INFO - 'sessionrestore_no_auto_restore', 03:31:37 INFO - 'tabpaint']}, 03:31:37 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:31:37 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:31:37 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 03:31:37 INFO - 'tests': ['bloom_basic_singleton']}, 03:31:37 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 03:31:37 INFO - 'tests': ['bloom_basic']}, 03:31:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:31:37 INFO - 'tsvgr_opacity', 03:31:37 INFO - 'tart', 03:31:37 INFO - 'tscrollx', 03:31:37 INFO - 'tsvg_static']}, 03:31:37 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 03:31:37 INFO - 'tests': ['tsvgx', 03:31:37 INFO - 'tsvgr_opacity', 03:31:37 INFO - 'tart', 03:31:37 INFO - 'tscrollx', 03:31:37 INFO - 'tsvg_static']}, 03:31:37 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:31:37 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 03:31:37 INFO - 'talos_options': ['--stylo'], 03:31:37 INFO - 'tests': ['tp5o']}, 03:31:37 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:31:37 INFO - 'talos_options': ['--mitmproxy', 03:31:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:31:37 INFO - '--firstNonBlankPaint'], 03:31:37 INFO - 'tests': ['tp6_google', 03:31:37 INFO - 'tp6_youtube', 03:31:37 INFO - 'tp6_amazon', 03:31:37 INFO - 'tp6_facebook']}, 03:31:37 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:31:37 INFO - 'talos_options': ['--stylo', 03:31:37 INFO - '--mitmproxy', 03:31:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:31:37 INFO - '--firstNonBlankPaint'], 03:31:37 INFO - 'tests': ['tp6_google', 03:31:37 INFO - 'tp6_youtube', 03:31:37 INFO - 'tp6_amazon', 03:31:37 INFO - 'tp6_facebook']}, 03:31:37 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:31:37 INFO - 'talos_options': ['--stylo', 03:31:37 INFO - '--stylo-threads=1', 03:31:37 INFO - '--mitmproxy', 03:31:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:31:37 INFO - '--firstNonBlankPaint'], 03:31:37 INFO - 'tests': ['tp6_google', 03:31:37 INFO - 'tp6_youtube', 03:31:37 INFO - 'tp6_amazon', 03:31:37 INFO - 'tp6_facebook']}, 03:31:37 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:31:37 INFO - 'talos_options': ['--xperf_path', 03:31:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:31:37 INFO - 'tests': ['tp5n']}, 03:31:37 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 03:31:37 INFO - 'talos_options': ['--stylo', 03:31:37 INFO - '--xperf_path', 03:31:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:31:37 INFO - 'tests': ['tp5n']}}} 03:31:37 INFO - Running post-action listener: _resource_record_post_action 03:31:37 INFO - [mozharness: 2017-08-23 10:31:37.490317Z] Finished populate-webroot step (success) 03:31:37 INFO - [mozharness: 2017-08-23 10:31:37.490407Z] Running create-virtualenv step. 03:31:37 INFO - Running pre-action listener: _resource_record_pre_action 03:31:37 INFO - Running main action method: create_virtualenv 03:31:37 INFO - Creating virtualenv /builds/slave/test/build/venv 03:31:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:31:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:31:37 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:31:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:31:37 INFO - Using real prefix '/usr' 03:31:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:31:38 INFO - Installing distribute.............................................................................................................................................................................................done. 03:31:40 INFO - Installing pip.................done. 03:31:40 INFO - Return code: 0 03:31:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:31:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:31:40 INFO - Reading from file tmpfile_stdout 03:31:40 INFO - Output received: 03:31:40 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:31:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:31:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:40 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 0x19951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b60a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d03f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d01130>, '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 0x1d02030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d024c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1503484264.192027-1359262871', '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:31:40 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:31:40 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:31:40 INFO - Using env: {'DISPLAY': ':0', 03:31:40 INFO - 'HOME': '/home/cltbld', 03:31:40 INFO - 'LANG': 'en_US.UTF-8', 03:31:40 INFO - 'LANGUAGE': 'en_US:en', 03:31:40 INFO - 'LOGNAME': 'cltbld', 03:31:40 INFO - 'MAIL': '/var/mail/cltbld', 03:31:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:40 INFO - 'MOZ_NO_REMOTE': '1', 03:31:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:40 INFO - 'NO_EM_RESTART': '1', 03:31:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:40 INFO - 'PWD': '/builds/slave/test', 03:31:40 INFO - 'SHELL': '/bin/bash', 03:31:40 INFO - 'SHLVL': '1', 03:31:40 INFO - 'TERM': 'linux', 03:31:40 INFO - 'TMOUT': '86400', 03:31:40 INFO - 'USER': 'cltbld', 03:31:40 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1503484264.192027-1359262871', 03:31:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:40 INFO - '_': '/tools/buildbot/bin/python'} 03:31:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:31:40 INFO - Cleaning up... 03:31:40 INFO - Return code: 0 03:31:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:31:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:40 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 0x19951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b60a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d03f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d01130>, '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 0x1d02030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d024c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1503484264.192027-1359262871', '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:31:40 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:31:40 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:31:40 INFO - Using env: {'DISPLAY': ':0', 03:31:40 INFO - 'HOME': '/home/cltbld', 03:31:40 INFO - 'LANG': 'en_US.UTF-8', 03:31:40 INFO - 'LANGUAGE': 'en_US:en', 03:31:40 INFO - 'LOGNAME': 'cltbld', 03:31:40 INFO - 'MAIL': '/var/mail/cltbld', 03:31:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:40 INFO - 'MOZ_NO_REMOTE': '1', 03:31:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:40 INFO - 'NO_EM_RESTART': '1', 03:31:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:40 INFO - 'PWD': '/builds/slave/test', 03:31:40 INFO - 'SHELL': '/bin/bash', 03:31:40 INFO - 'SHLVL': '1', 03:31:40 INFO - 'TERM': 'linux', 03:31:40 INFO - 'TMOUT': '86400', 03:31:40 INFO - 'USER': 'cltbld', 03:31:40 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1503484264.192027-1359262871', 03:31:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:40 INFO - '_': '/tools/buildbot/bin/python'} 03:31:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:40 INFO - Downloading/unpacking psutil>=3.1.1 03:31:40 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:31:40 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:31:40 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:31:40 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:31:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:31:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:31:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:31:41 INFO - Installing collected packages: psutil 03:31:41 INFO - Running setup.py install for psutil 03:31:41 INFO - building 'psutil._psutil_linux' extension 03:31:41 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:31:42 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:31:42 INFO - building 'psutil._psutil_posix' extension 03:31:42 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:31:42 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:31:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:31:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:31:42 INFO - Successfully installed psutil 03:31:42 INFO - Cleaning up... 03:31:42 INFO - Return code: 0 03:31:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:31:42 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:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:42 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:31:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:42 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 0x19951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b60a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d03f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d01130>, '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 0x1d02030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d024c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1503484264.192027-1359262871', '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:31:42 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:31:42 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:31:42 INFO - Using env: {'DISPLAY': ':0', 03:31:42 INFO - 'HOME': '/home/cltbld', 03:31:42 INFO - 'LANG': 'en_US.UTF-8', 03:31:42 INFO - 'LANGUAGE': 'en_US:en', 03:31:42 INFO - 'LOGNAME': 'cltbld', 03:31:42 INFO - 'MAIL': '/var/mail/cltbld', 03:31:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:42 INFO - 'MOZ_NO_REMOTE': '1', 03:31:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:42 INFO - 'NO_EM_RESTART': '1', 03:31:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:42 INFO - 'PWD': '/builds/slave/test', 03:31:42 INFO - 'SHELL': '/bin/bash', 03:31:42 INFO - 'SHLVL': '1', 03:31:42 INFO - 'TERM': 'linux', 03:31:42 INFO - 'TMOUT': '86400', 03:31:42 INFO - 'USER': 'cltbld', 03:31:42 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1503484264.192027-1359262871', 03:31:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:42 INFO - '_': '/tools/buildbot/bin/python'} 03:31:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:31:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:31:43 INFO - Installing collected packages: mozsystemmonitor 03:31:43 INFO - Running setup.py install for mozsystemmonitor 03:31:43 INFO - Successfully installed mozsystemmonitor 03:31:43 INFO - Cleaning up... 03:31:43 INFO - Return code: 0 03:31:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:43 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 0x19951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b60a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d03f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d01130>, '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 0x1d02030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d024c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1503484264.192027-1359262871', '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:31:43 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:31:43 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:31:43 INFO - Using env: {'DISPLAY': ':0', 03:31:43 INFO - 'HOME': '/home/cltbld', 03:31:43 INFO - 'LANG': 'en_US.UTF-8', 03:31:43 INFO - 'LANGUAGE': 'en_US:en', 03:31:43 INFO - 'LOGNAME': 'cltbld', 03:31:43 INFO - 'MAIL': '/var/mail/cltbld', 03:31:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:43 INFO - 'MOZ_NO_REMOTE': '1', 03:31:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:43 INFO - 'NO_EM_RESTART': '1', 03:31:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:43 INFO - 'PWD': '/builds/slave/test', 03:31:43 INFO - 'SHELL': '/bin/bash', 03:31:43 INFO - 'SHLVL': '1', 03:31:43 INFO - 'TERM': 'linux', 03:31:43 INFO - 'TMOUT': '86400', 03:31:43 INFO - 'USER': 'cltbld', 03:31:43 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1503484264.192027-1359262871', 03:31:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:43 INFO - '_': '/tools/buildbot/bin/python'} 03:31:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:44 INFO - Downloading/unpacking jsonschema==2.5.1 03:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:31:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:31:45 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:31:45 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:31:45 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:31:45 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:31:45 INFO - Downloading functools32-3.2.3-2.tar.gz 03:31:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:31:45 INFO - warning: no files found matching '*.txt' 03:31:45 INFO - no previously-included directories found matching 'build' 03:31:45 INFO - no previously-included directories found matching 'dist' 03:31:45 INFO - no previously-included directories found matching '.git*' 03:31:45 INFO - Installing collected packages: jsonschema, functools32 03:31:45 INFO - Running setup.py install for functools32 03:31:45 INFO - warning: no files found matching '*.txt' 03:31:45 INFO - no previously-included directories found matching 'build' 03:31:45 INFO - no previously-included directories found matching 'dist' 03:31:45 INFO - no previously-included directories found matching '.git*' 03:31:45 INFO - Successfully installed jsonschema functools32 03:31:45 INFO - Cleaning up... 03:31:45 INFO - Return code: 0 03:31:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:31:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x19951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b60a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d03f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d01130>, '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 0x1d02030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d024c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1503484264.192027-1359262871', '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:31:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:31:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:31:45 INFO - Using env: {'DISPLAY': ':0', 03:31:45 INFO - 'HOME': '/home/cltbld', 03:31:45 INFO - 'LANG': 'en_US.UTF-8', 03:31:45 INFO - 'LANGUAGE': 'en_US:en', 03:31:45 INFO - 'LOGNAME': 'cltbld', 03:31:45 INFO - 'MAIL': '/var/mail/cltbld', 03:31:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:45 INFO - 'MOZ_NO_REMOTE': '1', 03:31:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:45 INFO - 'NO_EM_RESTART': '1', 03:31:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:45 INFO - 'PWD': '/builds/slave/test', 03:31:45 INFO - 'SHELL': '/bin/bash', 03:31:45 INFO - 'SHLVL': '1', 03:31:45 INFO - 'TERM': 'linux', 03:31:45 INFO - 'TMOUT': '86400', 03:31:45 INFO - 'USER': 'cltbld', 03:31:45 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1503484264.192027-1359262871', 03:31:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:45 INFO - '_': '/tools/buildbot/bin/python'} 03:31:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:31:45 INFO - Cleaning up... 03:31:45 INFO - Return code: 0 03:31:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:31:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x19951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b60a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d03f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d01130>, '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 0x1d02030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d024c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1503484264.192027-1359262871', '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:31:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:31:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:31:45 INFO - Using env: {'DISPLAY': ':0', 03:31:45 INFO - 'HOME': '/home/cltbld', 03:31:45 INFO - 'LANG': 'en_US.UTF-8', 03:31:45 INFO - 'LANGUAGE': 'en_US:en', 03:31:45 INFO - 'LOGNAME': 'cltbld', 03:31:45 INFO - 'MAIL': '/var/mail/cltbld', 03:31:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:45 INFO - 'MOZ_NO_REMOTE': '1', 03:31:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:45 INFO - 'NO_EM_RESTART': '1', 03:31:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:45 INFO - 'PWD': '/builds/slave/test', 03:31:45 INFO - 'SHELL': '/bin/bash', 03:31:45 INFO - 'SHLVL': '1', 03:31:45 INFO - 'TERM': 'linux', 03:31:45 INFO - 'TMOUT': '86400', 03:31:45 INFO - 'USER': 'cltbld', 03:31:45 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1503484264.192027-1359262871', 03:31:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:45 INFO - '_': '/tools/buildbot/bin/python'} 03:31:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:46 INFO - Downloading/unpacking blobuploader==1.2.4 03:31:46 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:31:46 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:31:46 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:31:46 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:31:47 INFO - Downloading blobuploader-1.2.4.tar.gz 03:31:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:31:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:31:47 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:31:47 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:31:47 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:31:47 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:31:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:31:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:31:47 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:31:47 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:31:47 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:31:47 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:31:47 INFO - Downloading docopt-0.6.1.tar.gz 03:31:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:31:47 INFO - Installing collected packages: blobuploader, requests, docopt 03:31:47 INFO - Running setup.py install for blobuploader 03:31:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:31:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:31:47 INFO - Running setup.py install for requests 03:31:48 INFO - Running setup.py install for docopt 03:31:48 INFO - Successfully installed blobuploader requests docopt 03:31:48 INFO - Cleaning up... 03:31:48 INFO - Return code: 0 03:31:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31:48 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:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:48 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:31:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:48 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 0x19951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b60a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d03f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d01130>, '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 0x1d02030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d024c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1503484264.192027-1359262871', '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:31:48 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:31:48 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:31:48 INFO - Using env: {'DISPLAY': ':0', 03:31:48 INFO - 'HOME': '/home/cltbld', 03:31:48 INFO - 'LANG': 'en_US.UTF-8', 03:31:48 INFO - 'LANGUAGE': 'en_US:en', 03:31:48 INFO - 'LOGNAME': 'cltbld', 03:31:48 INFO - 'MAIL': '/var/mail/cltbld', 03:31:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:48 INFO - 'MOZ_NO_REMOTE': '1', 03:31:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:48 INFO - 'NO_EM_RESTART': '1', 03:31:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:48 INFO - 'PWD': '/builds/slave/test', 03:31:48 INFO - 'SHELL': '/bin/bash', 03:31:48 INFO - 'SHLVL': '1', 03:31:48 INFO - 'TERM': 'linux', 03:31:48 INFO - 'TMOUT': '86400', 03:31:48 INFO - 'USER': 'cltbld', 03:31:48 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1503484264.192027-1359262871', 03:31:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:48 INFO - '_': '/tools/buildbot/bin/python'} 03:31:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:31:48 INFO - Running setup.py (path:/tmp/pip-OgjH0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:31:48 INFO - Running setup.py (path:/tmp/pip-slf2Qz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:31:48 INFO - Running setup.py (path:/tmp/pip-2Myrum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:31:48 INFO - Running setup.py (path:/tmp/pip-2jeaJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:31:48 INFO - Running setup.py (path:/tmp/pip-fCqfa5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:31:48 INFO - Running setup.py (path:/tmp/pip-GHbDYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:31:49 INFO - Running setup.py (path:/tmp/pip-c341F2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:31:49 INFO - Running setup.py (path:/tmp/pip-yp_Kx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:31:49 INFO - Running setup.py (path:/tmp/pip-AiscsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:31:49 INFO - Running setup.py (path:/tmp/pip-6l5DG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:31:49 INFO - Running setup.py (path:/tmp/pip-0GEG1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:31:49 INFO - Running setup.py (path:/tmp/pip-lFuI1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:31:49 INFO - Running setup.py (path:/tmp/pip-fNKepO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:31:49 INFO - Running setup.py (path:/tmp/pip-MYYVBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:49 INFO - Running setup.py (path:/tmp/pip-HfEKUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:31:49 INFO - Running setup.py (path:/tmp/pip-dwu42C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:31:49 INFO - Running setup.py (path:/tmp/pip-0Gk41W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:31:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:31:49 INFO - Running setup.py install for manifestparser 03:31:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:31:49 INFO - Running setup.py install for mozcrash 03:31:50 INFO - Running setup.py install for mozdebug 03:31:50 INFO - Running setup.py install for mozdevice 03:31:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:31:50 INFO - Running setup.py install for mozfile 03:31:50 INFO - Running setup.py install for mozhttpd 03:31:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:31:50 INFO - Running setup.py install for mozinfo 03:31:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:31:50 INFO - Running setup.py install for mozInstall 03:31:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:31:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:31:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:31:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:31:50 INFO - Running setup.py install for mozleak 03:31:50 INFO - Running setup.py install for mozlog 03:31:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:31:50 INFO - Running setup.py install for moznetwork 03:31:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:31:50 INFO - Running setup.py install for mozprocess 03:31:51 INFO - Running setup.py install for mozprofile 03:31:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:31:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:31:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:31:51 INFO - Running setup.py install for mozrunner 03:31:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:31:51 INFO - Running setup.py install for mozscreenshot 03:31:51 INFO - Running setup.py install for moztest 03:31:51 INFO - Running setup.py install for mozversion 03:31:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:31:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:31:51 INFO - Cleaning up... 03:31:51 INFO - Return code: 0 03:31:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31: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:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31: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:31:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:51 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 0x19951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b60a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d03f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d01130>, '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 0x1d02030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d024c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1503484264.192027-1359262871', '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:31:51 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:31:51 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:31:51 INFO - Using env: {'DISPLAY': ':0', 03:31:51 INFO - 'HOME': '/home/cltbld', 03:31:51 INFO - 'LANG': 'en_US.UTF-8', 03:31:51 INFO - 'LANGUAGE': 'en_US:en', 03:31:51 INFO - 'LOGNAME': 'cltbld', 03:31:51 INFO - 'MAIL': '/var/mail/cltbld', 03:31:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:51 INFO - 'MOZ_NO_REMOTE': '1', 03:31:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:51 INFO - 'NO_EM_RESTART': '1', 03:31:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:51 INFO - 'PWD': '/builds/slave/test', 03:31:51 INFO - 'SHELL': '/bin/bash', 03:31:51 INFO - 'SHLVL': '1', 03:31:51 INFO - 'TERM': 'linux', 03:31:51 INFO - 'TMOUT': '86400', 03:31:51 INFO - 'USER': 'cltbld', 03:31:51 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1503484264.192027-1359262871', 03:31:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:51 INFO - '_': '/tools/buildbot/bin/python'} 03:31:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:31:51 INFO - Running setup.py (path:/tmp/pip-GySnMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:31:51 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:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:31:51 INFO - Running setup.py (path:/tmp/pip-dfAUnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:31:52 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:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:31:52 INFO - Running setup.py (path:/tmp/pip-qGlkxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:31:52 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:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:31:52 INFO - Running setup.py (path:/tmp/pip-3x3WIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:31:52 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:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:31:52 INFO - Running setup.py (path:/tmp/pip-WSIMp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:31:52 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:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:31:52 INFO - Running setup.py (path:/tmp/pip-OHhu0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:31:52 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:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:31:52 INFO - Running setup.py (path:/tmp/pip-Ytd2_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:31:52 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:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:31:52 INFO - Running setup.py (path:/tmp/pip-v2gcGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:31:52 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:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:31:52 INFO - Running setup.py (path:/tmp/pip-miXIBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:31:52 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:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:31:52 INFO - Running setup.py (path:/tmp/pip-YaPaPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:31:52 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:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:31:52 INFO - Running setup.py (path:/tmp/pip-pymdjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:31:52 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:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:31:52 INFO - Running setup.py (path:/tmp/pip-UwUJoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:31:52 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:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:31:52 INFO - Running setup.py (path:/tmp/pip-oZYMup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:31:52 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:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:31:52 INFO - Running setup.py (path:/tmp/pip-ELHwk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:31:52 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:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:52 INFO - Running setup.py (path:/tmp/pip-Plcxc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:52 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:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:31:52 INFO - Running setup.py (path:/tmp/pip-3ozy86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:31:53 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:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:31:53 INFO - Running setup.py (path:/tmp/pip-kUIU3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:31:53 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:31:53 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:31:53 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:31:53 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:31:53 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:31:53 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:31:53 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:31:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:31:53 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:31:53 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:31:53 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:31:53 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:31:54 INFO - Downloading blessings-1.6.tar.gz 03:31:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:31:54 INFO - Installing collected packages: blessings 03:31:54 INFO - Running setup.py install for blessings 03:31:54 INFO - Successfully installed blessings 03:31:54 INFO - Cleaning up... 03:31:54 INFO - Return code: 0 03:31:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:31:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:31:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:31:54 INFO - Reading from file tmpfile_stdout 03:31:54 INFO - Current package versions: 03:31:54 INFO - argparse == 1.2.1 03:31:54 INFO - blessings == 1.6 03:31:54 INFO - blobuploader == 1.2.4 03:31:54 INFO - docopt == 0.6.1 03:31:54 INFO - functools32 == 3.2.3-2 03:31:54 INFO - jsonschema == 2.5.1 03:31:54 INFO - manifestparser == 1.1 03:31:54 INFO - mozInstall == 1.13 03:31:54 INFO - mozcrash == 1.0 03:31:54 INFO - mozdebug == 0.1 03:31:54 INFO - mozdevice == 0.51 03:31:54 INFO - mozfile == 1.2 03:31:54 INFO - mozhttpd == 0.7 03:31:54 INFO - mozinfo == 0.10 03:31:54 INFO - mozleak == 0.1 03:31:54 INFO - mozlog == 3.5 03:31:54 INFO - moznetwork == 0.27 03:31:54 INFO - mozprocess == 0.25 03:31:54 INFO - mozprofile == 0.28 03:31:54 INFO - mozrunner == 6.13 03:31:54 INFO - mozscreenshot == 0.1 03:31:54 INFO - mozsystemmonitor == 0.3 03:31:54 INFO - moztest == 0.8 03:31:54 INFO - mozversion == 1.4 03:31:54 INFO - psutil == 3.1.1 03:31:54 INFO - requests == 1.2.3 03:31:54 INFO - wsgiref == 0.1.2 03:31:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:54 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 0x19951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b60a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d03f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d01130>, '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 0x1d02030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d024c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1503484264.192027-1359262871', '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:31:54 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:31:54 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:31:54 INFO - Using env: {'DISPLAY': ':0', 03:31:54 INFO - 'HOME': '/home/cltbld', 03:31:54 INFO - 'LANG': 'en_US.UTF-8', 03:31:54 INFO - 'LANGUAGE': 'en_US:en', 03:31:54 INFO - 'LOGNAME': 'cltbld', 03:31:54 INFO - 'MAIL': '/var/mail/cltbld', 03:31:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:54 INFO - 'MOZ_NO_REMOTE': '1', 03:31:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:54 INFO - 'NO_EM_RESTART': '1', 03:31:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:54 INFO - 'PWD': '/builds/slave/test', 03:31:54 INFO - 'SHELL': '/bin/bash', 03:31:54 INFO - 'SHLVL': '1', 03:31:54 INFO - 'TERM': 'linux', 03:31:54 INFO - 'TMOUT': '86400', 03:31:54 INFO - 'USER': 'cltbld', 03:31:54 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1503484264.192027-1359262871', 03:31:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:54 INFO - '_': '/tools/buildbot/bin/python'} 03:31:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:54 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:31:54 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:31:54 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:31:54 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:31:54 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:31:54 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:31:54 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:31:54 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:31:54 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:31:54 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:31:56 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:31:56 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:31:56 INFO - Installing collected packages: simplejson 03:31:56 INFO - Running setup.py install for simplejson 03:31:56 INFO - building 'simplejson._speedups' extension 03:31:56 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:31:56 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:31:57 INFO - Successfully installed simplejson 03:31:57 INFO - Cleaning up... 03:31:57 INFO - Return code: 0 03:31:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:31:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b60a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d03f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d01130>, '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 0x1d02030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d024c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1503484264.192027-1359262871', '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:31:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:31:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:31:57 INFO - Using env: {'DISPLAY': ':0', 03:31:57 INFO - 'HOME': '/home/cltbld', 03:31:57 INFO - 'LANG': 'en_US.UTF-8', 03:31:57 INFO - 'LANGUAGE': 'en_US:en', 03:31:57 INFO - 'LOGNAME': 'cltbld', 03:31:57 INFO - 'MAIL': '/var/mail/cltbld', 03:31:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:57 INFO - 'MOZ_NO_REMOTE': '1', 03:31:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:57 INFO - 'NO_EM_RESTART': '1', 03:31:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:57 INFO - 'PWD': '/builds/slave/test', 03:31:57 INFO - 'SHELL': '/bin/bash', 03:31:57 INFO - 'SHLVL': '1', 03:31:57 INFO - 'TERM': 'linux', 03:31:57 INFO - 'TMOUT': '86400', 03:31:57 INFO - 'USER': 'cltbld', 03:31:57 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1503484264.192027-1359262871', 03:31:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:57 INFO - '_': '/tools/buildbot/bin/python'} 03:31:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:31:57 INFO - Cleaning up... 03:31:57 INFO - Return code: 0 03:31:57 INFO - Running post-action listener: _resource_record_post_action 03:31:57 INFO - Running post-action listener: _start_resource_monitoring 03:31:57 INFO - Starting resource monitoring. 03:31:57 INFO - [mozharness: 2017-08-23 10:31:57.375332Z] Finished create-virtualenv step (success) 03:31:57 INFO - [mozharness: 2017-08-23 10:31:57.375857Z] Running install step. 03:31:57 INFO - Running pre-action listener: _resource_record_pre_action 03:31:57 INFO - Running main action method: install 03:31:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:31:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:31:57 INFO - Reading from file tmpfile_stdout 03:31:57 INFO - Detecting whether we're running mozinstall >=1.0... 03:31:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:31:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:31:57 INFO - Reading from file tmpfile_stdout 03:31:57 INFO - Output received: 03:31:57 INFO - Usage: mozinstall [options] installer 03:31:57 INFO - Options: 03:31:57 INFO - -h, --help show this help message and exit 03:31:57 INFO - -d DEST, --destination=DEST 03:31:57 INFO - Directory to install application into. [default: 03:31:57 INFO - "/builds/slave/test"] 03:31:57 INFO - --app=APP Application being installed. [default: firefox] 03:31:57 INFO - mkdir: /builds/slave/test/build/application 03:31:57 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:31:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:32:15 INFO - Reading from file tmpfile_stdout 03:32:15 INFO - Output received: 03:32:15 INFO - /builds/slave/test/build/application/firefox/firefox 03:32:15 INFO - Running post-action listener: _resource_record_post_action 03:32:15 INFO - [mozharness: 2017-08-23 10:32:15.427939Z] Finished install step (success) 03:32:15 INFO - [mozharness: 2017-08-23 10:32:15.428219Z] Running setup-mitmproxy step. 03:32:15 INFO - Running pre-action listener: _resource_record_pre_action 03:32:15 INFO - Running main action method: setup_mitmproxy 03:32:15 INFO - Skipping: mitmproxy is not required 03:32:15 INFO - Running post-action listener: _resource_record_post_action 03:32:15 INFO - [mozharness: 2017-08-23 10:32:15.429363Z] Finished setup-mitmproxy step (success) 03:32:15 INFO - [mozharness: 2017-08-23 10:32:15.429660Z] Running run-tests step. 03:32:15 INFO - Running pre-action listener: _resource_record_pre_action 03:32:15 INFO - Running pre-action listener: _set_gcov_prefix 03:32:15 INFO - Running main action method: run_tests 03:32:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:32:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:32:15 INFO - Python 2.7.3 03:32:15 INFO - Return code: 0 03:32:15 INFO - grabbing minidump binary from tooltool 03:32:15 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:32:15 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 0x1d01130>, '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 0x1d02030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d024c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:32:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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:32:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:32:15 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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:32:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:32:15 INFO - Return code: 0 03:32:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:32:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:32:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:32:15 INFO - ENV: RUST_BACKTRACE is now full 03:32:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:32:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:32:15 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/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:32:15 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/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:32:15 INFO - Using env: {'DISPLAY': ':0', 03:32:15 INFO - 'HOME': '/home/cltbld', 03:32:15 INFO - 'LANG': 'en_US.UTF-8', 03:32:15 INFO - 'LANGUAGE': 'en_US:en', 03:32:15 INFO - 'LOGNAME': 'cltbld', 03:32:15 INFO - 'MAIL': '/var/mail/cltbld', 03:32:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:32:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:32:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:15 INFO - 'MOZ_NO_REMOTE': '1', 03:32:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:32:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:15 INFO - 'NO_EM_RESTART': '1', 03:32:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:15 INFO - 'PWD': '/builds/slave/test', 03:32:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:32:15 INFO - 'RUST_BACKTRACE': 'full', 03:32:15 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:32:15 INFO - 'SHELL': '/bin/bash', 03:32:15 INFO - 'SHLVL': '1', 03:32:15 INFO - 'STYLO_FORCE_ENABLED': '1', 03:32:15 INFO - 'TERM': 'linux', 03:32:15 INFO - 'TMOUT': '86400', 03:32:15 INFO - 'USER': 'cltbld', 03:32:15 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1503484264.192027-1359262871', 03:32:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:15 INFO - '_': '/tools/buildbot/bin/python'} 03:32:15 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/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:32:15 INFO - mozversion application_buildid: 20170823094126 03:32:15 INFO - mozversion application_changeset: b911a4c97fde5d8bdeebfd5d0266ee9f7b9e59b2 03:32:15 INFO - mozversion application_display_name: Nightly 03:32:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:32:15 INFO - mozversion application_name: Firefox 03:32:15 INFO - mozversion application_remotingname: firefox 03:32:15 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:32:15 INFO - mozversion application_vendor: Mozilla 03:32:15 INFO - mozversion application_version: 57.0a1 03:32:15 INFO - mozversion platform_buildid: 20170823094126 03:32:15 INFO - mozversion platform_changeset: b911a4c97fde5d8bdeebfd5d0266ee9f7b9e59b2 03:32:15 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:32:15 INFO - mozversion platform_version: 57.0a1 03:32:15 INFO - using testdate: 1503484335 03:32:15 INFO - actual date: 1503484335 03:32:15 INFO - starting webserver on 'localhost:54065' 03:32:15 INFO - SUITE-START | Running 2 tests 03:32:15 INFO - TEST-START | dromaeo_css 03:32:15 INFO - Initialising browser for dromaeo_css test... 03:32:15 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54065/getInfo.html -profile /tmp/tmp6LUeNA/profile 03:32:15 INFO - TEST-INFO | started process 1499 (/builds/slave/test/build/application/firefox/firefox http://localhost:54065/getInfo.html) 03:32:22 INFO - TEST-INFO | 1499: exit 0 03:32:22 INFO - Browser initialized. 03:32:22 INFO - Running cycle 1/1 for dromaeo_css test... 03:32:22 INFO - TEST-INFO | started process 1688 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6LUeNA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:32:23 INFO - PID 1688 | 03:32:23 INFO - PID 1688 | (/builds/slave/test/build/application/firefox/firefox:1738): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:32:23 INFO - PID 1688 | 03:32:24 INFO - PID 1688 | 03:32:24 INFO - PID 1688 | (/builds/slave/test/build/application/firefox/firefox:1799): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:32:24 INFO - PID 1688 | 03:32:24 INFO - PID 1688 | __metrics Screen width/height:1600/1200 03:32:24 INFO - PID 1688 | colorDepth:24 03:32:24 INFO - PID 1688 | Browser inner width/height: 1024/768 03:32:24 INFO - PID 1688 | __metrics 03:32:34 INFO - PID 1688 | RSS: Main: 174256128 03:32:34 INFO - PID 1688 | 03:35:32 INFO - PID 1688 | Cycle 1(1): loaded http://localhost:54065/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54065/tests/dromaeo/cssquery-ext.html) 03:35:33 INFO - PID 1688 | RSS: Main: 178286592 03:35:33 INFO - PID 1688 | 03:38:35 INFO - PID 1688 | Cycle 1(1): loaded http://localhost:54065/tests/dromaeo/cssquery-ext.html (next: http://localhost:54065/tests/dromaeo/cssquery-jquery.html) 03:38:36 INFO - PID 1688 | RSS: Main: 175509504 03:38:36 INFO - PID 1688 | 03:41:38 INFO - PID 1688 | Cycle 1(1): loaded http://localhost:54065/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54065/tests/dromaeo/cssquery-mootools.html) 03:41:38 INFO - PID 1688 | RSS: Main: 177508352 03:41:38 INFO - PID 1688 | 03:44:40 INFO - PID 1688 | Cycle 1(1): loaded http://localhost:54065/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54065/tests/dromaeo/cssquery-prototype.html) 03:44:41 INFO - PID 1688 | RSS: Main: 175407104 03:44:41 INFO - PID 1688 | 03:47:44 INFO - PID 1688 | Cycle 1(1): loaded http://localhost:54065/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54065/tests/dromaeo/cssquery-yui.html) 03:47:45 INFO - PID 1688 | RSS: Main: 179101696 03:47:45 INFO - PID 1688 | 03:50:47 INFO - PID 1688 | Cycle 1(1): loaded http://localhost:54065/tests/dromaeo/cssquery-yui.html (next: http://localhost:54065/tests/dromaeo/cssquery-dojo.html) 03:50:47 INFO - PID 1688 | RSS: Main: 179507200 03:50:47 INFO - PID 1688 | 03:50:47 INFO - PID 1688 | __start_tp_report 03:50:47 INFO - PID 1688 | _x_x_mozilla_page_load 03:50:47 INFO - PID 1688 | _x_x_mozilla_page_load_details 03:50:47 INFO - PID 1688 | |i|pagename|runs| 03:50:47 INFO - PID 1688 | |0;dojo.html;3283.40898638245;3292.3086151908096;3308.6525914778963;3322;3327.2680010397703;6119.449249567538;6189.876202475948;6204.162438070859;6227.595206311592;6273.12176295319;6125.173101631279;6214;6223.844403889905;6231.065340198972;6245.250569931603;5703.885922281552;5719.656820590768;5730.512906402961;5736.996025695507;5754.16564598133;5738.340090889538;5759.625624334426;5776.306843178803;5776.364599894029;5813.7383817728305;5750.309962804448;5759.251297331341;5806.680632565207;5815.592908496407;5816.476517113459;5730.197772311859;5769.913451298213;5778.393268706767;5810.273715785527;5825.271841019872;5120.641555091145;5568.749406276727;5671.376148623648;5686.601937864351;5745.080787074048;6097.085437184413;6148.600340977867;6182.814515564541;6219.502439804804;6226.844328891769;6648.700808463631;6697.095892054559;6780.694868730919;6784.76253331131;6796.422304104157;6610.239822420435;6633.03820945965;6685.799426017227;6710.463162946952;6732.394084532367;6208.161898143783;6219.315875253764;6229.750809967596;6289.150964619764;6306.306306306303;6902.482313826483;6951.061606683134;6951.061606683134;6972.163340399185;6985.720571177096;6579.671016449159;6585.835354116185;6598.307177746364;6657.733690652417;6702.798916032527;6558.8360290993105;6623.039659249382;6681.9331806682285;6711.127553418122;6785.8642827143185;6578.8355291118105;6660.966695166493;6676;6676.26561078281;6704.061431399608;6602.801915942529;6621.668916554153;6644.734210631521;6695.765648202289;6724.428423583952;5279.366476022825;5280.894382112337;5325.467453254643;5358.544523715528;5359.14253719403;4604.58558729716;4650.558196971282;4689.50760170184;4714.905701885943;4722.456917454537;5774.653520788682;5815.912761308584;5845.620034697731;5846.444587764156;5870.031444811643;6581.605103693793;6596.175478065242;6597.043428702811;6601.504887133484;6632.535722499475;5809.7095145242565;5870.882582348415;5890.67601281925;5904.852378690567;5921.02303119989;5821.650700957956;5897.49871260939;5899.76400943966;5908.822735317947;5909.497692696083;6374.075759014917;6476.287608363076;6493.090967264587;6527.738890444424;6613.371729685672;6839.69221385029;6846.4522838173825;6876.587404755731;6877.828054298682;6878.896816547855;6530.738770449128;6555.4427873631275;6633.436157926437;6636.203655561363;6643.56816806906;6633.800985970429;6637.137172167587;6726.529142960141;6732.192136943402;6739.528233023641;6516.51126165549;6621.039949207434;6746.898796518154;6772.796816095328;6819.5908245505425;6528.412442880163;6574.934250657432;6584.8024559263295;6585.374389432996;6596.175478065242;6492.513061520499;6520.445762110274;6521.250056243593;6613.27254002069;6616.569922954993;6463.547551671338;6473;6523.412892839668;6553.04980777775;6563.015547667888;6470.029495575702;6556.409923106943;6643.036759669917;6649.73401063952;6688.598684078971;6432.903506447314;6439.710213040331;6463.547551671338;6467.450266727381;6483.546151769331 03:50:47 INFO - PID 1688 | |1;ext.html;808.2079562029211;861.9310455163586;880.9647614095436;883.1830556735023;1128.6952522818844;29880.70119298809;39031.80484097579;39984.800075999614;40028.59971400285;40193.79903100488;39544.40683389751;40126;40144.19711605766;40165.7991710041;40209.79895100521;7511.737089201879;7674.117476490192;7676.616169191546;7695.345895598881;7704.229577042307;7475.215102414222;7520.285572870568;7614.581198034106;7620.199879012707;7621.542707437544;5705.771769129251;5836.241288632472;5842.620229685057;7445.664945077485;7630.618469076552;7600.809979750523;7665.693372265103;7669.846603067936;7670.3480204182715;7671.616419179047;7460.25397460255;7537.585432801194;7545.170031296553;7558.924410755877;7559.3196612305155;36246;36472.452913206325;36474.088147796254;36478;36481.087972800626;3422.7946323220435;3433.9656603434146;3439.6216416194197;3444.9483257750903;3446.0178849027907;30374.54438183429;30555.541666875015;30565.847170764227;30581;30583.541246881316;4966.900661986776;4997.525235102659;5012.398512178562;5021.17150670139;5025.572826309768;189784;190335;190603;191076;191513;47388.52611473841;47418.28872566914;47461;47468.287975680396;47895;50036;50067.49932500701;50180.498195018314;50184.247236291485;50195;15501.224938753017;15764.842351576566;15770.921145394199;15771.29029193689;15783.605409864846;13039.152455090389;13047.804282935764;13062.477500899857;13067.085304028817;13089.41097650608;12772.808407873888;12920.935395322964;12999.1550549214;13043.869561304455;13122.409491572902;4522.66080043998;4626.97686511572;5106.821261255838;5285.1237810576695;5500.119980803132;997.7356000659831;1007.4005966449951;1009.9899001010043;1010.1111022300329;1032.9070383665355;22627.773722262566;28255.43489130206;28330.575041374395;28356.291092722848;29234.415311693647;1084.446932064637;1090.3839330778085;1093.606301731376;1095.2497539185524;1110.9166812488934;11357.829632555518;11696.181267311207;11743.647690569296;11880.821787673192;11905.940470297593;226806;227414;227588;227645;227718;49107;49638.25542616864;49680.50319496759;49706;49739.50260497421;1374.4090041282345;1400.7548678981138;1408.3521580073282;1414.9221792801495;1416.3484796993293;21397.572048559254;21426.464338391666;21656.242031528822;21877.234296799536;21912;35078.29843403168;35111.824440878656;35190;35192.64807351894;35245.82377088098;202954;203435;204386;204482.97758511113;204515;31082.689173108884;31411;32793.34413311768;34487.82756086203;34746.826265868505;38406.079696015644;43090.56909430865;45437.54562454333;45860;46050;33188.668113318556;33315.83342083274;33576.32847342991;33795.4930676045;34181.65818341785;32429.675703242665;32511.512327314635;32733.872298300535;32882.67117328796;33428.498572521916;37072.258554828215;37305.6269437313;37353.62646373502;37388;37508.2498350026;31451.370972579964;31469.685303146674;31481.370372591962;32047.198820029687;32051.03846884597;23918.402039948443;24047.51904961926;24340.026398943843;24796.38009049788;24923.75076249287 03:50:47 INFO - PID 1688 | |2;jquery.html;559.9612718407352;565.5051829649057;573.8794853080852;575.2636625119845;578.4129108954411;21617.891910540446;22287.331380058604;22327.66508502374;22359;22985.540289194207;22567.887160564173;22847.086116555318;22914.770852291473;22920;22950;6499.415052645273;6632.568883022612;6638.634875081869;6640.369164929348;6646.734130634769;6005;6538.6076835389795;6605.174353205849;6613.338666133396;6617.801465956005;6536.607803531803;6581.078648989145;6581.440577550914;6581.868362632745;6590.373914478141;6527.575707579016;6567.310432404624;6568.573042752206;6574.145361103074;6579.17760279965;6065.63606183626;6097.20736304282;6101.664408457533;6103.542234332443;6124;27759.444811103665;28079.859600701864;28688.282792930135;28933.42133157346;29438.41123177546;1981.0787983587702;2028.908699108529;2029.1173339597322;2031.5124370151057;2032.5934813037452;18845.623087538308;19422.80577194224;19427.22291108354;19453.610927781367;19468;2385.971825435921;2396.1373905394044;2451.669024681663;2517.6852893388327;2522.911698090558;126090;129856.35071824674;130999;131027;131308;14231.78652320216;14436.639084022983;14836.554903352917;14844.925775371054;14955.476558320406;22551.210707625156;22700.432489187904;22705.318840434815;22717;22730.659040114413;9876.35803672759;10057.346272492265;10070.74115735533;10101.19190464761;10209.38743675382;7872.567008814455;9306.86039709405;9346.20557252641;9616.807663846825;9655.275854310814;7627.389808815282;8934.151255630704;9045.231155351868;9053.547322633842;9089.136532029446;2586.818922675395;2621.6460777795137;2668.813183077166;2723.809333346647;2725.2914242297147;968.3560432312433;982.7985263021063;983.188869182927;999.9650012249537;1003.9949800251098;19202.51993700141;19614.509637258896;19988.900055499922;20094;20379.388618341472;1025.6974192613047;1045.3466583385384;1048.2714513413257;1053.4574694032578;1057.5293994172519;10976.560937562568;11060.834087488694;11120.443977801078;11254.943725281484;11341.262817916973;534355;535714;538601;544777;548057;114458.42770786093;121921.39039304746;121947;123258.53482930291;123701;1201.633501781965;1221.291919649755;1244.8132780082879;1246.9501219951283;1254.0406588959454;20773.27293544719;20959.476013099793;21009.264675736886;21281.73038088915;21383.893080534497;56692.433075670364;57262.7136864313;57909.42090579209;57909.71045144747;59393.70303148457;72000.63999679968;72069.63965180141;72415.63792181005;72461;73171.63414182895;13939.372728227052;14441.855581444051;14468.565943021726;14482.98619096653;14519.92740036293;22432.327030188466;22616.773832261468;22753.317400478012;22858.657120142878;22967.88516057409;18657.81342186561;19168.233270669574;19524.121414536097;19554.804451955297;19852.60294794125;17550.473485795446;17613.471595852145;17638.735418968983;17774.46676599704;18125.909370453064;18133.27466901309;19271.51821204481;19848;19959.20163193456;20021;14460.20468874222;14556.19940903218;14659.120452772868;14749;14768.704625907636;18810.811891881454;18935.053247337855;18969.33607323737;19023.52441188926;19042.619147617246 03:50:47 INFO - PID 1688 | |3;mootools.html;1279.5073896549827;1297.8507471640764;1318.7824009038502;1319.9208047517152;1339.9933000334997;14427.855721442782;15078.698426031473;15085.245737713125;15099.16954567497;15226;15195.924020379882;15494.922525387385;15495.302711377986;15509.379624814994;15510.844891551082;2661.4810112028163;2700.9189724308303;2709.9593506097326;2716.578930265812;2720.687120981083;2605.7003444603924;2710.823796453224;2765.5713364428548;2771.847548384838;2778.5137600919757;2675.357914100621;2698.541247987837;2699.35215548269;2702.554078577032;2717.605947137664;2624.3045592917892;2675.4381579868054;2679.718629543899;2682.946341073168;2703.418764965532;2557.539642864284;2604.7525485078886;2609.686837579484;2630.2898217481365;2637.3933995181023;14673.926630366886;14763.926180369137;14789.260536973215;14804.185769782658;14845;7993.4004949628425;8258.132896045949;8259.339252859756;8260.8347833043;8268.875966860502;5363.651362661414;5587.580931430119;5704.914426283609;5712.914306285409;5715.599908006441;1886.141805478504;1931.1502938707065;1943.2421355671158;1987.1058023889307;2002.5994801039706;25747;25823.612645810328;25867.0946516871;25983.61024584633;25992.22023339303;6520.445762110179;7175.748848790372;7251.202367739545;7544.886826697604;7548.584827834412;16871.493855184362;17095.829041709425;17150.571235719206;17256.827431725775;17278.827211727723;7820.491668041559;7946.9602651987525;7949.966504354513;7959.920400796033;7960.56216908064;6117.235345581802;7235.638218089074;7321.560706357635;7337.19290878003;7359.411247100219;4679;5226.92159617606;5375.838724838261;5383.757730902119;5391.595630327741;1501.3919362657923;1542.8765698744073;1551.115863957556;1555.5799934017978;1571.1908367190906;774.6823802241054;804.5253300552702;806.5402720449288;814.230552128245;815.6615004773072;8016.599170041474;8391.286740627114;8414.11651776567;8424.368172387096;8445.788855278668;992.503748125937;994.5280984143508;995.3629677006721;998.2014388489325;1020.9132223760915;4460.576245256695;4629.467611224685;5024.346834911438;5188.558972487381;5210.010098081352;20324;20639.69040464394;21192.15231390727;21231.15075396967;21505.462363440725;20511.38465846027;20568.897155514125;20646.380608581767;20748;20838.895805520875;10772.569097236023;10988.120950323955;11022.063124634336;11023.889761102608;11091.778164436666;8609.13908609159;8612.870806937775;8680.91319086801;8681.565921704016;8857.025727170136;18093.638127237118;18239.179236934637;18390.839068912064;18652.44042678722;18678.439646810617;18480.168392422103;18624.255029798656;18955.810441895956;19001.619967600847;19451.51371215731;11922.880771192524;12107.878921210675;12271.57049503263;12275.75448491043;12284.508619655113;13844.584662460142;13940.790888136484;13971.510997115052;13977.161370317814;13998.650033749238;10707.732306692395;10714.678559643224;10984.945075274572;11031.393273370042;11242.718932026764;10950.945245273722;10981.450927453756;11007.394593297446;11143.2199746017;11292;10004.999500050228;10149.543270552991;10255.077043065861;10269.948650256702;10270.383776973405;6960.617166055916;6979;6989.650517474004;7059.823504412226;7062.505624606229;7401.777946661608;7408.851822963618;7485.850282994418;7486.513376630502;7549.169591345058 03:50:47 INFO - PID 1688 | |4;prototype.html;496.5243296921549;500.9757376285208;512.8794733237689;515.3326442257277;518.9351331083615;6150.600210986283;6190.514276573624;6246.469614944339;6276.968615156923;6277.34087920768;5996.850078748033;6014.158017877489;6058;6078.118672792442;6112.877742445148;4918.827841025565;4974.1295273327205;4987.725675087887;4996.82511112112;5047.570956468705;4887.120318342697;4969.527894850002;5017.222330538754;5020.723860187688;5022.246663000561;4780.641451891122;4782.7608619569055;4855.421987853944;4934.6299027572895;4955.776990035457;4880.560749532559;4941.357623508957;4964.429090654567;4965.577925876305;4966.708655749495;4389.736615803062;4394.62645675118;4432.224360736858;4443.822247110112;4447.488538818045;5933.643981361089;5938.703064846741;5966.701664916737;5994.732870585542;6014.1580178775;5641.915371269434;5710.600257981943;5716.628009277785;5719.571032172562;5730.914036289459;6375.458086062644;6454.838629034265;6493.25327587324;6525.934740652628;6556.24603170632;4845.515448455161;4861.635377346678;4861.927071093936;4879.243717223836;4879.512048795127;6781.931510889177;6902.758403455905;6930.826729331807;6931.168259808805;6936.4797640177185;4903.950960490421;4921.342475063498;4966.304717339575;4999.525519556153;5047.520485553867;4976.552110310089;5013;5019.874503137451;5051.621128415383;5052.722100284446;5652.3217213934595;5701.344345400249;5703.116017017369;5708.800191993343;5721.628094173865;6630.469562434993;6645.800625981228;6662.933370666328;6664.366885145903;6690.156683409628;1653.2560347843519;1705.2411676803704;1710.8366310908702;1732.7487514310606;1737.218251786701;1120.3166068698088;1197.4970512384818;1216.385725208764;1220.9572664956684;1225.185251807556;5731.799387021434;5742.7415766290615;5805.187273781674;5828.76684932598;5831.542114471382;6587.341265873374;6597.670116494156;6657.46740260778;6705.6982435790505;6722.193336799615;5645.971770141123;5670.744816483269;5744.684042377709;5771.567132465082;5799.159121927381;3514.9648503514636;3516.7362447816517;3542.8051457170104;3568.57177138745;3595.7303202259936;6365.649889256136;6392.808215753535;6433.195850518685;6502.934970650233;6516.837079073061;6747.763828265987;6783.9824026395445;6882.518223724292;6895.379415852597;6966.860662786716;6413.414408697803;6456.548041637135;6561.606303621798;6576.506761992965;6576.671166441659;6569.770058047945;6639.2364878037715;6675.23234828001;6707.798766037026;6710.530262881552;6481.351864813481;6553.148090748172;6612.933870661232;6640.269570347161;6726.932730672631;6401.519886008475;6455.160829092188;6471.838204044749;6513.055606936873;6514.1531600891585;4889.168841297059;4965.627577931742;4979.3277907482025;4988.21131713559;5006.69959802413;6533.248676402274;6645.734170633314;6670.332966703291;6681.398674119353;6696.464282857457;6457.903131452938;6510.934890651033;6512.218533775977;6553.082568440327;6569.211694596679;6403.743850246125;6475.967620161869;6539.574927629689;6545.672716364067;6549.8690026200165;6104.359042300494;6227.719752611234;6391.552591318749;6501.544891857525;6504.15445992018;6619.933800662125;6629.933700663125;6645.501587381063;6650.567713098633;6657.866842663217;6361.17304750398;6365.490760739222;6387.520935929917;6418.935810641834;6422.197225346832 03:50:47 INFO - PID 1688 | |5;yui.html;854.8065554956443;869.6477926439786;872.511393619573;887.7159309021112;900.6667533012786;18743.718844217346;19355.516112097186;19462.221511139538;19505.12226949787;21624.567508649816;19839.5040123997;20892;20893.895530522364;20911.895440522814;20994.580108397822;894.3605322194646;919.6183583812709;924.4083786376724;925.6852670092168;927.7077720518049;923.4966943016038;964.6334392930677;974.28390133252;974.4543055888689;977.4575110813496;1016.425719468498;1029.3103620574234;1030.855680204772;1031.2214278219933;1031.814273430786;1016.9135623472014;1016.9949150254201;1018.3686114608915;1018.5212949913603;1018.6231094495047;750.8610906982226;750.913644930829;751.0461713623722;751.1924680967927;751.6504825256227;17849.7322540162;17876.642467150716;18043.639127217513;18052.458426247103;19418;20535.691964620542;20581.38255852327;20749.688754668692;21281.467963301042;21300;16711.247993840305;16822.15889205547;16916.830831691772;16917.407890723767;16937.237824297936;3411.3347897160065;3411.3688967541084;3435.9656403436147;3444.2767018925806;3445.9655403445895;125424;125580.37209813892;127905;129156.35421822924;135202.3239883804;16905.661886762195;17127.14364281781;17366.21852016637;17506.649867002845;17598;29974.55038174429;30570.235744106132;30690;30888.845555772077;30929;7537.736179233701;7912.36701063925;8396.118407567239;8888.644454221889;8973.685920992733;4093.4473846030405;4182.602652747984;4188.267053265728;4223.556526564728;4231.936520952188;4929.950700492949;4957.628177886673;4982.975085124624;4997.450280469146;5040.546350828443;996.6013594562233;1017.4149863828328;1026.2405819693374;1026.9024442677933;1028.573142146016;638.9169407976933;682.6518475577491;694.264080075122;700.6216643012716;707.1549498349423;11658.18392712519;11865;12063.698407539707;12339.568115115928;13320.800187997187;706.3678008182751;708.5677736580682;710.1655554723283;713.4470785141557;715.8103102677794;5697.4587414195585;5833.533317334603;5840.357560668408;5908.409159084057;6038.667873266924;111726.44136779426;113499;115847.42076289734;116275.41862290635;117626.41186794182;97671.51164244133;99124;100973;101638.49180754197;106170;88501;88660;88985.55507222422;91361.54319228361;93570;11091.112710983263;12334.629961101182;12550.1842380245;13280.269585172908;13364.866351336363;38739.41890871583;39780.2043959125;41060.58939410687;41472.170556589306;41817.1636567273;65573.5738137609;70423;71603;72536.63731681308;74945.25054749382;18044;18490;18584.7212291813;18590.53523661919;18805.529861753566;21811.781882180974;21954.34136975893;22039.33881983543;22237.55524889461;22340.21809236669;17282.22229999678;17862.642747145244;17933.461996140137;17953.102344882966;17996.730049049536;18343.449696509128;18489.260429583202;18576.907115464335;18705.34531291398;19010.23959041623;17494;17704.734428983316;18336.90831545834;18355.816441835945;19377.321793737152;13150.736985260433;13521.59435216945;13573.52492662752;13796.03427760047;13819.447222111003;14409.78385324242;14472.638184045483;14514.346854391366;14746.852531474548;14796.630084247548 03:50:47 INFO - PID 1688 | __end_tp_report 03:50:47 INFO - PID 1688 | __start_cc_report 03:50:47 INFO - PID 1688 | _x_x_mozilla_cycle_collect,387 03:50:47 INFO - PID 1688 | __end_cc_report 03:50:47 INFO - PID 1688 | __startTimestamp1503485447637__endTimestamp 03:50:47 INFO - PID 1688 | 03:50:47 INFO - PID 1688 | ------- Summary: start ------- 03:50:47 INFO - PID 1688 | Number of tests: 6 03:50:47 INFO - PID 1688 | 03:50:47 INFO - PID 1688 | [#0] dojo.html Cycles:165 Average:6181.98 Median:6473.00 stddev:718.13 (11.1%) stddev-sans-first:683.38 03:50:47 INFO - PID 1688 | Values: 3283.4 3292.3 3308.7 3322.0 3327.3 6119.4 6189.9 6204.2 6227.6 6273.1 6125.2 6214.0 6223.8 6231.1 6245.3 5703.9 5719.7 5730.5 5737.0 5754.2 5738.3 5759.6 5776.3 5776.4 5813.7 5750.3 5759.3 5806.7 5815.6 5816.5 5730.2 5769.9 5778.4 5810.3 5825.3 5120.6 5568.7 5671.4 5686.6 5745.1 6097.1 6148.6 6182.8 6219.5 6226.8 6648.7 6697.1 6780.7 6784.8 6796.4 6610.2 6633.0 6685.8 6710.5 6732.4 6208.2 6219.3 6229.8 6289.2 6306.3 6902.5 6951.1 6951.1 6972.2 6985.7 6579.7 6585.8 6598.3 6657.7 6702.8 6558.8 6623.0 6681.9 6711.1 6785.9 6578.8 6661.0 6676.0 6676.3 6704.1 6602.8 6621.7 6644.7 6695.8 6724.4 5279.4 5280.9 5325.5 5358.5 5359.1 4604.6 4650.6 4689.5 4714.9 4722.5 5774.7 5815.9 5845.6 5846.4 5870.0 6581.6 6596.2 6597.0 6601.5 6632.5 5809.7 5870.9 5890.7 5904.9 5921.0 5821.7 5897.5 5899.8 5908.8 5909.5 6374.1 6476.3 6493.1 6527.7 6613.4 6839.7 6846.5 6876.6 6877.8 6878.9 6530.7 6555.4 6633.4 6636.2 6643.6 6633.8 6637.1 6726.5 6732.2 6739.5 6516.5 6621.0 6746.9 6772.8 6819.6 6528.4 6574.9 6584.8 6585.4 6596.2 6492.5 6520.4 6521.3 6613.3 6616.6 6463.5 6473.0 6523.4 6553.0 6563.0 6470.0 6556.4 6643.0 6649.7 6688.6 6432.9 6439.7 6463.5 6467.5 6483.5 03:50:47 INFO - PID 1688 | 03:50:47 INFO - PID 1688 | [#1] ext.html Cycles:180 Average:37306.77 Median:3436.79 stddev:53857.84 (1567.1%) stddev-sans-first:53939.19 03:50:47 INFO - PID 1688 | Values: 808.2 861.9 881.0 883.2 1128.7 29880.7 39031.8 39984.8 40028.6 40193.8 39544.4 40126.0 40144.2 40165.8 40209.8 7511.7 7674.1 7676.6 7695.3 7704.2 7475.2 7520.3 7614.6 7620.2 7621.5 5705.8 5836.2 5842.6 7445.7 7630.6 7600.8 7665.7 7669.8 7670.3 7671.6 7460.3 7537.6 7545.2 7558.9 7559.3 36246.0 36472.5 36474.1 36478.0 36481.1 3422.8 3434.0 3439.6 3444.9 3446.0 30374.5 30555.5 30565.8 30581.0 30583.5 4966.9 4997.5 5012.4 5021.2 5025.6 189784.0 190335.0 190603.0 191076.0 191513.0 47388.5 47418.3 47461.0 47468.3 47895.0 50036.0 50067.5 50180.5 50184.2 50195.0 15501.2 15764.8 15770.9 15771.3 15783.6 13039.2 13047.8 13062.5 13067.1 13089.4 12772.8 12920.9 12999.2 13043.9 13122.4 4522.7 4627.0 5106.8 5285.1 5500.1 997.7 1007.4 1010.0 1010.1 1032.9 22627.8 28255.4 28330.6 28356.3 29234.4 1084.4 1090.4 1093.6 1095.2 1110.9 11357.8 11696.2 11743.6 11880.8 11905.9 226806.0 227414.0 227588.0 227645.0 227718.0 49107.0 49638.3 49680.5 49706.0 49739.5 1374.4 1400.8 1408.4 1414.9 1416.3 21397.6 21426.5 21656.2 21877.2 21912.0 35078.3 35111.8 35190.0 35192.6 35245.8 202954.0 203435.0 204386.0 204483.0 204515.0 31082.7 31411.0 32793.3 34487.8 34746.8 38406.1 43090.6 45437.5 45860.0 46050.0 33188.7 33315.8 33576.3 33795.5 34181.7 32429.7 32511.5 32733.9 32882.7 33428.5 37072.3 37305.6 37353.6 37388.0 37508.2 31451.4 31469.7 31481.4 32047.2 32051.0 23918.4 24047.5 24340.0 24796.4 24923.8 03:50:47 INFO - PID 1688 | 03:50:47 INFO - PID 1688 | [#2] jquery.html Cycles:180 Average:36179.59 Median:22559.55 stddev:90268.77 (400.1%) stddev-sans-first:90482.38 03:50:47 INFO - PID 1688 | Values: 560.0 565.5 573.9 575.3 578.4 21617.9 22287.3 22327.7 22359.0 22985.5 22567.9 22847.1 22914.8 22920.0 22950.0 6499.4 6632.6 6638.6 6640.4 6646.7 6005.0 6538.6 6605.2 6613.3 6617.8 6536.6 6581.1 6581.4 6581.9 6590.4 6527.6 6567.3 6568.6 6574.1 6579.2 6065.6 6097.2 6101.7 6103.5 6124.0 27759.4 28079.9 28688.3 28933.4 29438.4 1981.1 2028.9 2029.1 2031.5 2032.6 18845.6 19422.8 19427.2 19453.6 19468.0 2386.0 2396.1 2451.7 2517.7 2522.9 126090.0 129856.4 130999.0 131027.0 131308.0 14231.8 14436.6 14836.6 14844.9 14955.5 22551.2 22700.4 22705.3 22717.0 22730.7 9876.4 10057.3 10070.7 10101.2 10209.4 7872.6 9306.9 9346.2 9616.8 9655.3 7627.4 8934.2 9045.2 9053.5 9089.1 2586.8 2621.6 2668.8 2723.8 2725.3 968.4 982.8 983.2 1000.0 1004.0 19202.5 19614.5 19988.9 20094.0 20379.4 1025.7 1045.3 1048.3 1053.5 1057.5 10976.6 11060.8 11120.4 11254.9 11341.3 534355.0 535714.0 538601.0 544777.0 548057.0 114458.4 121921.4 121947.0 123258.5 123701.0 1201.6 1221.3 1244.8 1247.0 1254.0 20773.3 20959.5 21009.3 21281.7 21383.9 56692.4 57262.7 57909.4 57909.7 59393.7 72000.6 72069.6 72415.6 72461.0 73171.6 13939.4 14441.9 14468.6 14483.0 14519.9 22432.3 22616.8 22753.3 22858.7 22967.9 18657.8 19168.2 19524.1 19554.8 19852.6 17550.5 17613.5 17638.7 17774.5 18125.9 18133.3 19271.5 19848.0 19959.2 20021.0 14460.2 14556.2 14659.1 14749.0 14768.7 18810.8 18935.1 18969.3 19023.5 19042.6 03:50:47 INFO - PID 1688 | 03:50:47 INFO - PID 1688 | [#3] mootools.html Cycles:180 Average:9281.61 Median:25987.92 stddev:6532.11 (25.1%) stddev-sans-first:6522.76 03:50:47 INFO - PID 1688 | Values: 1279.5 1297.9 1318.8 1319.9 1340.0 14427.9 15078.7 15085.2 15099.2 15226.0 15195.9 15494.9 15495.3 15509.4 15510.8 2661.5 2700.9 2710.0 2716.6 2720.7 2605.7 2710.8 2765.6 2771.8 2778.5 2675.4 2698.5 2699.4 2702.6 2717.6 2624.3 2675.4 2679.7 2682.9 2703.4 2557.5 2604.8 2609.7 2630.3 2637.4 14673.9 14763.9 14789.3 14804.2 14845.0 7993.4 8258.1 8259.3 8260.8 8268.9 5363.7 5587.6 5704.9 5712.9 5715.6 1886.1 1931.2 1943.2 1987.1 2002.6 25747.0 25823.6 25867.1 25983.6 25992.2 6520.4 7175.7 7251.2 7544.9 7548.6 16871.5 17095.8 17150.6 17256.8 17278.8 7820.5 7947.0 7950.0 7959.9 7960.6 6117.2 7235.6 7321.6 7337.2 7359.4 4679.0 5226.9 5375.8 5383.8 5391.6 1501.4 1542.9 1551.1 1555.6 1571.2 774.7 804.5 806.5 814.2 815.7 8016.6 8391.3 8414.1 8424.4 8445.8 992.5 994.5 995.4 998.2 1020.9 4460.6 4629.5 5024.3 5188.6 5210.0 20324.0 20639.7 21192.2 21231.2 21505.5 20511.4 20568.9 20646.4 20748.0 20838.9 10772.6 10988.1 11022.1 11023.9 11091.8 8609.1 8612.9 8680.9 8681.6 8857.0 18093.6 18239.2 18390.8 18652.4 18678.4 18480.2 18624.3 18955.8 19001.6 19451.5 11922.9 12107.9 12271.6 12275.8 12284.5 13844.6 13940.8 13971.5 13977.2 13998.7 10707.7 10714.7 10984.9 11031.4 11242.7 10950.9 10981.5 11007.4 11143.2 11292.0 10005.0 10149.5 10255.1 10269.9 10270.4 6960.6 6979.0 6989.7 7059.8 7062.5 7401.8 7408.9 7485.9 7486.5 7549.2 03:50:47 INFO - PID 1688 | 03:50:47 INFO - PID 1688 | [#4] prototype.html Cycles:180 Average:5484.17 Median:6014.16 stddev:1546.53 (25.7%) stddev-sans-first:1504.88 03:50:47 INFO - PID 1688 | Values: 496.5 501.0 512.9 515.3 518.9 6150.6 6190.5 6246.5 6277.0 6277.3 5996.9 6014.2 6058.0 6078.1 6112.9 4918.8 4974.1 4987.7 4996.8 5047.6 4887.1 4969.5 5017.2 5020.7 5022.2 4780.6 4782.8 4855.4 4934.6 4955.8 4880.6 4941.4 4964.4 4965.6 4966.7 4389.7 4394.6 4432.2 4443.8 4447.5 5933.6 5938.7 5966.7 5994.7 6014.2 5641.9 5710.6 5716.6 5719.6 5730.9 6375.5 6454.8 6493.3 6525.9 6556.2 4845.5 4861.6 4861.9 4879.2 4879.5 6781.9 6902.8 6930.8 6931.2 6936.5 4904.0 4921.3 4966.3 4999.5 5047.5 4976.6 5013.0 5019.9 5051.6 5052.7 5652.3 5701.3 5703.1 5708.8 5721.6 6630.5 6645.8 6662.9 6664.4 6690.2 1653.3 1705.2 1710.8 1732.7 1737.2 1120.3 1197.5 1216.4 1221.0 1225.2 5731.8 5742.7 5805.2 5828.8 5831.5 6587.3 6597.7 6657.5 6705.7 6722.2 5646.0 5670.7 5744.7 5771.6 5799.2 3515.0 3516.7 3542.8 3568.6 3595.7 6365.6 6392.8 6433.2 6502.9 6516.8 6747.8 6784.0 6882.5 6895.4 6966.9 6413.4 6456.5 6561.6 6576.5 6576.7 6569.8 6639.2 6675.2 6707.8 6710.5 6481.4 6553.1 6612.9 6640.3 6726.9 6401.5 6455.2 6471.8 6513.1 6514.2 4889.2 4965.6 4979.3 4988.2 5006.7 6533.2 6645.7 6670.3 6681.4 6696.5 6457.9 6510.9 6512.2 6553.1 6569.2 6403.7 6476.0 6539.6 6545.7 6549.9 6104.4 6227.7 6391.6 6501.5 6504.2 6619.9 6629.9 6645.5 6650.6 6657.9 6361.2 6365.5 6387.5 6418.9 6422.2 03:50:47 INFO - PID 1688 | 03:50:47 INFO - PID 1688 | [#5] yui.html Cycles:180 Average:24274.81 Median:20892.95 stddev:33201.31 (158.9%) stddev-sans-first:33247.88 03:50:47 INFO - PID 1688 | Values: 854.8 869.6 872.5 887.7 900.7 18743.7 19355.5 19462.2 19505.1 21624.6 19839.5 20892.0 20893.9 20911.9 20994.6 894.4 919.6 924.4 925.7 927.7 923.5 964.6 974.3 974.5 977.5 1016.4 1029.3 1030.9 1031.2 1031.8 1016.9 1017.0 1018.4 1018.5 1018.6 750.9 750.9 751.0 751.2 751.7 17849.7 17876.6 18043.6 18052.5 19418.0 20535.7 20581.4 20749.7 21281.5 21300.0 16711.2 16822.2 16916.8 16917.4 16937.2 3411.3 3411.4 3436.0 3444.3 3446.0 125424.0 125580.4 127905.0 129156.4 135202.3 16905.7 17127.1 17366.2 17506.6 17598.0 29974.6 30570.2 30690.0 30888.8 30929.0 7537.7 7912.4 8396.1 8888.6 8973.7 4093.4 4182.6 4188.3 4223.6 4231.9 4930.0 4957.6 4983.0 4997.5 5040.5 996.6 1017.4 1026.2 1026.9 1028.6 638.9 682.7 694.3 700.6 707.2 11658.2 11865.0 12063.7 12339.6 13320.8 706.4 708.6 710.2 713.4 715.8 5697.5 5833.5 5840.4 5908.4 6038.7 111726.4 113499.0 115847.4 116275.4 117626.4 97671.5 99124.0 100973.0 101638.5 106170.0 88501.0 88660.0 88985.6 91361.5 93570.0 11091.1 12334.6 12550.2 13280.3 13364.9 38739.4 39780.2 41060.6 41472.2 41817.2 65573.6 70423.0 71603.0 72536.6 74945.3 18044.0 18490.0 18584.7 18590.5 18805.5 21811.8 21954.3 22039.3 22237.6 22340.2 17282.2 17862.6 17933.5 17953.1 17996.7 18343.4 18489.3 18576.9 18705.3 19010.2 17494.0 17704.7 18336.9 18355.8 19377.3 13150.7 13521.6 13573.5 13796.0 13819.4 14409.8 14472.6 14514.3 14746.9 14796.6 03:50:47 INFO - PID 1688 | -------- Summary: end -------- 03:50:47 INFO - PID 1688 | 03:50:48 INFO - TEST-INFO | 1688: exit 0 03:50:48 INFO - TEST-OK | dromaeo_css | took 1112658ms 03:50:48 INFO - TEST-START | kraken 03:50:48 INFO - Initialising browser for kraken test... 03:50:48 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54065/getInfo.html -profile /tmp/tmp_IfwUn/profile 03:50:48 INFO - TEST-INFO | started process 2111 (/builds/slave/test/build/application/firefox/firefox http://localhost:54065/getInfo.html) 03:50:55 INFO - TEST-INFO | 2111: exit 0 03:50:55 INFO - Browser initialized. 03:50:55 INFO - Running cycle 1/1 for kraken test... 03:50:55 INFO - TEST-INFO | started process 2296 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_IfwUn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:50:56 INFO - PID 2296 | 03:50:56 INFO - PID 2296 | (/builds/slave/test/build/application/firefox/firefox:2346): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:50:56 INFO - PID 2296 | 03:50:56 INFO - PID 2296 | 03:50:56 INFO - PID 2296 | (/builds/slave/test/build/application/firefox/firefox:2478): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:50:56 INFO - PID 2296 | 03:50:56 INFO - PID 2296 | __metrics Screen width/height:1600/1200 03:50:56 INFO - PID 2296 | colorDepth:24 03:50:56 INFO - PID 2296 | Browser inner width/height: 1024/768 03:50:56 INFO - PID 2296 | __metrics 03:51:06 INFO - PID 2296 | RSS: Main: 174833664 03:51:06 INFO - PID 2296 | 03:51:09 INFO - PID 2296 | Cycle 1(1): loaded http://localhost:54065/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54065/tests/kraken/driver.html?testName=audio-beat-detection) 03:51:10 INFO - PID 2296 | RSS: Main: 179826688 03:51:10 INFO - PID 2296 | 03:51:12 INFO - PID 2296 | Cycle 1(1): loaded http://localhost:54065/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54065/tests/kraken/driver.html?testName=audio-dft) 03:51:13 INFO - PID 2296 | RSS: Main: 180088832 03:51:13 INFO - PID 2296 | 03:51:16 INFO - PID 2296 | Cycle 1(1): loaded http://localhost:54065/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54065/tests/kraken/driver.html?testName=audio-fft) 03:51:17 INFO - PID 2296 | RSS: Main: 173891584 03:51:17 INFO - PID 2296 | 03:51:19 INFO - PID 2296 | Cycle 1(1): loaded http://localhost:54065/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54065/tests/kraken/driver.html?testName=audio-oscillator) 03:51:19 INFO - PID 2296 | RSS: Main: 174522368 03:51:19 INFO - PID 2296 | 03:51:22 INFO - PID 2296 | Cycle 1(1): loaded http://localhost:54065/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54065/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:51:22 INFO - PID 2296 | RSS: Main: 175067136 03:51:22 INFO - PID 2296 | 03:51:25 INFO - PID 2296 | Cycle 1(1): loaded http://localhost:54065/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54065/tests/kraken/driver.html?testName=imaging-darkroom) 03:51:26 INFO - PID 2296 | RSS: Main: 175562752 03:51:26 INFO - PID 2296 | 03:51:30 INFO - PID 2296 | Cycle 1(1): loaded http://localhost:54065/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54065/tests/kraken/driver.html?testName=imaging-desaturate) 03:51:30 INFO - PID 2296 | RSS: Main: 176046080 03:51:30 INFO - PID 2296 | 03:51:33 INFO - PID 2296 | Cycle 1(1): loaded http://localhost:54065/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54065/tests/kraken/driver.html?testName=json-parse-financial) 03:51:34 INFO - PID 2296 | RSS: Main: 176562176 03:51:34 INFO - PID 2296 | 03:51:36 INFO - PID 2296 | Cycle 1(1): loaded http://localhost:54065/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54065/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:51:36 INFO - PID 2296 | RSS: Main: 176705536 03:51:36 INFO - PID 2296 | 03:51:38 INFO - PID 2296 | Cycle 1(1): loaded http://localhost:54065/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54065/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:51:39 INFO - PID 2296 | RSS: Main: 176775168 03:51:39 INFO - PID 2296 | 03:51:41 INFO - PID 2296 | Cycle 1(1): loaded http://localhost:54065/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54065/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:51:41 INFO - PID 2296 | RSS: Main: 176594944 03:51:41 INFO - PID 2296 | 03:51:44 INFO - PID 2296 | Cycle 1(1): loaded http://localhost:54065/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54065/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:51:45 INFO - PID 2296 | RSS: Main: 177274880 03:51:45 INFO - PID 2296 | 03:51:48 INFO - PID 2296 | Cycle 1(1): loaded http://localhost:54065/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54065/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:51:49 INFO - PID 2296 | RSS: Main: 177303552 03:51:49 INFO - PID 2296 | 03:51:50 INFO - PID 2296 | Cycle 1(1): loaded http://localhost:54065/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54065/tests/kraken/driver.html?testName=ai-astar) 03:51:51 INFO - PID 2296 | RSS: Main: 178597888 03:51:51 INFO - PID 2296 | 03:51:51 INFO - PID 2296 | __start_tp_report 03:51:51 INFO - PID 2296 | _x_x_mozilla_page_load 03:51:51 INFO - PID 2296 | _x_x_mozilla_page_load_details 03:51:51 INFO - PID 2296 | |i|pagename|runs| 03:51:51 INFO - PID 2296 | |0;ai-astar;101;109;99;110;109;109;113;98;107;106 03:51:51 INFO - PID 2296 | |1;audio-beat-detection;147;119;139;178;118;158;154;119;174;117 03:51:51 INFO - PID 2296 | |2;audio-dft;166;161;166;163;163;162;169;162;165;170 03:51:51 INFO - PID 2296 | |3;audio-fft;74;73;75;159;83;74;74;87;97;76 03:51:51 INFO - PID 2296 | |4;audio-oscillator;82;85;129;79;79;79;132;80;84;138 03:51:51 INFO - PID 2296 | |5;imaging-gaussian-blur;114;113;114;113;113;118;114;115;114;114 03:51:51 INFO - PID 2296 | |6;imaging-darkroom;149;148;151;150;149;148;148;152;148;151 03:51:51 INFO - PID 2296 | |7;imaging-desaturate;101;94;93;95;94;94;93;101;94;93 03:51:51 INFO - PID 2296 | |8;json-parse-financial;52;53;51;60;53;52;51;54;51;61 03:51:51 INFO - PID 2296 | |9;json-stringify-tinderbox;59;56;57;57;55;55;54;64;55;55 03:51:51 INFO - PID 2296 | |10;stanford-crypto-aes;76;76;74;75;74;74;79;75;76;75 03:51:51 INFO - PID 2296 | |11;stanford-crypto-ccm;123;131;129;126;128;129;123;127;115;162 03:51:51 INFO - PID 2296 | |12;stanford-crypto-pbkdf2;169;167;190;170;166;166;179;180;169;180 03:51:51 INFO - PID 2296 | |13;stanford-crypto-sha256-iterative;73;70;63;65;66;71;62;67;63;67 03:51:51 INFO - PID 2296 | __end_tp_report 03:51:51 INFO - PID 2296 | __start_cc_report 03:51:51 INFO - PID 2296 | _x_x_mozilla_cycle_collect,967 03:51:51 INFO - PID 2296 | __end_cc_report 03:51:51 INFO - PID 2296 | __startTimestamp1503485511171__endTimestamp 03:51:51 INFO - PID 2296 | 03:51:51 INFO - PID 2296 | ------- Summary: start ------- 03:51:51 INFO - PID 2296 | Number of tests: 14 03:51:51 INFO - PID 2296 | 03:51:51 INFO - PID 2296 | [#0] ai-astar Cycles:10 Average:106.10 Median:109.50 stddev:5.07 (4.6%) stddev-sans-first:5.02 03:51:51 INFO - PID 2296 | Values: 101.0 109.0 99.0 110.0 109.0 109.0 113.0 98.0 107.0 106.0 03:51:51 INFO - PID 2296 | 03:51:51 INFO - PID 2296 | [#1] audio-beat-detection Cycles:10 Average:142.30 Median:150.50 stddev:23.60 (15.7%) stddev-sans-first:24.97 03:51:51 INFO - PID 2296 | Values: 147.0 119.0 139.0 178.0 118.0 158.0 154.0 119.0 174.0 117.0 03:51:51 INFO - PID 2296 | 03:51:51 INFO - PID 2296 | [#2] audio-dft Cycles:10 Average:164.70 Median:165.50 stddev:3.06 (1.8%) stddev-sans-first:3.21 03:51:51 INFO - PID 2296 | Values: 166.0 161.0 166.0 163.0 163.0 162.0 169.0 162.0 165.0 170.0 03:51:51 INFO - PID 2296 | 03:51:51 INFO - PID 2296 | [#3] audio-fft Cycles:10 Average:87.20 Median:75.50 stddev:26.39 (35.0%) stddev-sans-first:27.55 03:51:51 INFO - PID 2296 | Values: 74.0 73.0 75.0 159.0 83.0 74.0 74.0 87.0 97.0 76.0 03:51:51 INFO - PID 2296 | 03:51:51 INFO - PID 2296 | [#4] audio-oscillator Cycles:10 Average:96.70 Median:79.50 stddev:25.23 (31.7%) stddev-sans-first:26.19 03:51:51 INFO - PID 2296 | Values: 82.0 85.0 129.0 79.0 79.0 79.0 132.0 80.0 84.0 138.0 03:51:51 INFO - PID 2296 | 03:51:51 INFO - PID 2296 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:1.48 (1.3%) stddev-sans-first:1.56 03:51:51 INFO - PID 2296 | Values: 114.0 113.0 114.0 113.0 113.0 118.0 114.0 115.0 114.0 114.0 03:51:51 INFO - PID 2296 | 03:51:51 INFO - PID 2296 | [#6] imaging-darkroom Cycles:10 Average:149.40 Median:149.50 stddev:1.51 (1.0%) stddev-sans-first:1.59 03:51:51 INFO - PID 2296 | Values: 149.0 148.0 151.0 150.0 149.0 148.0 148.0 152.0 148.0 151.0 03:51:51 INFO - PID 2296 | 03:51:51 INFO - PID 2296 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:94.00 stddev:3.12 (3.3%) stddev-sans-first:2.51 03:51:51 INFO - PID 2296 | Values: 101.0 94.0 93.0 95.0 94.0 94.0 93.0 101.0 94.0 93.0 03:51:51 INFO - PID 2296 | 03:51:51 INFO - PID 2296 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:53.00 stddev:3.68 (6.9%) stddev-sans-first:3.84 03:51:51 INFO - PID 2296 | Values: 52.0 53.0 51.0 60.0 53.0 52.0 51.0 54.0 51.0 61.0 03:51:51 INFO - PID 2296 | 03:51:51 INFO - PID 2296 | [#9] json-stringify-tinderbox Cycles:10 Average:56.70 Median:56.50 stddev:2.95 (5.2%) stddev-sans-first:3.00 03:51:51 INFO - PID 2296 | Values: 59.0 56.0 57.0 57.0 55.0 55.0 54.0 64.0 55.0 55.0 03:51:51 INFO - PID 2296 | 03:51:51 INFO - PID 2296 | [#10] stanford-crypto-aes Cycles:10 Average:75.40 Median:75.50 stddev:1.51 (2.0%) stddev-sans-first:1.58 03:51:51 INFO - PID 2296 | Values: 76.0 76.0 74.0 75.0 74.0 74.0 79.0 75.0 76.0 75.0 03:51:51 INFO - PID 2296 | 03:51:51 INFO - PID 2296 | [#11] stanford-crypto-ccm Cycles:10 Average:129.30 Median:128.50 stddev:12.36 (9.6%) stddev-sans-first:12.89 03:51:51 INFO - PID 2296 | Values: 123.0 131.0 129.0 126.0 128.0 129.0 123.0 127.0 115.0 162.0 03:51:51 INFO - PID 2296 | 03:51:51 INFO - PID 2296 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.60 Median:174.50 stddev:8.13 (4.7%) stddev-sans-first:8.45 03:51:51 INFO - PID 2296 | Values: 169.0 167.0 190.0 170.0 166.0 166.0 179.0 180.0 169.0 180.0 03:51:51 INFO - PID 2296 | 03:51:51 INFO - PID 2296 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:3.68 (5.5%) stddev-sans-first:3.12 03:51:51 INFO - PID 2296 | Values: 73.0 70.0 63.0 65.0 66.0 71.0 62.0 67.0 63.0 67.0 03:51:51 INFO - PID 2296 | -------- Summary: end -------- 03:51:51 INFO - PID 2296 | 03:51:51 INFO - PID 2296 | 03:51:51 INFO - PID 2296 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150079,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 03:51:51 INFO - PID 2296 | 03:51:51 INFO - PID 2296 | 03:51:51 INFO - PID 2296 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 03:51:51 INFO - PID 2296 | 03:51:51 INFO - PID 2296 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:51:51 INFO - TEST-INFO | 2296: exit 0 03:51:51 INFO - TEST-OK | kraken | took 63474ms 03:51:51 INFO - SUITE-END | took 1176s 03:51:52 INFO - Completed test suite (00:19:36) 03:51:52 INFO - javascript benchmark 03:51:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8514.548319737261, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3283.40898638245, 3292.3086151908096, 3308.6525914778963, 3322.0, 3327.2680010397703, 6119.449249567538, 6189.876202475948, 6204.162438070859, 6227.595206311592, 6273.12176295319, 6125.173101631279, 6214.0, 6223.844403889905, 6231.065340198972, 6245.250569931603, 5703.885922281552, 5719.656820590768, 5730.512906402961, 5736.996025695507, 5754.16564598133, 5738.340090889538, 5759.625624334426, 5776.306843178803, 5776.364599894029, 5813.7383817728305, 5750.309962804448, 5759.251297331341, 5806.680632565207, 5815.592908496407, 5816.476517113459, 5730.197772311859, 5769.913451298213, 5778.393268706767, 5810.273715785527, 5825.271841019872, 5120.641555091145, 5568.749406276727, 5671.376148623648, 5686.601937864351, 5745.080787074048, 6097.085437184413, 6148.600340977867, 6182.814515564541, 6219.502439804804, 6226.844328891769, 6648.700808463631, 6697.095892054559, 6780.694868730919, 6784.76253331131, 6796.422304104157, 6610.239822420435, 6633.03820945965, 6685.799426017227, 6710.463162946952, 6732.394084532367, 6208.161898143783, 6219.315875253764, 6229.750809967596, 6289.150964619764, 6306.306306306303, 6902.482313826483, 6951.061606683134, 6951.061606683134, 6972.163340399185, 6985.720571177096, 6579.671016449159, 6585.835354116185, 6598.307177746364, 6657.733690652417, 6702.798916032527, 6558.8360290993105, 6623.039659249382, 6681.9331806682285, 6711.127553418122, 6785.8642827143185, 6578.8355291118105, 6660.966695166493, 6676.0, 6676.26561078281, 6704.061431399608, 6602.801915942529, 6621.668916554153, 6644.734210631521, 6695.765648202289, 6724.428423583952, 5279.366476022825, 5280.894382112337, 5325.467453254643, 5358.544523715528, 5359.14253719403, 4604.58558729716, 4650.558196971282, 4689.50760170184, 4714.905701885943, 4722.456917454537, 5774.653520788682, 5815.912761308584, 5845.620034697731, 5846.444587764156, 5870.031444811643, 6581.605103693793, 6596.175478065242, 6597.043428702811, 6601.504887133484, 6632.535722499475, 5809.7095145242565, 5870.882582348415, 5890.67601281925, 5904.852378690567, 5921.02303119989, 5821.650700957956, 5897.49871260939, 5899.76400943966, 5908.822735317947, 5909.497692696083, 6374.075759014917, 6476.287608363076, 6493.090967264587, 6527.738890444424, 6613.371729685672, 6839.69221385029, 6846.4522838173825, 6876.587404755731, 6877.828054298682, 6878.896816547855, 6530.738770449128, 6555.4427873631275, 6633.436157926437, 6636.203655561363, 6643.56816806906, 6633.800985970429, 6637.137172167587, 6726.529142960141, 6732.192136943402, 6739.528233023641, 6516.51126165549, 6621.039949207434, 6746.898796518154, 6772.796816095328, 6819.5908245505425, 6528.412442880163, 6574.934250657432, 6584.8024559263295, 6585.374389432996, 6596.175478065242, 6492.513061520499, 6520.445762110274, 6521.250056243593, 6613.27254002069, 6616.569922954993, 6463.547551671338, 6473.0, 6523.412892839668, 6553.04980777775, 6563.015547667888, 6470.029495575702, 6556.409923106943, 6643.036759669917, 6649.73401063952, 6688.598684078971, 6432.903506447314, 6439.710213040331, 6463.547551671338, 6467.450266727381, 6483.546151769331], "value": 6130.304765380717, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [808.2079562029211, 861.9310455163586, 880.9647614095436, 883.1830556735023, 1128.6952522818844, 29880.70119298809, 39031.80484097579, 39984.800075999614, 40028.59971400285, 40193.79903100488, 39544.40683389751, 40126.0, 40144.19711605766, 40165.7991710041, 40209.79895100521, 7511.737089201879, 7674.117476490192, 7676.616169191546, 7695.345895598881, 7704.229577042307, 7475.215102414222, 7520.285572870568, 7614.581198034106, 7620.199879012707, 7621.542707437544, 5705.771769129251, 5836.241288632472, 5842.620229685057, 7445.664945077485, 7630.618469076552, 7600.809979750523, 7665.693372265103, 7669.846603067936, 7670.3480204182715, 7671.616419179047, 7460.25397460255, 7537.585432801194, 7545.170031296553, 7558.924410755877, 7559.3196612305155, 36246.0, 36472.452913206325, 36474.088147796254, 36478.0, 36481.087972800626, 3422.7946323220435, 3433.9656603434146, 3439.6216416194197, 3444.9483257750903, 3446.0178849027907, 30374.54438183429, 30555.541666875015, 30565.847170764227, 30581.0, 30583.541246881316, 4966.900661986776, 4997.525235102659, 5012.398512178562, 5021.17150670139, 5025.572826309768, 189784.0, 190335.0, 190603.0, 191076.0, 191513.0, 47388.52611473841, 47418.28872566914, 47461.0, 47468.287975680396, 47895.0, 50036.0, 50067.49932500701, 50180.498195018314, 50184.247236291485, 50195.0, 15501.224938753017, 15764.842351576566, 15770.921145394199, 15771.29029193689, 15783.605409864846, 13039.152455090389, 13047.804282935764, 13062.477500899857, 13067.085304028817, 13089.41097650608, 12772.808407873888, 12920.935395322964, 12999.1550549214, 13043.869561304455, 13122.409491572902, 4522.66080043998, 4626.97686511572, 5106.821261255838, 5285.1237810576695, 5500.119980803132, 997.7356000659831, 1007.4005966449951, 1009.9899001010043, 1010.1111022300329, 1032.9070383665355, 22627.773722262566, 28255.43489130206, 28330.575041374395, 28356.291092722848, 29234.415311693647, 1084.446932064637, 1090.3839330778085, 1093.606301731376, 1095.2497539185524, 1110.9166812488934, 11357.829632555518, 11696.181267311207, 11743.647690569296, 11880.821787673192, 11905.940470297593, 226806.0, 227414.0, 227588.0, 227645.0, 227718.0, 49107.0, 49638.25542616864, 49680.50319496759, 49706.0, 49739.50260497421, 1374.4090041282345, 1400.7548678981138, 1408.3521580073282, 1414.9221792801495, 1416.3484796993293, 21397.572048559254, 21426.464338391666, 21656.242031528822, 21877.234296799536, 21912.0, 35078.29843403168, 35111.824440878656, 35190.0, 35192.64807351894, 35245.82377088098, 202954.0, 203435.0, 204386.0, 204482.97758511113, 204515.0, 31082.689173108884, 31411.0, 32793.34413311768, 34487.82756086203, 34746.826265868505, 38406.079696015644, 43090.56909430865, 45437.54562454333, 45860.0, 46050.0, 33188.668113318556, 33315.83342083274, 33576.32847342991, 33795.4930676045, 34181.65818341785, 32429.675703242665, 32511.512327314635, 32733.872298300535, 32882.67117328796, 33428.498572521916, 37072.258554828215, 37305.6269437313, 37353.62646373502, 37388.0, 37508.2498350026, 31451.370972579964, 31469.685303146674, 31481.370372591962, 32047.198820029687, 32051.03846884597, 23918.402039948443, 24047.51904961926, 24340.026398943843, 24796.38009049788, 24923.75076249287], "value": 16835.96246950097, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.9612718407352, 565.5051829649057, 573.8794853080852, 575.2636625119845, 578.4129108954411, 21617.891910540446, 22287.331380058604, 22327.66508502374, 22359.0, 22985.540289194207, 22567.887160564173, 22847.086116555318, 22914.770852291473, 22920.0, 22950.0, 6499.415052645273, 6632.568883022612, 6638.634875081869, 6640.369164929348, 6646.734130634769, 6005.0, 6538.6076835389795, 6605.174353205849, 6613.338666133396, 6617.801465956005, 6536.607803531803, 6581.078648989145, 6581.440577550914, 6581.868362632745, 6590.373914478141, 6527.575707579016, 6567.310432404624, 6568.573042752206, 6574.145361103074, 6579.17760279965, 6065.63606183626, 6097.20736304282, 6101.664408457533, 6103.542234332443, 6124.0, 27759.444811103665, 28079.859600701864, 28688.282792930135, 28933.42133157346, 29438.41123177546, 1981.0787983587702, 2028.908699108529, 2029.1173339597322, 2031.5124370151057, 2032.5934813037452, 18845.623087538308, 19422.80577194224, 19427.22291108354, 19453.610927781367, 19468.0, 2385.971825435921, 2396.1373905394044, 2451.669024681663, 2517.6852893388327, 2522.911698090558, 126090.0, 129856.35071824674, 130999.0, 131027.0, 131308.0, 14231.78652320216, 14436.639084022983, 14836.554903352917, 14844.925775371054, 14955.476558320406, 22551.210707625156, 22700.432489187904, 22705.318840434815, 22717.0, 22730.659040114413, 9876.35803672759, 10057.346272492265, 10070.74115735533, 10101.19190464761, 10209.38743675382, 7872.567008814455, 9306.86039709405, 9346.20557252641, 9616.807663846825, 9655.275854310814, 7627.389808815282, 8934.151255630704, 9045.231155351868, 9053.547322633842, 9089.136532029446, 2586.818922675395, 2621.6460777795137, 2668.813183077166, 2723.809333346647, 2725.2914242297147, 968.3560432312433, 982.7985263021063, 983.188869182927, 999.9650012249537, 1003.9949800251098, 19202.51993700141, 19614.509637258896, 19988.900055499922, 20094.0, 20379.388618341472, 1025.6974192613047, 1045.3466583385384, 1048.2714513413257, 1053.4574694032578, 1057.5293994172519, 10976.560937562568, 11060.834087488694, 11120.443977801078, 11254.943725281484, 11341.262817916973, 534355.0, 535714.0, 538601.0, 544777.0, 548057.0, 114458.42770786093, 121921.39039304746, 121947.0, 123258.53482930291, 123701.0, 1201.633501781965, 1221.291919649755, 1244.8132780082879, 1246.9501219951283, 1254.0406588959454, 20773.27293544719, 20959.476013099793, 21009.264675736886, 21281.73038088915, 21383.893080534497, 56692.433075670364, 57262.7136864313, 57909.42090579209, 57909.71045144747, 59393.70303148457, 72000.63999679968, 72069.63965180141, 72415.63792181005, 72461.0, 73171.63414182895, 13939.372728227052, 14441.855581444051, 14468.565943021726, 14482.98619096653, 14519.92740036293, 22432.327030188466, 22616.773832261468, 22753.317400478012, 22858.657120142878, 22967.88516057409, 18657.81342186561, 19168.233270669574, 19524.121414536097, 19554.804451955297, 19852.60294794125, 17550.473485795446, 17613.471595852145, 17638.735418968983, 17774.46676599704, 18125.909370453064, 18133.27466901309, 19271.51821204481, 19848.0, 19959.20163193456, 20021.0, 14460.20468874222, 14556.19940903218, 14659.120452772868, 14749.0, 14768.704625907636, 18810.811891881454, 18935.053247337855, 18969.33607323737, 19023.52441188926, 19042.619147617246], "value": 12050.962374082523, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1279.5073896549827, 1297.8507471640764, 1318.7824009038502, 1319.9208047517152, 1339.9933000334997, 14427.855721442782, 15078.698426031473, 15085.245737713125, 15099.16954567497, 15226.0, 15195.924020379882, 15494.922525387385, 15495.302711377986, 15509.379624814994, 15510.844891551082, 2661.4810112028163, 2700.9189724308303, 2709.9593506097326, 2716.578930265812, 2720.687120981083, 2605.7003444603924, 2710.823796453224, 2765.5713364428548, 2771.847548384838, 2778.5137600919757, 2675.357914100621, 2698.541247987837, 2699.35215548269, 2702.554078577032, 2717.605947137664, 2624.3045592917892, 2675.4381579868054, 2679.718629543899, 2682.946341073168, 2703.418764965532, 2557.539642864284, 2604.7525485078886, 2609.686837579484, 2630.2898217481365, 2637.3933995181023, 14673.926630366886, 14763.926180369137, 14789.260536973215, 14804.185769782658, 14845.0, 7993.4004949628425, 8258.132896045949, 8259.339252859756, 8260.8347833043, 8268.875966860502, 5363.651362661414, 5587.580931430119, 5704.914426283609, 5712.914306285409, 5715.599908006441, 1886.141805478504, 1931.1502938707065, 1943.2421355671158, 1987.1058023889307, 2002.5994801039706, 25747.0, 25823.612645810328, 25867.0946516871, 25983.61024584633, 25992.22023339303, 6520.445762110179, 7175.748848790372, 7251.202367739545, 7544.886826697604, 7548.584827834412, 16871.493855184362, 17095.829041709425, 17150.571235719206, 17256.827431725775, 17278.827211727723, 7820.491668041559, 7946.9602651987525, 7949.966504354513, 7959.920400796033, 7960.56216908064, 6117.235345581802, 7235.638218089074, 7321.560706357635, 7337.19290878003, 7359.411247100219, 4679.0, 5226.92159617606, 5375.838724838261, 5383.757730902119, 5391.595630327741, 1501.3919362657923, 1542.8765698744073, 1551.115863957556, 1555.5799934017978, 1571.1908367190906, 774.6823802241054, 804.5253300552702, 806.5402720449288, 814.230552128245, 815.6615004773072, 8016.599170041474, 8391.286740627114, 8414.11651776567, 8424.368172387096, 8445.788855278668, 992.503748125937, 994.5280984143508, 995.3629677006721, 998.2014388489325, 1020.9132223760915, 4460.576245256695, 4629.467611224685, 5024.346834911438, 5188.558972487381, 5210.010098081352, 20324.0, 20639.69040464394, 21192.15231390727, 21231.15075396967, 21505.462363440725, 20511.38465846027, 20568.897155514125, 20646.380608581767, 20748.0, 20838.895805520875, 10772.569097236023, 10988.120950323955, 11022.063124634336, 11023.889761102608, 11091.778164436666, 8609.13908609159, 8612.870806937775, 8680.91319086801, 8681.565921704016, 8857.025727170136, 18093.638127237118, 18239.179236934637, 18390.839068912064, 18652.44042678722, 18678.439646810617, 18480.168392422103, 18624.255029798656, 18955.810441895956, 19001.619967600847, 19451.51371215731, 11922.880771192524, 12107.878921210675, 12271.57049503263, 12275.75448491043, 12284.508619655113, 13844.584662460142, 13940.790888136484, 13971.510997115052, 13977.161370317814, 13998.650033749238, 10707.732306692395, 10714.678559643224, 10984.945075274572, 11031.393273370042, 11242.718932026764, 10950.945245273722, 10981.450927453756, 11007.394593297446, 11143.2199746017, 11292.0, 10004.999500050228, 10149.543270552991, 10255.077043065861, 10269.948650256702, 10270.383776973405, 6960.617166055916, 6979.0, 6989.650517474004, 7059.823504412226, 7062.505624606229, 7401.777946661608, 7408.851822963618, 7485.850282994418, 7486.513376630502, 7549.169591345058], "value": 6650.265780182926, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.5243296921549, 500.9757376285208, 512.8794733237689, 515.3326442257277, 518.9351331083615, 6150.600210986283, 6190.514276573624, 6246.469614944339, 6276.968615156923, 6277.34087920768, 5996.850078748033, 6014.158017877489, 6058.0, 6078.118672792442, 6112.877742445148, 4918.827841025565, 4974.1295273327205, 4987.725675087887, 4996.82511112112, 5047.570956468705, 4887.120318342697, 4969.527894850002, 5017.222330538754, 5020.723860187688, 5022.246663000561, 4780.641451891122, 4782.7608619569055, 4855.421987853944, 4934.6299027572895, 4955.776990035457, 4880.560749532559, 4941.357623508957, 4964.429090654567, 4965.577925876305, 4966.708655749495, 4389.736615803062, 4394.62645675118, 4432.224360736858, 4443.822247110112, 4447.488538818045, 5933.643981361089, 5938.703064846741, 5966.701664916737, 5994.732870585542, 6014.1580178775, 5641.915371269434, 5710.600257981943, 5716.628009277785, 5719.571032172562, 5730.914036289459, 6375.458086062644, 6454.838629034265, 6493.25327587324, 6525.934740652628, 6556.24603170632, 4845.515448455161, 4861.635377346678, 4861.927071093936, 4879.243717223836, 4879.512048795127, 6781.931510889177, 6902.758403455905, 6930.826729331807, 6931.168259808805, 6936.4797640177185, 4903.950960490421, 4921.342475063498, 4966.304717339575, 4999.525519556153, 5047.520485553867, 4976.552110310089, 5013.0, 5019.874503137451, 5051.621128415383, 5052.722100284446, 5652.3217213934595, 5701.344345400249, 5703.116017017369, 5708.800191993343, 5721.628094173865, 6630.469562434993, 6645.800625981228, 6662.933370666328, 6664.366885145903, 6690.156683409628, 1653.2560347843519, 1705.2411676803704, 1710.8366310908702, 1732.7487514310606, 1737.218251786701, 1120.3166068698088, 1197.4970512384818, 1216.385725208764, 1220.9572664956684, 1225.185251807556, 5731.799387021434, 5742.7415766290615, 5805.187273781674, 5828.76684932598, 5831.542114471382, 6587.341265873374, 6597.670116494156, 6657.46740260778, 6705.6982435790505, 6722.193336799615, 5645.971770141123, 5670.744816483269, 5744.684042377709, 5771.567132465082, 5799.159121927381, 3514.9648503514636, 3516.7362447816517, 3542.8051457170104, 3568.57177138745, 3595.7303202259936, 6365.649889256136, 6392.808215753535, 6433.195850518685, 6502.934970650233, 6516.837079073061, 6747.763828265987, 6783.9824026395445, 6882.518223724292, 6895.379415852597, 6966.860662786716, 6413.414408697803, 6456.548041637135, 6561.606303621798, 6576.506761992965, 6576.671166441659, 6569.770058047945, 6639.2364878037715, 6675.23234828001, 6707.798766037026, 6710.530262881552, 6481.351864813481, 6553.148090748172, 6612.933870661232, 6640.269570347161, 6726.932730672631, 6401.519886008475, 6455.160829092188, 6471.838204044749, 6513.055606936873, 6514.1531600891585, 4889.168841297059, 4965.627577931742, 4979.3277907482025, 4988.21131713559, 5006.69959802413, 6533.248676402274, 6645.734170633314, 6670.332966703291, 6681.398674119353, 6696.464282857457, 6457.903131452938, 6510.934890651033, 6512.218533775977, 6553.082568440327, 6569.211694596679, 6403.743850246125, 6475.967620161869, 6539.574927629689, 6545.672716364067, 6549.8690026200165, 6104.359042300494, 6227.719752611234, 6391.552591318749, 6501.544891857525, 6504.15445992018, 6619.933800662125, 6629.933700663125, 6645.501587381063, 6650.567713098633, 6657.866842663217, 6361.17304750398, 6365.490760739222, 6387.520935929917, 6418.935810641834, 6422.197225346832], "value": 5026.100104467462, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [854.8065554956443, 869.6477926439786, 872.511393619573, 887.7159309021112, 900.6667533012786, 18743.718844217346, 19355.516112097186, 19462.221511139538, 19505.12226949787, 21624.567508649816, 19839.5040123997, 20892.0, 20893.895530522364, 20911.895440522814, 20994.580108397822, 894.3605322194646, 919.6183583812709, 924.4083786376724, 925.6852670092168, 927.7077720518049, 923.4966943016038, 964.6334392930677, 974.28390133252, 974.4543055888689, 977.4575110813496, 1016.425719468498, 1029.3103620574234, 1030.855680204772, 1031.2214278219933, 1031.814273430786, 1016.9135623472014, 1016.9949150254201, 1018.3686114608915, 1018.5212949913603, 1018.6231094495047, 750.8610906982226, 750.913644930829, 751.0461713623722, 751.1924680967927, 751.6504825256227, 17849.7322540162, 17876.642467150716, 18043.639127217513, 18052.458426247103, 19418.0, 20535.691964620542, 20581.38255852327, 20749.688754668692, 21281.467963301042, 21300.0, 16711.247993840305, 16822.15889205547, 16916.830831691772, 16917.407890723767, 16937.237824297936, 3411.3347897160065, 3411.3688967541084, 3435.9656403436147, 3444.2767018925806, 3445.9655403445895, 125424.0, 125580.37209813892, 127905.0, 129156.35421822924, 135202.3239883804, 16905.661886762195, 17127.14364281781, 17366.21852016637, 17506.649867002845, 17598.0, 29974.55038174429, 30570.235744106132, 30690.0, 30888.845555772077, 30929.0, 7537.736179233701, 7912.36701063925, 8396.118407567239, 8888.644454221889, 8973.685920992733, 4093.4473846030405, 4182.602652747984, 4188.267053265728, 4223.556526564728, 4231.936520952188, 4929.950700492949, 4957.628177886673, 4982.975085124624, 4997.450280469146, 5040.546350828443, 996.6013594562233, 1017.4149863828328, 1026.2405819693374, 1026.9024442677933, 1028.573142146016, 638.9169407976933, 682.6518475577491, 694.264080075122, 700.6216643012716, 707.1549498349423, 11658.18392712519, 11865.0, 12063.698407539707, 12339.568115115928, 13320.800187997187, 706.3678008182751, 708.5677736580682, 710.1655554723283, 713.4470785141557, 715.8103102677794, 5697.4587414195585, 5833.533317334603, 5840.357560668408, 5908.409159084057, 6038.667873266924, 111726.44136779426, 113499.0, 115847.42076289734, 116275.41862290635, 117626.41186794182, 97671.51164244133, 99124.0, 100973.0, 101638.49180754197, 106170.0, 88501.0, 88660.0, 88985.55507222422, 91361.54319228361, 93570.0, 11091.112710983263, 12334.629961101182, 12550.1842380245, 13280.269585172908, 13364.866351336363, 38739.41890871583, 39780.2043959125, 41060.58939410687, 41472.170556589306, 41817.1636567273, 65573.5738137609, 70423.0, 71603.0, 72536.63731681308, 74945.25054749382, 18044.0, 18490.0, 18584.7212291813, 18590.53523661919, 18805.529861753566, 21811.781882180974, 21954.34136975893, 22039.33881983543, 22237.55524889461, 22340.21809236669, 17282.22229999678, 17862.642747145244, 17933.461996140137, 17953.102344882966, 17996.730049049536, 18343.449696509128, 18489.260429583202, 18576.907115464335, 18705.34531291398, 19010.23959041623, 17494.0, 17704.734428983316, 18336.90831545834, 18355.816441835945, 19377.321793737152, 13150.736985260433, 13521.59435216945, 13573.52492662752, 13796.03427760047, 13819.447222111003, 14409.78385324242, 14472.638184045483, 14514.346854391366, 14746.852531474548, 14796.630084247548], "value": 9164.991602696435, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1511.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 109.0, 99.0, 110.0, 109.0, 109.0, 113.0, 98.0, 107.0, 106.0], "value": 106.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 119.0, 139.0, 178.0, 118.0, 158.0, 154.0, 119.0, 174.0, 117.0], "value": 142.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 161.0, 166.0, 163.0, 163.0, 162.0, 169.0, 162.0, 165.0, 170.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 75.0, 159.0, 83.0, 74.0, 74.0, 87.0, 97.0, 76.0], "value": 87.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 129.0, 79.0, 79.0, 79.0, 132.0, 80.0, 84.0, 138.0], "value": 96.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 113.0, 113.0, 118.0, 114.0, 115.0, 114.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 151.0, 150.0, 149.0, 148.0, 148.0, 152.0, 148.0, 151.0], "value": 149.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 94.0, 93.0, 95.0, 94.0, 94.0, 93.0, 101.0, 94.0, 93.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 51.0, 60.0, 53.0, 52.0, 51.0, 54.0, 51.0, 61.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 56.0, 57.0, 57.0, 55.0, 55.0, 54.0, 64.0, 55.0, 55.0], "value": 56.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 74.0, 75.0, 74.0, 74.0, 79.0, 75.0, 76.0, 75.0], "value": 75.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 131.0, 129.0, 126.0, 128.0, 129.0, 123.0, 127.0, 115.0, 162.0], "value": 129.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 167.0, 190.0, 170.0, 166.0, 166.0, 179.0, 180.0, 169.0, 180.0], "value": 173.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 70.0, 63.0, 65.0, 66.0, 71.0, 62.0, 67.0, 63.0, 67.0], "value": 66.7, "unit": "score"}]}]} 03:51:52 INFO - Return code: 0 03:51:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:51:52 INFO - # TBPL SUCCESS # 03:51:52 INFO - Running post-action listener: _package_coverage_data 03:51:52 INFO - Running post-action listener: _resource_record_post_action 03:51:52 INFO - [mozharness: 2017-08-23 10:51:52.458049Z] Finished run-tests step (success) 03:51:52 INFO - Running post-run listener: _resource_record_post_run 03:51:52 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 427343872; Read time: 12; Write time: 560568 03:51:52 INFO - TinderboxPrint: CPU usage
13.2% 03:51:52 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 03:51:52 INFO - TinderboxPrint: I/O write bytes / time
427,343,872 / 560,568 03:51:52 INFO - TinderboxPrint: CPU idle
8,272.1 (86.8%) 03:51:52 INFO - TinderboxPrint: CPU user
1,199.5 (12.6%) 03:51:52 INFO - TinderboxPrint: Swap in / out
0 / 0 03:51:52 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 108326912; Read time: 0; Write time: 186756 03:51:52 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:51:52 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 319016960; Read time: 0; Write time: 373812 03:51:53 INFO - Running post-run listener: _upload_blobber_files 03:51:53 INFO - Blob upload gear active. 03:51:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:51:53 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:51:53 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:51:53 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:51:53 INFO - (blobuploader) - INFO - Open directory for files ... 03:51:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:51:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:54 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:51:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:54 INFO - (blobuploader) - INFO - Done attempting. 03:51:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:51:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:52:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:52:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:52:01 INFO - (blobuploader) - INFO - Done attempting. 03:52:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:52:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:52:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:52:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:52:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:52:02 INFO - (blobuploader) - INFO - Done attempting. 03:52:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:52:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:52:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:52:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:52:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:52:02 INFO - (blobuploader) - INFO - Done attempting. 03:52:02 INFO - (blobuploader) - INFO - Iteration through files over. 03:52:02 INFO - Return code: 0 03:52:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:52:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:52:02 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/976aa255319fb7171ffbbdfda19107df5266d6c7c30ba86eb87f5eac6975066fd82995a8617239bf4b394181af55f09cae201371f2a5390fa59d1de11cad5745", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58d487776b1c7a0c9222496ca6061a28b60fa899f5f3bc9a6d7b8aee8f60a16def09b3c12a82c6665c8bf85b503b4fcf68dbf0fe18df75b2c1a788d63f710486", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cfbb36cb549ce300058c6d202567c786712762890c54cace0fa98e966eabd6c9fc1130b64ddd032ea54898754b71bec71e979f39034da3b74d9275131e5b6e5e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df5c356bdd9fc37f4b5a2440b5f23bed65a3b6fb89e8d5d66f85d26fbb8fcc29c5a125906d2e1424535fb74baa2f2d5b35a385b81e6e459d22c045030ebf1432"} 03:52:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:52:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:52:02 INFO - Contents: 03:52:02 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/976aa255319fb7171ffbbdfda19107df5266d6c7c30ba86eb87f5eac6975066fd82995a8617239bf4b394181af55f09cae201371f2a5390fa59d1de11cad5745", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58d487776b1c7a0c9222496ca6061a28b60fa899f5f3bc9a6d7b8aee8f60a16def09b3c12a82c6665c8bf85b503b4fcf68dbf0fe18df75b2c1a788d63f710486", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cfbb36cb549ce300058c6d202567c786712762890c54cace0fa98e966eabd6c9fc1130b64ddd032ea54898754b71bec71e979f39034da3b74d9275131e5b6e5e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df5c356bdd9fc37f4b5a2440b5f23bed65a3b6fb89e8d5d66f85d26fbb8fcc29c5a125906d2e1424535fb74baa2f2d5b35a385b81e6e459d22c045030ebf1432"} 03:52:02 INFO - Running post-run listener: copy_logs_to_upload_dir 03:52:02 INFO - Copying logs to upload dir... 03:52:02 INFO - mkdir: /builds/slave/test/build/upload/logs 03:52:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.169269 ========= master_lag: -0.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-23 03:52:02.635232) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-23 03:52:02.639519) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1503484264.192027-1359262871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/976aa255319fb7171ffbbdfda19107df5266d6c7c30ba86eb87f5eac6975066fd82995a8617239bf4b394181af55f09cae201371f2a5390fa59d1de11cad5745", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58d487776b1c7a0c9222496ca6061a28b60fa899f5f3bc9a6d7b8aee8f60a16def09b3c12a82c6665c8bf85b503b4fcf68dbf0fe18df75b2c1a788d63f710486", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cfbb36cb549ce300058c6d202567c786712762890c54cace0fa98e966eabd6c9fc1130b64ddd032ea54898754b71bec71e979f39034da3b74d9275131e5b6e5e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df5c356bdd9fc37f4b5a2440b5f23bed65a3b6fb89e8d5d66f85d26fbb8fcc29c5a125906d2e1424535fb74baa2f2d5b35a385b81e6e459d22c045030ebf1432"} build_url:https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011279 build_url: 'https://queue.taskcluster.net/v1/task/Fvl1I_gnToGP5nRGmDBdyw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/976aa255319fb7171ffbbdfda19107df5266d6c7c30ba86eb87f5eac6975066fd82995a8617239bf4b394181af55f09cae201371f2a5390fa59d1de11cad5745", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58d487776b1c7a0c9222496ca6061a28b60fa899f5f3bc9a6d7b8aee8f60a16def09b3c12a82c6665c8bf85b503b4fcf68dbf0fe18df75b2c1a788d63f710486", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cfbb36cb549ce300058c6d202567c786712762890c54cace0fa98e966eabd6c9fc1130b64ddd032ea54898754b71bec71e979f39034da3b74d9275131e5b6e5e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df5c356bdd9fc37f4b5a2440b5f23bed65a3b6fb89e8d5d66f85d26fbb8fcc29c5a125906d2e1424535fb74baa2f2d5b35a385b81e6e459d22c045030ebf1432"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-23 03:52:02.668956) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 03:52:02.669279) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1503484264.192027-1359262871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004538 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 03:52:02.749852) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-23 03:52:02.753173) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-23 03:52:02.753457) ========= ========= Total master_lag: 0.06 =========