builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-047 starttime: 1506163344.42 results: success (0) revision: 8db0c4ecd94cb62a35a25a5fe411d9f0aed7087e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-23 03:42:24.422395) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-23 03:42:24.422864) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-23 03:42:24.423155) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-23 03:42:24.448327) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 03:42:24.448733) ========= 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=03627c79f6bb3d1578c4a402000001ba-1506163343.180261-953808805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-23 03:42:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 101M=0s 2017-09-23 03:42:24 (101 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.167521 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 03:42:24.634430) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 03:42:24.634800) ========= 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=03627c79f6bb3d1578c4a402000001ba-1506163343.180261-953808805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019021 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 03:42:24.687460) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 03:42:24.687869) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8db0c4ecd94cb62a35a25a5fe411d9f0aed7087e --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 8db0c4ecd94cb62a35a25a5fe411d9f0aed7087e --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=03627c79f6bb3d1578c4a402000001ba-1506163343.180261-953808805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-23 03:42:24,753 truncating revision to first 12 chars 2017-09-23 03:42:24,753 Setting DEBUG logging. 2017-09-23 03:42:24,753 attempt 1/10 2017-09-23 03:42:24,753 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8db0c4ecd94c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-23 03:42:25,125 unpacking tar archive at: mozilla-central-8db0c4ecd94c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.703340 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 03:42:25.407006) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-23 03:42:25.407341) ========= script_repo_revision: 8db0c4ecd94cb62a35a25a5fe411d9f0aed7087e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-23 03:42:25.410894) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-23 03:42:25.411186) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-23 03:42:25.424987) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-09-23 03:42:25.425402) ========= /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=03627c79f6bb3d1578c4a402000001ba-1506163343.180261-953808805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:42:25 INFO - MultiFileLogger online at 20170923 03:42:25 in /builds/slave/test 03:42:25 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:42:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:42:25 INFO - {'append_to_log': False, 03:42:25 INFO - 'base_work_dir': '/builds/slave/test', 03:42:25 INFO - 'blob_upload_branch': 'Firefox', 03:42:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:42:25 INFO - 'branch': 'Firefox', 03:42:25 INFO - 'buildbot_json_path': 'buildprops.json', 03:42:25 INFO - 'code_coverage': False, 03:42:25 INFO - 'config_files': ('talos/linux_config.py',), 03:42:25 INFO - 'default_actions': ('clobber', 03:42:25 INFO - 'read-buildbot-config', 03:42:25 INFO - 'download-and-extract', 03:42:25 INFO - 'populate-webroot', 03:42:25 INFO - 'create-virtualenv', 03:42:25 INFO - 'install', 03:42:25 INFO - 'setup-mitmproxy', 03:42:25 INFO - 'run-tests'), 03:42:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:42:25 INFO - 'disable_ccov_upload': False, 03:42:25 INFO - 'disable_stylo': False, 03:42:25 INFO - 'download_minidump_stackwalk': True, 03:42:25 INFO - 'download_symbols': 'ondemand', 03:42:25 INFO - 'enable_stylo': False, 03:42:25 INFO - 'enable_webrender': False, 03:42:25 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:42:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:42:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:42:25 INFO - 'gecko_profile': False, 03:42:25 INFO - 'gecko_profile_interval': 0, 03:42:25 INFO - 'installer_path': 'installer.exe', 03:42:25 INFO - 'log_level': 'info', 03:42:25 INFO - 'log_name': 'talos', 03:42:25 INFO - 'log_to_console': True, 03:42:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:42:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:42:25 INFO - 'opt_config_files': (), 03:42:25 INFO - 'pip_index': False, 03:42:25 INFO - 'suite': 'dromaeojs-e10s', 03:42:25 INFO - 'system_bits': '32', 03:42:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:42:25 INFO - 'title': 'talos-linux64-ix-047', 03:42:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:42:25 INFO - 'use_talos_json': True, 03:42:25 INFO - 'verify': 'False', 03:42:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:42:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:42:25 INFO - 'work_dir': 'build'} 03:42:25 INFO - [mozharness: 2017-09-23 10:42:25.710503Z] Running clobber step. 03:42:25 INFO - Running pre-action listener: _resource_record_pre_action 03:42:25 INFO - Running main action method: clobber 03:42:25 INFO - rmtree: /builds/slave/test/build 03:42:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:42:26 INFO - Running post-action listener: _resource_record_post_action 03:42:26 INFO - [mozharness: 2017-09-23 10:42:26.730665Z] Finished clobber step (success) 03:42:26 INFO - [mozharness: 2017-09-23 10:42:26.730762Z] Running read-buildbot-config step. 03:42:26 INFO - Running pre-action listener: _resource_record_pre_action 03:42:26 INFO - Running main action method: read_buildbot_config 03:42:26 INFO - Using buildbot properties: 03:42:26 INFO - { 03:42:26 INFO - "project": "", 03:42:26 INFO - "product": "firefox", 03:42:26 INFO - "who": "archaeopteryx@coole-files.de", 03:42:26 INFO - "installer_path": "public/build/target.tar.bz2", 03:42:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 03:42:26 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:42:26 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 03:42:26 INFO - "stage_platform": "linux64-qr", 03:42:26 INFO - "basedir": "/builds/slave/test", 03:42:26 INFO - "buildnumber": 76, 03:42:26 INFO - "platform": "ubuntu64_hw_qr", 03:42:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:42:26 INFO - "slavebuilddir": "test", 03:42:26 INFO - "taskId": "faqyIXHrQGeY1cZsGpMvew", 03:42:26 INFO - "branch": "mozilla-central", 03:42:26 INFO - "script_repo_revision": "production", 03:42:26 INFO - "revision": "8db0c4ecd94cb62a35a25a5fe411d9f0aed7087e", 03:42:26 INFO - "slavename": "talos-linux64-ix-047", 03:42:26 INFO - "repo_path": "mozilla-central" 03:42:26 INFO - } 03:42:26 INFO - Finding installer, test and symbols from parent task. 03:42:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/faqyIXHrQGeY1cZsGpMvew'}, attempt #1 03:42:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/faqyIXHrQGeY1cZsGpMvew'}, attempt #1 03:42:27 INFO - Task dependencies: G4ULSq9NTWSDYYmNphUW3A 03:42:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A'}, attempt #1 03:42:28 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.tar.bz2 03:42:28 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.test_packages.json 03:42:28 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.crashreporter-symbols.zip 03:42:28 INFO - Running post-action listener: _resource_record_post_action 03:42:28 INFO - [mozharness: 2017-09-23 10:42:28.096439Z] Finished read-buildbot-config step (success) 03:42:28 INFO - [mozharness: 2017-09-23 10:42:28.096658Z] Running download-and-extract step. 03:42:28 INFO - Running pre-action listener: _resource_record_pre_action 03:42:28 INFO - Running main action method: download_and_extract 03:42:28 INFO - mkdir: /builds/slave/test/build/tests 03:42:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:28 INFO - trying https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.test_packages.json 03:42:28 INFO - Downloading https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:42:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:42:28 INFO - Downloaded 989 bytes. 03:42:28 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:42:28 INFO - Using the following test package requirements: 03:42:28 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:42:28 INFO - u'common': [u'target.common.tests.zip'], 03:42:28 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:42:28 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:42:28 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:42:28 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:42:28 INFO - u'mozbase': [u'target.common.tests.zip'], 03:42:28 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:42:28 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:42:28 INFO - u'web-platform': [u'target.common.tests.zip', 03:42:28 INFO - u'target.web-platform.tests.tar.gz'], 03:42:28 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:42:28 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:42:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.common.tests.zip 03:42:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:42:28 INFO - Fetch https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.common.tests.zip into memory 03:42:29 INFO - Content-Length response header: 54943895 03:42:29 INFO - Bytes received: 54943895 03:42:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.talos.tests.zip 03:42:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:42:40 INFO - Fetch https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.talos.tests.zip into memory 03:42:41 INFO - Content-Length response header: 14513823 03:42:41 INFO - Bytes received: 14513823 03:42: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:42:42 INFO - trying https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.tar.bz2 03:42:42 INFO - Downloading https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:42:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:42:43 INFO - Downloaded 61675129 bytes. 03:42:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.tar.bz2 03:42:43 INFO - mkdir: /builds/slave/test/properties 03:42:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:42:43 INFO - Writing to file /builds/slave/test/properties/build_url 03:42:43 INFO - Contents: 03:42:43 INFO - build_url:https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.tar.bz2 03:42:43 INFO - Running post-action listener: _resource_record_post_action 03:42:43 INFO - Running post-action listener: find_tests_for_verification 03:42:43 INFO - Running post-action listener: set_extra_try_arguments 03:42:43 INFO - [mozharness: 2017-09-23 10:42:43.256880Z] Finished download-and-extract step (success) 03:42:43 INFO - [mozharness: 2017-09-23 10:42:43.256978Z] Running populate-webroot step. 03:42:43 INFO - Running pre-action listener: _resource_record_pre_action 03:42:43 INFO - Running main action method: populate_webroot 03:42:43 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:42:43 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:42:43 INFO - 'tests': ['tresize', 03:42:43 INFO - 'tcanvasmark']}, 03:42:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:42:43 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:42:43 INFO - 'tests': ['dromaeo_css', 03:42:43 INFO - 'kraken']}, 03:42:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:42:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:42:43 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:42:43 INFO - 'talos_options': ['--disable-stylo'], 03:42:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:42:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:42:43 INFO - 'tests': ['damp', 'tps']}, 03:42:43 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:42:43 INFO - 'talos_options': ['--disable-stylo'], 03:42:43 INFO - 'tests': ['damp', 'tps']}, 03:42:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:42:43 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:42:43 INFO - 'tests': ['dromaeo_dom']}, 03:42:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:42:43 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:42:43 INFO - 'tests': ['basic_compositor_video', 03:42:43 INFO - 'glvideo']}, 03:42:43 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:42:43 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:42:43 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:42:43 INFO - 'talos_options': ['--disable-stylo'], 03:42:43 INFO - 'tests': ['ts_paint_webext', 03:42:43 INFO - 'tp5o_webext']}, 03:42:43 INFO - 'other-e10s': {'tests': ['a11yr', 03:42:43 INFO - 'ts_paint', 03:42:43 INFO - 'tpaint', 03:42:43 INFO - 'sessionrestore', 03:42:43 INFO - 'sessionrestore_many_windows', 03:42:43 INFO - 'sessionrestore_no_auto_restore', 03:42:43 INFO - 'tabpaint']}, 03:42:43 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:42:43 INFO - 'tests': ['a11yr', 03:42:43 INFO - 'ts_paint', 03:42:43 INFO - 'tpaint', 03:42:43 INFO - 'sessionrestore', 03:42:43 INFO - 'sessionrestore_many_windows', 03:42:43 INFO - 'sessionrestore_no_auto_restore', 03:42:43 INFO - 'tabpaint']}, 03:42:43 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 03:42:43 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 03:42:43 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:42:43 INFO - 'tests': ['perf_reftest_singletons']}, 03:42:43 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:42:43 INFO - 'tests': ['perf_reftest']}, 03:42:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:42:43 INFO - 'tsvgr_opacity', 03:42:43 INFO - 'tart', 03:42:43 INFO - 'tscrollx', 03:42:43 INFO - 'tsvg_static']}, 03:42:43 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:42:43 INFO - 'tests': ['tsvgx', 03:42:43 INFO - 'tsvgr_opacity', 03:42:43 INFO - 'tart', 03:42:43 INFO - 'tscrollx', 03:42:43 INFO - 'tsvg_static']}, 03:42:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:42:43 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:42:43 INFO - 'talos_options': ['--disable-stylo'], 03:42:43 INFO - 'tests': ['tp5o']}, 03:42:43 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:42:43 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:42:43 INFO - 'talos_options': ['--mitmproxy', 03:42:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:42:43 INFO - '--firstNonBlankPaint'], 03:42:43 INFO - 'tests': ['tp6_google', 03:42:43 INFO - 'tp6_youtube', 03:42:43 INFO - 'tp6_amazon', 03:42:43 INFO - 'tp6_facebook']}, 03:42:43 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:42:43 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:42:43 INFO - 'talos_options': ['--disable-stylo', 03:42:43 INFO - '--mitmproxy', 03:42:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:42:43 INFO - '--firstNonBlankPaint'], 03:42:43 INFO - 'tests': ['tp6_google', 03:42:43 INFO - 'tp6_youtube', 03:42:43 INFO - 'tp6_amazon', 03:42:43 INFO - 'tp6_facebook']}, 03:42:43 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:42:43 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:42:43 INFO - 'talos_options': ['--stylo-threads=1', 03:42:43 INFO - '--mitmproxy', 03:42:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:42:43 INFO - '--firstNonBlankPaint'], 03:42:43 INFO - 'tests': ['tp6_google', 03:42:43 INFO - 'tp6_youtube', 03:42:43 INFO - 'tp6_amazon', 03:42:43 INFO - 'tp6_facebook']}, 03:42:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:42:43 INFO - 'talos_options': ['--xperf_path', 03:42:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:42:43 INFO - 'tests': ['tp5n']}, 03:42:43 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:42:43 INFO - 'talos_options': ['--disable-stylo', 03:42:43 INFO - '--xperf_path', 03:42:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:42:43 INFO - 'tests': ['tp5n']}}} 03:42:43 INFO - Running post-action listener: _resource_record_post_action 03:42:43 INFO - [mozharness: 2017-09-23 10:42:43.272499Z] Finished populate-webroot step (success) 03:42:43 INFO - [mozharness: 2017-09-23 10:42:43.272589Z] Running create-virtualenv step. 03:42:43 INFO - Running pre-action listener: _resource_record_pre_action 03:42:43 INFO - Running main action method: create_virtualenv 03:42:43 INFO - Creating virtualenv /builds/slave/test/build/venv 03:42:43 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:42:43 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:42:43 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:42:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:42:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:42:44 INFO - Installing distribute.............................................................................................................................................................................................done. 03:42:44 INFO - Installing pip...............done. 03:42:44 INFO - Return code: 0 03:42:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:42:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:42:44 INFO - Reading from file tmpfile_stdout 03:42:44 INFO - Output received: 03:42:44 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:42:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:42:44 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:42:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:44 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:42:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:44 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 0x1d761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e39c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e0d60>, '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 0x20e1a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e1ef0>, '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': '03627c79f6bb3d1578c4a402000001ba-1506163343.180261-953808805', '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:42:44 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:42:44 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:42:44 INFO - Using env: {'DISPLAY': ':0', 03:42:44 INFO - 'HOME': '/home/cltbld', 03:42:44 INFO - 'LANG': 'en_US.UTF-8', 03:42:44 INFO - 'LANGUAGE': 'en_US:en', 03:42:44 INFO - 'LOGNAME': 'cltbld', 03:42:44 INFO - 'MAIL': '/var/mail/cltbld', 03:42:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:44 INFO - 'MOZ_NO_REMOTE': '1', 03:42:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:44 INFO - 'NO_EM_RESTART': '1', 03:42:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:44 INFO - 'PWD': '/builds/slave/test', 03:42:44 INFO - 'SHELL': '/bin/bash', 03:42:44 INFO - 'SHLVL': '1', 03:42:44 INFO - 'TERM': 'linux', 03:42:44 INFO - 'TMOUT': '86400', 03:42:44 INFO - 'USER': 'cltbld', 03:42:44 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1506163343.180261-953808805', 03:42:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:44 INFO - '_': '/tools/buildbot/bin/python'} 03:42:45 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:42:45 INFO - Downloading/unpacking pip>=1.5 03:42:45 INFO - Running setup.py egg_info for package pip 03:42:45 INFO - warning: no files found matching 'pip/cacert.pem' 03:42:45 INFO - warning: no files found matching '*.html' under directory 'docs' 03:42:45 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:42:45 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:42:45 INFO - Installing collected packages: pip 03:42:45 INFO - Found existing installation: pip 1.1 03:42:45 INFO - Uninstalling pip: 03:42:45 INFO - Successfully uninstalled pip 03:42:45 INFO - Running setup.py install for pip 03:42:45 INFO - warning: no files found matching 'pip/cacert.pem' 03:42:45 INFO - warning: no files found matching '*.html' under directory 'docs' 03:42:45 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:42:45 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:42:45 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:42:45 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:42:45 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:42:45 INFO - Successfully installed pip 03:42:45 INFO - Cleaning up... 03:42:45 INFO - Return code: 0 03:42:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:42: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:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42: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:42:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42: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', '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 0x1d761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e39c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e0d60>, '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 0x20e1a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e1ef0>, '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': '03627c79f6bb3d1578c4a402000001ba-1506163343.180261-953808805', '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:42: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', 'psutil>=3.1.1'] in /builds/slave/test/build 03:42: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 psutil>=3.1.1 03:42:45 INFO - Using env: {'DISPLAY': ':0', 03:42:45 INFO - 'HOME': '/home/cltbld', 03:42:45 INFO - 'LANG': 'en_US.UTF-8', 03:42:45 INFO - 'LANGUAGE': 'en_US:en', 03:42:45 INFO - 'LOGNAME': 'cltbld', 03:42:45 INFO - 'MAIL': '/var/mail/cltbld', 03:42:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:45 INFO - 'MOZ_NO_REMOTE': '1', 03:42:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:45 INFO - 'NO_EM_RESTART': '1', 03:42:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:45 INFO - 'PWD': '/builds/slave/test', 03:42:45 INFO - 'SHELL': '/bin/bash', 03:42:45 INFO - 'SHLVL': '1', 03:42:45 INFO - 'TERM': 'linux', 03:42:45 INFO - 'TMOUT': '86400', 03:42:45 INFO - 'USER': 'cltbld', 03:42:45 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1506163343.180261-953808805', 03:42:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:45 INFO - '_': '/tools/buildbot/bin/python'} 03:42:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:46 INFO - Downloading/unpacking psutil>=3.1.1 03:42: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:42: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:42: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:42: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:42:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:42:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:42:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:42:47 INFO - Installing collected packages: psutil 03:42:47 INFO - Running setup.py install for psutil 03:42:47 INFO - building 'psutil._psutil_linux' extension 03:42:47 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:42:49 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:42:50 INFO - building 'psutil._psutil_posix' extension 03:42:50 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:42:50 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:42:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:42:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:42:50 INFO - Successfully installed psutil 03:42:50 INFO - Cleaning up... 03:42:50 INFO - Return code: 0 03:42:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:42:50 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:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:50 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:42:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:50 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 0x1d761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e39c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e0d60>, '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 0x20e1a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e1ef0>, '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': '03627c79f6bb3d1578c4a402000001ba-1506163343.180261-953808805', '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:42:50 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:42:50 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:42:50 INFO - Using env: {'DISPLAY': ':0', 03:42:50 INFO - 'HOME': '/home/cltbld', 03:42:50 INFO - 'LANG': 'en_US.UTF-8', 03:42:50 INFO - 'LANGUAGE': 'en_US:en', 03:42:50 INFO - 'LOGNAME': 'cltbld', 03:42:50 INFO - 'MAIL': '/var/mail/cltbld', 03:42:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:50 INFO - 'MOZ_NO_REMOTE': '1', 03:42:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:50 INFO - 'NO_EM_RESTART': '1', 03:42:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:50 INFO - 'PWD': '/builds/slave/test', 03:42:50 INFO - 'SHELL': '/bin/bash', 03:42:50 INFO - 'SHLVL': '1', 03:42:50 INFO - 'TERM': 'linux', 03:42:50 INFO - 'TMOUT': '86400', 03:42:50 INFO - 'USER': 'cltbld', 03:42:50 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1506163343.180261-953808805', 03:42:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:50 INFO - '_': '/tools/buildbot/bin/python'} 03:42:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:42:50 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:42:50 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:42:50 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:42:50 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:42:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:42:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:42:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:42:51 INFO - Installing collected packages: mozsystemmonitor 03:42:51 INFO - Running setup.py install for mozsystemmonitor 03:42:52 INFO - Successfully installed mozsystemmonitor 03:42:52 INFO - Cleaning up... 03:42:52 INFO - Return code: 0 03:42:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1d761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e39c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e0d60>, '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 0x20e1a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e1ef0>, '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': '03627c79f6bb3d1578c4a402000001ba-1506163343.180261-953808805', '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:42:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:42:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:42:52 INFO - Using env: {'DISPLAY': ':0', 03:42:52 INFO - 'HOME': '/home/cltbld', 03:42:52 INFO - 'LANG': 'en_US.UTF-8', 03:42:52 INFO - 'LANGUAGE': 'en_US:en', 03:42:52 INFO - 'LOGNAME': 'cltbld', 03:42:52 INFO - 'MAIL': '/var/mail/cltbld', 03:42:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:52 INFO - 'MOZ_NO_REMOTE': '1', 03:42:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:52 INFO - 'NO_EM_RESTART': '1', 03:42:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:52 INFO - 'PWD': '/builds/slave/test', 03:42:52 INFO - 'SHELL': '/bin/bash', 03:42:52 INFO - 'SHLVL': '1', 03:42:52 INFO - 'TERM': 'linux', 03:42:52 INFO - 'TMOUT': '86400', 03:42:52 INFO - 'USER': 'cltbld', 03:42:52 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1506163343.180261-953808805', 03:42:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:52 INFO - '_': '/tools/buildbot/bin/python'} 03:42:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:52 INFO - Downloading/unpacking jsonschema==2.5.1 03:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:42:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:42: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:42: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:42: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:42: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:42:53 INFO - Downloading functools32-3.2.3-2.tar.gz 03:42:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:42:53 INFO - warning: no files found matching '*.txt' 03:42:53 INFO - no previously-included directories found matching 'build' 03:42:53 INFO - no previously-included directories found matching 'dist' 03:42:53 INFO - no previously-included directories found matching '.git*' 03:42:53 INFO - Installing collected packages: jsonschema, functools32 03:42:53 INFO - Running setup.py install for functools32 03:42:53 INFO - warning: no files found matching '*.txt' 03:42:53 INFO - no previously-included directories found matching 'build' 03:42:53 INFO - no previously-included directories found matching 'dist' 03:42:53 INFO - no previously-included directories found matching '.git*' 03:42:53 INFO - Successfully installed jsonschema functools32 03:42:53 INFO - Cleaning up... 03:42:53 INFO - Return code: 0 03:42:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:42:53 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:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:53 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:42:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:53 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 0x1d761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e39c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e0d60>, '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 0x20e1a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e1ef0>, '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': '03627c79f6bb3d1578c4a402000001ba-1506163343.180261-953808805', '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:42:53 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:42:53 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:42:53 INFO - Using env: {'DISPLAY': ':0', 03:42:53 INFO - 'HOME': '/home/cltbld', 03:42:53 INFO - 'LANG': 'en_US.UTF-8', 03:42:53 INFO - 'LANGUAGE': 'en_US:en', 03:42:53 INFO - 'LOGNAME': 'cltbld', 03:42:53 INFO - 'MAIL': '/var/mail/cltbld', 03:42:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:53 INFO - 'MOZ_NO_REMOTE': '1', 03:42:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:53 INFO - 'NO_EM_RESTART': '1', 03:42:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:53 INFO - 'PWD': '/builds/slave/test', 03:42:53 INFO - 'SHELL': '/bin/bash', 03:42:53 INFO - 'SHLVL': '1', 03:42:53 INFO - 'TERM': 'linux', 03:42:53 INFO - 'TMOUT': '86400', 03:42:53 INFO - 'USER': 'cltbld', 03:42:53 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1506163343.180261-953808805', 03:42:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:53 INFO - '_': '/tools/buildbot/bin/python'} 03:42:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:42:53 INFO - Cleaning up... 03:42:53 INFO - Return code: 0 03:42:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:42:53 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:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:53 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:42:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1d761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e39c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e0d60>, '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 0x20e1a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e1ef0>, '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': '03627c79f6bb3d1578c4a402000001ba-1506163343.180261-953808805', '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:42:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:42:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:42:54 INFO - Using env: {'DISPLAY': ':0', 03:42:54 INFO - 'HOME': '/home/cltbld', 03:42:54 INFO - 'LANG': 'en_US.UTF-8', 03:42:54 INFO - 'LANGUAGE': 'en_US:en', 03:42:54 INFO - 'LOGNAME': 'cltbld', 03:42:54 INFO - 'MAIL': '/var/mail/cltbld', 03:42:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:54 INFO - 'MOZ_NO_REMOTE': '1', 03:42:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:54 INFO - 'NO_EM_RESTART': '1', 03:42:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:54 INFO - 'PWD': '/builds/slave/test', 03:42:54 INFO - 'SHELL': '/bin/bash', 03:42:54 INFO - 'SHLVL': '1', 03:42:54 INFO - 'TERM': 'linux', 03:42:54 INFO - 'TMOUT': '86400', 03:42:54 INFO - 'USER': 'cltbld', 03:42:54 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1506163343.180261-953808805', 03:42:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:54 INFO - '_': '/tools/buildbot/bin/python'} 03:42:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:54 INFO - Downloading/unpacking blobuploader==1.2.4 03:42: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:42: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:42: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:42: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:42:55 INFO - Downloading blobuploader-1.2.4.tar.gz 03:42:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:42:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:42:55 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:42:55 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:42:55 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:42:55 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:42:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:42:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:42:55 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:42:55 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:42:55 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:42:55 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:42:55 INFO - Downloading docopt-0.6.1.tar.gz 03:42:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:42:55 INFO - Installing collected packages: blobuploader, requests, docopt 03:42:55 INFO - Running setup.py install for blobuploader 03:42:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:42:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:42:56 INFO - Running setup.py install for requests 03:42:56 INFO - Running setup.py install for docopt 03:42:56 INFO - Successfully installed blobuploader requests docopt 03:42:56 INFO - Cleaning up... 03:42:56 INFO - Return code: 0 03:42:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:42:56 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:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:56 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:42:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:56 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 0x1d761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e39c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e0d60>, '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 0x20e1a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e1ef0>, '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': '03627c79f6bb3d1578c4a402000001ba-1506163343.180261-953808805', '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:42:56 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:42:56 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:42:56 INFO - Using env: {'DISPLAY': ':0', 03:42:56 INFO - 'HOME': '/home/cltbld', 03:42:56 INFO - 'LANG': 'en_US.UTF-8', 03:42:56 INFO - 'LANGUAGE': 'en_US:en', 03:42:56 INFO - 'LOGNAME': 'cltbld', 03:42:56 INFO - 'MAIL': '/var/mail/cltbld', 03:42:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:56 INFO - 'MOZ_NO_REMOTE': '1', 03:42:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:56 INFO - 'NO_EM_RESTART': '1', 03:42:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:56 INFO - 'PWD': '/builds/slave/test', 03:42:56 INFO - 'SHELL': '/bin/bash', 03:42:56 INFO - 'SHLVL': '1', 03:42:56 INFO - 'TERM': 'linux', 03:42:56 INFO - 'TMOUT': '86400', 03:42:56 INFO - 'USER': 'cltbld', 03:42:56 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1506163343.180261-953808805', 03:42:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:56 INFO - '_': '/tools/buildbot/bin/python'} 03:42:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:42:56 INFO - Running setup.py (path:/tmp/pip-2YqGT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:42:56 INFO - Running setup.py (path:/tmp/pip-FwWSva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:42:56 INFO - Running setup.py (path:/tmp/pip-V9Btxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:42:56 INFO - Running setup.py (path:/tmp/pip-Ta93X1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:42:57 INFO - Running setup.py (path:/tmp/pip-zB4eY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:42:57 INFO - Running setup.py (path:/tmp/pip-jDRcsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:42:57 INFO - Running setup.py (path:/tmp/pip-AzexxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:42:57 INFO - Running setup.py (path:/tmp/pip-daSV0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:42:57 INFO - Running setup.py (path:/tmp/pip-VJJYQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:42:57 INFO - Running setup.py (path:/tmp/pip-_9N5nx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:42:57 INFO - Running setup.py (path:/tmp/pip-PdzUhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:42:57 INFO - Running setup.py (path:/tmp/pip-gXShUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:42:57 INFO - Running setup.py (path:/tmp/pip-sbeylQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:42:57 INFO - Running setup.py (path:/tmp/pip-VYOCeJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:42:57 INFO - Running setup.py (path:/tmp/pip-6PguhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:42:57 INFO - Running setup.py (path:/tmp/pip-ghk_yQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:42:57 INFO - Running setup.py (path:/tmp/pip-sfHhi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:42:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:42:57 INFO - Running setup.py install for manifestparser 03:42:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:42:58 INFO - Running setup.py install for mozcrash 03:42:58 INFO - Running setup.py install for mozdebug 03:42:58 INFO - Running setup.py install for mozdevice 03:42:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:42:58 INFO - Running setup.py install for mozfile 03:42:58 INFO - Running setup.py install for mozhttpd 03:42:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:42:58 INFO - Running setup.py install for mozinfo 03:42:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:42:58 INFO - Running setup.py install for mozInstall 03:42:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:42:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:42:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:42:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:42:58 INFO - Running setup.py install for mozleak 03:42:58 INFO - Running setup.py install for mozlog 03:42:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:42:58 INFO - Running setup.py install for moznetwork 03:42:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:42:59 INFO - Running setup.py install for mozprocess 03:42:59 INFO - Running setup.py install for mozprofile 03:42:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:42:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:42:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:42:59 INFO - Running setup.py install for mozrunner 03:42:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:42:59 INFO - Running setup.py install for mozscreenshot 03:42:59 INFO - Running setup.py install for moztest 03:42:59 INFO - Running setup.py install for mozversion 03:42:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:42:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:42:59 INFO - Cleaning up... 03:42:59 INFO - Return code: 0 03:42:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:42:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:59 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 0x1d761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e39c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e0d60>, '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 0x20e1a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e1ef0>, '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': '03627c79f6bb3d1578c4a402000001ba-1506163343.180261-953808805', '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:42:59 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:42:59 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:42:59 INFO - Using env: {'DISPLAY': ':0', 03:42:59 INFO - 'HOME': '/home/cltbld', 03:42:59 INFO - 'LANG': 'en_US.UTF-8', 03:42:59 INFO - 'LANGUAGE': 'en_US:en', 03:42:59 INFO - 'LOGNAME': 'cltbld', 03:42:59 INFO - 'MAIL': '/var/mail/cltbld', 03:42:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:59 INFO - 'MOZ_NO_REMOTE': '1', 03:42:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:59 INFO - 'NO_EM_RESTART': '1', 03:42:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:59 INFO - 'PWD': '/builds/slave/test', 03:42:59 INFO - 'SHELL': '/bin/bash', 03:42:59 INFO - 'SHLVL': '1', 03:42:59 INFO - 'TERM': 'linux', 03:42:59 INFO - 'TMOUT': '86400', 03:42:59 INFO - 'USER': 'cltbld', 03:42:59 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1506163343.180261-953808805', 03:42:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:59 INFO - '_': '/tools/buildbot/bin/python'} 03:42:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:42:59 INFO - Running setup.py (path:/tmp/pip-ROMiCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:42:59 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:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:42:59 INFO - Running setup.py (path:/tmp/pip-X2EuIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:43:00 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:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:43:00 INFO - Running setup.py (path:/tmp/pip-x8JIVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:43:00 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:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:43:00 INFO - Running setup.py (path:/tmp/pip-lpNKv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:43:00 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:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:43:00 INFO - Running setup.py (path:/tmp/pip-6SKG6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:43:00 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:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:43:00 INFO - Running setup.py (path:/tmp/pip-WrvV7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:43:00 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:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:43:00 INFO - Running setup.py (path:/tmp/pip-scjYES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:43:00 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:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:43:00 INFO - Running setup.py (path:/tmp/pip-R1YOdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:43:00 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:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:43:00 INFO - Running setup.py (path:/tmp/pip-tawEPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:43:00 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:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:43:00 INFO - Running setup.py (path:/tmp/pip-87Gff4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:43:00 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:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:43:00 INFO - Running setup.py (path:/tmp/pip-riVzBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:43:00 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:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:43:00 INFO - Running setup.py (path:/tmp/pip-RBGJYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:43:00 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:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:43:00 INFO - Running setup.py (path:/tmp/pip-PicaZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:43:00 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:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:43:00 INFO - Running setup.py (path:/tmp/pip-VkzuA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:43:00 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:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:43:00 INFO - Running setup.py (path:/tmp/pip-tCrDQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:43:00 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:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:43:00 INFO - Running setup.py (path:/tmp/pip-iBuEbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:43:01 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:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:43:01 INFO - Running setup.py (path:/tmp/pip-a4f_nq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:43:01 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:43:01 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:43:01 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:43:01 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:43:01 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:43:01 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:43:01 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:43:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:02 INFO - Downloading blessings-1.6.tar.gz 03:43:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:43:02 INFO - Installing collected packages: blessings 03:43:02 INFO - Running setup.py install for blessings 03:43:02 INFO - Successfully installed blessings 03:43:02 INFO - Cleaning up... 03:43:02 INFO - Return code: 0 03:43:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:43:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:43:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:43:02 INFO - Reading from file tmpfile_stdout 03:43:02 INFO - Current package versions: 03:43:02 INFO - argparse == 1.2.1 03:43:02 INFO - blessings == 1.6 03:43:02 INFO - blobuploader == 1.2.4 03:43:02 INFO - docopt == 0.6.1 03:43:02 INFO - functools32 == 3.2.3-2 03:43:02 INFO - jsonschema == 2.5.1 03:43:02 INFO - manifestparser == 1.1 03:43:02 INFO - mozInstall == 1.13 03:43:02 INFO - mozcrash == 1.0 03:43:02 INFO - mozdebug == 0.1 03:43:02 INFO - mozdevice == 0.51 03:43:02 INFO - mozfile == 1.2 03:43:02 INFO - mozhttpd == 0.7 03:43:02 INFO - mozinfo == 0.10 03:43:02 INFO - mozleak == 0.1 03:43:02 INFO - mozlog == 3.5 03:43:02 INFO - moznetwork == 0.27 03:43:02 INFO - mozprocess == 0.25 03:43:02 INFO - mozprofile == 0.28 03:43:02 INFO - mozrunner == 6.13 03:43:02 INFO - mozscreenshot == 0.1 03:43:02 INFO - mozsystemmonitor == 0.3 03:43:02 INFO - moztest == 0.8 03:43:02 INFO - mozversion == 1.4 03:43:02 INFO - psutil == 3.1.1 03:43:02 INFO - requests == 1.2.3 03:43:02 INFO - wsgiref == 0.1.2 03:43:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:43:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:43:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:02 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 0x1d761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e39c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e0d60>, '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 0x20e1a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e1ef0>, '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': '03627c79f6bb3d1578c4a402000001ba-1506163343.180261-953808805', '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:43:02 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:43:02 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:43:02 INFO - Using env: {'DISPLAY': ':0', 03:43:02 INFO - 'HOME': '/home/cltbld', 03:43:02 INFO - 'LANG': 'en_US.UTF-8', 03:43:02 INFO - 'LANGUAGE': 'en_US:en', 03:43:02 INFO - 'LOGNAME': 'cltbld', 03:43:02 INFO - 'MAIL': '/var/mail/cltbld', 03:43:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:02 INFO - 'MOZ_NO_REMOTE': '1', 03:43:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:02 INFO - 'NO_EM_RESTART': '1', 03:43:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:02 INFO - 'PWD': '/builds/slave/test', 03:43:02 INFO - 'SHELL': '/bin/bash', 03:43:02 INFO - 'SHLVL': '1', 03:43:02 INFO - 'TERM': 'linux', 03:43:02 INFO - 'TMOUT': '86400', 03:43:02 INFO - 'USER': 'cltbld', 03:43:02 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1506163343.180261-953808805', 03:43:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:02 INFO - '_': '/tools/buildbot/bin/python'} 03:43:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:02 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:43:02 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:43:02 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:43:02 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:43:02 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:43:02 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:43:02 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:43:02 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:43:02 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:43:02 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:43:02 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:43:02 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:43:02 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:43:02 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:43:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:43:04 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:43:04 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:43:04 INFO - Installing collected packages: simplejson 03:43:04 INFO - Running setup.py install for simplejson 03:43:04 INFO - building 'simplejson._speedups' extension 03:43:04 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:43:05 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:43:05 INFO - Successfully installed simplejson 03:43:05 INFO - Cleaning up... 03:43:05 INFO - Return code: 0 03:43:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:43:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:43:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:43:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:05 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 0x1d761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e39c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e0d60>, '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 0x20e1a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e1ef0>, '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': '03627c79f6bb3d1578c4a402000001ba-1506163343.180261-953808805', '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:43:05 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:43:05 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:43:05 INFO - Using env: {'DISPLAY': ':0', 03:43:05 INFO - 'HOME': '/home/cltbld', 03:43:05 INFO - 'LANG': 'en_US.UTF-8', 03:43:05 INFO - 'LANGUAGE': 'en_US:en', 03:43:05 INFO - 'LOGNAME': 'cltbld', 03:43:05 INFO - 'MAIL': '/var/mail/cltbld', 03:43:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:05 INFO - 'MOZ_NO_REMOTE': '1', 03:43:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:05 INFO - 'NO_EM_RESTART': '1', 03:43:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:05 INFO - 'PWD': '/builds/slave/test', 03:43:05 INFO - 'SHELL': '/bin/bash', 03:43:05 INFO - 'SHLVL': '1', 03:43:05 INFO - 'TERM': 'linux', 03:43:05 INFO - 'TMOUT': '86400', 03:43:05 INFO - 'USER': 'cltbld', 03:43:05 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1506163343.180261-953808805', 03:43:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:05 INFO - '_': '/tools/buildbot/bin/python'} 03:43:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:43:05 INFO - Cleaning up... 03:43:05 INFO - Return code: 0 03:43:05 INFO - Running post-action listener: _resource_record_post_action 03:43:05 INFO - Running post-action listener: _start_resource_monitoring 03:43:05 INFO - Starting resource monitoring. 03:43:05 INFO - [mozharness: 2017-09-23 10:43:05.480582Z] Finished create-virtualenv step (success) 03:43:05 INFO - [mozharness: 2017-09-23 10:43:05.481617Z] Running install step. 03:43:05 INFO - Running pre-action listener: _resource_record_pre_action 03:43:05 INFO - Running main action method: install 03:43:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:43:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:43:05 INFO - Reading from file tmpfile_stdout 03:43:05 INFO - Detecting whether we're running mozinstall >=1.0... 03:43:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:43:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:43:05 INFO - Reading from file tmpfile_stdout 03:43:05 INFO - Output received: 03:43:05 INFO - Usage: mozinstall [options] installer 03:43:05 INFO - Options: 03:43:05 INFO - -h, --help show this help message and exit 03:43:05 INFO - -d DEST, --destination=DEST 03:43:05 INFO - Directory to install application into. [default: 03:43:05 INFO - "/builds/slave/test"] 03:43:05 INFO - --app=APP Application being installed. [default: firefox] 03:43:05 INFO - mkdir: /builds/slave/test/build/application 03:43:05 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:43:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:43:23 INFO - Reading from file tmpfile_stdout 03:43:23 INFO - Output received: 03:43:23 INFO - /builds/slave/test/build/application/firefox/firefox 03:43:23 INFO - Running post-action listener: _resource_record_post_action 03:43:23 INFO - [mozharness: 2017-09-23 10:43:23.643941Z] Finished install step (success) 03:43:23 INFO - [mozharness: 2017-09-23 10:43:23.644193Z] Running setup-mitmproxy step. 03:43:23 INFO - Running pre-action listener: _resource_record_pre_action 03:43:23 INFO - Running main action method: setup_mitmproxy 03:43:23 INFO - Skipping: mitmproxy is not required 03:43:23 INFO - Running post-action listener: _resource_record_post_action 03:43:23 INFO - [mozharness: 2017-09-23 10:43:23.645405Z] Finished setup-mitmproxy step (success) 03:43:23 INFO - [mozharness: 2017-09-23 10:43:23.645629Z] Running run-tests step. 03:43:23 INFO - Running pre-action listener: _resource_record_pre_action 03:43:23 INFO - Running pre-action listener: _set_gcov_prefix 03:43:23 INFO - Running main action method: run_tests 03:43:23 WARNING - Try message not found. 03:43:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:43:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:43:23 INFO - Python 2.7.3 03:43:23 INFO - Return code: 0 03:43:23 INFO - grabbing minidump binary from tooltool 03:43:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:43:23 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e0d60>, '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 0x20e1a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e1ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:43:23 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:43:23 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:43:23 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:43:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:43:24 INFO - Return code: 0 03:43:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:43:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:43:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:43:24 INFO - ENV: RUST_BACKTRACE is now full 03:43:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:43:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:43:24 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/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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:43:24 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/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-047 --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:43:24 INFO - Using env: {'DISPLAY': ':0', 03:43:24 INFO - 'HOME': '/home/cltbld', 03:43:24 INFO - 'LANG': 'en_US.UTF-8', 03:43:24 INFO - 'LANGUAGE': 'en_US:en', 03:43:24 INFO - 'LOGNAME': 'cltbld', 03:43:24 INFO - 'MAIL': '/var/mail/cltbld', 03:43:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:43:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:43:24 INFO - 'MOZ_ACCELERATED': '1', 03:43:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:24 INFO - 'MOZ_NO_REMOTE': '1', 03:43:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:43:24 INFO - 'MOZ_WEBRENDER': '1', 03:43:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:24 INFO - 'NO_EM_RESTART': '1', 03:43:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:24 INFO - 'PWD': '/builds/slave/test', 03:43:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:43:24 INFO - 'RUST_BACKTRACE': 'full', 03:43:24 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:43:24 INFO - 'SHELL': '/bin/bash', 03:43:24 INFO - 'SHLVL': '1', 03:43:24 INFO - 'TERM': 'linux', 03:43:24 INFO - 'TMOUT': '86400', 03:43:24 INFO - 'USER': 'cltbld', 03:43:24 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1506163343.180261-953808805', 03:43:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:24 INFO - '_': '/tools/buildbot/bin/python'} 03:43:24 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/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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:43:24 INFO - mozversion application_buildid: 20170923093829 03:43:24 INFO - mozversion application_changeset: 8db0c4ecd94cb62a35a25a5fe411d9f0aed7087e 03:43:24 INFO - mozversion application_display_name: Nightly 03:43:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:43:24 INFO - mozversion application_name: Firefox 03:43:24 INFO - mozversion application_remotingname: firefox 03:43:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:43:24 INFO - mozversion application_vendor: Mozilla 03:43:24 INFO - mozversion application_version: 58.0a1 03:43:24 INFO - mozversion platform_buildid: 20170923093829 03:43:24 INFO - mozversion platform_changeset: 8db0c4ecd94cb62a35a25a5fe411d9f0aed7087e 03:43:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:43:24 INFO - mozversion platform_version: 58.0a1 03:43:24 INFO - using testdate: 1506163404 03:43:24 INFO - actual date: 1506163404 03:43:24 INFO - starting webserver on 'localhost:52166' 03:43:24 INFO - SUITE-START | Running 2 tests 03:43:24 INFO - TEST-START | dromaeo_css 03:43:24 INFO - Initialising browser for dromaeo_css test... 03:43:24 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52166/getInfo.html -profile /tmp/tmpNkr9FY/profile 03:43:24 INFO - TEST-INFO | started process 3589 (/builds/slave/test/build/application/firefox/firefox http://localhost:52166/getInfo.html) 03:43:34 INFO - TEST-INFO | 3589: exit 0 03:43:34 INFO - Browser initialized. 03:43:34 INFO - Running cycle 1/1 for dromaeo_css test... 03:43:34 INFO - Using env: {'DISPLAY': ':0', 03:43:34 INFO - 'HOME': '/home/cltbld', 03:43:34 INFO - 'JSGC_DISABLE_POISONING': '1', 03:43:34 INFO - 'LANG': 'en_US.UTF-8', 03:43:34 INFO - 'LANGUAGE': 'en_US:en', 03:43:34 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:43:34 INFO - 'LOGNAME': 'cltbld', 03:43:34 INFO - 'MAIL': '/var/mail/cltbld', 03:43:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:43:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:43:34 INFO - 'MOZ_ACCELERATED': '1', 03:43:34 INFO - 'MOZ_CRASHREPORTER': '1', 03:43:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:34 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:43:34 INFO - 'MOZ_NO_REMOTE': '1', 03:43:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:43:34 INFO - 'MOZ_WEBRENDER': '1', 03:43:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:34 INFO - 'NO_EM_RESTART': '1', 03:43:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:34 INFO - 'PWD': '/builds/slave/test', 03:43:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:43:34 INFO - 'RUST_BACKTRACE': 'full', 03:43:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:43:34 INFO - 'SHELL': '/bin/bash', 03:43:34 INFO - 'SHLVL': '1', 03:43:34 INFO - 'TERM': 'linux', 03:43:34 INFO - 'TMOUT': '86400', 03:43:34 INFO - 'USER': 'cltbld', 03:43:34 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1506163343.180261-953808805', 03:43:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:34 INFO - '_': '/tools/buildbot/bin/python'} 03:43:34 INFO - TEST-INFO | started process 3837 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNkr9FY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:43:35 INFO - PID 3837 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:43:35 INFO - PID 3837 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:43:35 INFO - PID 3837 | 03:43:35 INFO - PID 3837 | (/builds/slave/test/build/application/firefox/firefox:3897): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:43:35 INFO - PID 3837 | 03:43:45 INFO - PID 3837 | RSS: Main: 204111872 03:43:45 INFO - PID 3837 | 03:46:43 INFO - PID 3837 | Cycle 1(1): loaded http://localhost:52166/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52166/tests/dromaeo/cssquery-ext.html) 03:46:44 INFO - PID 3837 | RSS: Main: 208859136 03:46:44 INFO - PID 3837 | 03:49:47 INFO - PID 3837 | Cycle 1(1): loaded http://localhost:52166/tests/dromaeo/cssquery-ext.html (next: http://localhost:52166/tests/dromaeo/cssquery-jquery.html) 03:49:47 INFO - PID 3837 | RSS: Main: 210481152 03:49:47 INFO - PID 3837 | 03:52:49 INFO - PID 3837 | Cycle 1(1): loaded http://localhost:52166/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52166/tests/dromaeo/cssquery-mootools.html) 03:52:50 INFO - PID 3837 | RSS: Main: 211656704 03:52:50 INFO - PID 3837 | 03:55:52 INFO - PID 3837 | Cycle 1(1): loaded http://localhost:52166/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52166/tests/dromaeo/cssquery-prototype.html) 03:55:53 INFO - PID 3837 | RSS: Main: 213172224 03:55:53 INFO - PID 3837 | 03:58:56 INFO - PID 3837 | Cycle 1(1): loaded http://localhost:52166/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52166/tests/dromaeo/cssquery-yui.html) 03:58:57 INFO - PID 3837 | RSS: Main: 211562496 03:58:57 INFO - PID 3837 | 04:01:59 INFO - PID 3837 | Cycle 1(1): loaded http://localhost:52166/tests/dromaeo/cssquery-yui.html (next: http://localhost:52166/tests/dromaeo/cssquery-dojo.html) 04:01:59 INFO - PID 3837 | RSS: Main: 214003712 04:01:59 INFO - PID 3837 | 04:01:59 INFO - PID 3837 | __start_tp_report 04:01:59 INFO - PID 3837 | _x_x_mozilla_page_load 04:01:59 INFO - PID 3837 | _x_x_mozilla_page_load_details 04:01:59 INFO - PID 3837 | |i|pagename|runs| 04:01:59 INFO - PID 3837 | |0;dojo.html;3079.6766339534347;3108.440480713472;3113.8131712097274;3116.3144108296183;3121.219695076231;6167.845803854894;6193.78321758738;6251.09359142924;6282.057691346295;6346.936530634698;6154.753809847601;6159.476444502211;6377.904331435032;6396.360363963601;6409.583377080498;5625.943740562603;5726.45598668128;5763.193152958589;5825.737841797109;5858.88282234355;5746.425357464241;5753.827385178452;5848.415158484138;5850.795222167225;5864.912026319587;5653.321601407857;5670.461306175906;5721.6853073080965;5796.217510636052;5801.187833703285;5679.829605111853;5686.147077938301;5707;5710.571707121982;5715.685637289947;5605.691686957216;5609.1305847593685;5696.6866822324755;5729.6562206267345;5736.1682556029145;6160.7535698572;6165.815025549241;6216.222972128484;6297.118403423525;6305.5901366411035;6580.341965803429;6583.604983700993;6625.602463852184;6666.100076489661;6773.72905083796;6684.16447944007;6707.463402927803;6708.698108585077;6747.021681856152;6752.1222241108835;6101.694915254219;6203.596766210182;6205.627662340274;6215.098810672427;6249.218847644044;6861.691223894937;6866.279040700754;7047.859042819115;7051.753188638373;7074.575525468488;6575.901361479581;6577.736890524421;6640.402363787282;6661.067450556926;6713.765018224436;6627.469802415795;6733.393994540417;6769.8646027079185;6859.416949559343;6898.965505172542;6650.102236198148;6685;6752.257251702309;6754.5609535380045;6776.661166941633;6800.251972283045;6802.217744959294;6808.6255255960405;6814.965925170442;6819.147606549182;5297.788088476418;5351.411344752074;5376.924615077;5383.892322153535;5388.434214407509;4589.518100599389;4623.722576645412;4628.421447319085;4634.768261586907;4646.535346465326;5603.3836278009385;5727.742251598688;5740.253767010262;5841.678707671034;5857.20927674767;6775.593464392152;6810.965945170243;6815.011823285695;6847.041414202015;6849.691763870638;5760.855978600569;5772.509336706343;5823.854403639858;5862.384449632812;5867.882642347129;5767.394423585547;5768.480836724715;5830.7084645767545;5831.854203644943;5836.270466191726;6305.842353941096;6475.417212450808;6507.479401647857;6507.934920650733;6550.115734375799;6752.864942701217;6779.796606101726;6875.312468753084;6882.105326307548;6902.827429314308;6499.772507962388;6500.869982600227;6517.511186661114;6532.640704761284;6593.901091483535;6599.043138744951;6650.800475985729;6690.330966903271;6722.1261236039;6727.2263689674355;6604.273529911609;6644.867102657823;6723.865522689616;6732.091167692299;6736.562123461959;6474.514411419068;6512.6092434454085;6522.510811689048;6524.380183882524;6527.902081468686;6371.7132729028235;6517.8696426072165;6557.213134423709;6588.8023359299295;6590.80227593173;6496.187976502937;6544.214694236722;6562;6613.867722645617;6622.205335359595;6545;6622.70197841108;6635.170603674541;6724.327567243432;6747.291534388818;6243.875122497616;6296.811095667137;6375.553711240169;6453.999630057348;6486.0919471275 04:01:59 INFO - PID 3837 | |1;ext.html;735.6799792090441;751.0161688188471;757.5909009135067;757.7310054930499;760.186600337639;38422.231555368875;42146.36780448288;42264.94337641557;42343.153136937246;42376.36435453471;39169.69133395331;39424;39704.40443393344;39907.20185596286;40031.79984100076;7156.427485801137;7205.711771529159;7267.563946163221;7288.416926645856;7295.416366690679;7145.14258289006;7237.986681864543;7246.094238220223;7251.891221631653;7252.0572325597595;7215.6752946117285;7241.203467618558;7248.782536523912;7916.960415197916;8139.7558073257605;8026.237507436784;8094.231048050426;8107.837843243161;8113.7565873023905;8119.472234304811;7952.363810895173;7980.401469889782;7983.2415920487465;8073.233042860918;8074.788781682794;37874.62125378766;37921;37921.81039094814;38090.42864357037;38157.42763858545;3556.466530020492;3596.1369271374942;3609.7112231021456;3611.277744451094;3615.204654975901;31626;31695.84152079248;31701.365972680647;31845.681543184503;31877.84061079703;5020.949790502084;5059.595232381437;5133.12736834739;5223;5223.399309079467;188568;188964;190625;191569;192451;42870.35694464586;43215;43493;49225.753871230416;49911;52128.73935630298;53005.46994530082;53419.73290133524;53440;53505.464945350046;16568.585785355463;16604.169791510376;16608.91695541539;16714.080725560212;16761.83238167627;13499.392527336293;13512.12171208888;13537.864621353858;13629.318534073454;13636.65908352299;14490.85509144895;14578.927105364617;14603.707925841423;14681.462557879584;14773.63065923339;5820.534357251409;5850.912236316459;5864.70676466175;5905.940940590539;6030.6080104793045;987.6148302162162;991.4646091110719;993.5325713260668;999.6301368493704;1033.7415646088477;22774.316770496913;22790.088396463954;23025;23049.308520744406;23217.53564928692;1101.64196636092;1111.1999360460457;1122.6688127002553;1123.1632433836844;1134.4157758754247;12049.457774400173;12114.394280285951;12165.756684866254;12223.449944752507;12243.469566304211;224163;225330;225609;225851;226408;52421.47578524242;52711.472885270654;52776.736116319174;52799.73600131975;52851.47148528542;1433.2403825972042;1470.8527348668056;1473.7420951333474;1489.1214183631494;1490.1655073159066;22259.666105008113;22326.77673223247;22633.8868305664;22771.203007894645;22827.31518054461;36255.093622659646;36347.09132271714;36599.26801463903;36649.267014659024;36695.26609467849;188906;189458;189948.0502597478;190174;191592;31180.22049448691;32063.839680801448;33570.832145839115;34898;35335.64664353323;43972.34041489444;44112.33831492466;44178;44577.55422445734;44663;32126.678733212368;32265.193370165933;32284.192895176868;32408;32416.675833241366;31043.84478077595;31316.217094571908;31341.33598644141;31377.215569610944;31460.2134946619;36179.81910090433;36408.45387319139;36455.817720911225;36467.27065458623;36637.81681091578;30973.69026309708;31207.375852483277;31320.68679313269;31385;32014.839925801152;23064.769352306263;23182.88408558014;23300.184493542645;23436.882815585814;24040.39899002539 04:01:59 INFO - PID 3837 | |2;jquery.html;565.6577770448878;583.7519054401878;590.9113632955059;600.3486217454063;603.0742809786976;22207.445478816488;22744.8862755686;22799.658005129935;23065.884670576666;23091.191808286712;23035.193768218116;24538;24660.013599456;24811.875940620317;24825.37936551587;6559.376859198369;6755.32446755323;6755.898661520081;6759.966200169017;6765.830854228634;6578.769743058994;6635.137432133816;6655;6655.035019922108;6659.267480577133;6222.315545290015;6442.516811239152;6468.838279043038;6473.061406096113;6475.805725828209;6379.5853269537565;6430.421262086435;6431.3247109053345;6435.420812126931;6499.837504062412;5793.7392817323325;5993.220881285449;6046.6069705469445;6056.757729690807;6067.544934129914;28216.294592635142;28679.71320286791;28683.13950581486;28840.42319153605;28929.276768080756;2066.5970135823522;2091.7071609974614;2094.8219401350752;2096.2139197800825;2096.423483542023;18506.44480665582;19028.5242868928;19054.714179287323;19174.520636984187;19356.322528711567;2380.726216485109;2422.7456117107804;2443.5235129149823;2450.8774561271866;2458.311672731638;119281;123751.3812430932;124492;136509;141643;14440.436761049381;14740.189289589176;14811.407543698348;14939.388339185578;15321.387144514094;23229.53540929172;23232.53534929292;23314.417139571648;23352.299431017098;23352.416189595395;9971.401715896924;10164.440955747357;10259.409791482332;10299.12457441111;10365;9409.858852117224;9453.52732363379;9473.66842160521;9512.904870951203;9625.470599116976;9035.186833185046;9037.373272810957;9074.954625226832;9114.134157255183;9329.30030247734;2731.4946734854116;2757.889684412641;2792.7765778737653;2804.733550312717;2869.497837878405;945.8108378324363;957.5786653872274;965.5317171171976;971.2278738402987;973.8733964584559;18715.81284187168;19057.714134287995;19224.134913928905;19490.902545487465;19608.117634706472;1012.2155329619603;1012.8581998520214;1018.7554986803262;1036.160709825044;1040.3445829127602;10196.949015254877;10538.947305263424;10720.035196832323;10731.624393146203;10830.18773591968;463438;474251;480813;483720;489957;109526.45236773766;111727.44136279267;113732.43133784443;114224.42887785508;114921.4253928725;1139.3847322445952;1162.2968104296947;1238.8451443569554;1243.763684899848;1253.7680529102145;19980.800191998474;20079;20293.898530507253;20504.589908201455;20600.896995515526;56707;58980.1152982697;59330;59888.40111598828;60227;73969;74767;75290.62354688192;76523.61738191273;76875;14445.277736113363;14622.488212912496;14723.852761472677;14748.483803066842;14771.704565908836;21800.34598962034;21849.344519664435;22005.33983980483;22102.77897221007;22130.22544211009;16637.833621663627;18041.639167216843;18246.908765456086;18271.543211419288;18321.908390457964;14412.567622971328;16027.439039634024;16349.591260218589;16429.67140657204;17079.231434585225;13472.259025753285;14361.784573231618;14478.782818257523;14589.124652520883;17761.200745966722;13814.93092534571;13991.930040349733;13995.650108747363;14012.509562165684;14016.088954217943;17420.651586967935;17421.912890435466;17487.300507979537;17769.911150444164;17862.732059019385 04:01:59 INFO - PID 3837 | |3;mootools.html;1316.5918565244772;1376.2843321472828;1410.8307003159623;1422.9359678814455;1435.354090659203;14879.404823807035;15522.767158492603;15600.063996160225;15617.609559761011;15627.687446251082;15374.154421506813;15457.613559661015;15499.380024798995;15519.612009699764;15522.223888805544;2687.516247075526;2724.9781332000452;2752.229375774776;2773.972260277402;2778.2915356584144;2646.192911162095;2762.2265765585666;2763.7098104699016;2766.0318888389106;2773.071021207898;2711.30861630284;2745.835249885013;2781.1378472673437;2793.455276221138;2796.958045629317;2803;2820.9844455995826;2823.0683874321426;2831.7876159288035;2832.518471859789;2691.1388355726176;2738.4659991301705;2743.1907587261608;2756.710545392745;2777.277907744001;15249.847501524953;15489.380424782996;15524.456644017406;15529.767053494206;15563.844361556352;7784.455088143832;8099.838003239961;8121.593920303962;8140.796480087986;8146.777983302492;5645.435456454322;5724.5992780505385;5746.13807928814;5876.55925805562;5913.970430147865;1912.7800302965197;1918.673825449677;1941.3787587971854;2004.6892731626476;2005.5487515309085;26492.86753566239;27109.457810843673;27468;27481.86259068712;27548;6757;7169.139703235541;7201.855962880713;7260.636968151572;7270.272972702794;18064.548386290448;18204.089795510437;18241.63516729658;18289.908550457163;18309.99295038759;7611.885821712679;7909;7930.484518506394;7932.08780990182;8107.513549187068;7611.695532178762;7726.150123486412;7739.535627862347;7746.845063098706;7781.572013539197;5309.123994540934;5442.863928401822;5538.363088244903;5547.639403438844;5558.055130627803;1566.6553358261165;1570.1991984088197;1580.7786909832632;1585.5265785374852;1585.8661057344054;895.4895709445684;926.2543652359781;931.0596297739197;940.1773448232797;941.802221533472;7641.541507509567;7652.885206721904;7681.5775132367135;7729.227077292226;7763.378929685611;726.8546290741767;729.8394353242278;740.8481261341412;748.3377211168155;748.6256871564218;4837.661363704507;5351.277577526984;5370.275012873212;5476.67139971603;5501.752421141058;21306.680399794015;21311.25410610621;21409.357719268446;21660.675089873665;22227.77772222257;21393.57212855734;21884.671729923746;21912.12351505922;22349.217777377715;22358.776412235995;11408.315501069963;11564.074874010228;11643.53425862956;11776.17566770335;11947.641570752892;8193.67225310981;8246.958765206136;8307.958460207661;8380.53907035119;8510.574471276535;18084.90957545204;18938.147783350058;18981.715274271173;19120.852748835114;19211.807881921002;19146.90426547914;19575.60848782988;19793.505162371057;19896.801031990075;20000;11207.60773372928;11390.316581005167;11511.366874821964;11521.596744113916;11530.135239857213;14046;14234.786478203043;14235.857641423867;14246.715065698836;14250.857491424953;10743.677689669323;11326.773464530828;11330.37682927447;11462.254953428;11604.245724027911;11318.434078296217;11413.771724565628;11564.595239166589;11610.071194304604;11651.47568359409;10221.540030698488;10443.164546836082;10474.004969527883;10529.78940421172;10561.89438105609;6954.130733658293;6971.6165610891885;6983.3714965653335;7012.614306213207;7058.647067646494;7048.577085374894;7140.500164988609;7237.674304656409;7294.270572942663;7299.343059124491 04:01:59 INFO - PID 3837 | |4;prototype.html;511.9820806271779;531.9945303376621;534.8287250920483;537.4303238567117;539.2854467830124;6228.6262824230525;6241.594296370733;6246.843828904274;6261.3738626137365;6287.591306565076;6031.758729650809;6092.299385570661;6137.785177518787;6167.198264225655;6176.104464852594;5035.647504674675;5137.768800403972;5154.304168937202;5173.637845350827;5201.24581935621;5168.379794424655;5169.638125331228;5173.818916337929;5187.5590574801;5207;4862.562369386755;5000.549950504454;5113.079645663797;5172.224166375055;5198.92201616976;4917.483664215241;4984.576311013569;5009.2486127080865;5015.172496538067;5032.547070763612;4446.244138496463;4489.685721999462;4505.977470112629;4524.61540769035;4530.365748795171;5875.970620146872;6000.549958753111;6003.459688628044;6016.398360163992;6020.64535479518;5583.469570390806;5609.4390560943575;5648.350439699446;5676.858078548028;5740.225069615591;6437.581557198814;6501.707423165922;6523.347665233486;6542.345765423467;6572.967135164294;4860.562549370538;4869.3931002769;4882.09681208974;4885;4908.5336892995465;6522.054302126166;6676.46588272937;6731.2932142125355;6817.420519255819;6834.350736680057;4974.507647705674;4988.850334489971;4990.72551009698;5011.574016208663;5028.7737051832755;5091.159958606862;5118.641695081308;5137.820176293886;5138.332016837862;5161.915997640537;5605.635633683879;5687.544996400278;5708.4862362387585;5709.200711900337;5759.452851979056;6485.4163125318;6602.6698665067515;6628.270890202074;6639.502037347218;6686.72049888072;1757.402483155733;1774.9290028398977;1779.813119622421;1786.8385549393;1789.9015554144387;904.5206040798388;1236;1245.6574442028514;1250.9624711258496;1265.329375431023;5588.776448942078;5599.496045355938;5615.831525054255;5615.943840561542;5655.3779084300695;6520.641364724891;6544.70548825304;6605.240397354366;6641.701123449359;6684.398404143651;5549.195366671891;5574.777008919597;5596.972015139898;5597.832065038056;5619.353774315924;3456.42968910127;3514.24443744591;3560.412531932254;3561.4123669594746;3565.6969157621893;6387.3073635486635;6398.784230996096;6451.838704032437;6460;6468.256150542654;6711.194656641137;6769.593824370553;6780.457563394916;6793.218779840382;6805;6360.363963603602;6378.2346118466085;6427.614343139333;6468.865274459417;6480.773172939019;6574.638394888327;6577.572457790228;6638.0417776755;6711.791877462104;6725.226598940989;5992.340842507408;6468.644224567505;6558.934410656023;6612.23959244693;6615.867682646416;6359.682015899279;6364.331745166876;6425.485961123006;6445.452136568444;6493.350664933469;5001.424836143745;5035.395752509722;5038.84883453497;5058.873528161678;5073.315102461268;6386.904196436964;6596.208454985433;6643.833904152241;6656.7670131545165;6691.866162676816;6265.530085243534;6367.028104225866;6372.267189273293;6525.934740652533;6548.377904099103;6303.180586523723;6332.715027823667;6403.679816009274;6427.775027874002;6461.741530338733;6053.303870055;6189.938100618936;6302.1492098566105;6327.525435592441;6342.682865856596;6395.505752756521;6492.64290464029;6518;6538.83652908662;6559;6285.465735412541;6285.874282514415;6326.715297811702;6345.333739957238;6389.456896163878 04:01:59 INFO - PID 3837 | |5;yui.html;896.5024411451644;909.9636014559418;922.4050487435604;931.2224292715587;933.5472295936472;20202.39392818216;20489.692654610157;20960.16159353626;21029.579408411842;21052.684209736864;19304.80695193051;19762.80237197631;19893.104810283538;19905.104270307835;19925.900370498126;959.8896126945403;969.6170012844922;971.5433746139303;976.8046390721848;982.1946004276496;960.7309953213112;991.7570195302161;995.6764051683195;997.281956990969;1000.5997600959602;1066.3814987307383;1072.5066469424075;1072.785442911421;1072.8873468285835;1074.1782536359692;1048.9895101049005;1050.4275170032352;1057.7778666480049;1058.2433560004595;1058.8888166742536;717.6232477949067;743.1305372713938;752.7290175536803;753.2730914667318;753.6721526136148;20648.793512064836;20712;20805.895970520203;20820.37538873836;20850.895745521328;22066.66899996501;22105.226317078985;22683.659745103836;22791;22923.31230063101;16834.663306733797;17052.317907283817;17244.827551724447;17404.56488587783;17590;3782.489363935861;3786.223824116077;3793.412021136701;3796.52543432071;3812.1994381179984;142292;142587;144882.27558862243;146228;146317.99999999892;16750.664986700198;17054;17134.057626830643;17138.571535711457;17161.31354745796;31470.21324466861;31798.523022154684;32294.35411291808;32496.512552311735;32673.673263267538;8573.056963733985;8650.826983460296;8665.43674661145;8693.304535637133;8694.913050869536;4047.6357127858632;4148.191102734938;4204.07510347723;4226.344916537942;4252.064545799919;5520.558355331564;5636.126400407943;5639.943600564024;5665.915011274834;5671.971640141773;974.181687382602;986.921046316293;995.0894931138073;995.3977843404635;1007.2294694558668;659.864727730814;680.9391783931261;692.5913710910486;697.8394969157122;700.6321681117353;10913.781724365468;10946.288491248044;11727.589534366427;12327.630171094881;12797.232166070065;676.1885737115383;685.4653370371118;697.5988806436319;700.3836623771049;700.4011570107587;5686.5735069869925;5732;5774.48029677331;5795.739191736382;5795.768169273266;110968;112344;112938;113411.43294283476;114813;97402;99152;100379;102128;104191.4790426043;87192.56403717941;88173.5591322052;88974;89682.55158724164;92487.53756231176;10682.679519614425;10710.518026688662;10809.729756756144;10894.346339219355;10997.670069897917;43702.78148609237;44045.77977110222;44138.55861441344;44646.9999999987;44684.55315446934;55208;55952.720236398556;56789.71605141948;56988.43011569997;57579.1363129545;14579.708405832036;14807.777883331542;15269.465568705042;15294.847051529343;15449.613759656098;17664.381746638806;17906.462806115836;17998;18096.72854907151;18167.091645417942;15488;15519.689606207587;15620.531384058497;15764.76352854731;15802.209889505708;15902.60243493922;16029.759553606938;16188;16227.432039878548;16397;15756.527304180892;15770.605734856721;15823;15901.840981590036;16127.75808362852;11639.709007274885;11655.76688466243;11701.356425396685;12118.212316199419;12186.695332616755;11209.887901120885;11423.143264255048;11444.141689373497;11495.827562586735;11500.884991149982 04:01:59 INFO - PID 3837 | __end_tp_report 04:01:59 INFO - PID 3837 | __start_cc_report 04:01:59 INFO - PID 3837 | _x_x_mozilla_cycle_collect,288 04:01:59 INFO - PID 3837 | __end_cc_report 04:01:59 INFO - PID 3837 | __startTimestamp1506164519471__endTimestamp 04:01:59 INFO - PID 3837 | 04:01:59 INFO - PID 3837 | ------- Summary: start ------- 04:01:59 INFO - PID 3837 | Number of tests: 6 04:01:59 INFO - PID 3837 | 04:01:59 INFO - PID 3837 | [#0] dojo.html Cycles:165 Average:6183.77 Median:6475.42 stddev:755.62 (11.7%) stddev-sans-first:717.63 04:01:59 INFO - PID 3837 | Values: 3079.7 3108.4 3113.8 3116.3 3121.2 6167.8 6193.8 6251.1 6282.1 6346.9 6154.8 6159.5 6377.9 6396.4 6409.6 5625.9 5726.5 5763.2 5825.7 5858.9 5746.4 5753.8 5848.4 5850.8 5864.9 5653.3 5670.5 5721.7 5796.2 5801.2 5679.8 5686.1 5707.0 5710.6 5715.7 5605.7 5609.1 5696.7 5729.7 5736.2 6160.8 6165.8 6216.2 6297.1 6305.6 6580.3 6583.6 6625.6 6666.1 6773.7 6684.2 6707.5 6708.7 6747.0 6752.1 6101.7 6203.6 6205.6 6215.1 6249.2 6861.7 6866.3 7047.9 7051.8 7074.6 6575.9 6577.7 6640.4 6661.1 6713.8 6627.5 6733.4 6769.9 6859.4 6899.0 6650.1 6685.0 6752.3 6754.6 6776.7 6800.3 6802.2 6808.6 6815.0 6819.1 5297.8 5351.4 5376.9 5383.9 5388.4 4589.5 4623.7 4628.4 4634.8 4646.5 5603.4 5727.7 5740.3 5841.7 5857.2 6775.6 6811.0 6815.0 6847.0 6849.7 5760.9 5772.5 5823.9 5862.4 5867.9 5767.4 5768.5 5830.7 5831.9 5836.3 6305.8 6475.4 6507.5 6507.9 6550.1 6752.9 6779.8 6875.3 6882.1 6902.8 6499.8 6500.9 6517.5 6532.6 6593.9 6599.0 6650.8 6690.3 6722.1 6727.2 6604.3 6644.9 6723.9 6732.1 6736.6 6474.5 6512.6 6522.5 6524.4 6527.9 6371.7 6517.9 6557.2 6588.8 6590.8 6496.2 6544.2 6562.0 6613.9 6622.2 6545.0 6622.7 6635.2 6724.3 6747.3 6243.9 6296.8 6375.6 6454.0 6486.1 04:01:59 INFO - PID 3837 | 04:01:59 INFO - PID 3837 | [#1] ext.html Cycles:180 Average:37140.30 Median:19897.51 stddev:52462.39 (263.7%) stddev-sans-first:52538.34 04:01:59 INFO - PID 3837 | Values: 735.7 751.0 757.6 757.7 760.2 38422.2 42146.4 42264.9 42343.2 42376.4 39169.7 39424.0 39704.4 39907.2 40031.8 7156.4 7205.7 7267.6 7288.4 7295.4 7145.1 7238.0 7246.1 7251.9 7252.1 7215.7 7241.2 7248.8 7917.0 8139.8 8026.2 8094.2 8107.8 8113.8 8119.5 7952.4 7980.4 7983.2 8073.2 8074.8 37874.6 37921.0 37921.8 38090.4 38157.4 3556.5 3596.1 3609.7 3611.3 3615.2 31626.0 31695.8 31701.4 31845.7 31877.8 5020.9 5059.6 5133.1 5223.0 5223.4 188568.0 188964.0 190625.0 191569.0 192451.0 42870.4 43215.0 43493.0 49225.8 49911.0 52128.7 53005.5 53419.7 53440.0 53505.5 16568.6 16604.2 16608.9 16714.1 16761.8 13499.4 13512.1 13537.9 13629.3 13636.7 14490.9 14578.9 14603.7 14681.5 14773.6 5820.5 5850.9 5864.7 5905.9 6030.6 987.6 991.5 993.5 999.6 1033.7 22774.3 22790.1 23025.0 23049.3 23217.5 1101.6 1111.2 1122.7 1123.2 1134.4 12049.5 12114.4 12165.8 12223.4 12243.5 224163.0 225330.0 225609.0 225851.0 226408.0 52421.5 52711.5 52776.7 52799.7 52851.5 1433.2 1470.9 1473.7 1489.1 1490.2 22259.7 22326.8 22633.9 22771.2 22827.3 36255.1 36347.1 36599.3 36649.3 36695.3 188906.0 189458.0 189948.1 190174.0 191592.0 31180.2 32063.8 33570.8 34898.0 35335.6 43972.3 44112.3 44178.0 44577.6 44663.0 32126.7 32265.2 32284.2 32408.0 32416.7 31043.8 31316.2 31341.3 31377.2 31460.2 36179.8 36408.5 36455.8 36467.3 36637.8 30973.7 31207.4 31320.7 31385.0 32014.8 23064.8 23182.9 23300.2 23436.9 24040.4 04:01:59 INFO - PID 3837 | 04:01:59 INFO - PID 3837 | [#2] jquery.html Cycles:180 Average:34089.85 Median:22772.27 stddev:80550.10 (353.7%) stddev-sans-first:80736.74 04:01:59 INFO - PID 3837 | Values: 565.7 583.8 590.9 600.3 603.1 22207.4 22744.9 22799.7 23065.9 23091.2 23035.2 24538.0 24660.0 24811.9 24825.4 6559.4 6755.3 6755.9 6760.0 6765.8 6578.8 6635.1 6655.0 6655.0 6659.3 6222.3 6442.5 6468.8 6473.1 6475.8 6379.6 6430.4 6431.3 6435.4 6499.8 5793.7 5993.2 6046.6 6056.8 6067.5 28216.3 28679.7 28683.1 28840.4 28929.3 2066.6 2091.7 2094.8 2096.2 2096.4 18506.4 19028.5 19054.7 19174.5 19356.3 2380.7 2422.7 2443.5 2450.9 2458.3 119281.0 123751.4 124492.0 136509.0 141643.0 14440.4 14740.2 14811.4 14939.4 15321.4 23229.5 23232.5 23314.4 23352.3 23352.4 9971.4 10164.4 10259.4 10299.1 10365.0 9409.9 9453.5 9473.7 9512.9 9625.5 9035.2 9037.4 9075.0 9114.1 9329.3 2731.5 2757.9 2792.8 2804.7 2869.5 945.8 957.6 965.5 971.2 973.9 18715.8 19057.7 19224.1 19490.9 19608.1 1012.2 1012.9 1018.8 1036.2 1040.3 10196.9 10538.9 10720.0 10731.6 10830.2 463438.0 474251.0 480813.0 483720.0 489957.0 109526.5 111727.4 113732.4 114224.4 114921.4 1139.4 1162.3 1238.8 1243.8 1253.8 19980.8 20079.0 20293.9 20504.6 20600.9 56707.0 58980.1 59330.0 59888.4 60227.0 73969.0 74767.0 75290.6 76523.6 76875.0 14445.3 14622.5 14723.9 14748.5 14771.7 21800.3 21849.3 22005.3 22102.8 22130.2 16637.8 18041.6 18246.9 18271.5 18321.9 14412.6 16027.4 16349.6 16429.7 17079.2 13472.3 14361.8 14478.8 14589.1 17761.2 13814.9 13991.9 13995.7 14012.5 14016.1 17420.7 17421.9 17487.3 17769.9 17862.7 04:01:59 INFO - PID 3837 | 04:01:59 INFO - PID 3837 | [#3] mootools.html Cycles:180 Average:9514.23 Median:2718.14 stddev:6829.10 (251.2%) stddev-sans-first:6820.49 04:01:59 INFO - PID 3837 | Values: 1316.6 1376.3 1410.8 1422.9 1435.4 14879.4 15522.8 15600.1 15617.6 15627.7 15374.2 15457.6 15499.4 15519.6 15522.2 2687.5 2725.0 2752.2 2774.0 2778.3 2646.2 2762.2 2763.7 2766.0 2773.1 2711.3 2745.8 2781.1 2793.5 2797.0 2803.0 2821.0 2823.1 2831.8 2832.5 2691.1 2738.5 2743.2 2756.7 2777.3 15249.8 15489.4 15524.5 15529.8 15563.8 7784.5 8099.8 8121.6 8140.8 8146.8 5645.4 5724.6 5746.1 5876.6 5914.0 1912.8 1918.7 1941.4 2004.7 2005.5 26492.9 27109.5 27468.0 27481.9 27548.0 6757.0 7169.1 7201.9 7260.6 7270.3 18064.5 18204.1 18241.6 18289.9 18310.0 7611.9 7909.0 7930.5 7932.1 8107.5 7611.7 7726.2 7739.5 7746.8 7781.6 5309.1 5442.9 5538.4 5547.6 5558.1 1566.7 1570.2 1580.8 1585.5 1585.9 895.5 926.3 931.1 940.2 941.8 7641.5 7652.9 7681.6 7729.2 7763.4 726.9 729.8 740.8 748.3 748.6 4837.7 5351.3 5370.3 5476.7 5501.8 21306.7 21311.3 21409.4 21660.7 22227.8 21393.6 21884.7 21912.1 22349.2 22358.8 11408.3 11564.1 11643.5 11776.2 11947.6 8193.7 8247.0 8308.0 8380.5 8510.6 18084.9 18938.1 18981.7 19120.9 19211.8 19146.9 19575.6 19793.5 19896.8 20000.0 11207.6 11390.3 11511.4 11521.6 11530.1 14046.0 14234.8 14235.9 14246.7 14250.9 10743.7 11326.8 11330.4 11462.3 11604.2 11318.4 11413.8 11564.6 11610.1 11651.5 10221.5 10443.2 10474.0 10529.8 10561.9 6954.1 6971.6 6983.4 7012.6 7058.6 7048.6 7140.5 7237.7 7294.3 7299.3 04:01:59 INFO - PID 3837 | 04:01:59 INFO - PID 3837 | [#4] prototype.html Cycles:180 Average:5469.69 Median:6042.53 stddev:1509.41 (25.0%) stddev-sans-first:1467.06 04:01:59 INFO - PID 3837 | Values: 512.0 532.0 534.8 537.4 539.3 6228.6 6241.6 6246.8 6261.4 6287.6 6031.8 6092.3 6137.8 6167.2 6176.1 5035.6 5137.8 5154.3 5173.6 5201.2 5168.4 5169.6 5173.8 5187.6 5207.0 4862.6 5000.5 5113.1 5172.2 5198.9 4917.5 4984.6 5009.2 5015.2 5032.5 4446.2 4489.7 4506.0 4524.6 4530.4 5876.0 6000.5 6003.5 6016.4 6020.6 5583.5 5609.4 5648.4 5676.9 5740.2 6437.6 6501.7 6523.3 6542.3 6573.0 4860.6 4869.4 4882.1 4885.0 4908.5 6522.1 6676.5 6731.3 6817.4 6834.4 4974.5 4988.9 4990.7 5011.6 5028.8 5091.2 5118.6 5137.8 5138.3 5161.9 5605.6 5687.5 5708.5 5709.2 5759.5 6485.4 6602.7 6628.3 6639.5 6686.7 1757.4 1774.9 1779.8 1786.8 1789.9 904.5 1236.0 1245.7 1251.0 1265.3 5588.8 5599.5 5615.8 5615.9 5655.4 6520.6 6544.7 6605.2 6641.7 6684.4 5549.2 5574.8 5597.0 5597.8 5619.4 3456.4 3514.2 3560.4 3561.4 3565.7 6387.3 6398.8 6451.8 6460.0 6468.3 6711.2 6769.6 6780.5 6793.2 6805.0 6360.4 6378.2 6427.6 6468.9 6480.8 6574.6 6577.6 6638.0 6711.8 6725.2 5992.3 6468.6 6558.9 6612.2 6615.9 6359.7 6364.3 6425.5 6445.5 6493.4 5001.4 5035.4 5038.8 5058.9 5073.3 6386.9 6596.2 6643.8 6656.8 6691.9 6265.5 6367.0 6372.3 6525.9 6548.4 6303.2 6332.7 6403.7 6427.8 6461.7 6053.3 6189.9 6302.1 6327.5 6342.7 6395.5 6492.6 6518.0 6538.8 6559.0 6285.5 6285.9 6326.7 6345.3 6389.5 04:01:59 INFO - PID 3837 | 04:01:59 INFO - PID 3837 | [#5] yui.html Cycles:180 Average:23915.00 Median:20835.64 stddev:34124.52 (163.8%) stddev-sans-first:34176.47 04:01:59 INFO - PID 3837 | Values: 896.5 910.0 922.4 931.2 933.5 20202.4 20489.7 20960.2 21029.6 21052.7 19304.8 19762.8 19893.1 19905.1 19925.9 959.9 969.6 971.5 976.8 982.2 960.7 991.8 995.7 997.3 1000.6 1066.4 1072.5 1072.8 1072.9 1074.2 1049.0 1050.4 1057.8 1058.2 1058.9 717.6 743.1 752.7 753.3 753.7 20648.8 20712.0 20805.9 20820.4 20850.9 22066.7 22105.2 22683.7 22791.0 22923.3 16834.7 17052.3 17244.8 17404.6 17590.0 3782.5 3786.2 3793.4 3796.5 3812.2 142292.0 142587.0 144882.3 146228.0 146318.0 16750.7 17054.0 17134.1 17138.6 17161.3 31470.2 31798.5 32294.4 32496.5 32673.7 8573.1 8650.8 8665.4 8693.3 8694.9 4047.6 4148.2 4204.1 4226.3 4252.1 5520.6 5636.1 5639.9 5665.9 5672.0 974.2 986.9 995.1 995.4 1007.2 659.9 680.9 692.6 697.8 700.6 10913.8 10946.3 11727.6 12327.6 12797.2 676.2 685.5 697.6 700.4 700.4 5686.6 5732.0 5774.5 5795.7 5795.8 110968.0 112344.0 112938.0 113411.4 114813.0 97402.0 99152.0 100379.0 102128.0 104191.5 87192.6 88173.6 88974.0 89682.6 92487.5 10682.7 10710.5 10809.7 10894.3 10997.7 43702.8 44045.8 44138.6 44647.0 44684.6 55208.0 55952.7 56789.7 56988.4 57579.1 14579.7 14807.8 15269.5 15294.8 15449.6 17664.4 17906.5 17998.0 18096.7 18167.1 15488.0 15519.7 15620.5 15764.8 15802.2 15902.6 16029.8 16188.0 16227.4 16397.0 15756.5 15770.6 15823.0 15901.8 16127.8 11639.7 11655.8 11701.4 12118.2 12186.7 11209.9 11423.1 11444.1 11495.8 11500.9 04:01:59 INFO - PID 3837 | -------- Summary: end -------- 04:01:59 INFO - PID 3837 | 04:02:00 INFO - TEST-INFO | 3837: exit 0 04:02:00 INFO - TEST-OK | dromaeo_css | took 1115854ms 04:02:00 INFO - TEST-START | kraken 04:02:00 INFO - Initialising browser for kraken test... 04:02:00 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52166/getInfo.html -profile /tmp/tmpuw8PHx/profile 04:02:00 INFO - TEST-INFO | started process 4220 (/builds/slave/test/build/application/firefox/firefox http://localhost:52166/getInfo.html) 04:02:05 INFO - TEST-INFO | 4220: exit 0 04:02:06 INFO - Browser initialized. 04:02:06 INFO - Running cycle 1/1 for kraken test... 04:02:06 INFO - Using env: {'DISPLAY': ':0', 04:02:06 INFO - 'HOME': '/home/cltbld', 04:02:06 INFO - 'JSGC_DISABLE_POISONING': '1', 04:02:06 INFO - 'LANG': 'en_US.UTF-8', 04:02:06 INFO - 'LANGUAGE': 'en_US:en', 04:02:06 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:02:06 INFO - 'LOGNAME': 'cltbld', 04:02:06 INFO - 'MAIL': '/var/mail/cltbld', 04:02:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:02:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:02:06 INFO - 'MOZ_ACCELERATED': '1', 04:02:06 INFO - 'MOZ_CRASHREPORTER': '1', 04:02:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:06 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:02:06 INFO - 'MOZ_NO_REMOTE': '1', 04:02:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:02:06 INFO - 'MOZ_WEBRENDER': '1', 04:02:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:06 INFO - 'NO_EM_RESTART': '1', 04:02:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:06 INFO - 'PWD': '/builds/slave/test', 04:02:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:02:06 INFO - 'RUST_BACKTRACE': 'full', 04:02:06 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:02:06 INFO - 'SHELL': '/bin/bash', 04:02:06 INFO - 'SHLVL': '1', 04:02:06 INFO - 'TERM': 'linux', 04:02:06 INFO - 'TMOUT': '86400', 04:02:06 INFO - 'USER': 'cltbld', 04:02:06 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1506163343.180261-953808805', 04:02:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:06 INFO - '_': '/tools/buildbot/bin/python'} 04:02:06 INFO - TEST-INFO | started process 4466 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuw8PHx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:02:06 INFO - PID 4466 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 04:02:07 INFO - PID 4466 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 04:02:07 INFO - PID 4466 | 04:02:07 INFO - PID 4466 | (/builds/slave/test/build/application/firefox/firefox:4526): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:02:07 INFO - PID 4466 | 04:02:17 INFO - PID 4466 | RSS: Main: 211353600 04:02:17 INFO - PID 4466 | 04:02:20 INFO - PID 4466 | Cycle 1(1): loaded http://localhost:52166/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52166/tests/kraken/driver.html?testName=audio-beat-detection) 04:02:21 INFO - PID 4466 | RSS: Main: 209641472 04:02:21 INFO - PID 4466 | 04:02:24 INFO - PID 4466 | Cycle 1(1): loaded http://localhost:52166/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52166/tests/kraken/driver.html?testName=audio-dft) 04:02:24 INFO - PID 4466 | RSS: Main: 209870848 04:02:24 INFO - PID 4466 | 04:02:27 INFO - PID 4466 | Cycle 1(1): loaded http://localhost:52166/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52166/tests/kraken/driver.html?testName=audio-fft) 04:02:28 INFO - PID 4466 | RSS: Main: 206082048 04:02:28 INFO - PID 4466 | 04:02:30 INFO - PID 4466 | Cycle 1(1): loaded http://localhost:52166/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52166/tests/kraken/driver.html?testName=audio-oscillator) 04:02:31 INFO - PID 4466 | RSS: Main: 207929344 04:02:31 INFO - PID 4466 | 04:02:33 INFO - PID 4466 | Cycle 1(1): loaded http://localhost:52166/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52166/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:02:33 INFO - PID 4466 | RSS: Main: 207618048 04:02:33 INFO - PID 4466 | 04:02:37 INFO - PID 4466 | Cycle 1(1): loaded http://localhost:52166/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52166/tests/kraken/driver.html?testName=imaging-darkroom) 04:02:37 INFO - PID 4466 | RSS: Main: 210354176 04:02:37 INFO - PID 4466 | 04:02:41 INFO - PID 4466 | Cycle 1(1): loaded http://localhost:52166/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52166/tests/kraken/driver.html?testName=imaging-desaturate) 04:02:42 INFO - PID 4466 | RSS: Main: 210108416 04:02:42 INFO - PID 4466 | 04:02:45 INFO - PID 4466 | Cycle 1(1): loaded http://localhost:52166/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52166/tests/kraken/driver.html?testName=json-parse-financial) 04:02:45 INFO - PID 4466 | RSS: Main: 209879040 04:02:45 INFO - PID 4466 | 04:02:47 INFO - PID 4466 | Cycle 1(1): loaded http://localhost:52166/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52166/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:02:48 INFO - PID 4466 | RSS: Main: 210739200 04:02:48 INFO - PID 4466 | 04:02:49 INFO - PID 4466 | Cycle 1(1): loaded http://localhost:52166/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52166/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:02:50 INFO - PID 4466 | RSS: Main: 206917632 04:02:50 INFO - PID 4466 | 04:02:52 INFO - PID 4466 | Cycle 1(1): loaded http://localhost:52166/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52166/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:02:53 INFO - PID 4466 | RSS: Main: 207904768 04:02:53 INFO - PID 4466 | 04:02:55 INFO - PID 4466 | Cycle 1(1): loaded http://localhost:52166/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52166/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:02:56 INFO - PID 4466 | RSS: Main: 208244736 04:02:56 INFO - PID 4466 | 04:02:59 INFO - PID 4466 | Cycle 1(1): loaded http://localhost:52166/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52166/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:03:00 INFO - PID 4466 | RSS: Main: 208351232 04:03:00 INFO - PID 4466 | 04:03:01 INFO - PID 4466 | Cycle 1(1): loaded http://localhost:52166/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52166/tests/kraken/driver.html?testName=ai-astar) 04:03:02 INFO - PID 4466 | RSS: Main: 208068608 04:03:02 INFO - PID 4466 | 04:03:02 INFO - PID 4466 | __start_tp_report 04:03:02 INFO - PID 4466 | _x_x_mozilla_page_load 04:03:02 INFO - PID 4466 | _x_x_mozilla_page_load_details 04:03:02 INFO - PID 4466 | |i|pagename|runs| 04:03:02 INFO - PID 4466 | |0;ai-astar;112;110;110;112;123;114;114;110;109;107 04:03:02 INFO - PID 4466 | |1;audio-beat-detection;126;117;134;129;119;141;128;128;120;143 04:03:02 INFO - PID 4466 | |2;audio-dft;166;168;176;167;165;166;173;166;170;170 04:03:02 INFO - PID 4466 | |3;audio-fft;80;77;83;79;74;75;75;84;81;74 04:03:02 INFO - PID 4466 | |4;audio-oscillator;88;82;87;81;79;79;86;81;82;84 04:03:02 INFO - PID 4466 | |5;imaging-gaussian-blur;118;114;110;114;112;122;115;110;114;118 04:03:02 INFO - PID 4466 | |6;imaging-darkroom;153;148;149;156;155;155;151;152;152;152 04:03:02 INFO - PID 4466 | |7;imaging-desaturate;96;99;95;94;96;101;103;95;99;95 04:03:02 INFO - PID 4466 | |8;json-parse-financial;54;54;54;60;54;59;56;55;56;57 04:03:02 INFO - PID 4466 | |9;json-stringify-tinderbox;38;42;42;38;42;45;47;37;39;44 04:03:02 INFO - PID 4466 | |10;stanford-crypto-aes;85;77;82;77;72;76;85;75;86;82 04:03:02 INFO - PID 4466 | |11;stanford-crypto-ccm;126;116;115;116;114;121;113;111;124;116 04:03:02 INFO - PID 4466 | |12;stanford-crypto-pbkdf2;171;170;172;179;176;178;175;171;172;166 04:03:02 INFO - PID 4466 | |13;stanford-crypto-sha256-iterative;65;64;66;67;64;67;67;71;67;69 04:03:02 INFO - PID 4466 | __end_tp_report 04:03:02 INFO - PID 4466 | __start_cc_report 04:03:02 INFO - PID 4466 | _x_x_mozilla_cycle_collect,762 04:03:02 INFO - PID 4466 | __end_cc_report 04:03:02 INFO - PID 4466 | __startTimestamp1506164582139__endTimestamp 04:03:02 INFO - PID 4466 | 04:03:02 INFO - PID 4466 | ------- Summary: start ------- 04:03:02 INFO - PID 4466 | Number of tests: 14 04:03:02 INFO - PID 4466 | 04:03:02 INFO - PID 4466 | [#0] ai-astar Cycles:10 Average:112.10 Median:112.00 stddev:4.41 (3.9%) stddev-sans-first:4.68 04:03:02 INFO - PID 4466 | Values: 112.0 110.0 110.0 112.0 123.0 114.0 114.0 110.0 109.0 107.0 04:03:02 INFO - PID 4466 | 04:03:02 INFO - PID 4466 | [#1] audio-beat-detection Cycles:10 Average:128.50 Median:128.50 stddev:8.81 (6.9%) stddev-sans-first:9.30 04:03:02 INFO - PID 4466 | Values: 126.0 117.0 134.0 129.0 119.0 141.0 128.0 128.0 120.0 143.0 04:03:02 INFO - PID 4466 | 04:03:02 INFO - PID 4466 | [#2] audio-dft Cycles:10 Average:168.70 Median:169.00 stddev:3.56 (2.1%) stddev-sans-first:3.64 04:03:02 INFO - PID 4466 | Values: 166.0 168.0 176.0 167.0 165.0 166.0 173.0 166.0 170.0 170.0 04:03:02 INFO - PID 4466 | 04:03:02 INFO - PID 4466 | [#3] audio-fft Cycles:10 Average:78.20 Median:79.50 stddev:3.74 (4.7%) stddev-sans-first:3.91 04:03:02 INFO - PID 4466 | Values: 80.0 77.0 83.0 79.0 74.0 75.0 75.0 84.0 81.0 74.0 04:03:02 INFO - PID 4466 | 04:03:02 INFO - PID 4466 | [#4] audio-oscillator Cycles:10 Average:82.90 Median:83.00 stddev:3.21 (3.9%) stddev-sans-first:2.83 04:03:02 INFO - PID 4466 | Values: 88.0 82.0 87.0 81.0 79.0 79.0 86.0 81.0 82.0 84.0 04:03:02 INFO - PID 4466 | 04:03:02 INFO - PID 4466 | [#5] imaging-gaussian-blur Cycles:10 Average:114.70 Median:114.50 stddev:3.77 (3.3%) stddev-sans-first:3.81 04:03:02 INFO - PID 4466 | Values: 118.0 114.0 110.0 114.0 112.0 122.0 115.0 110.0 114.0 118.0 04:03:02 INFO - PID 4466 | 04:03:02 INFO - PID 4466 | [#6] imaging-darkroom Cycles:10 Average:152.30 Median:152.50 stddev:2.58 (1.7%) stddev-sans-first:2.73 04:03:02 INFO - PID 4466 | Values: 153.0 148.0 149.0 156.0 155.0 155.0 151.0 152.0 152.0 152.0 04:03:02 INFO - PID 4466 | 04:03:02 INFO - PID 4466 | [#7] imaging-desaturate Cycles:10 Average:97.30 Median:95.50 stddev:3.02 (3.2%) stddev-sans-first:3.17 04:03:02 INFO - PID 4466 | Values: 96.0 99.0 95.0 94.0 96.0 101.0 103.0 95.0 99.0 95.0 04:03:02 INFO - PID 4466 | 04:03:02 INFO - PID 4466 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:56.00 stddev:2.18 (3.9%) stddev-sans-first:2.20 04:03:02 INFO - PID 4466 | Values: 54.0 54.0 54.0 60.0 54.0 59.0 56.0 55.0 56.0 57.0 04:03:02 INFO - PID 4466 | 04:03:02 INFO - PID 4466 | [#9] json-stringify-tinderbox Cycles:10 Average:41.40 Median:42.00 stddev:3.34 (8.0%) stddev-sans-first:3.31 04:03:02 INFO - PID 4466 | Values: 38.0 42.0 42.0 38.0 42.0 45.0 47.0 37.0 39.0 44.0 04:03:02 INFO - PID 4466 | 04:03:02 INFO - PID 4466 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:82.00 stddev:4.90 (6.0%) stddev-sans-first:4.81 04:03:02 INFO - PID 4466 | Values: 85.0 77.0 82.0 77.0 72.0 76.0 85.0 75.0 86.0 82.0 04:03:02 INFO - PID 4466 | 04:03:02 INFO - PID 4466 | [#11] stanford-crypto-ccm Cycles:10 Average:117.20 Median:116.00 stddev:4.87 (4.2%) stddev-sans-first:3.99 04:03:02 INFO - PID 4466 | Values: 126.0 116.0 115.0 116.0 114.0 121.0 113.0 111.0 124.0 116.0 04:03:02 INFO - PID 4466 | 04:03:02 INFO - PID 4466 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.00 Median:173.50 stddev:3.97 (2.3%) stddev-sans-first:4.15 04:03:02 INFO - PID 4466 | Values: 171.0 170.0 172.0 179.0 176.0 178.0 175.0 171.0 172.0 166.0 04:03:02 INFO - PID 4466 | 04:03:02 INFO - PID 4466 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:2.16 (3.2%) stddev-sans-first:2.20 04:03:02 INFO - PID 4466 | Values: 65.0 64.0 66.0 67.0 64.0 67.0 67.0 71.0 67.0 69.0 04:03:02 INFO - PID 4466 | -------- Summary: end -------- 04:03:02 INFO - PID 4466 | 04:03:02 INFO - PID 4466 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:03:03 INFO - TEST-INFO | 4466: exit 0 04:03:03 INFO - TEST-OK | kraken | took 62733ms 04:03:03 INFO - SUITE-END | took 1178s 04:03:03 INFO - Completed test suite (00:19:38) 04:03:03 INFO - javascript benchmark 04:03:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8498.822153606554, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3079.6766339534347, 3108.440480713472, 3113.8131712097274, 3116.3144108296183, 3121.219695076231, 6167.845803854894, 6193.78321758738, 6251.09359142924, 6282.057691346295, 6346.936530634698, 6154.753809847601, 6159.476444502211, 6377.904331435032, 6396.360363963601, 6409.583377080498, 5625.943740562603, 5726.45598668128, 5763.193152958589, 5825.737841797109, 5858.88282234355, 5746.425357464241, 5753.827385178452, 5848.415158484138, 5850.795222167225, 5864.912026319587, 5653.321601407857, 5670.461306175906, 5721.6853073080965, 5796.217510636052, 5801.187833703285, 5679.829605111853, 5686.147077938301, 5707.0, 5710.571707121982, 5715.685637289947, 5605.691686957216, 5609.1305847593685, 5696.6866822324755, 5729.6562206267345, 5736.1682556029145, 6160.7535698572, 6165.815025549241, 6216.222972128484, 6297.118403423525, 6305.5901366411035, 6580.341965803429, 6583.604983700993, 6625.602463852184, 6666.100076489661, 6773.72905083796, 6684.16447944007, 6707.463402927803, 6708.698108585077, 6747.021681856152, 6752.1222241108835, 6101.694915254219, 6203.596766210182, 6205.627662340274, 6215.098810672427, 6249.218847644044, 6861.691223894937, 6866.279040700754, 7047.859042819115, 7051.753188638373, 7074.575525468488, 6575.901361479581, 6577.736890524421, 6640.402363787282, 6661.067450556926, 6713.765018224436, 6627.469802415795, 6733.393994540417, 6769.8646027079185, 6859.416949559343, 6898.965505172542, 6650.102236198148, 6685.0, 6752.257251702309, 6754.5609535380045, 6776.661166941633, 6800.251972283045, 6802.217744959294, 6808.6255255960405, 6814.965925170442, 6819.147606549182, 5297.788088476418, 5351.411344752074, 5376.924615077, 5383.892322153535, 5388.434214407509, 4589.518100599389, 4623.722576645412, 4628.421447319085, 4634.768261586907, 4646.535346465326, 5603.3836278009385, 5727.742251598688, 5740.253767010262, 5841.678707671034, 5857.20927674767, 6775.593464392152, 6810.965945170243, 6815.011823285695, 6847.041414202015, 6849.691763870638, 5760.855978600569, 5772.509336706343, 5823.854403639858, 5862.384449632812, 5867.882642347129, 5767.394423585547, 5768.480836724715, 5830.7084645767545, 5831.854203644943, 5836.270466191726, 6305.842353941096, 6475.417212450808, 6507.479401647857, 6507.934920650733, 6550.115734375799, 6752.864942701217, 6779.796606101726, 6875.312468753084, 6882.105326307548, 6902.827429314308, 6499.772507962388, 6500.869982600227, 6517.511186661114, 6532.640704761284, 6593.901091483535, 6599.043138744951, 6650.800475985729, 6690.330966903271, 6722.1261236039, 6727.2263689674355, 6604.273529911609, 6644.867102657823, 6723.865522689616, 6732.091167692299, 6736.562123461959, 6474.514411419068, 6512.6092434454085, 6522.510811689048, 6524.380183882524, 6527.902081468686, 6371.7132729028235, 6517.8696426072165, 6557.213134423709, 6588.8023359299295, 6590.80227593173, 6496.187976502937, 6544.214694236722, 6562.0, 6613.867722645617, 6622.205335359595, 6545.0, 6622.70197841108, 6635.170603674541, 6724.327567243432, 6747.291534388818, 6243.875122497616, 6296.811095667137, 6375.553711240169, 6453.999630057348, 6486.0919471275], "value": 6124.998339040101, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [735.6799792090441, 751.0161688188471, 757.5909009135067, 757.7310054930499, 760.186600337639, 38422.231555368875, 42146.36780448288, 42264.94337641557, 42343.153136937246, 42376.36435453471, 39169.69133395331, 39424.0, 39704.40443393344, 39907.20185596286, 40031.79984100076, 7156.427485801137, 7205.711771529159, 7267.563946163221, 7288.416926645856, 7295.416366690679, 7145.14258289006, 7237.986681864543, 7246.094238220223, 7251.891221631653, 7252.0572325597595, 7215.6752946117285, 7241.203467618558, 7248.782536523912, 7916.960415197916, 8139.7558073257605, 8026.237507436784, 8094.231048050426, 8107.837843243161, 8113.7565873023905, 8119.472234304811, 7952.363810895173, 7980.401469889782, 7983.2415920487465, 8073.233042860918, 8074.788781682794, 37874.62125378766, 37921.0, 37921.81039094814, 38090.42864357037, 38157.42763858545, 3556.466530020492, 3596.1369271374942, 3609.7112231021456, 3611.277744451094, 3615.204654975901, 31626.0, 31695.84152079248, 31701.365972680647, 31845.681543184503, 31877.84061079703, 5020.949790502084, 5059.595232381437, 5133.12736834739, 5223.0, 5223.399309079467, 188568.0, 188964.0, 190625.0, 191569.0, 192451.0, 42870.35694464586, 43215.0, 43493.0, 49225.753871230416, 49911.0, 52128.73935630298, 53005.46994530082, 53419.73290133524, 53440.0, 53505.464945350046, 16568.585785355463, 16604.169791510376, 16608.91695541539, 16714.080725560212, 16761.83238167627, 13499.392527336293, 13512.12171208888, 13537.864621353858, 13629.318534073454, 13636.65908352299, 14490.85509144895, 14578.927105364617, 14603.707925841423, 14681.462557879584, 14773.63065923339, 5820.534357251409, 5850.912236316459, 5864.70676466175, 5905.940940590539, 6030.6080104793045, 987.6148302162162, 991.4646091110719, 993.5325713260668, 999.6301368493704, 1033.7415646088477, 22774.316770496913, 22790.088396463954, 23025.0, 23049.308520744406, 23217.53564928692, 1101.64196636092, 1111.1999360460457, 1122.6688127002553, 1123.1632433836844, 1134.4157758754247, 12049.457774400173, 12114.394280285951, 12165.756684866254, 12223.449944752507, 12243.469566304211, 224163.0, 225330.0, 225609.0, 225851.0, 226408.0, 52421.47578524242, 52711.472885270654, 52776.736116319174, 52799.73600131975, 52851.47148528542, 1433.2403825972042, 1470.8527348668056, 1473.7420951333474, 1489.1214183631494, 1490.1655073159066, 22259.666105008113, 22326.77673223247, 22633.8868305664, 22771.203007894645, 22827.31518054461, 36255.093622659646, 36347.09132271714, 36599.26801463903, 36649.267014659024, 36695.26609467849, 188906.0, 189458.0, 189948.0502597478, 190174.0, 191592.0, 31180.22049448691, 32063.839680801448, 33570.832145839115, 34898.0, 35335.64664353323, 43972.34041489444, 44112.33831492466, 44178.0, 44577.55422445734, 44663.0, 32126.678733212368, 32265.193370165933, 32284.192895176868, 32408.0, 32416.675833241366, 31043.84478077595, 31316.217094571908, 31341.33598644141, 31377.215569610944, 31460.2134946619, 36179.81910090433, 36408.45387319139, 36455.817720911225, 36467.27065458623, 36637.81681091578, 30973.69026309708, 31207.375852483277, 31320.68679313269, 31385.0, 32014.839925801152, 23064.769352306263, 23182.88408558014, 23300.184493542645, 23436.882815585814, 24040.39899002539], "value": 17048.633121315856, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.6577770448878, 583.7519054401878, 590.9113632955059, 600.3486217454063, 603.0742809786976, 22207.445478816488, 22744.8862755686, 22799.658005129935, 23065.884670576666, 23091.191808286712, 23035.193768218116, 24538.0, 24660.013599456, 24811.875940620317, 24825.37936551587, 6559.376859198369, 6755.32446755323, 6755.898661520081, 6759.966200169017, 6765.830854228634, 6578.769743058994, 6635.137432133816, 6655.0, 6655.035019922108, 6659.267480577133, 6222.315545290015, 6442.516811239152, 6468.838279043038, 6473.061406096113, 6475.805725828209, 6379.5853269537565, 6430.421262086435, 6431.3247109053345, 6435.420812126931, 6499.837504062412, 5793.7392817323325, 5993.220881285449, 6046.6069705469445, 6056.757729690807, 6067.544934129914, 28216.294592635142, 28679.71320286791, 28683.13950581486, 28840.42319153605, 28929.276768080756, 2066.5970135823522, 2091.7071609974614, 2094.8219401350752, 2096.2139197800825, 2096.423483542023, 18506.44480665582, 19028.5242868928, 19054.714179287323, 19174.520636984187, 19356.322528711567, 2380.726216485109, 2422.7456117107804, 2443.5235129149823, 2450.8774561271866, 2458.311672731638, 119281.0, 123751.3812430932, 124492.0, 136509.0, 141643.0, 14440.436761049381, 14740.189289589176, 14811.407543698348, 14939.388339185578, 15321.387144514094, 23229.53540929172, 23232.53534929292, 23314.417139571648, 23352.299431017098, 23352.416189595395, 9971.401715896924, 10164.440955747357, 10259.409791482332, 10299.12457441111, 10365.0, 9409.858852117224, 9453.52732363379, 9473.66842160521, 9512.904870951203, 9625.470599116976, 9035.186833185046, 9037.373272810957, 9074.954625226832, 9114.134157255183, 9329.30030247734, 2731.4946734854116, 2757.889684412641, 2792.7765778737653, 2804.733550312717, 2869.497837878405, 945.8108378324363, 957.5786653872274, 965.5317171171976, 971.2278738402987, 973.8733964584559, 18715.81284187168, 19057.714134287995, 19224.134913928905, 19490.902545487465, 19608.117634706472, 1012.2155329619603, 1012.8581998520214, 1018.7554986803262, 1036.160709825044, 1040.3445829127602, 10196.949015254877, 10538.947305263424, 10720.035196832323, 10731.624393146203, 10830.18773591968, 463438.0, 474251.0, 480813.0, 483720.0, 489957.0, 109526.45236773766, 111727.44136279267, 113732.43133784443, 114224.42887785508, 114921.4253928725, 1139.3847322445952, 1162.2968104296947, 1238.8451443569554, 1243.763684899848, 1253.7680529102145, 19980.800191998474, 20079.0, 20293.898530507253, 20504.589908201455, 20600.896995515526, 56707.0, 58980.1152982697, 59330.0, 59888.40111598828, 60227.0, 73969.0, 74767.0, 75290.62354688192, 76523.61738191273, 76875.0, 14445.277736113363, 14622.488212912496, 14723.852761472677, 14748.483803066842, 14771.704565908836, 21800.34598962034, 21849.344519664435, 22005.33983980483, 22102.77897221007, 22130.22544211009, 16637.833621663627, 18041.639167216843, 18246.908765456086, 18271.543211419288, 18321.908390457964, 14412.567622971328, 16027.439039634024, 16349.591260218589, 16429.67140657204, 17079.231434585225, 13472.259025753285, 14361.784573231618, 14478.782818257523, 14589.124652520883, 17761.200745966722, 13814.93092534571, 13991.930040349733, 13995.650108747363, 14012.509562165684, 14016.088954217943, 17420.651586967935, 17421.912890435466, 17487.300507979537, 17769.911150444164, 17862.732059019385], "value": 11846.305879478135, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1316.5918565244772, 1376.2843321472828, 1410.8307003159623, 1422.9359678814455, 1435.354090659203, 14879.404823807035, 15522.767158492603, 15600.063996160225, 15617.609559761011, 15627.687446251082, 15374.154421506813, 15457.613559661015, 15499.380024798995, 15519.612009699764, 15522.223888805544, 2687.516247075526, 2724.9781332000452, 2752.229375774776, 2773.972260277402, 2778.2915356584144, 2646.192911162095, 2762.2265765585666, 2763.7098104699016, 2766.0318888389106, 2773.071021207898, 2711.30861630284, 2745.835249885013, 2781.1378472673437, 2793.455276221138, 2796.958045629317, 2803.0, 2820.9844455995826, 2823.0683874321426, 2831.7876159288035, 2832.518471859789, 2691.1388355726176, 2738.4659991301705, 2743.1907587261608, 2756.710545392745, 2777.277907744001, 15249.847501524953, 15489.380424782996, 15524.456644017406, 15529.767053494206, 15563.844361556352, 7784.455088143832, 8099.838003239961, 8121.593920303962, 8140.796480087986, 8146.777983302492, 5645.435456454322, 5724.5992780505385, 5746.13807928814, 5876.55925805562, 5913.970430147865, 1912.7800302965197, 1918.673825449677, 1941.3787587971854, 2004.6892731626476, 2005.5487515309085, 26492.86753566239, 27109.457810843673, 27468.0, 27481.86259068712, 27548.0, 6757.0, 7169.139703235541, 7201.855962880713, 7260.636968151572, 7270.272972702794, 18064.548386290448, 18204.089795510437, 18241.63516729658, 18289.908550457163, 18309.99295038759, 7611.885821712679, 7909.0, 7930.484518506394, 7932.08780990182, 8107.513549187068, 7611.695532178762, 7726.150123486412, 7739.535627862347, 7746.845063098706, 7781.572013539197, 5309.123994540934, 5442.863928401822, 5538.363088244903, 5547.639403438844, 5558.055130627803, 1566.6553358261165, 1570.1991984088197, 1580.7786909832632, 1585.5265785374852, 1585.8661057344054, 895.4895709445684, 926.2543652359781, 931.0596297739197, 940.1773448232797, 941.802221533472, 7641.541507509567, 7652.885206721904, 7681.5775132367135, 7729.227077292226, 7763.378929685611, 726.8546290741767, 729.8394353242278, 740.8481261341412, 748.3377211168155, 748.6256871564218, 4837.661363704507, 5351.277577526984, 5370.275012873212, 5476.67139971603, 5501.752421141058, 21306.680399794015, 21311.25410610621, 21409.357719268446, 21660.675089873665, 22227.77772222257, 21393.57212855734, 21884.671729923746, 21912.12351505922, 22349.217777377715, 22358.776412235995, 11408.315501069963, 11564.074874010228, 11643.53425862956, 11776.17566770335, 11947.641570752892, 8193.67225310981, 8246.958765206136, 8307.958460207661, 8380.53907035119, 8510.574471276535, 18084.90957545204, 18938.147783350058, 18981.715274271173, 19120.852748835114, 19211.807881921002, 19146.90426547914, 19575.60848782988, 19793.505162371057, 19896.801031990075, 20000.0, 11207.60773372928, 11390.316581005167, 11511.366874821964, 11521.596744113916, 11530.135239857213, 14046.0, 14234.786478203043, 14235.857641423867, 14246.715065698836, 14250.857491424953, 10743.677689669323, 11326.773464530828, 11330.37682927447, 11462.254953428, 11604.245724027911, 11318.434078296217, 11413.771724565628, 11564.595239166589, 11610.071194304604, 11651.47568359409, 10221.540030698488, 10443.164546836082, 10474.004969527883, 10529.78940421172, 10561.89438105609, 6954.130733658293, 6971.6165610891885, 6983.3714965653335, 7012.614306213207, 7058.647067646494, 7048.577085374894, 7140.500164988609, 7237.674304656409, 7294.270572942663, 7299.343059124491], "value": 6759.325782246907, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [511.9820806271779, 531.9945303376621, 534.8287250920483, 537.4303238567117, 539.2854467830124, 6228.6262824230525, 6241.594296370733, 6246.843828904274, 6261.3738626137365, 6287.591306565076, 6031.758729650809, 6092.299385570661, 6137.785177518787, 6167.198264225655, 6176.104464852594, 5035.647504674675, 5137.768800403972, 5154.304168937202, 5173.637845350827, 5201.24581935621, 5168.379794424655, 5169.638125331228, 5173.818916337929, 5187.5590574801, 5207.0, 4862.562369386755, 5000.549950504454, 5113.079645663797, 5172.224166375055, 5198.92201616976, 4917.483664215241, 4984.576311013569, 5009.2486127080865, 5015.172496538067, 5032.547070763612, 4446.244138496463, 4489.685721999462, 4505.977470112629, 4524.61540769035, 4530.365748795171, 5875.970620146872, 6000.549958753111, 6003.459688628044, 6016.398360163992, 6020.64535479518, 5583.469570390806, 5609.4390560943575, 5648.350439699446, 5676.858078548028, 5740.225069615591, 6437.581557198814, 6501.707423165922, 6523.347665233486, 6542.345765423467, 6572.967135164294, 4860.562549370538, 4869.3931002769, 4882.09681208974, 4885.0, 4908.5336892995465, 6522.054302126166, 6676.46588272937, 6731.2932142125355, 6817.420519255819, 6834.350736680057, 4974.507647705674, 4988.850334489971, 4990.72551009698, 5011.574016208663, 5028.7737051832755, 5091.159958606862, 5118.641695081308, 5137.820176293886, 5138.332016837862, 5161.915997640537, 5605.635633683879, 5687.544996400278, 5708.4862362387585, 5709.200711900337, 5759.452851979056, 6485.4163125318, 6602.6698665067515, 6628.270890202074, 6639.502037347218, 6686.72049888072, 1757.402483155733, 1774.9290028398977, 1779.813119622421, 1786.8385549393, 1789.9015554144387, 904.5206040798388, 1236.0, 1245.6574442028514, 1250.9624711258496, 1265.329375431023, 5588.776448942078, 5599.496045355938, 5615.831525054255, 5615.943840561542, 5655.3779084300695, 6520.641364724891, 6544.70548825304, 6605.240397354366, 6641.701123449359, 6684.398404143651, 5549.195366671891, 5574.777008919597, 5596.972015139898, 5597.832065038056, 5619.353774315924, 3456.42968910127, 3514.24443744591, 3560.412531932254, 3561.4123669594746, 3565.6969157621893, 6387.3073635486635, 6398.784230996096, 6451.838704032437, 6460.0, 6468.256150542654, 6711.194656641137, 6769.593824370553, 6780.457563394916, 6793.218779840382, 6805.0, 6360.363963603602, 6378.2346118466085, 6427.614343139333, 6468.865274459417, 6480.773172939019, 6574.638394888327, 6577.572457790228, 6638.0417776755, 6711.791877462104, 6725.226598940989, 5992.340842507408, 6468.644224567505, 6558.934410656023, 6612.23959244693, 6615.867682646416, 6359.682015899279, 6364.331745166876, 6425.485961123006, 6445.452136568444, 6493.350664933469, 5001.424836143745, 5035.395752509722, 5038.84883453497, 5058.873528161678, 5073.315102461268, 6386.904196436964, 6596.208454985433, 6643.833904152241, 6656.7670131545165, 6691.866162676816, 6265.530085243534, 6367.028104225866, 6372.267189273293, 6525.934740652533, 6548.377904099103, 6303.180586523723, 6332.715027823667, 6403.679816009274, 6427.775027874002, 6461.741530338733, 6053.303870055, 6189.938100618936, 6302.1492098566105, 6327.525435592441, 6342.682865856596, 6395.505752756521, 6492.64290464029, 6518.0, 6538.83652908662, 6559.0, 6285.465735412541, 6285.874282514415, 6326.715297811702, 6345.333739957238, 6389.456896163878], "value": 5027.948506462872, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [896.5024411451644, 909.9636014559418, 922.4050487435604, 931.2224292715587, 933.5472295936472, 20202.39392818216, 20489.692654610157, 20960.16159353626, 21029.579408411842, 21052.684209736864, 19304.80695193051, 19762.80237197631, 19893.104810283538, 19905.104270307835, 19925.900370498126, 959.8896126945403, 969.6170012844922, 971.5433746139303, 976.8046390721848, 982.1946004276496, 960.7309953213112, 991.7570195302161, 995.6764051683195, 997.281956990969, 1000.5997600959602, 1066.3814987307383, 1072.5066469424075, 1072.785442911421, 1072.8873468285835, 1074.1782536359692, 1048.9895101049005, 1050.4275170032352, 1057.7778666480049, 1058.2433560004595, 1058.8888166742536, 717.6232477949067, 743.1305372713938, 752.7290175536803, 753.2730914667318, 753.6721526136148, 20648.793512064836, 20712.0, 20805.895970520203, 20820.37538873836, 20850.895745521328, 22066.66899996501, 22105.226317078985, 22683.659745103836, 22791.0, 22923.31230063101, 16834.663306733797, 17052.317907283817, 17244.827551724447, 17404.56488587783, 17590.0, 3782.489363935861, 3786.223824116077, 3793.412021136701, 3796.52543432071, 3812.1994381179984, 142292.0, 142587.0, 144882.27558862243, 146228.0, 146317.99999999892, 16750.664986700198, 17054.0, 17134.057626830643, 17138.571535711457, 17161.31354745796, 31470.21324466861, 31798.523022154684, 32294.35411291808, 32496.512552311735, 32673.673263267538, 8573.056963733985, 8650.826983460296, 8665.43674661145, 8693.304535637133, 8694.913050869536, 4047.6357127858632, 4148.191102734938, 4204.07510347723, 4226.344916537942, 4252.064545799919, 5520.558355331564, 5636.126400407943, 5639.943600564024, 5665.915011274834, 5671.971640141773, 974.181687382602, 986.921046316293, 995.0894931138073, 995.3977843404635, 1007.2294694558668, 659.864727730814, 680.9391783931261, 692.5913710910486, 697.8394969157122, 700.6321681117353, 10913.781724365468, 10946.288491248044, 11727.589534366427, 12327.630171094881, 12797.232166070065, 676.1885737115383, 685.4653370371118, 697.5988806436319, 700.3836623771049, 700.4011570107587, 5686.5735069869925, 5732.0, 5774.48029677331, 5795.739191736382, 5795.768169273266, 110968.0, 112344.0, 112938.0, 113411.43294283476, 114813.0, 97402.0, 99152.0, 100379.0, 102128.0, 104191.4790426043, 87192.56403717941, 88173.5591322052, 88974.0, 89682.55158724164, 92487.53756231176, 10682.679519614425, 10710.518026688662, 10809.729756756144, 10894.346339219355, 10997.670069897917, 43702.78148609237, 44045.77977110222, 44138.55861441344, 44646.9999999987, 44684.55315446934, 55208.0, 55952.720236398556, 56789.71605141948, 56988.43011569997, 57579.1363129545, 14579.708405832036, 14807.777883331542, 15269.465568705042, 15294.847051529343, 15449.613759656098, 17664.381746638806, 17906.462806115836, 17998.0, 18096.72854907151, 18167.091645417942, 15488.0, 15519.689606207587, 15620.531384058497, 15764.76352854731, 15802.209889505708, 15902.60243493922, 16029.759553606938, 16188.0, 16227.432039878548, 16397.0, 15756.527304180892, 15770.605734856721, 15823.0, 15901.840981590036, 16127.75808362852, 11639.709007274885, 11655.76688466243, 11701.356425396685, 12118.212316199419, 12186.695332616755, 11209.887901120885, 11423.143264255048, 11444.141689373497, 11495.827562586735, 11500.884991149982], "value": 8963.017685889628, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1468.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 110.0, 110.0, 112.0, 123.0, 114.0, 114.0, 110.0, 109.0, 107.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 117.0, 134.0, 129.0, 119.0, 141.0, 128.0, 128.0, 120.0, 143.0], "value": 128.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 168.0, 176.0, 167.0, 165.0, 166.0, 173.0, 166.0, 170.0, 170.0], "value": 168.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 77.0, 83.0, 79.0, 74.0, 75.0, 75.0, 84.0, 81.0, 74.0], "value": 78.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 82.0, 87.0, 81.0, 79.0, 79.0, 86.0, 81.0, 82.0, 84.0], "value": 82.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 114.0, 110.0, 114.0, 112.0, 122.0, 115.0, 110.0, 114.0, 118.0], "value": 114.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 148.0, 149.0, 156.0, 155.0, 155.0, 151.0, 152.0, 152.0, 152.0], "value": 152.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 99.0, 95.0, 94.0, 96.0, 101.0, 103.0, 95.0, 99.0, 95.0], "value": 97.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 60.0, 54.0, 59.0, 56.0, 55.0, 56.0, 57.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 42.0, 42.0, 38.0, 42.0, 45.0, 47.0, 37.0, 39.0, 44.0], "value": 41.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 77.0, 82.0, 77.0, 72.0, 76.0, 85.0, 75.0, 86.0, 82.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 116.0, 115.0, 116.0, 114.0, 121.0, 113.0, 111.0, 124.0, 116.0], "value": 117.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 170.0, 172.0, 179.0, 176.0, 178.0, 175.0, 171.0, 172.0, 166.0], "value": 173.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 66.0, 67.0, 64.0, 67.0, 67.0, 71.0, 67.0, 69.0], "value": 66.7, "unit": "score"}]}]} 04:03:03 INFO - Return code: 0 04:03:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:03:03 INFO - # TBPL SUCCESS # 04:03:03 INFO - Running post-action listener: _package_coverage_data 04:03:03 INFO - Running post-action listener: _resource_record_post_action 04:03:03 INFO - [mozharness: 2017-09-23 11:03:03.432029Z] Finished run-tests step (success) 04:03:03 INFO - Running post-run listener: _resource_record_post_run 04:03:03 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 21778432; Write bytes: 384192512; Read time: 8372; Write time: 338780 04:03:03 INFO - TinderboxPrint: CPU usage
13.3% 04:03:03 INFO - TinderboxPrint: I/O read bytes / time
21,778,432 / 8,372 04:03:03 INFO - TinderboxPrint: I/O write bytes / time
384,192,512 / 338,780 04:03:03 INFO - TinderboxPrint: CPU idle
8,268.4 (86.7%) 04:03:03 INFO - TinderboxPrint: CPU user
1,201.4 (12.6%) 04:03:03 INFO - TinderboxPrint: Swap in / out
0 / 0 04:03:03 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 49790976; Read time: 0; Write time: 24756 04:03:03 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:03:03 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 19628032; Write bytes: 277778432; Read time: 7836; Write time: 216088 04:03:04 INFO - Running post-run listener: _upload_blobber_files 04:03:04 INFO - Blob upload gear active. 04:03:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:03:04 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:03:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:03:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:03:04 INFO - (blobuploader) - INFO - Open directory for files ... 04:03:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:03:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:03:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:03:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:03:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:03:10 INFO - (blobuploader) - INFO - Done attempting. 04:03:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:03:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:03:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:03:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:03:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:03:11 INFO - (blobuploader) - INFO - Done attempting. 04:03:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:03:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:03:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:03:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:03:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:03:12 INFO - (blobuploader) - INFO - Done attempting. 04:03:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:03:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:03:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:03:14 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:03:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:03:14 INFO - (blobuploader) - INFO - Done attempting. 04:03:14 INFO - (blobuploader) - INFO - Iteration through files over. 04:03:14 INFO - Return code: 0 04:03:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:03:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:03:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e55f3e1116a96f0370ef8eed94de5676439698f0ecb372e74116f4ac66368e1d8f8ac8496ecfaba05e6e84c216f0f8bd142d7467610d67d81fbf36e1ec995b6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0bfb6f17f67c0da68f0dff4604238bb10891a194dd0e4fadbcae0d9db49b545cee5cbaf5de0f215c5911c0c2bb6e2233a39a7819edcf8126bb4941b514b70b4", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60409abbda65d470147cc99c3474cb81ed4d5f3e5e03aa8489de9513bbb26dd80fbc82c8c87e6084f2defc92c11f025344edb2e676368d7d86a19cbfc0001168", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b34c660928dac55d64560f945dcf40f1ecff93d7fee248e58a5d19d8090e12d5a81a8a7409b7bdd5590c32fdfa620d8603eaeee2c12785b87df09cf34f160a14"} 04:03:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:03:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:03:14 INFO - Contents: 04:03:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e55f3e1116a96f0370ef8eed94de5676439698f0ecb372e74116f4ac66368e1d8f8ac8496ecfaba05e6e84c216f0f8bd142d7467610d67d81fbf36e1ec995b6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0bfb6f17f67c0da68f0dff4604238bb10891a194dd0e4fadbcae0d9db49b545cee5cbaf5de0f215c5911c0c2bb6e2233a39a7819edcf8126bb4941b514b70b4", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60409abbda65d470147cc99c3474cb81ed4d5f3e5e03aa8489de9513bbb26dd80fbc82c8c87e6084f2defc92c11f025344edb2e676368d7d86a19cbfc0001168", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b34c660928dac55d64560f945dcf40f1ecff93d7fee248e58a5d19d8090e12d5a81a8a7409b7bdd5590c32fdfa620d8603eaeee2c12785b87df09cf34f160a14"} 04:03:14 INFO - Running post-run listener: copy_logs_to_upload_dir 04:03:14 INFO - Copying logs to upload dir... 04:03:14 INFO - mkdir: /builds/slave/test/build/upload/logs 04:03:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.616247 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-09-23 04:03:14.116976) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-23 04:03:14.120907) ========= 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=03627c79f6bb3d1578c4a402000001ba-1506163343.180261-953808805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e55f3e1116a96f0370ef8eed94de5676439698f0ecb372e74116f4ac66368e1d8f8ac8496ecfaba05e6e84c216f0f8bd142d7467610d67d81fbf36e1ec995b6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0bfb6f17f67c0da68f0dff4604238bb10891a194dd0e4fadbcae0d9db49b545cee5cbaf5de0f215c5911c0c2bb6e2233a39a7819edcf8126bb4941b514b70b4", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60409abbda65d470147cc99c3474cb81ed4d5f3e5e03aa8489de9513bbb26dd80fbc82c8c87e6084f2defc92c11f025344edb2e676368d7d86a19cbfc0001168", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b34c660928dac55d64560f945dcf40f1ecff93d7fee248e58a5d19d8090e12d5a81a8a7409b7bdd5590c32fdfa620d8603eaeee2c12785b87df09cf34f160a14"} build_url:https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011064 build_url: 'https://queue.taskcluster.net/v1/task/G4ULSq9NTWSDYYmNphUW3A/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e55f3e1116a96f0370ef8eed94de5676439698f0ecb372e74116f4ac66368e1d8f8ac8496ecfaba05e6e84c216f0f8bd142d7467610d67d81fbf36e1ec995b6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0bfb6f17f67c0da68f0dff4604238bb10891a194dd0e4fadbcae0d9db49b545cee5cbaf5de0f215c5911c0c2bb6e2233a39a7819edcf8126bb4941b514b70b4", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60409abbda65d470147cc99c3474cb81ed4d5f3e5e03aa8489de9513bbb26dd80fbc82c8c87e6084f2defc92c11f025344edb2e676368d7d86a19cbfc0001168", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b34c660928dac55d64560f945dcf40f1ecff93d7fee248e58a5d19d8090e12d5a81a8a7409b7bdd5590c32fdfa620d8603eaeee2c12785b87df09cf34f160a14"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-23 04:03:14.154244) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 04:03:14.154948) ========= 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=03627c79f6bb3d1578c4a402000001ba-1506163343.180261-953808805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004477 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 04:03:14.236007) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-23 04:03:14.236404) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-23 04:03:14.236783) ========= ========= Total master_lag: 0.24 =========