builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-032 starttime: 1503444532.71 results: success (0) revision: 80fafbaaf8484104018976c2a0442c91805d3554 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-22 16:28:52.706889) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-22 16:28:52.707379) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-22 16:28:52.707655) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-22 16:28:52.728001) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 16:28:52.728305) ========= 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=745a4373a2a16df560f216e000000264-1503444530.970780-1478601249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-22 16:28:52-- 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% 46.2M=0s 2017-08-22 16:28:52 (46.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.159097 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 16:28:52.920392) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 16:28:52.920707) ========= 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=745a4373a2a16df560f216e000000264-1503444530.970780-1478601249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016238 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 16:28:52.969830) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-22 16:28:52.973175) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 80fafbaaf8484104018976c2a0442c91805d3554 --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 80fafbaaf8484104018976c2a0442c91805d3554 --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=745a4373a2a16df560f216e000000264-1503444530.970780-1478601249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-22 16:28:52,971 truncating revision to first 12 chars 2017-08-22 16:28:52,971 Setting DEBUG logging. 2017-08-22 16:28:52,971 attempt 1/10 2017-08-22 16:28:52,971 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/80fafbaaf848?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-22 16:28:53,837 unpacking tar archive at: mozilla-central-80fafbaaf848/testing/mozharness/ program finished with exit code 0 elapsedTime=1.186070 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-22 16:28:54.177006) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-22 16:28:54.177338) ========= script_repo_revision: 80fafbaaf8484104018976c2a0442c91805d3554 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-22 16:28:54.177727) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-22 16:28:54.178014) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-22 16:28:54.189574) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-08-22 16:28:54.189873) ========= /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=745a4373a2a16df560f216e000000264-1503444530.970780-1478601249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:28:54 INFO - MultiFileLogger online at 20170822 16:28:54 in /builds/slave/test 16:28:54 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 16:28:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:28:54 INFO - {'append_to_log': False, 16:28:54 INFO - 'base_work_dir': '/builds/slave/test', 16:28:54 INFO - 'blob_upload_branch': 'Firefox', 16:28:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:28:54 INFO - 'branch': 'Firefox', 16:28:54 INFO - 'buildbot_json_path': 'buildprops.json', 16:28:54 INFO - 'code_coverage': False, 16:28:54 INFO - 'config_files': ('talos/linux_config.py',), 16:28:54 INFO - 'default_actions': ('clobber', 16:28:54 INFO - 'read-buildbot-config', 16:28:54 INFO - 'download-and-extract', 16:28:54 INFO - 'populate-webroot', 16:28:54 INFO - 'create-virtualenv', 16:28:54 INFO - 'install', 16:28:54 INFO - 'setup-mitmproxy', 16:28:54 INFO - 'run-tests'), 16:28:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:28:54 INFO - 'disable_ccov_upload': False, 16:28:54 INFO - 'download_minidump_stackwalk': True, 16:28:54 INFO - 'download_symbols': 'ondemand', 16:28:54 INFO - 'enable_stylo': False, 16:28:54 INFO - 'enable_webrender': False, 16:28:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:28:54 INFO - 'tooltool.py': '/tools/tooltool.py', 16:28:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:28:54 INFO - '/tools/misc-python/virtualenv.py')}, 16:28:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:28:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:28:54 INFO - 'gecko_profile': False, 16:28:54 INFO - 'gecko_profile_interval': 0, 16:28:54 INFO - 'installer_path': 'installer.exe', 16:28:54 INFO - 'log_level': 'info', 16:28:54 INFO - 'log_name': 'talos', 16:28:54 INFO - 'log_to_console': True, 16:28:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:28:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:28:54 INFO - 'opt_config_files': (), 16:28:54 INFO - 'pip_index': False, 16:28:54 INFO - 'suite': 'dromaeojs-e10s', 16:28:54 INFO - 'system_bits': '32', 16:28:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:28:54 INFO - 'title': 'talos-linux64-ix-032', 16:28:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:28:54 INFO - 'use_talos_json': True, 16:28:54 INFO - 'verify': 'False', 16:28:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:28:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:28:54 INFO - 'work_dir': 'build'} 16:28:54 INFO - [mozharness: 2017-08-22 23:28:54.460620Z] Running clobber step. 16:28:54 INFO - Running pre-action listener: _resource_record_pre_action 16:28:54 INFO - Running main action method: clobber 16:28:54 INFO - rmtree: /builds/slave/test/build 16:28:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:28:55 INFO - Running post-action listener: _resource_record_post_action 16:28:55 INFO - [mozharness: 2017-08-22 23:28:55.430971Z] Finished clobber step (success) 16:28:55 INFO - [mozharness: 2017-08-22 23:28:55.431131Z] Running read-buildbot-config step. 16:28:55 INFO - Running pre-action listener: _resource_record_pre_action 16:28:55 INFO - Running main action method: read_buildbot_config 16:28:55 INFO - Using buildbot properties: 16:28:55 INFO - { 16:28:55 INFO - "project": "", 16:28:55 INFO - "product": "firefox", 16:28:55 INFO - "who": "kwierso@gmail.com", 16:28:55 INFO - "installer_path": "public/build/target.tar.bz2", 16:28:55 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 16:28:55 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:28:55 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 16:28:55 INFO - "stage_platform": "linux64-stylosequential", 16:28:55 INFO - "basedir": "/builds/slave/test", 16:28:55 INFO - "buildnumber": 164, 16:28:55 INFO - "platform": "ubuntu64_hw_styloseq", 16:28:55 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:28:55 INFO - "slavebuilddir": "test", 16:28:55 INFO - "taskId": "Ah7KqWp8RAaXry3LcTLXLQ", 16:28:55 INFO - "branch": "mozilla-central", 16:28:55 INFO - "script_repo_revision": "production", 16:28:55 INFO - "revision": "80fafbaaf8484104018976c2a0442c91805d3554", 16:28:55 INFO - "slavename": "talos-linux64-ix-032", 16:28:55 INFO - "repo_path": "mozilla-central" 16:28:55 INFO - } 16:28:55 INFO - Finding installer, test and symbols from parent task. 16:28:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ah7KqWp8RAaXry3LcTLXLQ'}, attempt #1 16:28:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ah7KqWp8RAaXry3LcTLXLQ'}, attempt #1 16:28:56 INFO - Task dependencies: KRW8BKGhS3m3qhpOl1dvTA 16:28:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KRW8BKGhS3m3qhpOl1dvTA'}, attempt #1 16:28:56 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/KRW8BKGhS3m3qhpOl1dvTA/artifacts/public/build/target.tar.bz2 16:28:56 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/KRW8BKGhS3m3qhpOl1dvTA/artifacts/public/build/target.test_packages.json 16:28:56 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/KRW8BKGhS3m3qhpOl1dvTA/artifacts/public/build/target.crashreporter-symbols.zip 16:28:56 INFO - Running post-action listener: _resource_record_post_action 16:28:56 INFO - [mozharness: 2017-08-22 23:28:56.784915Z] Finished read-buildbot-config step (success) 16:28:56 INFO - [mozharness: 2017-08-22 23:28:56.785130Z] Running download-and-extract step. 16:28:56 INFO - Running pre-action listener: _resource_record_pre_action 16:28:56 INFO - Running main action method: download_and_extract 16:28:56 INFO - mkdir: /builds/slave/test/build/tests 16:28: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')]} 16:28:56 INFO - trying https://queue.taskcluster.net/v1/task/KRW8BKGhS3m3qhpOl1dvTA/artifacts/public/build/target.test_packages.json 16:28:56 INFO - Downloading https://queue.taskcluster.net/v1/task/KRW8BKGhS3m3qhpOl1dvTA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:28:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KRW8BKGhS3m3qhpOl1dvTA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:28:57 INFO - Downloaded 989 bytes. 16:28:57 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:28:57 INFO - Using the following test package requirements: 16:28:57 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:28:57 INFO - u'common': [u'target.common.tests.zip'], 16:28:57 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:28:57 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:28:57 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:28:57 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:28:57 INFO - u'mozbase': [u'target.common.tests.zip'], 16:28:57 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:28:57 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:28:57 INFO - u'web-platform': [u'target.common.tests.zip', 16:28:57 INFO - u'target.web-platform.tests.tar.gz'], 16:28:57 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:28:57 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:28:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KRW8BKGhS3m3qhpOl1dvTA/artifacts/public/build/target.common.tests.zip 16:28:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KRW8BKGhS3m3qhpOl1dvTA/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:28:57 INFO - Fetch https://queue.taskcluster.net/v1/task/KRW8BKGhS3m3qhpOl1dvTA/artifacts/public/build/target.common.tests.zip into memory 16:28:58 INFO - Content-Length response header: 54949663 16:28:58 INFO - Bytes received: 54949663 16:29:11 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:29:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KRW8BKGhS3m3qhpOl1dvTA/artifacts/public/build/target.common.tests.zip 16:29:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KRW8BKGhS3m3qhpOl1dvTA/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:29:11 INFO - Fetch https://queue.taskcluster.net/v1/task/KRW8BKGhS3m3qhpOl1dvTA/artifacts/public/build/target.common.tests.zip into memory 16:29:12 INFO - Content-Length response header: 54949663 16:29:12 INFO - Bytes received: 54949663 16:29:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KRW8BKGhS3m3qhpOl1dvTA/artifacts/public/build/target.talos.tests.zip 16:29:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KRW8BKGhS3m3qhpOl1dvTA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:29:29 INFO - Fetch https://queue.taskcluster.net/v1/task/KRW8BKGhS3m3qhpOl1dvTA/artifacts/public/build/target.talos.tests.zip into memory 16:29:29 INFO - Content-Length response header: 14496256 16:29:29 INFO - Bytes received: 14496256 16:29:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:30 INFO - trying https://queue.taskcluster.net/v1/task/KRW8BKGhS3m3qhpOl1dvTA/artifacts/public/build/target.tar.bz2 16:29:30 INFO - Downloading https://queue.taskcluster.net/v1/task/KRW8BKGhS3m3qhpOl1dvTA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:29:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KRW8BKGhS3m3qhpOl1dvTA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:29:31 INFO - Downloaded 61341819 bytes. 16:29:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KRW8BKGhS3m3qhpOl1dvTA/artifacts/public/build/target.tar.bz2 16:29:31 INFO - mkdir: /builds/slave/test/properties 16:29:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:29:31 INFO - Writing to file /builds/slave/test/properties/build_url 16:29:31 INFO - Contents: 16:29:31 INFO - build_url:https://queue.taskcluster.net/v1/task/KRW8BKGhS3m3qhpOl1dvTA/artifacts/public/build/target.tar.bz2 16:29:31 INFO - Running post-action listener: _resource_record_post_action 16:29:31 INFO - Running post-action listener: find_tests_for_verification 16:29:31 INFO - Running post-action listener: set_extra_try_arguments 16:29:31 INFO - [mozharness: 2017-08-22 23:29:31.222269Z] Finished download-and-extract step (success) 16:29:31 INFO - [mozharness: 2017-08-22 23:29:31.222366Z] Running populate-webroot step. 16:29:31 INFO - Running pre-action listener: _resource_record_pre_action 16:29:31 INFO - Running main action method: populate_webroot 16:29:31 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:29:31 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 16:29:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:29:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:29:31 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 16:29:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:29:31 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:29:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:29:31 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:29:31 INFO - 'talos_options': ['--stylo'], 16:29:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:29:31 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:29:31 INFO - 'tests': ['damp', 'tps']}, 16:29:31 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:29:31 INFO - 'talos_options': ['--stylo'], 16:29:31 INFO - 'tests': ['damp', 'tps']}, 16:29:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:29:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:29:31 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 16:29:31 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 16:29:31 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:29:31 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:29:31 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:29:31 INFO - 'talos_options': ['--stylo'], 16:29:31 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:29:31 INFO - 'other-e10s': {'tests': ['a11yr', 16:29:31 INFO - 'ts_paint', 16:29:31 INFO - 'tpaint', 16:29:31 INFO - 'sessionrestore', 16:29:31 INFO - 'sessionrestore_many_windows', 16:29:31 INFO - 'sessionrestore_no_auto_restore', 16:29:31 INFO - 'tabpaint']}, 16:29:31 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 16:29:31 INFO - 'tests': ['a11yr', 16:29:31 INFO - 'ts_paint', 16:29:31 INFO - 'tpaint', 16:29:31 INFO - 'sessionrestore', 16:29:31 INFO - 'sessionrestore_many_windows', 16:29:31 INFO - 'sessionrestore_no_auto_restore', 16:29:31 INFO - 'tabpaint']}, 16:29:31 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 16:29:31 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 16:29:31 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 16:29:31 INFO - 'tests': ['bloom_basic_singleton']}, 16:29:31 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 16:29:31 INFO - 'tests': ['bloom_basic']}, 16:29:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:29:31 INFO - 'tsvgr_opacity', 16:29:31 INFO - 'tart', 16:29:31 INFO - 'tscrollx', 16:29:31 INFO - 'tsvg_static']}, 16:29:31 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 16:29:31 INFO - 'tests': ['tsvgx', 16:29:31 INFO - 'tsvgr_opacity', 16:29:31 INFO - 'tart', 16:29:31 INFO - 'tscrollx', 16:29:31 INFO - 'tsvg_static']}, 16:29:31 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:29:31 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:29:31 INFO - 'talos_options': ['--stylo'], 16:29:31 INFO - 'tests': ['tp5o']}, 16:29:31 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:29:31 INFO - 'talos_options': ['--mitmproxy', 16:29:31 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:29:31 INFO - '--firstNonBlankPaint'], 16:29:31 INFO - 'tests': ['tp6_google', 16:29:31 INFO - 'tp6_youtube', 16:29:31 INFO - 'tp6_amazon', 16:29:31 INFO - 'tp6_facebook']}, 16:29:31 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:29:31 INFO - 'talos_options': ['--stylo', 16:29:31 INFO - '--mitmproxy', 16:29:31 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:29:31 INFO - '--firstNonBlankPaint'], 16:29:31 INFO - 'tests': ['tp6_google', 16:29:31 INFO - 'tp6_youtube', 16:29:31 INFO - 'tp6_amazon', 16:29:31 INFO - 'tp6_facebook']}, 16:29:31 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:29:31 INFO - 'talos_options': ['--stylo', 16:29:31 INFO - '--stylo-threads=1', 16:29:31 INFO - '--mitmproxy', 16:29:31 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:29:31 INFO - '--firstNonBlankPaint'], 16:29:31 INFO - 'tests': ['tp6_google', 16:29:31 INFO - 'tp6_youtube', 16:29:31 INFO - 'tp6_amazon', 16:29:31 INFO - 'tp6_facebook']}, 16:29:31 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:29:31 INFO - 'talos_options': ['--xperf_path', 16:29:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:29:31 INFO - 'tests': ['tp5n']}, 16:29:31 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:29:31 INFO - 'talos_options': ['--stylo', 16:29:31 INFO - '--xperf_path', 16:29:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:29:31 INFO - 'tests': ['tp5n']}}} 16:29:31 INFO - Running post-action listener: _resource_record_post_action 16:29:31 INFO - [mozharness: 2017-08-22 23:29:31.236587Z] Finished populate-webroot step (success) 16:29:31 INFO - [mozharness: 2017-08-22 23:29:31.236676Z] Running create-virtualenv step. 16:29:31 INFO - Running pre-action listener: _resource_record_pre_action 16:29:31 INFO - Running main action method: create_virtualenv 16:29:31 INFO - Creating virtualenv /builds/slave/test/build/venv 16:29:31 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:29:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:29:31 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:29:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:29:31 INFO - Using real prefix '/usr' 16:29:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:29:32 INFO - Installing distribute.............................................................................................................................................................................................done. 16:29:33 INFO - Installing pip.................done. 16:29:34 INFO - Return code: 0 16:29:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:29:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:29:34 INFO - Reading from file tmpfile_stdout 16:29:34 INFO - Output received: 16:29:34 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 16:29:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:29:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c52a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df5f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df3130>, '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 0x1df4030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df44c0>, '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': '745a4373a2a16df560f216e000000264-1503444530.970780-1478601249', '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 16:29:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:29:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:29:34 INFO - Using env: {'DISPLAY': ':0', 16:29:34 INFO - 'HOME': '/home/cltbld', 16:29:34 INFO - 'LANG': 'en_US.UTF-8', 16:29:34 INFO - 'LANGUAGE': 'en_US:en', 16:29:34 INFO - 'LOGNAME': 'cltbld', 16:29:34 INFO - 'MAIL': '/var/mail/cltbld', 16:29:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:34 INFO - 'MOZ_NO_REMOTE': '1', 16:29:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:34 INFO - 'NO_EM_RESTART': '1', 16:29:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:34 INFO - 'PWD': '/builds/slave/test', 16:29:34 INFO - 'SHELL': '/bin/bash', 16:29:34 INFO - 'SHLVL': '1', 16:29:34 INFO - 'TERM': 'linux', 16:29:34 INFO - 'TMOUT': '86400', 16:29:34 INFO - 'USER': 'cltbld', 16:29:34 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1503444530.970780-1478601249', 16:29:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:34 INFO - '_': '/tools/buildbot/bin/python'} 16:29:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:34 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:29:34 INFO - Cleaning up... 16:29:34 INFO - Return code: 0 16:29:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:29:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1a871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c52a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df5f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df3130>, '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 0x1df4030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df44c0>, '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': '745a4373a2a16df560f216e000000264-1503444530.970780-1478601249', '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 16:29:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:29:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:29:34 INFO - Using env: {'DISPLAY': ':0', 16:29:34 INFO - 'HOME': '/home/cltbld', 16:29:34 INFO - 'LANG': 'en_US.UTF-8', 16:29:34 INFO - 'LANGUAGE': 'en_US:en', 16:29:34 INFO - 'LOGNAME': 'cltbld', 16:29:34 INFO - 'MAIL': '/var/mail/cltbld', 16:29:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:34 INFO - 'MOZ_NO_REMOTE': '1', 16:29:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:34 INFO - 'NO_EM_RESTART': '1', 16:29:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:34 INFO - 'PWD': '/builds/slave/test', 16:29:34 INFO - 'SHELL': '/bin/bash', 16:29:34 INFO - 'SHLVL': '1', 16:29:34 INFO - 'TERM': 'linux', 16:29:34 INFO - 'TMOUT': '86400', 16:29:34 INFO - 'USER': 'cltbld', 16:29:34 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1503444530.970780-1478601249', 16:29:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:34 INFO - '_': '/tools/buildbot/bin/python'} 16:29:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:34 INFO - Downloading/unpacking psutil>=3.1.1 16:29:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:29:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:29:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:29:36 INFO - Installing collected packages: psutil 16:29:36 INFO - Running setup.py install for psutil 16:29:36 INFO - building 'psutil._psutil_linux' extension 16:29:36 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 16:29:37 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 16:29:37 INFO - building 'psutil._psutil_posix' extension 16:29:37 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 16:29:37 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 16:29:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:29:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:29:37 INFO - Successfully installed psutil 16:29:37 INFO - Cleaning up... 16:29:37 INFO - Return code: 0 16:29:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:29:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:37 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 0x1a871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c52a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df5f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df3130>, '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 0x1df4030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df44c0>, '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': '745a4373a2a16df560f216e000000264-1503444530.970780-1478601249', '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 16:29:37 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 16:29:37 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 16:29:37 INFO - Using env: {'DISPLAY': ':0', 16:29:37 INFO - 'HOME': '/home/cltbld', 16:29:37 INFO - 'LANG': 'en_US.UTF-8', 16:29:37 INFO - 'LANGUAGE': 'en_US:en', 16:29:37 INFO - 'LOGNAME': 'cltbld', 16:29:37 INFO - 'MAIL': '/var/mail/cltbld', 16:29:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:37 INFO - 'MOZ_NO_REMOTE': '1', 16:29:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:37 INFO - 'NO_EM_RESTART': '1', 16:29:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:37 INFO - 'PWD': '/builds/slave/test', 16:29:37 INFO - 'SHELL': '/bin/bash', 16:29:37 INFO - 'SHLVL': '1', 16:29:37 INFO - 'TERM': 'linux', 16:29:37 INFO - 'TMOUT': '86400', 16:29:37 INFO - 'USER': 'cltbld', 16:29:37 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1503444530.970780-1478601249', 16:29:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:37 INFO - '_': '/tools/buildbot/bin/python'} 16:29:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:29:38 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 16:29:38 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 16:29:38 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 16:29:38 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 16:29:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:29:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:29:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:29:39 INFO - Installing collected packages: mozsystemmonitor 16:29:39 INFO - Running setup.py install for mozsystemmonitor 16:29:39 INFO - Successfully installed mozsystemmonitor 16:29:39 INFO - Cleaning up... 16:29:39 INFO - Return code: 0 16:29:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:29:39 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')]} 16:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:39 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')]} 16:29:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:39 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 0x1a871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c52a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df5f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df3130>, '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 0x1df4030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df44c0>, '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': '745a4373a2a16df560f216e000000264-1503444530.970780-1478601249', '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 16:29:39 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 16:29:39 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 16:29:39 INFO - Using env: {'DISPLAY': ':0', 16:29:39 INFO - 'HOME': '/home/cltbld', 16:29:39 INFO - 'LANG': 'en_US.UTF-8', 16:29:39 INFO - 'LANGUAGE': 'en_US:en', 16:29:39 INFO - 'LOGNAME': 'cltbld', 16:29:39 INFO - 'MAIL': '/var/mail/cltbld', 16:29:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:39 INFO - 'MOZ_NO_REMOTE': '1', 16:29:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:39 INFO - 'NO_EM_RESTART': '1', 16:29:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:39 INFO - 'PWD': '/builds/slave/test', 16:29:39 INFO - 'SHELL': '/bin/bash', 16:29:39 INFO - 'SHLVL': '1', 16:29:39 INFO - 'TERM': 'linux', 16:29:39 INFO - 'TMOUT': '86400', 16:29:39 INFO - 'USER': 'cltbld', 16:29:39 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1503444530.970780-1478601249', 16:29:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:39 INFO - '_': '/tools/buildbot/bin/python'} 16:29:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:39 INFO - Downloading/unpacking jsonschema==2.5.1 16:29:39 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 16:29:39 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 16:29:39 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 16:29:39 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 16:29:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:29:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:29:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:40 INFO - Downloading functools32-3.2.3-2.tar.gz 16:29:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:29:40 INFO - warning: no files found matching '*.txt' 16:29:40 INFO - no previously-included directories found matching 'build' 16:29:40 INFO - no previously-included directories found matching 'dist' 16:29:40 INFO - no previously-included directories found matching '.git*' 16:29:40 INFO - Installing collected packages: jsonschema, functools32 16:29:41 INFO - Running setup.py install for functools32 16:29:41 INFO - warning: no files found matching '*.txt' 16:29:41 INFO - no previously-included directories found matching 'build' 16:29:41 INFO - no previously-included directories found matching 'dist' 16:29:41 INFO - no previously-included directories found matching '.git*' 16:29:41 INFO - Successfully installed jsonschema functools32 16:29:41 INFO - Cleaning up... 16:29:41 INFO - Return code: 0 16:29:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:29:41 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')]} 16:29:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:41 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')]} 16:29:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:41 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 0x1a871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c52a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df5f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df3130>, '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 0x1df4030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df44c0>, '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': '745a4373a2a16df560f216e000000264-1503444530.970780-1478601249', '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 16:29:41 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 16:29:41 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 16:29:41 INFO - Using env: {'DISPLAY': ':0', 16:29:41 INFO - 'HOME': '/home/cltbld', 16:29:41 INFO - 'LANG': 'en_US.UTF-8', 16:29:41 INFO - 'LANGUAGE': 'en_US:en', 16:29:41 INFO - 'LOGNAME': 'cltbld', 16:29:41 INFO - 'MAIL': '/var/mail/cltbld', 16:29:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:41 INFO - 'MOZ_NO_REMOTE': '1', 16:29:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:41 INFO - 'NO_EM_RESTART': '1', 16:29:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:41 INFO - 'PWD': '/builds/slave/test', 16:29:41 INFO - 'SHELL': '/bin/bash', 16:29:41 INFO - 'SHLVL': '1', 16:29:41 INFO - 'TERM': 'linux', 16:29:41 INFO - 'TMOUT': '86400', 16:29:41 INFO - 'USER': 'cltbld', 16:29:41 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1503444530.970780-1478601249', 16:29:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:41 INFO - '_': '/tools/buildbot/bin/python'} 16:29:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:29:41 INFO - Cleaning up... 16:29:41 INFO - Return code: 0 16:29:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:29:41 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')]} 16:29:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:41 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')]} 16:29:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:41 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 0x1a871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c52a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df5f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df3130>, '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 0x1df4030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df44c0>, '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': '745a4373a2a16df560f216e000000264-1503444530.970780-1478601249', '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 16:29:41 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 16:29:41 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 16:29:41 INFO - Using env: {'DISPLAY': ':0', 16:29:41 INFO - 'HOME': '/home/cltbld', 16:29:41 INFO - 'LANG': 'en_US.UTF-8', 16:29:41 INFO - 'LANGUAGE': 'en_US:en', 16:29:41 INFO - 'LOGNAME': 'cltbld', 16:29:41 INFO - 'MAIL': '/var/mail/cltbld', 16:29:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:41 INFO - 'MOZ_NO_REMOTE': '1', 16:29:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:41 INFO - 'NO_EM_RESTART': '1', 16:29:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:41 INFO - 'PWD': '/builds/slave/test', 16:29:41 INFO - 'SHELL': '/bin/bash', 16:29:41 INFO - 'SHLVL': '1', 16:29:41 INFO - 'TERM': 'linux', 16:29:41 INFO - 'TMOUT': '86400', 16:29:41 INFO - 'USER': 'cltbld', 16:29:41 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1503444530.970780-1478601249', 16:29:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:41 INFO - '_': '/tools/buildbot/bin/python'} 16:29:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:41 INFO - Downloading/unpacking blobuploader==1.2.4 16:29:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:42 INFO - Downloading blobuploader-1.2.4.tar.gz 16:29:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:29:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:29:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:29:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:29:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:43 INFO - Downloading docopt-0.6.1.tar.gz 16:29:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:29:43 INFO - Installing collected packages: blobuploader, requests, docopt 16:29:43 INFO - Running setup.py install for blobuploader 16:29:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:29:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:29:43 INFO - Running setup.py install for requests 16:29:43 INFO - Running setup.py install for docopt 16:29:43 INFO - Successfully installed blobuploader requests docopt 16:29:43 INFO - Cleaning up... 16:29:43 INFO - Return code: 0 16:29:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:29:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:43 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 0x1a871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c52a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df5f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df3130>, '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 0x1df4030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df44c0>, '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': '745a4373a2a16df560f216e000000264-1503444530.970780-1478601249', '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 16:29:43 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 16:29:43 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 16:29:43 INFO - Using env: {'DISPLAY': ':0', 16:29:43 INFO - 'HOME': '/home/cltbld', 16:29:43 INFO - 'LANG': 'en_US.UTF-8', 16:29:43 INFO - 'LANGUAGE': 'en_US:en', 16:29:43 INFO - 'LOGNAME': 'cltbld', 16:29:43 INFO - 'MAIL': '/var/mail/cltbld', 16:29:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:43 INFO - 'MOZ_NO_REMOTE': '1', 16:29:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:43 INFO - 'NO_EM_RESTART': '1', 16:29:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:43 INFO - 'PWD': '/builds/slave/test', 16:29:43 INFO - 'SHELL': '/bin/bash', 16:29:43 INFO - 'SHLVL': '1', 16:29:43 INFO - 'TERM': 'linux', 16:29:43 INFO - 'TMOUT': '86400', 16:29:43 INFO - 'USER': 'cltbld', 16:29:43 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1503444530.970780-1478601249', 16:29:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:43 INFO - '_': '/tools/buildbot/bin/python'} 16:29:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:29:44 INFO - Running setup.py (path:/tmp/pip-f4PuKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:29:44 INFO - Running setup.py (path:/tmp/pip-faf1Ur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:29:44 INFO - Running setup.py (path:/tmp/pip-mv3P2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:29:44 INFO - Running setup.py (path:/tmp/pip-dMVarY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:29:44 INFO - Running setup.py (path:/tmp/pip-T0Irv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:29:44 INFO - Running setup.py (path:/tmp/pip-PupjxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:29:44 INFO - Running setup.py (path:/tmp/pip-cFiL4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:29:44 INFO - Running setup.py (path:/tmp/pip-PeDvGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:29:44 INFO - Running setup.py (path:/tmp/pip-TZ8COh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:29:44 INFO - Running setup.py (path:/tmp/pip-wqpk81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:29:44 INFO - Running setup.py (path:/tmp/pip-NUOkCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:29:44 INFO - Running setup.py (path:/tmp/pip-9yD8w8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:29:45 INFO - Running setup.py (path:/tmp/pip-YvLRTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:29:45 INFO - Running setup.py (path:/tmp/pip-gJQd4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:29:45 INFO - Running setup.py (path:/tmp/pip-RwvFNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:29:45 INFO - Running setup.py (path:/tmp/pip-fTW8mY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:29:45 INFO - Running setup.py (path:/tmp/pip-YjFz4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:29:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:29:45 INFO - Running setup.py install for manifestparser 16:29:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:29:45 INFO - Running setup.py install for mozcrash 16:29:45 INFO - Running setup.py install for mozdebug 16:29:45 INFO - Running setup.py install for mozdevice 16:29:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:29:45 INFO - Running setup.py install for mozfile 16:29:45 INFO - Running setup.py install for mozhttpd 16:29:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:29:45 INFO - Running setup.py install for mozinfo 16:29:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:29:46 INFO - Running setup.py install for mozInstall 16:29:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:29:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:29:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:29:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:29:46 INFO - Running setup.py install for mozleak 16:29:46 INFO - Running setup.py install for mozlog 16:29:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:29:46 INFO - Running setup.py install for moznetwork 16:29:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:29:46 INFO - Running setup.py install for mozprocess 16:29:46 INFO - Running setup.py install for mozprofile 16:29:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:29:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:29:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:29:46 INFO - Running setup.py install for mozrunner 16:29:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:29:46 INFO - Running setup.py install for mozscreenshot 16:29:46 INFO - Running setup.py install for moztest 16:29:47 INFO - Running setup.py install for mozversion 16:29:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:29:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:29:47 INFO - Cleaning up... 16:29:47 INFO - Return code: 0 16:29:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:29:47 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')]} 16:29:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:47 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')]} 16:29:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:47 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 0x1a871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c52a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df5f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df3130>, '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 0x1df4030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df44c0>, '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': '745a4373a2a16df560f216e000000264-1503444530.970780-1478601249', '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 16:29:47 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 16:29:47 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 16:29:47 INFO - Using env: {'DISPLAY': ':0', 16:29:47 INFO - 'HOME': '/home/cltbld', 16:29:47 INFO - 'LANG': 'en_US.UTF-8', 16:29:47 INFO - 'LANGUAGE': 'en_US:en', 16:29:47 INFO - 'LOGNAME': 'cltbld', 16:29:47 INFO - 'MAIL': '/var/mail/cltbld', 16:29:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:47 INFO - 'MOZ_NO_REMOTE': '1', 16:29:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:47 INFO - 'NO_EM_RESTART': '1', 16:29:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:47 INFO - 'PWD': '/builds/slave/test', 16:29:47 INFO - 'SHELL': '/bin/bash', 16:29:47 INFO - 'SHLVL': '1', 16:29:47 INFO - 'TERM': 'linux', 16:29:47 INFO - 'TMOUT': '86400', 16:29:47 INFO - 'USER': 'cltbld', 16:29:47 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1503444530.970780-1478601249', 16:29:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:47 INFO - '_': '/tools/buildbot/bin/python'} 16:29:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:29:47 INFO - Running setup.py (path:/tmp/pip-M8jUQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:29:47 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)) 16:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:29:47 INFO - Running setup.py (path:/tmp/pip-zc5VBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:29:47 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)) 16:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:29:47 INFO - Running setup.py (path:/tmp/pip-0POqPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:29:47 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)) 16:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:29:47 INFO - Running setup.py (path:/tmp/pip-KTC00n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:29:47 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)) 16:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:29:47 INFO - Running setup.py (path:/tmp/pip-Bk7l34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:29:47 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)) 16:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:29:47 INFO - Running setup.py (path:/tmp/pip-BVaXym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:29:47 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)) 16:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:29:47 INFO - Running setup.py (path:/tmp/pip-zQ7CPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:29:47 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)) 16:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:29:47 INFO - Running setup.py (path:/tmp/pip-DQmZ5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:29:47 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)) 16:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:29:47 INFO - Running setup.py (path:/tmp/pip-BlN6db-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:29:47 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)) 16:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:29:47 INFO - Running setup.py (path:/tmp/pip-MPsPPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:29:48 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)) 16:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:29:48 INFO - Running setup.py (path:/tmp/pip-B_hwwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:29:48 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)) 16:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:29:48 INFO - Running setup.py (path:/tmp/pip-Av2icB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:29:48 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)) 16:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:29:48 INFO - Running setup.py (path:/tmp/pip-LF70YV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:29:48 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)) 16:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:29:48 INFO - Running setup.py (path:/tmp/pip-nLfYCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:29:48 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)) 16:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:29:48 INFO - Running setup.py (path:/tmp/pip-1ErBtp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:29:48 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)) 16:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:29:48 INFO - Running setup.py (path:/tmp/pip-OVRmeh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:29:48 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)) 16:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:29:48 INFO - Running setup.py (path:/tmp/pip-GqKWkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:29:48 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)) 16:29:48 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)) 16:29:48 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)) 16:29:48 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)) 16:29:48 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)) 16:29:48 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)) 16:29:48 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)) 16:29:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:29:48 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 16:29:48 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 16:29:48 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 16:29:48 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 16:29:49 INFO - Downloading blessings-1.6.tar.gz 16:29:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:29:49 INFO - Installing collected packages: blessings 16:29:49 INFO - Running setup.py install for blessings 16:29:49 INFO - Successfully installed blessings 16:29:49 INFO - Cleaning up... 16:29:49 INFO - Return code: 0 16:29:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:29:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:29:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:29:50 INFO - Reading from file tmpfile_stdout 16:29:50 INFO - Current package versions: 16:29:50 INFO - argparse == 1.2.1 16:29:50 INFO - blessings == 1.6 16:29:50 INFO - blobuploader == 1.2.4 16:29:50 INFO - docopt == 0.6.1 16:29:50 INFO - functools32 == 3.2.3-2 16:29:50 INFO - jsonschema == 2.5.1 16:29:50 INFO - manifestparser == 1.1 16:29:50 INFO - mozInstall == 1.13 16:29:50 INFO - mozcrash == 1.0 16:29:50 INFO - mozdebug == 0.1 16:29:50 INFO - mozdevice == 0.51 16:29:50 INFO - mozfile == 1.2 16:29:50 INFO - mozhttpd == 0.7 16:29:50 INFO - mozinfo == 0.10 16:29:50 INFO - mozleak == 0.1 16:29:50 INFO - mozlog == 3.5 16:29:50 INFO - moznetwork == 0.27 16:29:50 INFO - mozprocess == 0.25 16:29:50 INFO - mozprofile == 0.28 16:29:50 INFO - mozrunner == 6.13 16:29:50 INFO - mozscreenshot == 0.1 16:29:50 INFO - mozsystemmonitor == 0.3 16:29:50 INFO - moztest == 0.8 16:29:50 INFO - mozversion == 1.4 16:29:50 INFO - psutil == 3.1.1 16:29:50 INFO - requests == 1.2.3 16:29:50 INFO - wsgiref == 0.1.2 16:29:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:29: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')]} 16:29:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29: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')]} 16:29:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:50 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 0x1a871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c52a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df5f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df3130>, '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 0x1df4030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df44c0>, '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': '745a4373a2a16df560f216e000000264-1503444530.970780-1478601249', '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 16:29:50 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 16:29:50 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 16:29:50 INFO - Using env: {'DISPLAY': ':0', 16:29:50 INFO - 'HOME': '/home/cltbld', 16:29:50 INFO - 'LANG': 'en_US.UTF-8', 16:29:50 INFO - 'LANGUAGE': 'en_US:en', 16:29:50 INFO - 'LOGNAME': 'cltbld', 16:29:50 INFO - 'MAIL': '/var/mail/cltbld', 16:29:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:50 INFO - 'MOZ_NO_REMOTE': '1', 16:29:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:50 INFO - 'NO_EM_RESTART': '1', 16:29:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:50 INFO - 'PWD': '/builds/slave/test', 16:29:50 INFO - 'SHELL': '/bin/bash', 16:29:50 INFO - 'SHLVL': '1', 16:29:50 INFO - 'TERM': 'linux', 16:29:50 INFO - 'TMOUT': '86400', 16:29:50 INFO - 'USER': 'cltbld', 16:29:50 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1503444530.970780-1478601249', 16:29:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:50 INFO - '_': '/tools/buildbot/bin/python'} 16:29:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:50 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)) 16:29:50 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)) 16:29:50 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)) 16:29:50 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)) 16:29:50 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)) 16:29:50 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)) 16:29:50 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)) 16:29:50 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)) 16:29:50 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)) 16:29:50 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:29: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 16:29: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 16:29: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 16:29: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 16:29:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:29:51 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)) 16:29:51 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)) 16:29:51 INFO - Installing collected packages: simplejson 16:29:51 INFO - Running setup.py install for simplejson 16:29:51 INFO - building 'simplejson._speedups' extension 16:29:51 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 16:29:52 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 16:29:52 INFO - Successfully installed simplejson 16:29:52 INFO - Cleaning up... 16:29:52 INFO - Return code: 0 16:29:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:29: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')]} 16:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29: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')]} 16:29:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c52a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df5f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df3130>, '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 0x1df4030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df44c0>, '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': '745a4373a2a16df560f216e000000264-1503444530.970780-1478601249', '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 16:29: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'] in /builds/slave/test/build 16:29: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 16:29:52 INFO - Using env: {'DISPLAY': ':0', 16:29:52 INFO - 'HOME': '/home/cltbld', 16:29:52 INFO - 'LANG': 'en_US.UTF-8', 16:29:52 INFO - 'LANGUAGE': 'en_US:en', 16:29:52 INFO - 'LOGNAME': 'cltbld', 16:29:52 INFO - 'MAIL': '/var/mail/cltbld', 16:29:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:52 INFO - 'MOZ_NO_REMOTE': '1', 16:29:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:52 INFO - 'NO_EM_RESTART': '1', 16:29:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:52 INFO - 'PWD': '/builds/slave/test', 16:29:52 INFO - 'SHELL': '/bin/bash', 16:29:52 INFO - 'SHLVL': '1', 16:29:52 INFO - 'TERM': 'linux', 16:29:52 INFO - 'TMOUT': '86400', 16:29:52 INFO - 'USER': 'cltbld', 16:29:52 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1503444530.970780-1478601249', 16:29:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:52 INFO - '_': '/tools/buildbot/bin/python'} 16:29:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:29:52 INFO - Cleaning up... 16:29:52 INFO - Return code: 0 16:29:52 INFO - Running post-action listener: _resource_record_post_action 16:29:52 INFO - Running post-action listener: _start_resource_monitoring 16:29:52 INFO - Starting resource monitoring. 16:29:52 INFO - [mozharness: 2017-08-22 23:29:52.889215Z] Finished create-virtualenv step (success) 16:29:52 INFO - [mozharness: 2017-08-22 23:29:52.889903Z] Running install step. 16:29:52 INFO - Running pre-action listener: _resource_record_pre_action 16:29:52 INFO - Running main action method: install 16:29:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:29:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:29:53 INFO - Reading from file tmpfile_stdout 16:29:53 INFO - Detecting whether we're running mozinstall >=1.0... 16:29:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:29:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:29:53 INFO - Reading from file tmpfile_stdout 16:29:53 INFO - Output received: 16:29:53 INFO - Usage: mozinstall [options] installer 16:29:53 INFO - Options: 16:29:53 INFO - -h, --help show this help message and exit 16:29:53 INFO - -d DEST, --destination=DEST 16:29:53 INFO - Directory to install application into. [default: 16:29:53 INFO - "/builds/slave/test"] 16:29:53 INFO - --app=APP Application being installed. [default: firefox] 16:29:53 INFO - mkdir: /builds/slave/test/build/application 16:29:53 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'] 16:29:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:30:10 INFO - Reading from file tmpfile_stdout 16:30:10 INFO - Output received: 16:30:10 INFO - /builds/slave/test/build/application/firefox/firefox 16:30:10 INFO - Running post-action listener: _resource_record_post_action 16:30:10 INFO - [mozharness: 2017-08-22 23:30:10.973034Z] Finished install step (success) 16:30:10 INFO - [mozharness: 2017-08-22 23:30:10.973180Z] Running setup-mitmproxy step. 16:30:10 INFO - Running pre-action listener: _resource_record_pre_action 16:30:10 INFO - Running main action method: setup_mitmproxy 16:30:10 INFO - Skipping: mitmproxy is not required 16:30:10 INFO - Running post-action listener: _resource_record_post_action 16:30:10 INFO - [mozharness: 2017-08-22 23:30:10.974247Z] Finished setup-mitmproxy step (success) 16:30:10 INFO - [mozharness: 2017-08-22 23:30:10.974459Z] Running run-tests step. 16:30:10 INFO - Running pre-action listener: _resource_record_pre_action 16:30:10 INFO - Running pre-action listener: _set_gcov_prefix 16:30:10 INFO - Running main action method: run_tests 16:30:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:30:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:30:10 INFO - Python 2.7.3 16:30:10 INFO - Return code: 0 16:30:10 INFO - grabbing minidump binary from tooltool 16:30:10 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')]} 16:30:10 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df3130>, '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 0x1df4030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df44c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:30:10 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:30:10 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:30:10 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:30:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:30:11 INFO - Return code: 0 16:30:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:30:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:30:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:30:11 INFO - ENV: RUST_BACKTRACE is now full 16:30:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:30:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:30:11 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/KRW8BKGhS3m3qhpOl1dvTA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 16:30:11 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/KRW8BKGhS3m3qhpOl1dvTA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 16:30:11 INFO - Using env: {'DISPLAY': ':0', 16:30:11 INFO - 'HOME': '/home/cltbld', 16:30:11 INFO - 'LANG': 'en_US.UTF-8', 16:30:11 INFO - 'LANGUAGE': 'en_US:en', 16:30:11 INFO - 'LOGNAME': 'cltbld', 16:30:11 INFO - 'MAIL': '/var/mail/cltbld', 16:30:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:30:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:30:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:11 INFO - 'MOZ_NO_REMOTE': '1', 16:30:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:30:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:11 INFO - 'NO_EM_RESTART': '1', 16:30:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:11 INFO - 'PWD': '/builds/slave/test', 16:30:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:30:11 INFO - 'RUST_BACKTRACE': 'full', 16:30:11 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:30:11 INFO - 'SHELL': '/bin/bash', 16:30:11 INFO - 'SHLVL': '1', 16:30:11 INFO - 'STYLO_FORCE_ENABLED': '1', 16:30:11 INFO - 'TERM': 'linux', 16:30:11 INFO - 'TMOUT': '86400', 16:30:11 INFO - 'USER': 'cltbld', 16:30:11 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1503444530.970780-1478601249', 16:30:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:11 INFO - '_': '/tools/buildbot/bin/python'} 16:30:11 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/KRW8BKGhS3m3qhpOl1dvTA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 16:30:11 INFO - mozversion application_buildid: 20170822224030 16:30:11 INFO - mozversion application_changeset: 80fafbaaf8484104018976c2a0442c91805d3554 16:30:11 INFO - mozversion application_display_name: Nightly 16:30:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:30:11 INFO - mozversion application_name: Firefox 16:30:11 INFO - mozversion application_remotingname: firefox 16:30:11 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:30:11 INFO - mozversion application_vendor: Mozilla 16:30:11 INFO - mozversion application_version: 57.0a1 16:30:11 INFO - mozversion platform_buildid: 20170822224030 16:30:11 INFO - mozversion platform_changeset: 80fafbaaf8484104018976c2a0442c91805d3554 16:30:11 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:30:11 INFO - mozversion platform_version: 57.0a1 16:30:11 INFO - using testdate: 1503444611 16:30:11 INFO - actual date: 1503444611 16:30:11 INFO - starting webserver on 'localhost:55294' 16:30:11 INFO - SUITE-START | Running 2 tests 16:30:11 INFO - TEST-START | dromaeo_css 16:30:11 INFO - Initialising browser for dromaeo_css test... 16:30:12 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55294/getInfo.html -profile /tmp/tmpCt0KvG/profile 16:30:12 INFO - TEST-INFO | started process 3349 (/builds/slave/test/build/application/firefox/firefox http://localhost:55294/getInfo.html) 16:30:20 INFO - TEST-INFO | 3349: exit 0 16:30:21 INFO - Browser initialized. 16:30:21 INFO - Running cycle 1/1 for dromaeo_css test... 16:30:21 INFO - TEST-INFO | started process 3591 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCt0KvG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:30:22 INFO - PID 3591 | 16:30:22 INFO - PID 3591 | (/builds/slave/test/build/application/firefox/firefox:3641): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:30:22 INFO - PID 3591 | 16:30:22 INFO - PID 3591 | 16:30:22 INFO - PID 3591 | (/builds/slave/test/build/application/firefox/firefox:3700): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:30:22 INFO - PID 3591 | 16:30:22 INFO - PID 3591 | __metrics Screen width/height:1600/1200 16:30:22 INFO - PID 3591 | colorDepth:24 16:30:22 INFO - PID 3591 | Browser inner width/height: 1024/768 16:30:22 INFO - PID 3591 | __metrics 16:30:32 INFO - PID 3591 | RSS: Main: 174108672 16:30:32 INFO - PID 3591 | 16:33:31 INFO - PID 3591 | Cycle 1(1): loaded http://localhost:55294/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55294/tests/dromaeo/cssquery-ext.html) 16:33:32 INFO - PID 3591 | RSS: Main: 178360320 16:33:32 INFO - PID 3591 | 16:36:34 INFO - PID 3591 | Cycle 1(1): loaded http://localhost:55294/tests/dromaeo/cssquery-ext.html (next: http://localhost:55294/tests/dromaeo/cssquery-jquery.html) 16:36:35 INFO - PID 3591 | RSS: Main: 175345664 16:36:35 INFO - PID 3591 | 16:39:37 INFO - PID 3591 | Cycle 1(1): loaded http://localhost:55294/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55294/tests/dromaeo/cssquery-mootools.html) 16:39:37 INFO - PID 3591 | RSS: Main: 175513600 16:39:37 INFO - PID 3591 | 16:42:39 INFO - PID 3591 | Cycle 1(1): loaded http://localhost:55294/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55294/tests/dromaeo/cssquery-prototype.html) 16:42:40 INFO - PID 3591 | RSS: Main: 175259648 16:42:40 INFO - PID 3591 | 16:45:43 INFO - PID 3591 | Cycle 1(1): loaded http://localhost:55294/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55294/tests/dromaeo/cssquery-yui.html) 16:45:44 INFO - PID 3591 | RSS: Main: 176881664 16:45:44 INFO - PID 3591 | 16:48:46 INFO - PID 3591 | Cycle 1(1): loaded http://localhost:55294/tests/dromaeo/cssquery-yui.html (next: http://localhost:55294/tests/dromaeo/cssquery-dojo.html) 16:48:46 INFO - PID 3591 | RSS: Main: 179429376 16:48:46 INFO - PID 3591 | 16:48:46 INFO - PID 3591 | __start_tp_report 16:48:46 INFO - PID 3591 | _x_x_mozilla_page_load 16:48:46 INFO - PID 3591 | _x_x_mozilla_page_load_details 16:48:46 INFO - PID 3591 | |i|pagename|runs| 16:48:46 INFO - PID 3591 | |0;dojo.html;3255.8534865931033;3291.4240007998596;3301.1912081540027;3322.867085316587;3328.2844188499466;6193.411625895533;6230.158928544651;6255.718492667824;6293.622382657044;6315.621062736228;6034.24571928509;6107.2976607690125;6130.0804879268135;6155.230596175478;6175.950088484957;5614.99999999999;5627.324721033461;5647.407022262665;5674.09214525676;5710.514606258473;5642.6614403135945;5670.688112153851;5734.770609175649;5770.307563092414;5802.622829516068;5687.772489100452;5741.167530708045;5768.250127483442;5777.913331300013;5804.332501762309;5549.223108764776;5616.550675945955;5630.746616402272;5702.54379649627;5705.48650621444;5632.5212356949705;5668.971655141698;5674.233978412903;5675.432456754333;5676.659400435987;5914.497267732248;6023.45788879003;6066;6090.086487026937;6112.694365281718;6510.64191469469;6592.373724496213;6606.207255129367;6687.030380594787;6687.933120668779;6637.203535575713;6644.900326495106;6729.158855143107;6752.189737231563;6774.0854984576945;6193.504519638418;6261.436470717612;6280.340564240689;6284.591501552431;6287.591306565058;6838.692258848364;6839.863202735917;6885.380315771605;6946.7221311148;6977.686004129826;6408.166938297992;6509.707063182168;6510.21877374718;6595.340465953366;6641.767538136142;6645;6649.667516624149;6650.800475985729;6658.300878407697;6694.129763130859;6462.935370646327;6620.470362370998;6637.402633762985;6646.401823835878;6653.667316634246;6581.14445122131;6581.440577550962;6605.603663780189;6661.500387470959;6676.566023208573;5151.974240128776;5230.163173892159;5231.843044708665;5241.50205730455;5252.107141785829;4621.098885717252;4622.052479241747;4631.62946964242;4631.652626053059;4679.789409476582;5770.076787713946;5839.065749480063;5847.356790753014;5849.210356601804;5850.824475265664;6654.3345665434035;6658.067870498134;6665.366790154928;6753.189617245962;6767.458603311822;5625.268715067015;5777.162311464814;5830.62100963436;5840.795572154954;5853.0635098384055;5594.468525490072;5638.633488823295;5689.6586204827845;5712.400197979236;5723.313202415654;6333.113364129025;6400.647964362005;6412.326705695835;6416.647084410402;6464.159659244362;6646.867062658816;6729.596224226562;6729.663516824041;6737.797866063928;6749.595024298362;6388.105665206967;6391.137196478416;6483.513736469878;6494.350564943468;6494.740210391531;6410.134631824644;6492.026196070438;6515.869682606416;6535.379138981789;6621.702023408862;6570.408663220333;6606.108175396452;6623.834404139742;6627.569208001464;6642.634655094016;6401.167848179707;6405.807825765234;6406.167198264196;6407.8718425630295;6449.258335291502;6456.903146452713;6458.677066146768;6480;6543.5419520633095;6550.181227346582;6395.136656551306;6411.8717625646295;6478.157839481026;6495.610263384212;6504.15445992018;6311.842203944938;6423.614583125028;6477.255115661571;6478;6512.544121911421;6268.937310626835;6279.748810047547;6307.148534947723;6312.179416675803;6316.747330106744 16:48:46 INFO - PID 3591 | |1;ext.html;764.4686942574913;851.306185458851;869.7477731457877;1094.8193548064569;1114.6377427336117;28784.856075719617;38433;38725;38915.610843891554;38996.02509937249;38817.80591097048;39210;39257;39268.607313926856;39304;7363.9631801840915;7514.887276690854;7545.207753185919;7557.508761930484;7562.810929726746;7253.274672532757;7306.452016098814;7320.8169795755;7324.560526368408;7330.266973302654;6924.930750692504;7108;7548.5093468924615;7549.584772837492;7557.622118894061;7476.551406915575;7544.547327160333;7548.018757561536;7551.320381165721;7554.811129721746;7419.10970683516;7423.109226892808;7423.480356375056;7457.627118644046;7501.324880760703;35202.29595408103;35245.647543524494;35409.82295088508;35437.29125417477;35519.64480355189;3288.19439237386;3319.336132773431;3325.8503367348526;3326.534285200074;3329.6337402885665;29462.558061629094;29689.851550742107;29841.552376714368;29896;29914.252143696365;4968.30443737877;4989.501049895018;5013.6490445668815;5019.3976722793495;5033.672811267293;180685;182492;182551.08724456426;183287.08356458266;183704;44485;44589.32464052102;44627.10745785131;44658.33012504815;44667.77666111714;46750.766246168554;46797.766011169726;46844.7657761709;46864;46870.062598747834;14612.561623151323;14905.25473726331;14938.402463901539;14940.850591494163;15064.171470569225;12415.255084694767;12480.375981200903;12608.180468269533;12621.93689031549;12630.684232894067;12031.578894738817;13530.45878164882;13622.182669039888;13702.657433564042;13736.519221827188;4867.561919427269;5454.509094181542;5458.208559758813;5477.260569823103;5484.341878974469;988.1156365053381;988.4958671077802;997.9101880830615;1003.372891942536;1006.1992612588433;21772.237971670915;21956.89021554882;22001.449963751034;22020.449488762588;22186.1304202251;1069.1553672598716;1083.9458027098613;1085.9076978456762;1090.3893819460968;1109.312226419625;11607.187496875138;11632.941835290769;11633.88366116328;11658.475368608433;11694.94152529249;230710;231845;233010;233719;233799;47787.28319075217;48064.27903581449;48099.75950120297;48395.27407088896;48484.515154848;1339.2767905331207;1351.6012776231034;1353.0528629958872;1361.8025386318927;1383.4466213514675;21307.25424610131;21588;21619.13523459044;21684.24105156312;21814.672779907996;32909;33021.83489082539;33031.17422064468;33033;33082.33835323328;189967;189995;190782;190936;191883;30545.694543055175;30824.537631935986;30834.074977750704;31299;31473.685263147076;34325.31349372949;35005.47491787676;39537.209255815294;39673.60326396814;39685.60314396935;29372.11883643494;29393.412131757672;29483.410331792817;29599.26001849971;29749.256268593457;29101.7089829099;29410.852945735136;29441.558376624795;29589;29720.851395742884;32885;32967.83516082404;33099.83450082734;33196.170095746835;33223;28434.85782571074;29075.7092429073;29196.124116276547;29613.85193074021;31361.686383135875;23533.882330588924;23722.169724059575;23809.880950595136;23851.642225366286;23902.402439939142 16:48:46 INFO - PID 3591 | |2;jquery.html;536.337623035551;545.9181122831573;549.3572520151425;550.0528130418319;552.8590209496579;21667.891660541696;22433.32700018998;22467;22469.55060898781;22569.210077647287;25325.493490130233;25717.22848314549;25781.226563203134;25844.870775646097;25983.870080649616;6348.492120630339;6489.675516224193;6492.7402903883785;6498.3826536478955;6499.545031847772;6217.720202590872;6372.203474565679;6407.231132264134;6501.9349806501805;6514.869702605945;6447.516436267275;6458.192725909262;6471.449926756231;6482.481401487869;6487.6756162191705;6451.516136289773;6453.12882760826;6455.193100862392;6458.225012998423;6467.159269295009;5979.312379076375;5997.310309314441;6016.548758843104;6019.759209631609;6024.427679370453;27993.160205193875;28868.42263154725;29104.708952910623;29335.266618334714;29736.40527189466;2038.0930485933766;2068.2761033638258;2085.8644188127723;2086.050846864673;2090.519180588458;18814.717779233324;19402.4179274622;19403.4178974631;19430.70853937192;19435.12541935616;2324.198151637699;2325.081592770863;2395.4610212702178;2398.112698301622;2417.6615273861676;131715;137825;137830;138062.3096884509;138356.30821845928;14071.788923166161;14865.777013344808;14946.551603451913;14961.625959351104;15454.536363909101;22677.319680409615;42460.57539424628;44210;44226.778866106106;44296.3355549667;10897.945510272399;11422.603342128436;11425.257358271685;11488.425578721031;11916.225445346197;9681.37071090377;9791.314607977516;9801.362911410735;9940.900590994142;10099.94950025245;10973.780524389627;11121.72195695098;11211.887881121085;11262.38056906878;11766.411679415995;3427.5715535558056;3728.2729867675544;3816.4275358695863;4095.8936245613836;4194.832206711759;925.1627277314042;938.7559234599054;963.7253382785873;968.7578105473632;968.9370190937567;19482.112232281772;19695.60608787816;19732.40802775919;20052.29816956429;20181.49546261355;1013.4172850610928;1013.9391636501833;1014.7919676466307;1024.2727663359099;1028.3007554862766;10909.34543927367;11167;11168.106551475863;11174;11306.604268850551;443017;448125;452494;454965;457909;112562.43718781354;114196.42901785437;114864.42567787107;116707;117105.41447292709;1154.168998321224;1154.8671902731126;1184.2894263442038;1186.211169572242;1186.8041773107514;17961.73057404114;18106.823056501285;18124.184411701768;18357.3574924877;18586.349477768756;57167;58338.7083064582;58636.41363586309;59363;59910;66252.33747662461;66450.66774666095;66574.33425665682;66612.33387666062;66645.33354666391;14372.425102996182;14721.116732996055;14833.777493337393;14857.108573485626;15004.849951500346;24006.39984000344;24035.27894163178;24043.51912961766;24159;24303.635445468684;18948.052597369802;19020.904895475433;19106.426807195807;19147.04264786727;19183.904080479508;16872.57818554546;17075.65848683044;17174.742378864077;17215.483535493957;17901.64196716032;19186.61626767429;19234.134463948874;19347;19551.902240488707;19656.213751450356;14623.634409139857;14624.122552646875;14691.632709182357;14737.631559210677;14805.851941480447;19024;19069;19110;19122.61754764869;19231.711524326867 16:48:46 INFO - PID 3591 | |3;mootools.html;1244.551961293934;1324.2451802472594;1339.2634051271805;1339.5646414915152;1348.986510134899;14404.567862964115;15073.39706411745;15221.847781522181;15271.694566108672;15289.082655040691;15154.166520841376;15456.459023934165;15483.14842683652;15492.070475771461;15493;2510.447701505666;2696.3933115049153;2699.0283497940727;2759.0067575672742;2766.363736340643;2707.742764437385;2735.124760076776;2739.8356098634144;2740.8355498670144;2743.2044707035034;2631.289551821007;2660.467906418724;2665.78673706104;2698.811083224175;2761.4753196892625;2634.841909485418;2648.827826191301;2656.296081538394;2676.678798544168;2681.6647919010124;2618.56793629051;2636.380450594109;2654.641623380838;2656.335916020995;2657.136430660043;14268.429262829475;14609.269536523132;14887.627809304746;14951.925240373728;14955.850441495555;7778.922210777876;8102.635381407851;8145.75562733113;8149.144339844291;8154;5373.731313434352;5378.677279363251;5417.322834645669;5543.556515478793;5553.194786755897;1878.2674756844842;1890.867639265252;1903.3243198664413;1911.1399870058528;1932.8357089647398;25634.48731025369;25884.611730824054;25896.611550826754;25899.223023309332;25914.22257332264;6472.385123413268;6515.967420162869;6564.522982328937;6767.255601883789;6843.965780171166;15396.153211573246;15432.92283538575;15448.459303924308;15449.459268925533;15457.84542154564;7650.923490765133;7776.5334079954255;7789.649465774054;7794.9220507795335;7811.453198276066;6022.728977196037;7181.964090179516;7196.244394338623;7290.927090729131;7305.159906610807;4874.926876096862;5063.518965698253;5120.257562653469;5123.180291153398;5158.226266060121;1457.30049576204;1476.6234610174338;1480.6372438752574;1490.3814916809404;1496.5959191018364;872.5506364222431;882.8940527136656;888.657866721317;899.1592860675289;907.5961197267285;8897.688580899638;8913.598888050054;9010.909890901006;9047.547622618842;9119.863202051974;962.5235508423235;968.5544649461186;985.3644399362371;987.511181964932;994.3487016004528;5038.118329292359;5094.974525127351;5112.6421150519855;5129.897402052013;5257.395399529027;20218.292359767336;21218.681719774217;21283.148674053173;21475.140994360365;21508;20499.487512812;20951.266705665534;21036.57926841485;21147.154113835582;21184.04671789773;10850.186236032328;11073;11200.887991119984;11242.55029798799;11251.268667536584;7929.960350198443;8016.599170041592;8318.627426474564;8349.12334204924;8369.748907532783;18161.818381816014;18277.177527011052;18508;18732.719009215147;18905.810941890406;18348.633027339645;18478;18565.164567594762;18672.346467873558;18803.717944230575;10159.593616255266;11132;11766.235194712317;11810.940945295219;11836.822447663464;13265.336733163496;13354.93322533381;13375.933120334335;13378.464861405435;13400.530981415604;10521.421321827373;10678.145748339959;10728.731781705208;10753.946230268799;10791.946040269748;9759.609615615296;9848;9875.259355548505;9896.851547226941;10067.1442927352;9750.31747777677;9820.263480238867;9832.065953734384;9835.21318294549;9865.852012219966;7370.63146842645;7442.813929651802;7500.399968002437;7509.9249007509225;7510.586917719578;7252.492325537372;7324.194338622854;7385.29839665231;7419.109706835215;7440.73957411488 16:48:46 INFO - PID 3591 | |4;prototype.html;484.5735752537766;497.93775778027737;511.19486808276963;518.1398877862746;519.742727349962;6136.601120927142;6165.969170154143;6217.9378206217925;6246.406591373812;6252.562320637558;6052.969735151318;6101.328853826076;6117.938820611793;6123.326434092258;6152.169457123298;5046.924296135561;5080.263361812535;5091.389033316007;5114.335136432268;5116.616253780962;4767.641222251659;4947.802087916479;5063.468335824722;5080.034793389244;5095.898082038357;4860.465348811628;4870.512948705119;4876.634252431064;4880.438259756879;4913.238448040559;4852.466228714874;4867.440244371889;4882.438519570223;4908.165611845995;4919.409670839486;4313.633341166004;4383.802728877176;4401.801918913625;4436.822527098912;4439.1121775645;5992.161097446317;5999.490043346321;6011.12838638395;6011.519078473755;6024.789132380346;5661.547076233891;5686.943130568683;5707.146426786607;5708.144852922816;5720.768900128953;6526.869462610769;6565.737370505221;6573.967130164367;6574.704138313739;6583.604983700945;4807.884530806434;4842.394700662418;4844.75776211188;4855.247436647325;4856.125897338477;6430.807075787687;6627.635480048595;6715.294894036105;6749.662516874137;6883.7590684325805;4910.53349931763;4937.518744376673;4952.603791696655;4964.35463389757;4964.652474326763;5029.17018691919;5032.396112466454;5038.521340472649;5053.166227572483;5057.216131499624;5624.578156638187;5673.461021202979;5678.77284908599;5679.943200568024;5690.857728556819;6614.933850661528;6617.503687223478;6648.833779155463;6659.766908158192;6670.232923213795;1735.8871673341193;1740.5213566269376;1753.9210735516933;1755.2540170427517;1761.9647607047787;1140.4411838199223;1195.5636192789743;1205.6021512900722;1216.191232830158;1217.9512819487122;5807.186993820868;5816.563757718188;5838.5621078418435;5839.240898683144;5861.531077513789;6727.697253623599;6740.460763138937;6741.831454213586;6778.661066946732;6782.355676210752;5803.955288048108;5811.4018644872995;5822.70886455684;5826.708664566755;5855.941440585625;3542.822858857047;3546.7871927684423;3562.5952482074495;3565.5186549815962;3592.317459682652;6459.870802584016;6466.191726034246;6494.870102597922;6500.447461965691;6565.901511477332;6856.931430685729;6876.346747059021;6881.311868813079;6886.51794374399;6904.206016308089;6492.156019717407;6496.935030649727;6498.707558159799;6517;6526.28210896801;6695.665216739241;6734.898976515454;6751.93248067513;6779.15260592426;6786.948023056434;6680.899786503303;6689.364510371507;6690.632015239208;6702.798916032527;6703.832404189934;5789.652620842763;6439.452646525097;6453;6473.546851720334;6483.902741458976;4923.113839508923;4940.456549779449;4949.554540091409;4957.479464656303;4976.2286845539;6438.29178790342;6546.770863019771;6648.368405001517;6697.497687673346;6745.730170793114;6408.807735767934;6455.741770329134;6469.935300646934;6486.6756662167645;6522.977876858189;6359.332270111571;6384.297727249906;6396.968015159894;6457.580257283262;6539.901901471387;6391.744330226739;6457.515686323639;6489.9026514603265;6500.837479063061;6501.934980650322;6540.967295163494;6563.671816409256;6581.5392922496885;6592.70332835014;6608.380946667905;6287.528435367274;6298.779542716166;6317.557770955989;6348.746050157942;6372.362763723776 16:48:46 INFO - PID 3591 | |5;yui.html;835.2941764209241;856.8157846063095;863.1756672377884;873.3188113271647;882.9470231786094;18848.246070157194;19454.221831126757;19454.513637159078;19467.31864384747;19500.51248718783;17046.74429883553;17257.654846903053;17291.30834766611;17357.39249126281;17444.47666570002;936.4053825820619;960.5389413081725;961.3654987708114;962.2206013129388;963.9132478077007;899.2626046641757;937.4328531238605;937.8827646544182;940.1585580905086;941.7033634405141;986.0927946289395;1009.1271050541302;1010.5200029985734;1010.6159659329481;1011.0193112680688;954.1651055326589;993.8409854423294;995.2286977592388;995.3082607587729;1000.5047501486738;712.1240873725346;714.2999860137043;717.1179449277366;720.1933834105782;720.4992530191519;17068;17069.914650426792;17164.570885727833;17169.82830171695;17261.395851145277;20036.1985520579;20806.58386832255;20956.371308860605;21059.789402105936;21129.260475883424;16027.759583606256;16868.325266989305;16946.491605251864;16962.575935601708;16982.15089245545;3596.280743851214;3615.5842078161086;3616.059824445637;3630.2920930418577;3630.419132938717;120049.39975300155;120921.39539302247;122569.38715306544;122998;124561;14499.855001450062;14957.102573845386;14959.850401496064;14974.550763477113;15251.237438128272;28963.56554651682;29117.980870669424;29130.126096217147;29393.11820645384;29469.410611787644;8887.688930887389;9005.954970225106;9126.178643921947;9219.262459003263;9232.8615070774;4158.251514727318;4318.546552611993;4331.112122014979;4336.566343365701;4336.934945975813;5194.506521880416;5231.686098834082;5285.418603953562;5298.947010529845;5324.733763311819;1012.86832711747;1026.1841835740604;1039.656913218636;1041.3491567770143;1042.2912419554625;654.7773756922574;660.923993740726;672.7914346552584;677.7051982387677;687.1959807025792;10708.768152777431;11229.66311010671;11651;11765.235259708092;12684.746305074032;640.4108220437209;650.2099948562425;655.7803135949415;657.3163909534031;671.1275342055407;5219.869503262449;5482.068048431776;5484.314460692413;5576;5692.0608099663095;108962.45518772355;111488.4425577867;111648.44175779069;111995;116536.41731791287;95134.52432737792;100849;102159.48920255351;105549.47225263978;105647;87760.56119719234;87985.56007219922;90342;92704;92760;11507.769844603228;11902.515016702104;12025.699357516132;12123.272603643809;12191.75616487683;38795.80602097084;40772.98067548335;41135.7943210282;41672.166556669305;43266;73151.26848731445;74085.62957185395;74389;75055.24944750483;76141.23858761563;17727.468175954742;17863.374781882572;18034.639307214045;18038.5490362742;18246.270149193882;20537.691934620692;21083.367498975054;21214.25750098739;21641.45896352541;21699.132034718434;16201.4329498467;16843.24205410784;17531.912340438215;17618.207180677156;17643.29426822913;15453.613659658598;16800.915995419946;17301.048442335792;17325;17509.474715758548;16446.83553164501;16696.916515417346;17470.213840377466;17811;17899.552511187325;12002.21985570935;12246.755064898474;12564.497420103093;12587.559435419716;12647.304398258184;12964.870351296366;13193;13204.141730787467;13363.66590835198;13471.719767470559 16:48:46 INFO - PID 3591 | __end_tp_report 16:48:46 INFO - PID 3591 | __start_cc_report 16:48:46 INFO - PID 3591 | _x_x_mozilla_cycle_collect,379 16:48:46 INFO - PID 3591 | __end_cc_report 16:48:46 INFO - PID 3591 | __startTimestamp1503445726286__endTimestamp 16:48:46 INFO - PID 3591 | 16:48:46 INFO - PID 3591 | ------- Summary: start ------- 16:48:46 INFO - PID 3591 | Number of tests: 6 16:48:46 INFO - PID 3591 | 16:48:46 INFO - PID 3591 | [#0] dojo.html Cycles:165 Average:6112.71 Median:6388.11 stddev:705.52 (11.0%) stddev-sans-first:671.15 16:48:46 INFO - PID 3591 | Values: 3255.9 3291.4 3301.2 3322.9 3328.3 6193.4 6230.2 6255.7 6293.6 6315.6 6034.2 6107.3 6130.1 6155.2 6176.0 5615.0 5627.3 5647.4 5674.1 5710.5 5642.7 5670.7 5734.8 5770.3 5802.6 5687.8 5741.2 5768.3 5777.9 5804.3 5549.2 5616.6 5630.7 5702.5 5705.5 5632.5 5669.0 5674.2 5675.4 5676.7 5914.5 6023.5 6066.0 6090.1 6112.7 6510.6 6592.4 6606.2 6687.0 6687.9 6637.2 6644.9 6729.2 6752.2 6774.1 6193.5 6261.4 6280.3 6284.6 6287.6 6838.7 6839.9 6885.4 6946.7 6977.7 6408.2 6509.7 6510.2 6595.3 6641.8 6645.0 6649.7 6650.8 6658.3 6694.1 6462.9 6620.5 6637.4 6646.4 6653.7 6581.1 6581.4 6605.6 6661.5 6676.6 5152.0 5230.2 5231.8 5241.5 5252.1 4621.1 4622.1 4631.6 4631.7 4679.8 5770.1 5839.1 5847.4 5849.2 5850.8 6654.3 6658.1 6665.4 6753.2 6767.5 5625.3 5777.2 5830.6 5840.8 5853.1 5594.5 5638.6 5689.7 5712.4 5723.3 6333.1 6400.6 6412.3 6416.6 6464.2 6646.9 6729.6 6729.7 6737.8 6749.6 6388.1 6391.1 6483.5 6494.4 6494.7 6410.1 6492.0 6515.9 6535.4 6621.7 6570.4 6606.1 6623.8 6627.6 6642.6 6401.2 6405.8 6406.2 6407.9 6449.3 6456.9 6458.7 6480.0 6543.5 6550.2 6395.1 6411.9 6478.2 6495.6 6504.2 6311.8 6423.6 6477.3 6478.0 6512.5 6268.9 6279.7 6307.1 6312.2 6316.7 16:48:46 INFO - PID 3591 | 16:48:46 INFO - PID 3591 | [#1] ext.html Cycles:180 Average:35686.94 Median:18086.60 stddev:52648.75 (291.1%) stddev-sans-first:52731.14 16:48:46 INFO - PID 3591 | Values: 764.5 851.3 869.7 1094.8 1114.6 28784.9 38433.0 38725.0 38915.6 38996.0 38817.8 39210.0 39257.0 39268.6 39304.0 7364.0 7514.9 7545.2 7557.5 7562.8 7253.3 7306.5 7320.8 7324.6 7330.3 6924.9 7108.0 7548.5 7549.6 7557.6 7476.6 7544.5 7548.0 7551.3 7554.8 7419.1 7423.1 7423.5 7457.6 7501.3 35202.3 35245.6 35409.8 35437.3 35519.6 3288.2 3319.3 3325.9 3326.5 3329.6 29462.6 29689.9 29841.6 29896.0 29914.3 4968.3 4989.5 5013.6 5019.4 5033.7 180685.0 182492.0 182551.1 183287.1 183704.0 44485.0 44589.3 44627.1 44658.3 44667.8 46750.8 46797.8 46844.8 46864.0 46870.1 14612.6 14905.3 14938.4 14940.9 15064.2 12415.3 12480.4 12608.2 12621.9 12630.7 12031.6 13530.5 13622.2 13702.7 13736.5 4867.6 5454.5 5458.2 5477.3 5484.3 988.1 988.5 997.9 1003.4 1006.2 21772.2 21956.9 22001.4 22020.4 22186.1 1069.2 1083.9 1085.9 1090.4 1109.3 11607.2 11632.9 11633.9 11658.5 11694.9 230710.0 231845.0 233010.0 233719.0 233799.0 47787.3 48064.3 48099.8 48395.3 48484.5 1339.3 1351.6 1353.1 1361.8 1383.4 21307.3 21588.0 21619.1 21684.2 21814.7 32909.0 33021.8 33031.2 33033.0 33082.3 189967.0 189995.0 190782.0 190936.0 191883.0 30545.7 30824.5 30834.1 31299.0 31473.7 34325.3 35005.5 39537.2 39673.6 39685.6 29372.1 29393.4 29483.4 29599.3 29749.3 29101.7 29410.9 29441.6 29589.0 29720.9 32885.0 32967.8 33099.8 33196.2 33223.0 28434.9 29075.7 29196.1 29613.9 31361.7 23533.9 23722.2 23809.9 23851.6 23902.4 16:48:46 INFO - PID 3591 | 16:48:46 INFO - PID 3591 | [#2] jquery.html Cycles:180 Average:34252.29 Median:11879.21 stddev:76475.70 (643.8%) stddev-sans-first:76648.33 16:48:46 INFO - PID 3591 | Values: 536.3 545.9 549.4 550.1 552.9 21667.9 22433.3 22467.0 22469.6 22569.2 25325.5 25717.2 25781.2 25844.9 25983.9 6348.5 6489.7 6492.7 6498.4 6499.5 6217.7 6372.2 6407.2 6501.9 6514.9 6447.5 6458.2 6471.4 6482.5 6487.7 6451.5 6453.1 6455.2 6458.2 6467.2 5979.3 5997.3 6016.5 6019.8 6024.4 27993.2 28868.4 29104.7 29335.3 29736.4 2038.1 2068.3 2085.9 2086.1 2090.5 18814.7 19402.4 19403.4 19430.7 19435.1 2324.2 2325.1 2395.5 2398.1 2417.7 131715.0 137825.0 137830.0 138062.3 138356.3 14071.8 14865.8 14946.6 14961.6 15454.5 22677.3 42460.6 44210.0 44226.8 44296.3 10897.9 11422.6 11425.3 11488.4 11916.2 9681.4 9791.3 9801.4 9940.9 10099.9 10973.8 11121.7 11211.9 11262.4 11766.4 3427.6 3728.3 3816.4 4095.9 4194.8 925.2 938.8 963.7 968.8 968.9 19482.1 19695.6 19732.4 20052.3 20181.5 1013.4 1013.9 1014.8 1024.3 1028.3 10909.3 11167.0 11168.1 11174.0 11306.6 443017.0 448125.0 452494.0 454965.0 457909.0 112562.4 114196.4 114864.4 116707.0 117105.4 1154.2 1154.9 1184.3 1186.2 1186.8 17961.7 18106.8 18124.2 18357.4 18586.3 57167.0 58338.7 58636.4 59363.0 59910.0 66252.3 66450.7 66574.3 66612.3 66645.3 14372.4 14721.1 14833.8 14857.1 15004.8 24006.4 24035.3 24043.5 24159.0 24303.6 18948.1 19020.9 19106.4 19147.0 19183.9 16872.6 17075.7 17174.7 17215.5 17901.6 19186.6 19234.1 19347.0 19551.9 19656.2 14623.6 14624.1 14691.6 14737.6 14805.9 19024.0 19069.0 19110.0 19122.6 19231.7 16:48:46 INFO - PID 3591 | 16:48:46 INFO - PID 3591 | [#3] mootools.html Cycles:180 Average:9139.50 Median:2658.80 stddev:6470.84 (243.4%) stddev-sans-first:6461.80 16:48:46 INFO - PID 3591 | Values: 1244.6 1324.2 1339.3 1339.6 1349.0 14404.6 15073.4 15221.8 15271.7 15289.1 15154.2 15456.5 15483.1 15492.1 15493.0 2510.4 2696.4 2699.0 2759.0 2766.4 2707.7 2735.1 2739.8 2740.8 2743.2 2631.3 2660.5 2665.8 2698.8 2761.5 2634.8 2648.8 2656.3 2676.7 2681.7 2618.6 2636.4 2654.6 2656.3 2657.1 14268.4 14609.3 14887.6 14951.9 14955.9 7778.9 8102.6 8145.8 8149.1 8154.0 5373.7 5378.7 5417.3 5543.6 5553.2 1878.3 1890.9 1903.3 1911.1 1932.8 25634.5 25884.6 25896.6 25899.2 25914.2 6472.4 6516.0 6564.5 6767.3 6844.0 15396.2 15432.9 15448.5 15449.5 15457.8 7650.9 7776.5 7789.6 7794.9 7811.5 6022.7 7182.0 7196.2 7290.9 7305.2 4874.9 5063.5 5120.3 5123.2 5158.2 1457.3 1476.6 1480.6 1490.4 1496.6 872.6 882.9 888.7 899.2 907.6 8897.7 8913.6 9010.9 9047.5 9119.9 962.5 968.6 985.4 987.5 994.3 5038.1 5095.0 5112.6 5129.9 5257.4 20218.3 21218.7 21283.1 21475.1 21508.0 20499.5 20951.3 21036.6 21147.2 21184.0 10850.2 11073.0 11200.9 11242.6 11251.3 7930.0 8016.6 8318.6 8349.1 8369.7 18161.8 18277.2 18508.0 18732.7 18905.8 18348.6 18478.0 18565.2 18672.3 18803.7 10159.6 11132.0 11766.2 11810.9 11836.8 13265.3 13354.9 13375.9 13378.5 13400.5 10521.4 10678.1 10728.7 10753.9 10791.9 9759.6 9848.0 9875.3 9896.9 10067.1 9750.3 9820.3 9832.1 9835.2 9865.9 7370.6 7442.8 7500.4 7509.9 7510.6 7252.5 7324.2 7385.3 7419.1 7440.7 16:48:46 INFO - PID 3591 | 16:48:46 INFO - PID 3591 | [#4] prototype.html Cycles:180 Average:5487.77 Median:6038.88 stddev:1543.77 (25.6%) stddev-sans-first:1501.74 16:48:46 INFO - PID 3591 | Values: 484.6 497.9 511.2 518.1 519.7 6136.6 6166.0 6217.9 6246.4 6252.6 6053.0 6101.3 6117.9 6123.3 6152.2 5046.9 5080.3 5091.4 5114.3 5116.6 4767.6 4947.8 5063.5 5080.0 5095.9 4860.5 4870.5 4876.6 4880.4 4913.2 4852.5 4867.4 4882.4 4908.2 4919.4 4313.6 4383.8 4401.8 4436.8 4439.1 5992.2 5999.5 6011.1 6011.5 6024.8 5661.5 5686.9 5707.1 5708.1 5720.8 6526.9 6565.7 6574.0 6574.7 6583.6 4807.9 4842.4 4844.8 4855.2 4856.1 6430.8 6627.6 6715.3 6749.7 6883.8 4910.5 4937.5 4952.6 4964.4 4964.7 5029.2 5032.4 5038.5 5053.2 5057.2 5624.6 5673.5 5678.8 5679.9 5690.9 6614.9 6617.5 6648.8 6659.8 6670.2 1735.9 1740.5 1753.9 1755.3 1762.0 1140.4 1195.6 1205.6 1216.2 1218.0 5807.2 5816.6 5838.6 5839.2 5861.5 6727.7 6740.5 6741.8 6778.7 6782.4 5804.0 5811.4 5822.7 5826.7 5855.9 3542.8 3546.8 3562.6 3565.5 3592.3 6459.9 6466.2 6494.9 6500.4 6565.9 6856.9 6876.3 6881.3 6886.5 6904.2 6492.2 6496.9 6498.7 6517.0 6526.3 6695.7 6734.9 6751.9 6779.2 6786.9 6680.9 6689.4 6690.6 6702.8 6703.8 5789.7 6439.5 6453.0 6473.5 6483.9 4923.1 4940.5 4949.6 4957.5 4976.2 6438.3 6546.8 6648.4 6697.5 6745.7 6408.8 6455.7 6469.9 6486.7 6523.0 6359.3 6384.3 6397.0 6457.6 6539.9 6391.7 6457.5 6489.9 6500.8 6501.9 6541.0 6563.7 6581.5 6592.7 6608.4 6287.5 6298.8 6317.6 6348.7 6372.4 16:48:46 INFO - PID 3591 | 16:48:46 INFO - PID 3591 | [#5] yui.html Cycles:180 Average:23694.64 Median:20672.14 stddev:32712.96 (158.2%) stddev-sans-first:32759.69 16:48:46 INFO - PID 3591 | Values: 835.3 856.8 863.2 873.3 882.9 18848.2 19454.2 19454.5 19467.3 19500.5 17046.7 17257.7 17291.3 17357.4 17444.5 936.4 960.5 961.4 962.2 963.9 899.3 937.4 937.9 940.2 941.7 986.1 1009.1 1010.5 1010.6 1011.0 954.2 993.8 995.2 995.3 1000.5 712.1 714.3 717.1 720.2 720.5 17068.0 17069.9 17164.6 17169.8 17261.4 20036.2 20806.6 20956.4 21059.8 21129.3 16027.8 16868.3 16946.5 16962.6 16982.2 3596.3 3615.6 3616.1 3630.3 3630.4 120049.4 120921.4 122569.4 122998.0 124561.0 14499.9 14957.1 14959.9 14974.6 15251.2 28963.6 29118.0 29130.1 29393.1 29469.4 8887.7 9006.0 9126.2 9219.3 9232.9 4158.3 4318.5 4331.1 4336.6 4336.9 5194.5 5231.7 5285.4 5298.9 5324.7 1012.9 1026.2 1039.7 1041.3 1042.3 654.8 660.9 672.8 677.7 687.2 10708.8 11229.7 11651.0 11765.2 12684.7 640.4 650.2 655.8 657.3 671.1 5219.9 5482.1 5484.3 5576.0 5692.1 108962.5 111488.4 111648.4 111995.0 116536.4 95134.5 100849.0 102159.5 105549.5 105647.0 87760.6 87985.6 90342.0 92704.0 92760.0 11507.8 11902.5 12025.7 12123.3 12191.8 38795.8 40773.0 41135.8 41672.2 43266.0 73151.3 74085.6 74389.0 75055.2 76141.2 17727.5 17863.4 18034.6 18038.5 18246.3 20537.7 21083.4 21214.3 21641.5 21699.1 16201.4 16843.2 17531.9 17618.2 17643.3 15453.6 16800.9 17301.0 17325.0 17509.5 16446.8 16696.9 17470.2 17811.0 17899.6 12002.2 12246.8 12564.5 12587.6 12647.3 12964.9 13193.0 13204.1 13363.7 13471.7 16:48:46 INFO - PID 3591 | -------- Summary: end -------- 16:48:46 INFO - PID 3591 | 16:48:47 INFO - TEST-INFO | 3591: exit 0 16:48:47 INFO - TEST-OK | dromaeo_css | took 1115150ms 16:48:47 INFO - TEST-START | kraken 16:48:47 INFO - Initialising browser for kraken test... 16:48:47 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55294/getInfo.html -profile /tmp/tmpMCq2ev/profile 16:48:47 INFO - TEST-INFO | started process 4006 (/builds/slave/test/build/application/firefox/firefox http://localhost:55294/getInfo.html) 16:48:53 INFO - TEST-INFO | 4006: exit 0 16:48:53 INFO - Browser initialized. 16:48:53 INFO - Running cycle 1/1 for kraken test... 16:48:53 INFO - TEST-INFO | started process 4191 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMCq2ev/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:48:54 INFO - PID 4191 | 16:48:54 INFO - PID 4191 | (/builds/slave/test/build/application/firefox/firefox:4242): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:48:54 INFO - PID 4191 | 16:48:55 INFO - PID 4191 | 16:48:55 INFO - PID 4191 | (/builds/slave/test/build/application/firefox/firefox:4302): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:48:55 INFO - PID 4191 | 16:48:55 INFO - PID 4191 | __metrics Screen width/height:1600/1200 16:48:55 INFO - PID 4191 | colorDepth:24 16:48:55 INFO - PID 4191 | Browser inner width/height: 1024/768 16:48:55 INFO - PID 4191 | __metrics 16:49:05 INFO - PID 4191 | RSS: Main: 174465024 16:49:05 INFO - PID 4191 | 16:49:07 INFO - PID 4191 | Cycle 1(1): loaded http://localhost:55294/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55294/tests/kraken/driver.html?testName=audio-beat-detection) 16:49:08 INFO - PID 4191 | RSS: Main: 178630656 16:49:08 INFO - PID 4191 | 16:49:11 INFO - PID 4191 | Cycle 1(1): loaded http://localhost:55294/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55294/tests/kraken/driver.html?testName=audio-dft) 16:49:12 INFO - PID 4191 | RSS: Main: 180506624 16:49:12 INFO - PID 4191 | 16:49:15 INFO - PID 4191 | Cycle 1(1): loaded http://localhost:55294/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55294/tests/kraken/driver.html?testName=audio-fft) 16:49:15 INFO - PID 4191 | RSS: Main: 174309376 16:49:15 INFO - PID 4191 | 16:49:18 INFO - PID 4191 | Cycle 1(1): loaded http://localhost:55294/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55294/tests/kraken/driver.html?testName=audio-oscillator) 16:49:18 INFO - PID 4191 | RSS: Main: 174891008 16:49:18 INFO - PID 4191 | 16:49:20 INFO - PID 4191 | Cycle 1(1): loaded http://localhost:55294/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55294/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:49:21 INFO - PID 4191 | RSS: Main: 175136768 16:49:21 INFO - PID 4191 | 16:49:24 INFO - PID 4191 | Cycle 1(1): loaded http://localhost:55294/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55294/tests/kraken/driver.html?testName=imaging-darkroom) 16:49:25 INFO - PID 4191 | RSS: Main: 176312320 16:49:25 INFO - PID 4191 | 16:49:28 INFO - PID 4191 | Cycle 1(1): loaded http://localhost:55294/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55294/tests/kraken/driver.html?testName=imaging-desaturate) 16:49:29 INFO - PID 4191 | RSS: Main: 176009216 16:49:29 INFO - PID 4191 | 16:49:32 INFO - PID 4191 | Cycle 1(1): loaded http://localhost:55294/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55294/tests/kraken/driver.html?testName=json-parse-financial) 16:49:33 INFO - PID 4191 | RSS: Main: 176734208 16:49:33 INFO - PID 4191 | 16:49:34 INFO - PID 4191 | Cycle 1(1): loaded http://localhost:55294/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55294/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:49:35 INFO - PID 4191 | RSS: Main: 176754688 16:49:35 INFO - PID 4191 | 16:49:37 INFO - PID 4191 | Cycle 1(1): loaded http://localhost:55294/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55294/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:49:37 INFO - PID 4191 | RSS: Main: 176451584 16:49:37 INFO - PID 4191 | 16:49:40 INFO - PID 4191 | Cycle 1(1): loaded http://localhost:55294/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55294/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:49:40 INFO - PID 4191 | RSS: Main: 176463872 16:49:40 INFO - PID 4191 | 16:49:43 INFO - PID 4191 | Cycle 1(1): loaded http://localhost:55294/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55294/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:49:44 INFO - PID 4191 | RSS: Main: 177070080 16:49:44 INFO - PID 4191 | 16:49:47 INFO - PID 4191 | Cycle 1(1): loaded http://localhost:55294/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55294/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:49:47 INFO - PID 4191 | RSS: Main: 177065984 16:49:47 INFO - PID 4191 | 16:49:49 INFO - PID 4191 | Cycle 1(1): loaded http://localhost:55294/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55294/tests/kraken/driver.html?testName=ai-astar) 16:49:49 INFO - PID 4191 | RSS: Main: 177700864 16:49:49 INFO - PID 4191 | 16:49:49 INFO - PID 4191 | __start_tp_report 16:49:49 INFO - PID 4191 | _x_x_mozilla_page_load 16:49:49 INFO - PID 4191 | _x_x_mozilla_page_load_details 16:49:49 INFO - PID 4191 | |i|pagename|runs| 16:49:49 INFO - PID 4191 | |0;ai-astar;100;107;94;107;107;110;112;107;114;108 16:49:49 INFO - PID 4191 | |1;audio-beat-detection;150;119;145;173;118;154;152;130;182;127 16:49:49 INFO - PID 4191 | |2;audio-dft;162;162;161;168;163;169;165;162;166;163 16:49:49 INFO - PID 4191 | |3;audio-fft;76;83;75;166;76;77;74;74;169;75 16:49:49 INFO - PID 4191 | |4;audio-oscillator;79;79;129;88;85;79;134;80;81;127 16:49:49 INFO - PID 4191 | |5;imaging-gaussian-blur;115;114;115;114;115;116;117;114;114;113 16:49:49 INFO - PID 4191 | |6;imaging-darkroom;149;147;150;147;148;148;151;150;152;148 16:49:49 INFO - PID 4191 | |7;imaging-desaturate;94;98;99;99;93;99;99;99;98;98 16:49:49 INFO - PID 4191 | |8;json-parse-financial;53;54;52;55;54;60;53;54;54;63 16:49:49 INFO - PID 4191 | |9;json-stringify-tinderbox;56;56;60;64;55;56;60;59;55;56 16:49:49 INFO - PID 4191 | |10;stanford-crypto-aes;76;78;75;74;76;77;80;78;79;75 16:49:49 INFO - PID 4191 | |11;stanford-crypto-ccm;135;122;120;128;119;121;125;123;121;169 16:49:49 INFO - PID 4191 | |12;stanford-crypto-pbkdf2;176;172;174;170;182;182;167;179;169;168 16:49:49 INFO - PID 4191 | |13;stanford-crypto-sha256-iterative;73;69;64;68;67;64;64;72;72;66 16:49:49 INFO - PID 4191 | __end_tp_report 16:49:49 INFO - PID 4191 | __start_cc_report 16:49:49 INFO - PID 4191 | _x_x_mozilla_cycle_collect,942 16:49:49 INFO - PID 4191 | __end_cc_report 16:49:49 INFO - PID 4191 | __startTimestamp1503445789956__endTimestamp 16:49:49 INFO - PID 4191 | 16:49:49 INFO - PID 4191 | ------- Summary: start ------- 16:49:49 INFO - PID 4191 | Number of tests: 14 16:49:49 INFO - PID 4191 | 16:49:49 INFO - PID 4191 | [#0] ai-astar Cycles:10 Average:106.60 Median:109.00 stddev:5.78 (5.3%) stddev-sans-first:5.61 16:49:49 INFO - PID 4191 | Values: 100.0 107.0 94.0 107.0 107.0 110.0 112.0 107.0 114.0 108.0 16:49:49 INFO - PID 4191 | 16:49:49 INFO - PID 4191 | [#1] audio-beat-detection Cycles:10 Average:145.00 Median:151.00 stddev:21.76 (14.4%) stddev-sans-first:23.01 16:49:49 INFO - PID 4191 | Values: 150.0 119.0 145.0 173.0 118.0 154.0 152.0 130.0 182.0 127.0 16:49:49 INFO - PID 4191 | 16:49:49 INFO - PID 4191 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:2.77 (1.7%) stddev-sans-first:2.83 16:49:49 INFO - PID 4191 | Values: 162.0 162.0 161.0 168.0 163.0 169.0 165.0 162.0 166.0 163.0 16:49:49 INFO - PID 4191 | 16:49:49 INFO - PID 4191 | [#3] audio-fft Cycles:10 Average:94.50 Median:75.50 stddev:38.57 (51.1%) stddev-sans-first:40.32 16:49:49 INFO - PID 4191 | Values: 76.0 83.0 75.0 166.0 76.0 77.0 74.0 74.0 169.0 75.0 16:49:49 INFO - PID 4191 | 16:49:49 INFO - PID 4191 | [#4] audio-oscillator Cycles:10 Average:96.10 Median:79.50 stddev:23.63 (29.7%) stddev-sans-first:24.24 16:49:49 INFO - PID 4191 | Values: 79.0 79.0 129.0 88.0 85.0 79.0 134.0 80.0 81.0 127.0 16:49:49 INFO - PID 4191 | 16:49:49 INFO - PID 4191 | [#5] imaging-gaussian-blur Cycles:10 Average:114.70 Median:115.00 stddev:1.16 (1.0%) stddev-sans-first:1.22 16:49:49 INFO - PID 4191 | Values: 115.0 114.0 115.0 114.0 115.0 116.0 117.0 114.0 114.0 113.0 16:49:49 INFO - PID 4191 | 16:49:49 INFO - PID 4191 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:149.50 stddev:1.70 (1.1%) stddev-sans-first:1.80 16:49:49 INFO - PID 4191 | Values: 149.0 147.0 150.0 147.0 148.0 148.0 151.0 150.0 152.0 148.0 16:49:49 INFO - PID 4191 | 16:49:49 INFO - PID 4191 | [#7] imaging-desaturate Cycles:10 Average:97.60 Median:99.00 stddev:2.22 (2.2%) stddev-sans-first:1.94 16:49:49 INFO - PID 4191 | Values: 94.0 98.0 99.0 99.0 93.0 99.0 99.0 99.0 98.0 98.0 16:49:49 INFO - PID 4191 | 16:49:49 INFO - PID 4191 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:54.00 stddev:3.49 (6.5%) stddev-sans-first:3.61 16:49:49 INFO - PID 4191 | Values: 53.0 54.0 52.0 55.0 54.0 60.0 53.0 54.0 54.0 63.0 16:49:49 INFO - PID 4191 | 16:49:49 INFO - PID 4191 | [#9] json-stringify-tinderbox Cycles:10 Average:57.70 Median:57.50 stddev:2.95 (5.1%) stddev-sans-first:3.06 16:49:49 INFO - PID 4191 | Values: 56.0 56.0 60.0 64.0 55.0 56.0 60.0 59.0 55.0 56.0 16:49:49 INFO - PID 4191 | 16:49:49 INFO - PID 4191 | [#10] stanford-crypto-aes Cycles:10 Average:76.80 Median:77.50 stddev:1.93 (2.5%) stddev-sans-first:2.03 16:49:49 INFO - PID 4191 | Values: 76.0 78.0 75.0 74.0 76.0 77.0 80.0 78.0 79.0 75.0 16:49:49 INFO - PID 4191 | 16:49:49 INFO - PID 4191 | [#11] stanford-crypto-ccm Cycles:10 Average:128.30 Median:124.00 stddev:15.06 (12.1%) stddev-sans-first:15.78 16:49:49 INFO - PID 4191 | Values: 135.0 122.0 120.0 128.0 119.0 121.0 125.0 123.0 121.0 169.0 16:49:49 INFO - PID 4191 | 16:49:49 INFO - PID 4191 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.90 Median:175.00 stddev:5.65 (3.2%) stddev-sans-first:5.94 16:49:49 INFO - PID 4191 | Values: 176.0 172.0 174.0 170.0 182.0 182.0 167.0 179.0 169.0 168.0 16:49:49 INFO - PID 4191 | 16:49:49 INFO - PID 4191 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.50 stddev:3.51 (5.1%) stddev-sans-first:3.20 16:49:49 INFO - PID 4191 | Values: 73.0 69.0 64.0 68.0 67.0 64.0 64.0 72.0 72.0 66.0 16:49:49 INFO - PID 4191 | -------- Summary: end -------- 16:49:49 INFO - PID 4191 | 16:49:50 INFO - PID 4191 | 16:49:50 INFO - PID 4191 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150079,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 16:49:50 INFO - PID 4191 | 16:49:50 INFO - PID 4191 | 16:49:50 INFO - PID 4191 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 16:49:50 INFO - PID 4191 | 16:49:50 INFO - PID 4191 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:49:50 INFO - TEST-INFO | 4191: exit 0 16:49:50 INFO - TEST-OK | kraken | took 63675ms 16:49:50 INFO - SUITE-END | took 1178s 16:49:51 INFO - Completed test suite (00:19:39) 16:49:51 INFO - javascript benchmark 16:49:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8426.545235704465, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3255.8534865931033, 3291.4240007998596, 3301.1912081540027, 3322.867085316587, 3328.2844188499466, 6193.411625895533, 6230.158928544651, 6255.718492667824, 6293.622382657044, 6315.621062736228, 6034.24571928509, 6107.2976607690125, 6130.0804879268135, 6155.230596175478, 6175.950088484957, 5614.99999999999, 5627.324721033461, 5647.407022262665, 5674.09214525676, 5710.514606258473, 5642.6614403135945, 5670.688112153851, 5734.770609175649, 5770.307563092414, 5802.622829516068, 5687.772489100452, 5741.167530708045, 5768.250127483442, 5777.913331300013, 5804.332501762309, 5549.223108764776, 5616.550675945955, 5630.746616402272, 5702.54379649627, 5705.48650621444, 5632.5212356949705, 5668.971655141698, 5674.233978412903, 5675.432456754333, 5676.659400435987, 5914.497267732248, 6023.45788879003, 6066.0, 6090.086487026937, 6112.694365281718, 6510.64191469469, 6592.373724496213, 6606.207255129367, 6687.030380594787, 6687.933120668779, 6637.203535575713, 6644.900326495106, 6729.158855143107, 6752.189737231563, 6774.0854984576945, 6193.504519638418, 6261.436470717612, 6280.340564240689, 6284.591501552431, 6287.591306565058, 6838.692258848364, 6839.863202735917, 6885.380315771605, 6946.7221311148, 6977.686004129826, 6408.166938297992, 6509.707063182168, 6510.21877374718, 6595.340465953366, 6641.767538136142, 6645.0, 6649.667516624149, 6650.800475985729, 6658.300878407697, 6694.129763130859, 6462.935370646327, 6620.470362370998, 6637.402633762985, 6646.401823835878, 6653.667316634246, 6581.14445122131, 6581.440577550962, 6605.603663780189, 6661.500387470959, 6676.566023208573, 5151.974240128776, 5230.163173892159, 5231.843044708665, 5241.50205730455, 5252.107141785829, 4621.098885717252, 4622.052479241747, 4631.62946964242, 4631.652626053059, 4679.789409476582, 5770.076787713946, 5839.065749480063, 5847.356790753014, 5849.210356601804, 5850.824475265664, 6654.3345665434035, 6658.067870498134, 6665.366790154928, 6753.189617245962, 6767.458603311822, 5625.268715067015, 5777.162311464814, 5830.62100963436, 5840.795572154954, 5853.0635098384055, 5594.468525490072, 5638.633488823295, 5689.6586204827845, 5712.400197979236, 5723.313202415654, 6333.113364129025, 6400.647964362005, 6412.326705695835, 6416.647084410402, 6464.159659244362, 6646.867062658816, 6729.596224226562, 6729.663516824041, 6737.797866063928, 6749.595024298362, 6388.105665206967, 6391.137196478416, 6483.513736469878, 6494.350564943468, 6494.740210391531, 6410.134631824644, 6492.026196070438, 6515.869682606416, 6535.379138981789, 6621.702023408862, 6570.408663220333, 6606.108175396452, 6623.834404139742, 6627.569208001464, 6642.634655094016, 6401.167848179707, 6405.807825765234, 6406.167198264196, 6407.8718425630295, 6449.258335291502, 6456.903146452713, 6458.677066146768, 6480.0, 6543.5419520633095, 6550.181227346582, 6395.136656551306, 6411.8717625646295, 6478.157839481026, 6495.610263384212, 6504.15445992018, 6311.842203944938, 6423.614583125028, 6477.255115661571, 6478.0, 6512.544121911421, 6268.937310626835, 6279.748810047547, 6307.148534947723, 6312.179416675803, 6316.747330106744], "value": 6062.429899008488, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [764.4686942574913, 851.306185458851, 869.7477731457877, 1094.8193548064569, 1114.6377427336117, 28784.856075719617, 38433.0, 38725.0, 38915.610843891554, 38996.02509937249, 38817.80591097048, 39210.0, 39257.0, 39268.607313926856, 39304.0, 7363.9631801840915, 7514.887276690854, 7545.207753185919, 7557.508761930484, 7562.810929726746, 7253.274672532757, 7306.452016098814, 7320.8169795755, 7324.560526368408, 7330.266973302654, 6924.930750692504, 7108.0, 7548.5093468924615, 7549.584772837492, 7557.622118894061, 7476.551406915575, 7544.547327160333, 7548.018757561536, 7551.320381165721, 7554.811129721746, 7419.10970683516, 7423.109226892808, 7423.480356375056, 7457.627118644046, 7501.324880760703, 35202.29595408103, 35245.647543524494, 35409.82295088508, 35437.29125417477, 35519.64480355189, 3288.19439237386, 3319.336132773431, 3325.8503367348526, 3326.534285200074, 3329.6337402885665, 29462.558061629094, 29689.851550742107, 29841.552376714368, 29896.0, 29914.252143696365, 4968.30443737877, 4989.501049895018, 5013.6490445668815, 5019.3976722793495, 5033.672811267293, 180685.0, 182492.0, 182551.08724456426, 183287.08356458266, 183704.0, 44485.0, 44589.32464052102, 44627.10745785131, 44658.33012504815, 44667.77666111714, 46750.766246168554, 46797.766011169726, 46844.7657761709, 46864.0, 46870.062598747834, 14612.561623151323, 14905.25473726331, 14938.402463901539, 14940.850591494163, 15064.171470569225, 12415.255084694767, 12480.375981200903, 12608.180468269533, 12621.93689031549, 12630.684232894067, 12031.578894738817, 13530.45878164882, 13622.182669039888, 13702.657433564042, 13736.519221827188, 4867.561919427269, 5454.509094181542, 5458.208559758813, 5477.260569823103, 5484.341878974469, 988.1156365053381, 988.4958671077802, 997.9101880830615, 1003.372891942536, 1006.1992612588433, 21772.237971670915, 21956.89021554882, 22001.449963751034, 22020.449488762588, 22186.1304202251, 1069.1553672598716, 1083.9458027098613, 1085.9076978456762, 1090.3893819460968, 1109.312226419625, 11607.187496875138, 11632.941835290769, 11633.88366116328, 11658.475368608433, 11694.94152529249, 230710.0, 231845.0, 233010.0, 233719.0, 233799.0, 47787.28319075217, 48064.27903581449, 48099.75950120297, 48395.27407088896, 48484.515154848, 1339.2767905331207, 1351.6012776231034, 1353.0528629958872, 1361.8025386318927, 1383.4466213514675, 21307.25424610131, 21588.0, 21619.13523459044, 21684.24105156312, 21814.672779907996, 32909.0, 33021.83489082539, 33031.17422064468, 33033.0, 33082.33835323328, 189967.0, 189995.0, 190782.0, 190936.0, 191883.0, 30545.694543055175, 30824.537631935986, 30834.074977750704, 31299.0, 31473.685263147076, 34325.31349372949, 35005.47491787676, 39537.209255815294, 39673.60326396814, 39685.60314396935, 29372.11883643494, 29393.412131757672, 29483.410331792817, 29599.26001849971, 29749.256268593457, 29101.7089829099, 29410.852945735136, 29441.558376624795, 29589.0, 29720.851395742884, 32885.0, 32967.83516082404, 33099.83450082734, 33196.170095746835, 33223.0, 28434.85782571074, 29075.7092429073, 29196.124116276547, 29613.85193074021, 31361.686383135875, 23533.882330588924, 23722.169724059575, 23809.880950595136, 23851.642225366286, 23902.402439939142], "value": 16224.454138549103, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [536.337623035551, 545.9181122831573, 549.3572520151425, 550.0528130418319, 552.8590209496579, 21667.891660541696, 22433.32700018998, 22467.0, 22469.55060898781, 22569.210077647287, 25325.493490130233, 25717.22848314549, 25781.226563203134, 25844.870775646097, 25983.870080649616, 6348.492120630339, 6489.675516224193, 6492.7402903883785, 6498.3826536478955, 6499.545031847772, 6217.720202590872, 6372.203474565679, 6407.231132264134, 6501.9349806501805, 6514.869702605945, 6447.516436267275, 6458.192725909262, 6471.449926756231, 6482.481401487869, 6487.6756162191705, 6451.516136289773, 6453.12882760826, 6455.193100862392, 6458.225012998423, 6467.159269295009, 5979.312379076375, 5997.310309314441, 6016.548758843104, 6019.759209631609, 6024.427679370453, 27993.160205193875, 28868.42263154725, 29104.708952910623, 29335.266618334714, 29736.40527189466, 2038.0930485933766, 2068.2761033638258, 2085.8644188127723, 2086.050846864673, 2090.519180588458, 18814.717779233324, 19402.4179274622, 19403.4178974631, 19430.70853937192, 19435.12541935616, 2324.198151637699, 2325.081592770863, 2395.4610212702178, 2398.112698301622, 2417.6615273861676, 131715.0, 137825.0, 137830.0, 138062.3096884509, 138356.30821845928, 14071.788923166161, 14865.777013344808, 14946.551603451913, 14961.625959351104, 15454.536363909101, 22677.319680409615, 42460.57539424628, 44210.0, 44226.778866106106, 44296.3355549667, 10897.945510272399, 11422.603342128436, 11425.257358271685, 11488.425578721031, 11916.225445346197, 9681.37071090377, 9791.314607977516, 9801.362911410735, 9940.900590994142, 10099.94950025245, 10973.780524389627, 11121.72195695098, 11211.887881121085, 11262.38056906878, 11766.411679415995, 3427.5715535558056, 3728.2729867675544, 3816.4275358695863, 4095.8936245613836, 4194.832206711759, 925.1627277314042, 938.7559234599054, 963.7253382785873, 968.7578105473632, 968.9370190937567, 19482.112232281772, 19695.60608787816, 19732.40802775919, 20052.29816956429, 20181.49546261355, 1013.4172850610928, 1013.9391636501833, 1014.7919676466307, 1024.2727663359099, 1028.3007554862766, 10909.34543927367, 11167.0, 11168.106551475863, 11174.0, 11306.604268850551, 443017.0, 448125.0, 452494.0, 454965.0, 457909.0, 112562.43718781354, 114196.42901785437, 114864.42567787107, 116707.0, 117105.41447292709, 1154.168998321224, 1154.8671902731126, 1184.2894263442038, 1186.211169572242, 1186.8041773107514, 17961.73057404114, 18106.823056501285, 18124.184411701768, 18357.3574924877, 18586.349477768756, 57167.0, 58338.7083064582, 58636.41363586309, 59363.0, 59910.0, 66252.33747662461, 66450.66774666095, 66574.33425665682, 66612.33387666062, 66645.33354666391, 14372.425102996182, 14721.116732996055, 14833.777493337393, 14857.108573485626, 15004.849951500346, 24006.39984000344, 24035.27894163178, 24043.51912961766, 24159.0, 24303.635445468684, 18948.052597369802, 19020.904895475433, 19106.426807195807, 19147.04264786727, 19183.904080479508, 16872.57818554546, 17075.65848683044, 17174.742378864077, 17215.483535493957, 17901.64196716032, 19186.61626767429, 19234.134463948874, 19347.0, 19551.902240488707, 19656.213751450356, 14623.634409139857, 14624.122552646875, 14691.632709182357, 14737.631559210677, 14805.851941480447, 19024.0, 19069.0, 19110.0, 19122.61754764869, 19231.711524326867], "value": 12369.062846955301, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1244.551961293934, 1324.2451802472594, 1339.2634051271805, 1339.5646414915152, 1348.986510134899, 14404.567862964115, 15073.39706411745, 15221.847781522181, 15271.694566108672, 15289.082655040691, 15154.166520841376, 15456.459023934165, 15483.14842683652, 15492.070475771461, 15493.0, 2510.447701505666, 2696.3933115049153, 2699.0283497940727, 2759.0067575672742, 2766.363736340643, 2707.742764437385, 2735.124760076776, 2739.8356098634144, 2740.8355498670144, 2743.2044707035034, 2631.289551821007, 2660.467906418724, 2665.78673706104, 2698.811083224175, 2761.4753196892625, 2634.841909485418, 2648.827826191301, 2656.296081538394, 2676.678798544168, 2681.6647919010124, 2618.56793629051, 2636.380450594109, 2654.641623380838, 2656.335916020995, 2657.136430660043, 14268.429262829475, 14609.269536523132, 14887.627809304746, 14951.925240373728, 14955.850441495555, 7778.922210777876, 8102.635381407851, 8145.75562733113, 8149.144339844291, 8154.0, 5373.731313434352, 5378.677279363251, 5417.322834645669, 5543.556515478793, 5553.194786755897, 1878.2674756844842, 1890.867639265252, 1903.3243198664413, 1911.1399870058528, 1932.8357089647398, 25634.48731025369, 25884.611730824054, 25896.611550826754, 25899.223023309332, 25914.22257332264, 6472.385123413268, 6515.967420162869, 6564.522982328937, 6767.255601883789, 6843.965780171166, 15396.153211573246, 15432.92283538575, 15448.459303924308, 15449.459268925533, 15457.84542154564, 7650.923490765133, 7776.5334079954255, 7789.649465774054, 7794.9220507795335, 7811.453198276066, 6022.728977196037, 7181.964090179516, 7196.244394338623, 7290.927090729131, 7305.159906610807, 4874.926876096862, 5063.518965698253, 5120.257562653469, 5123.180291153398, 5158.226266060121, 1457.30049576204, 1476.6234610174338, 1480.6372438752574, 1490.3814916809404, 1496.5959191018364, 872.5506364222431, 882.8940527136656, 888.657866721317, 899.1592860675289, 907.5961197267285, 8897.688580899638, 8913.598888050054, 9010.909890901006, 9047.547622618842, 9119.863202051974, 962.5235508423235, 968.5544649461186, 985.3644399362371, 987.511181964932, 994.3487016004528, 5038.118329292359, 5094.974525127351, 5112.6421150519855, 5129.897402052013, 5257.395399529027, 20218.292359767336, 21218.681719774217, 21283.148674053173, 21475.140994360365, 21508.0, 20499.487512812, 20951.266705665534, 21036.57926841485, 21147.154113835582, 21184.04671789773, 10850.186236032328, 11073.0, 11200.887991119984, 11242.55029798799, 11251.268667536584, 7929.960350198443, 8016.599170041592, 8318.627426474564, 8349.12334204924, 8369.748907532783, 18161.818381816014, 18277.177527011052, 18508.0, 18732.719009215147, 18905.810941890406, 18348.633027339645, 18478.0, 18565.164567594762, 18672.346467873558, 18803.717944230575, 10159.593616255266, 11132.0, 11766.235194712317, 11810.940945295219, 11836.822447663464, 13265.336733163496, 13354.93322533381, 13375.933120334335, 13378.464861405435, 13400.530981415604, 10521.421321827373, 10678.145748339959, 10728.731781705208, 10753.946230268799, 10791.946040269748, 9759.609615615296, 9848.0, 9875.259355548505, 9896.851547226941, 10067.1442927352, 9750.31747777677, 9820.263480238867, 9832.065953734384, 9835.21318294549, 9865.852012219966, 7370.63146842645, 7442.813929651802, 7500.399968002437, 7509.9249007509225, 7510.586917719578, 7252.492325537372, 7324.194338622854, 7385.29839665231, 7419.109706835215, 7440.73957411488], "value": 6572.2691540955675, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [484.5735752537766, 497.93775778027737, 511.19486808276963, 518.1398877862746, 519.742727349962, 6136.601120927142, 6165.969170154143, 6217.9378206217925, 6246.406591373812, 6252.562320637558, 6052.969735151318, 6101.328853826076, 6117.938820611793, 6123.326434092258, 6152.169457123298, 5046.924296135561, 5080.263361812535, 5091.389033316007, 5114.335136432268, 5116.616253780962, 4767.641222251659, 4947.802087916479, 5063.468335824722, 5080.034793389244, 5095.898082038357, 4860.465348811628, 4870.512948705119, 4876.634252431064, 4880.438259756879, 4913.238448040559, 4852.466228714874, 4867.440244371889, 4882.438519570223, 4908.165611845995, 4919.409670839486, 4313.633341166004, 4383.802728877176, 4401.801918913625, 4436.822527098912, 4439.1121775645, 5992.161097446317, 5999.490043346321, 6011.12838638395, 6011.519078473755, 6024.789132380346, 5661.547076233891, 5686.943130568683, 5707.146426786607, 5708.144852922816, 5720.768900128953, 6526.869462610769, 6565.737370505221, 6573.967130164367, 6574.704138313739, 6583.604983700945, 4807.884530806434, 4842.394700662418, 4844.75776211188, 4855.247436647325, 4856.125897338477, 6430.807075787687, 6627.635480048595, 6715.294894036105, 6749.662516874137, 6883.7590684325805, 4910.53349931763, 4937.518744376673, 4952.603791696655, 4964.35463389757, 4964.652474326763, 5029.17018691919, 5032.396112466454, 5038.521340472649, 5053.166227572483, 5057.216131499624, 5624.578156638187, 5673.461021202979, 5678.77284908599, 5679.943200568024, 5690.857728556819, 6614.933850661528, 6617.503687223478, 6648.833779155463, 6659.766908158192, 6670.232923213795, 1735.8871673341193, 1740.5213566269376, 1753.9210735516933, 1755.2540170427517, 1761.9647607047787, 1140.4411838199223, 1195.5636192789743, 1205.6021512900722, 1216.191232830158, 1217.9512819487122, 5807.186993820868, 5816.563757718188, 5838.5621078418435, 5839.240898683144, 5861.531077513789, 6727.697253623599, 6740.460763138937, 6741.831454213586, 6778.661066946732, 6782.355676210752, 5803.955288048108, 5811.4018644872995, 5822.70886455684, 5826.708664566755, 5855.941440585625, 3542.822858857047, 3546.7871927684423, 3562.5952482074495, 3565.5186549815962, 3592.317459682652, 6459.870802584016, 6466.191726034246, 6494.870102597922, 6500.447461965691, 6565.901511477332, 6856.931430685729, 6876.346747059021, 6881.311868813079, 6886.51794374399, 6904.206016308089, 6492.156019717407, 6496.935030649727, 6498.707558159799, 6517.0, 6526.28210896801, 6695.665216739241, 6734.898976515454, 6751.93248067513, 6779.15260592426, 6786.948023056434, 6680.899786503303, 6689.364510371507, 6690.632015239208, 6702.798916032527, 6703.832404189934, 5789.652620842763, 6439.452646525097, 6453.0, 6473.546851720334, 6483.902741458976, 4923.113839508923, 4940.456549779449, 4949.554540091409, 4957.479464656303, 4976.2286845539, 6438.29178790342, 6546.770863019771, 6648.368405001517, 6697.497687673346, 6745.730170793114, 6408.807735767934, 6455.741770329134, 6469.935300646934, 6486.6756662167645, 6522.977876858189, 6359.332270111571, 6384.297727249906, 6396.968015159894, 6457.580257283262, 6539.901901471387, 6391.744330226739, 6457.515686323639, 6489.9026514603265, 6500.837479063061, 6501.934980650322, 6540.967295163494, 6563.671816409256, 6581.5392922496885, 6592.70332835014, 6608.380946667905, 6287.528435367274, 6298.779542716166, 6317.557770955989, 6348.746050157942, 6372.362763723776], "value": 5031.099784194248, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [835.2941764209241, 856.8157846063095, 863.1756672377884, 873.3188113271647, 882.9470231786094, 18848.246070157194, 19454.221831126757, 19454.513637159078, 19467.31864384747, 19500.51248718783, 17046.74429883553, 17257.654846903053, 17291.30834766611, 17357.39249126281, 17444.47666570002, 936.4053825820619, 960.5389413081725, 961.3654987708114, 962.2206013129388, 963.9132478077007, 899.2626046641757, 937.4328531238605, 937.8827646544182, 940.1585580905086, 941.7033634405141, 986.0927946289395, 1009.1271050541302, 1010.5200029985734, 1010.6159659329481, 1011.0193112680688, 954.1651055326589, 993.8409854423294, 995.2286977592388, 995.3082607587729, 1000.5047501486738, 712.1240873725346, 714.2999860137043, 717.1179449277366, 720.1933834105782, 720.4992530191519, 17068.0, 17069.914650426792, 17164.570885727833, 17169.82830171695, 17261.395851145277, 20036.1985520579, 20806.58386832255, 20956.371308860605, 21059.789402105936, 21129.260475883424, 16027.759583606256, 16868.325266989305, 16946.491605251864, 16962.575935601708, 16982.15089245545, 3596.280743851214, 3615.5842078161086, 3616.059824445637, 3630.2920930418577, 3630.419132938717, 120049.39975300155, 120921.39539302247, 122569.38715306544, 122998.0, 124561.0, 14499.855001450062, 14957.102573845386, 14959.850401496064, 14974.550763477113, 15251.237438128272, 28963.56554651682, 29117.980870669424, 29130.126096217147, 29393.11820645384, 29469.410611787644, 8887.688930887389, 9005.954970225106, 9126.178643921947, 9219.262459003263, 9232.8615070774, 4158.251514727318, 4318.546552611993, 4331.112122014979, 4336.566343365701, 4336.934945975813, 5194.506521880416, 5231.686098834082, 5285.418603953562, 5298.947010529845, 5324.733763311819, 1012.86832711747, 1026.1841835740604, 1039.656913218636, 1041.3491567770143, 1042.2912419554625, 654.7773756922574, 660.923993740726, 672.7914346552584, 677.7051982387677, 687.1959807025792, 10708.768152777431, 11229.66311010671, 11651.0, 11765.235259708092, 12684.746305074032, 640.4108220437209, 650.2099948562425, 655.7803135949415, 657.3163909534031, 671.1275342055407, 5219.869503262449, 5482.068048431776, 5484.314460692413, 5576.0, 5692.0608099663095, 108962.45518772355, 111488.4425577867, 111648.44175779069, 111995.0, 116536.41731791287, 95134.52432737792, 100849.0, 102159.48920255351, 105549.47225263978, 105647.0, 87760.56119719234, 87985.56007219922, 90342.0, 92704.0, 92760.0, 11507.769844603228, 11902.515016702104, 12025.699357516132, 12123.272603643809, 12191.75616487683, 38795.80602097084, 40772.98067548335, 41135.7943210282, 41672.166556669305, 43266.0, 73151.26848731445, 74085.62957185395, 74389.0, 75055.24944750483, 76141.23858761563, 17727.468175954742, 17863.374781882572, 18034.639307214045, 18038.5490362742, 18246.270149193882, 20537.691934620692, 21083.367498975054, 21214.25750098739, 21641.45896352541, 21699.132034718434, 16201.4329498467, 16843.24205410784, 17531.912340438215, 17618.207180677156, 17643.29426822913, 15453.613659658598, 16800.915995419946, 17301.048442335792, 17325.0, 17509.474715758548, 16446.83553164501, 16696.916515417346, 17470.213840377466, 17811.0, 17899.552511187325, 12002.21985570935, 12246.755064898474, 12564.497420103093, 12587.559435419716, 12647.304398258184, 12964.870351296366, 13193.0, 13204.141730787467, 13363.66590835198, 13471.719767470559], "value": 8898.974568851196, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1527.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 107.0, 94.0, 107.0, 107.0, 110.0, 112.0, 107.0, 114.0, 108.0], "value": 106.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 119.0, 145.0, 173.0, 118.0, 154.0, 152.0, 130.0, 182.0, 127.0], "value": 145.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 168.0, 163.0, 169.0, 165.0, 162.0, 166.0, 163.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 83.0, 75.0, 166.0, 76.0, 77.0, 74.0, 74.0, 169.0, 75.0], "value": 94.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 129.0, 88.0, 85.0, 79.0, 134.0, 80.0, 81.0, 127.0], "value": 96.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 115.0, 114.0, 115.0, 116.0, 117.0, 114.0, 114.0, 113.0], "value": 114.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 150.0, 147.0, 148.0, 148.0, 151.0, 150.0, 152.0, 148.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 98.0, 99.0, 99.0, 93.0, 99.0, 99.0, 99.0, 98.0, 98.0], "value": 97.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 52.0, 55.0, 54.0, 60.0, 53.0, 54.0, 54.0, 63.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 60.0, 64.0, 55.0, 56.0, 60.0, 59.0, 55.0, 56.0], "value": 57.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 75.0, 74.0, 76.0, 77.0, 80.0, 78.0, 79.0, 75.0], "value": 76.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 122.0, 120.0, 128.0, 119.0, 121.0, 125.0, 123.0, 121.0, 169.0], "value": 128.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 172.0, 174.0, 170.0, 182.0, 182.0, 167.0, 179.0, 169.0, 168.0], "value": 173.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 69.0, 64.0, 68.0, 67.0, 64.0, 64.0, 72.0, 72.0, 66.0], "value": 67.9, "unit": "score"}]}]} 16:49:51 INFO - Return code: 0 16:49:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:49:51 INFO - # TBPL SUCCESS # 16:49:51 INFO - Running post-action listener: _package_coverage_data 16:49:51 INFO - Running post-action listener: _resource_record_post_action 16:49:51 INFO - [mozharness: 2017-08-22 23:49:51.262514Z] Finished run-tests step (success) 16:49:51 INFO - Running post-run listener: _resource_record_post_run 16:49:51 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 5509120; Write bytes: 438730752; Read time: 3572; Write time: 538156 16:49:51 INFO - TinderboxPrint: CPU usage
13.1% 16:49:51 INFO - TinderboxPrint: I/O read bytes / time
5,509,120 / 3,572 16:49:51 INFO - TinderboxPrint: I/O write bytes / time
438,730,752 / 538,156 16:49:51 INFO - TinderboxPrint: CPU idle
8,293.4 (86.8%) 16:49:51 INFO - TinderboxPrint: CPU user
1,199.1 (12.6%) 16:49:51 INFO - TinderboxPrint: Swap in / out
0 / 0 16:49:51 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 8192; Write bytes: 184639488; Read time: 296; Write time: 237180 16:49:51 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:49:51 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 3350528; Write bytes: 208478208; Read time: 2676; Write time: 216072 16:49:51 INFO - Running post-run listener: _upload_blobber_files 16:49:51 INFO - Blob upload gear active. 16:49:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:49:51 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 16:49:51 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'] 16:49:51 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 16:49:52 INFO - (blobuploader) - INFO - Open directory for files ... 16:49:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:49:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:49:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:49:53 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:49:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:49:53 INFO - (blobuploader) - INFO - Done attempting. 16:49:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:49:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:49:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:49:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:49:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:49:59 INFO - (blobuploader) - INFO - Done attempting. 16:49:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:49:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:49:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:50:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:50:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:50:00 INFO - (blobuploader) - INFO - Done attempting. 16:50:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:50:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:50:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:50:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:50:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:50:01 INFO - (blobuploader) - INFO - Done attempting. 16:50:01 INFO - (blobuploader) - INFO - Iteration through files over. 16:50:01 INFO - Return code: 0 16:50:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:50:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:50:01 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd8a9f59b6e07fbdecda67eb6bdec0eb6bac7a8421b469e9a962374224589b77b15c14ca0e96fb5c4ed6e569d681b8807bf614d75884433a9060fb3d3b05d3c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/927d5697015bc0a98042c5919345f774fa546ea58e6ea1331994058c146decf5df496885603f3269648f3e2bbbbe37c626732657fcc64cf53acd02204cefaffd", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39be0a192aaace7cc8440ec4849aa4289251b561eee16cdb1d0abf5e854ac19b54dd3cc9f5d998526cd313023d0910f8a98f28937093d9a107e023c16b983e48", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1290780a1eb2f77c8f40cdb6e19cd9953ee51d149423613514d066c20cd4a071628f8e4392688e0cd1577fb008141e593d48e1cded5617827747e21a269cc830"} 16:50:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:50:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:50:01 INFO - Contents: 16:50:01 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd8a9f59b6e07fbdecda67eb6bdec0eb6bac7a8421b469e9a962374224589b77b15c14ca0e96fb5c4ed6e569d681b8807bf614d75884433a9060fb3d3b05d3c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/927d5697015bc0a98042c5919345f774fa546ea58e6ea1331994058c146decf5df496885603f3269648f3e2bbbbe37c626732657fcc64cf53acd02204cefaffd", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39be0a192aaace7cc8440ec4849aa4289251b561eee16cdb1d0abf5e854ac19b54dd3cc9f5d998526cd313023d0910f8a98f28937093d9a107e023c16b983e48", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1290780a1eb2f77c8f40cdb6e19cd9953ee51d149423613514d066c20cd4a071628f8e4392688e0cd1577fb008141e593d48e1cded5617827747e21a269cc830"} 16:50:01 INFO - Running post-run listener: copy_logs_to_upload_dir 16:50:01 INFO - Copying logs to upload dir... 16:50:01 INFO - mkdir: /builds/slave/test/build/upload/logs 16:50:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.726226 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-08-22 16:50:01.937469) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-22 16:50:01.942443) ========= 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=745a4373a2a16df560f216e000000264-1503444530.970780-1478601249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd8a9f59b6e07fbdecda67eb6bdec0eb6bac7a8421b469e9a962374224589b77b15c14ca0e96fb5c4ed6e569d681b8807bf614d75884433a9060fb3d3b05d3c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/927d5697015bc0a98042c5919345f774fa546ea58e6ea1331994058c146decf5df496885603f3269648f3e2bbbbe37c626732657fcc64cf53acd02204cefaffd", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39be0a192aaace7cc8440ec4849aa4289251b561eee16cdb1d0abf5e854ac19b54dd3cc9f5d998526cd313023d0910f8a98f28937093d9a107e023c16b983e48", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1290780a1eb2f77c8f40cdb6e19cd9953ee51d149423613514d066c20cd4a071628f8e4392688e0cd1577fb008141e593d48e1cded5617827747e21a269cc830"} build_url:https://queue.taskcluster.net/v1/task/KRW8BKGhS3m3qhpOl1dvTA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011164 build_url: 'https://queue.taskcluster.net/v1/task/KRW8BKGhS3m3qhpOl1dvTA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd8a9f59b6e07fbdecda67eb6bdec0eb6bac7a8421b469e9a962374224589b77b15c14ca0e96fb5c4ed6e569d681b8807bf614d75884433a9060fb3d3b05d3c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/927d5697015bc0a98042c5919345f774fa546ea58e6ea1331994058c146decf5df496885603f3269648f3e2bbbbe37c626732657fcc64cf53acd02204cefaffd", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39be0a192aaace7cc8440ec4849aa4289251b561eee16cdb1d0abf5e854ac19b54dd3cc9f5d998526cd313023d0910f8a98f28937093d9a107e023c16b983e48", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1290780a1eb2f77c8f40cdb6e19cd9953ee51d149423613514d066c20cd4a071628f8e4392688e0cd1577fb008141e593d48e1cded5617827747e21a269cc830"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-22 16:50:01.976506) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 16:50:01.976887) ========= 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=745a4373a2a16df560f216e000000264-1503444530.970780-1478601249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004636 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 16:50:02.061183) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-22 16:50:02.061673) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-22 16:50:02.062120) ========= ========= Total master_lag: 0.21 =========