builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-036 starttime: 1504787549.01 results: success (0) revision: 37b95547f0d27565452136d16b2df2857be840f6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-07 05:32:29.014566) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-07 05:32:29.015107) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-07 05:32:29.015401) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-07 05:32:29.039152) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 05:32:29.039443) ========= 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=14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-07 05:32:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 36.8M=0s 2017-09-07 05:32:29 (36.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.261980 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 05:32:29.361935) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 05:32:29.362306) ========= 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=14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.034031 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 05:32:29.419183) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-07 05:32:29.419649) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 37b95547f0d27565452136d16b2df2857be840f6 --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 37b95547f0d27565452136d16b2df2857be840f6 --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=14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-07 05:32:29,734 truncating revision to first 12 chars 2017-09-07 05:32:29,734 Setting DEBUG logging. 2017-09-07 05:32:29,734 attempt 1/10 2017-09-07 05:32:29,734 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/37b95547f0d2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-07 05:32:30,465 unpacking tar archive at: mozilla-central-37b95547f0d2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.081503 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-07 05:32:30.522124) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-07 05:32:30.522479) ========= script_repo_revision: 37b95547f0d27565452136d16b2df2857be840f6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-07 05:32:30.524998) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-07 05:32:30.525350) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-07 05:32:30.541849) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-09-07 05:32:30.542319) ========= /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=14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:32:31 INFO - MultiFileLogger online at 20170907 05:32:31 in /builds/slave/test 05:32:31 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 05:32:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:32:31 INFO - {'append_to_log': False, 05:32:31 INFO - 'base_work_dir': '/builds/slave/test', 05:32:31 INFO - 'blob_upload_branch': 'Firefox', 05:32:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:32:31 INFO - 'branch': 'Firefox', 05:32:31 INFO - 'buildbot_json_path': 'buildprops.json', 05:32:31 INFO - 'code_coverage': False, 05:32:31 INFO - 'config_files': ('talos/linux_config.py',), 05:32:31 INFO - 'default_actions': ('clobber', 05:32:31 INFO - 'read-buildbot-config', 05:32:31 INFO - 'download-and-extract', 05:32:31 INFO - 'populate-webroot', 05:32:31 INFO - 'create-virtualenv', 05:32:31 INFO - 'install', 05:32:31 INFO - 'setup-mitmproxy', 05:32:31 INFO - 'run-tests'), 05:32:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:32:31 INFO - 'disable_ccov_upload': False, 05:32:31 INFO - 'disable_stylo': False, 05:32:31 INFO - 'download_minidump_stackwalk': True, 05:32:31 INFO - 'download_symbols': 'ondemand', 05:32:31 INFO - 'enable_stylo': False, 05:32:31 INFO - 'enable_webrender': False, 05:32:31 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 05:32:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:32:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:32:31 INFO - 'gecko_profile': False, 05:32:31 INFO - 'gecko_profile_interval': 0, 05:32:31 INFO - 'installer_path': 'installer.exe', 05:32:31 INFO - 'log_level': 'info', 05:32:31 INFO - 'log_name': 'talos', 05:32:31 INFO - 'log_to_console': True, 05:32:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:32:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:32:31 INFO - 'opt_config_files': (), 05:32:31 INFO - 'pip_index': False, 05:32:31 INFO - 'suite': 'dromaeojs-e10s', 05:32:31 INFO - 'system_bits': '32', 05:32:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:32:31 INFO - 'title': 'talos-linux64-ix-036', 05:32:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:32:31 INFO - 'use_talos_json': True, 05:32:31 INFO - 'verify': 'False', 05:32:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:32:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:32:31 INFO - 'work_dir': 'build'} 05:32:31 INFO - [mozharness: 2017-09-07 12:32:31.092792Z] Running clobber step. 05:32:31 INFO - Running pre-action listener: _resource_record_pre_action 05:32:31 INFO - Running main action method: clobber 05:32:31 INFO - rmtree: /builds/slave/test/build 05:32:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:32:33 INFO - Running post-action listener: _resource_record_post_action 05:32:33 INFO - [mozharness: 2017-09-07 12:32:33.541341Z] Finished clobber step (success) 05:32:33 INFO - [mozharness: 2017-09-07 12:32:33.541463Z] Running read-buildbot-config step. 05:32:33 INFO - Running pre-action listener: _resource_record_pre_action 05:32:33 INFO - Running main action method: read_buildbot_config 05:32:33 INFO - Using buildbot properties: 05:32:33 INFO - { 05:32:33 INFO - "project": "", 05:32:33 INFO - "product": "firefox", 05:32:33 INFO - "who": "archaeopteryx@coole-files.de", 05:32:33 INFO - "installer_path": "public/build/target.tar.bz2", 05:32:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 05:32:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 05:32:33 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 05:32:33 INFO - "stage_platform": "linux64-stylosequential", 05:32:33 INFO - "basedir": "/builds/slave/test", 05:32:33 INFO - "buildnumber": 63, 05:32:33 INFO - "platform": "ubuntu64_hw_styloseq", 05:32:33 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:32:33 INFO - "slavebuilddir": "test", 05:32:33 INFO - "taskId": "WLpaGvWYQRynMWOjkyyJwA", 05:32:33 INFO - "branch": "mozilla-central", 05:32:33 INFO - "script_repo_revision": "production", 05:32:33 INFO - "revision": "37b95547f0d27565452136d16b2df2857be840f6", 05:32:33 INFO - "slavename": "talos-linux64-ix-036", 05:32:33 INFO - "repo_path": "mozilla-central" 05:32:33 INFO - } 05:32:33 INFO - Finding installer, test and symbols from parent task. 05:32:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WLpaGvWYQRynMWOjkyyJwA'}, attempt #1 05:32:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WLpaGvWYQRynMWOjkyyJwA'}, attempt #1 05:32:34 INFO - Task dependencies: O4Y3kdYKTk6AYNU8oh2jiA 05:32:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA'}, attempt #1 05:32:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.tar.bz2 05:32:34 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.test_packages.json 05:32:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.crashreporter-symbols.zip 05:32:34 INFO - Running post-action listener: _resource_record_post_action 05:32:34 INFO - [mozharness: 2017-09-07 12:32:34.956647Z] Finished read-buildbot-config step (success) 05:32:34 INFO - [mozharness: 2017-09-07 12:32:34.956867Z] Running download-and-extract step. 05:32:34 INFO - Running pre-action listener: _resource_record_pre_action 05:32:34 INFO - Running main action method: download_and_extract 05:32:34 INFO - mkdir: /builds/slave/test/build/tests 05:32: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')]} 05:32:34 INFO - trying https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.test_packages.json 05:32:34 INFO - Downloading https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:32:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:32:35 INFO - Downloaded 989 bytes. 05:32:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:32:35 INFO - Using the following test package requirements: 05:32:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:32:35 INFO - u'common': [u'target.common.tests.zip'], 05:32:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:32:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:32:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:32:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:32:35 INFO - u'mozbase': [u'target.common.tests.zip'], 05:32:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:32:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:32:35 INFO - u'web-platform': [u'target.common.tests.zip', 05:32:35 INFO - u'target.web-platform.tests.tar.gz'], 05:32:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:32:35 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:32:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.common.tests.zip 05:32:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:32:35 INFO - Fetch https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.common.tests.zip into memory 05:32:36 INFO - Content-Length response header: 55021160 05:32:36 INFO - Bytes received: 55021160 05:32:48 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:32:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.common.tests.zip 05:32:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:32:48 INFO - Fetch https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.common.tests.zip into memory 05:32:49 INFO - Content-Length response header: 55021160 05:32:49 INFO - Bytes received: 55021160 05:33:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.talos.tests.zip 05:33:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:33:03 INFO - Fetch https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.talos.tests.zip into memory 05:33:04 INFO - Content-Length response header: 14496665 05:33:04 INFO - Bytes received: 14496665 05:33:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:04 INFO - trying https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.tar.bz2 05:33:04 INFO - Downloading https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:33:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:33:05 INFO - Downloaded 62729505 bytes. 05:33:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.tar.bz2 05:33:05 INFO - mkdir: /builds/slave/test/properties 05:33:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:33:05 INFO - Writing to file /builds/slave/test/properties/build_url 05:33:05 INFO - Contents: 05:33:05 INFO - build_url:https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.tar.bz2 05:33:05 INFO - Running post-action listener: _resource_record_post_action 05:33:05 INFO - Running post-action listener: find_tests_for_verification 05:33:05 INFO - Running post-action listener: set_extra_try_arguments 05:33:05 INFO - [mozharness: 2017-09-07 12:33:05.930050Z] Finished download-and-extract step (success) 05:33:05 INFO - [mozharness: 2017-09-07 12:33:05.930159Z] Running populate-webroot step. 05:33:05 INFO - Running pre-action listener: _resource_record_pre_action 05:33:05 INFO - Running main action method: populate_webroot 05:33:05 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:33:05 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:33:05 INFO - 'tests': ['tresize', 05:33:05 INFO - 'tcanvasmark']}, 05:33:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:33:05 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:33:05 INFO - 'tests': ['dromaeo_css', 05:33:05 INFO - 'kraken']}, 05:33:05 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:33:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:33:05 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:33:05 INFO - 'talos_options': ['--disable-stylo'], 05:33:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:33:05 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:33:05 INFO - 'tests': ['damp', 'tps']}, 05:33:05 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:33:05 INFO - 'talos_options': ['--disable-stylo'], 05:33:05 INFO - 'tests': ['damp', 'tps']}, 05:33:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:33:05 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:33:05 INFO - 'tests': ['dromaeo_dom']}, 05:33:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:33:05 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:33:05 INFO - 'tests': ['basic_compositor_video', 05:33:05 INFO - 'glvideo']}, 05:33:05 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:33:05 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:33:05 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:33:05 INFO - 'talos_options': ['--disable-stylo'], 05:33:05 INFO - 'tests': ['ts_paint_webext', 05:33:05 INFO - 'tp5o_webext']}, 05:33:05 INFO - 'other-e10s': {'tests': ['a11yr', 05:33:05 INFO - 'ts_paint', 05:33:05 INFO - 'tpaint', 05:33:05 INFO - 'sessionrestore', 05:33:05 INFO - 'sessionrestore_many_windows', 05:33:05 INFO - 'sessionrestore_no_auto_restore', 05:33:05 INFO - 'tabpaint']}, 05:33:05 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:33:05 INFO - 'tests': ['a11yr', 05:33:05 INFO - 'ts_paint', 05:33:05 INFO - 'tpaint', 05:33:05 INFO - 'sessionrestore', 05:33:05 INFO - 'sessionrestore_many_windows', 05:33:05 INFO - 'sessionrestore_no_auto_restore', 05:33:05 INFO - 'tabpaint']}, 05:33:05 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 05:33:05 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 05:33:05 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:33:05 INFO - 'tests': ['bloom_basic_singleton']}, 05:33:05 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:33:05 INFO - 'tests': ['bloom_basic']}, 05:33:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:33:05 INFO - 'tsvgr_opacity', 05:33:05 INFO - 'tart', 05:33:05 INFO - 'tscrollx', 05:33:05 INFO - 'tsvg_static']}, 05:33:05 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:33:05 INFO - 'tests': ['tsvgx', 05:33:05 INFO - 'tsvgr_opacity', 05:33:05 INFO - 'tart', 05:33:05 INFO - 'tscrollx', 05:33:05 INFO - 'tsvg_static']}, 05:33:05 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:33:05 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:33:05 INFO - 'talos_options': ['--disable-stylo'], 05:33:05 INFO - 'tests': ['tp5o']}, 05:33:05 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:33:05 INFO - 'talos_options': ['--mitmproxy', 05:33:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:33:05 INFO - '--firstNonBlankPaint'], 05:33:05 INFO - 'tests': ['tp6_google', 05:33:05 INFO - 'tp6_youtube', 05:33:05 INFO - 'tp6_amazon', 05:33:05 INFO - 'tp6_facebook']}, 05:33:05 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:33:05 INFO - 'talos_options': ['--disable-stylo', 05:33:05 INFO - '--mitmproxy', 05:33:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:33:05 INFO - '--firstNonBlankPaint'], 05:33:05 INFO - 'tests': ['tp6_google', 05:33:05 INFO - 'tp6_youtube', 05:33:05 INFO - 'tp6_amazon', 05:33:05 INFO - 'tp6_facebook']}, 05:33:05 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:33:05 INFO - 'talos_options': ['--stylo-threads=1', 05:33:05 INFO - '--mitmproxy', 05:33:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:33:05 INFO - '--firstNonBlankPaint'], 05:33:05 INFO - 'tests': ['tp6_google', 05:33:05 INFO - 'tp6_youtube', 05:33:05 INFO - 'tp6_amazon', 05:33:05 INFO - 'tp6_facebook']}, 05:33:05 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:33:05 INFO - 'talos_options': ['--xperf_path', 05:33:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:33:05 INFO - 'tests': ['tp5n']}, 05:33:05 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:33:05 INFO - 'talos_options': ['--disable-stylo', 05:33:05 INFO - '--xperf_path', 05:33:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:33:05 INFO - 'tests': ['tp5n']}}} 05:33:05 INFO - Running post-action listener: _resource_record_post_action 05:33:05 INFO - [mozharness: 2017-09-07 12:33:05.946131Z] Finished populate-webroot step (success) 05:33:05 INFO - [mozharness: 2017-09-07 12:33:05.946231Z] Running create-virtualenv step. 05:33:05 INFO - Running pre-action listener: _resource_record_pre_action 05:33:05 INFO - Running main action method: create_virtualenv 05:33:05 INFO - Creating virtualenv /builds/slave/test/build/venv 05:33:05 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:33:05 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 05:33:05 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:33:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:33:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:33:06 INFO - Installing distribute.............................................................................................................................................................................................done. 05:33:07 INFO - Installing pip...............done. 05:33:07 INFO - Return code: 0 05:33:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:33:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:33:07 INFO - Reading from file tmpfile_stdout 05:33:07 INFO - Output received: 05:33:07 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 05:33:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:33:07 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')]} 05:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:07 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')]} 05:33:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:07 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 0xd571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf20a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7090>, '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 0x10c7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051', '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 05:33:07 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 05:33:07 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 05:33:07 INFO - Using env: {'DISPLAY': ':0', 05:33:07 INFO - 'HOME': '/home/cltbld', 05:33:07 INFO - 'LANG': 'en_US.UTF-8', 05:33:07 INFO - 'LANGUAGE': 'en_US:en', 05:33:07 INFO - 'LOGNAME': 'cltbld', 05:33:07 INFO - 'MAIL': '/var/mail/cltbld', 05:33:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:07 INFO - 'MOZ_NO_REMOTE': '1', 05:33:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:07 INFO - 'NO_EM_RESTART': '1', 05:33:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:07 INFO - 'PWD': '/builds/slave/test', 05:33:07 INFO - 'SHELL': '/bin/bash', 05:33:07 INFO - 'SHLVL': '1', 05:33:07 INFO - 'TERM': 'linux', 05:33:07 INFO - 'TMOUT': '86400', 05:33:07 INFO - 'USER': 'cltbld', 05:33:07 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051', 05:33:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:07 INFO - '_': '/tools/buildbot/bin/python'} 05:33:08 INFO - Ignoring indexes: http://pypi.python.org/simple/ 05:33:08 INFO - Downloading/unpacking pip>=1.5 05:33:08 INFO - Running setup.py egg_info for package pip 05:33:08 INFO - warning: no files found matching 'pip/cacert.pem' 05:33:08 INFO - warning: no files found matching '*.html' under directory 'docs' 05:33:08 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 05:33:08 INFO - no previously-included directories found matching 'docs/_build/_sources' 05:33:08 INFO - Installing collected packages: pip 05:33:08 INFO - Found existing installation: pip 1.1 05:33:08 INFO - Uninstalling pip: 05:33:08 INFO - Successfully uninstalled pip 05:33:08 INFO - Running setup.py install for pip 05:33:08 INFO - warning: no files found matching 'pip/cacert.pem' 05:33:08 INFO - warning: no files found matching '*.html' under directory 'docs' 05:33:08 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 05:33:08 INFO - no previously-included directories found matching 'docs/_build/_sources' 05:33:08 INFO - Installing pip script to /builds/slave/test/build/venv/bin 05:33:08 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 05:33:08 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 05:33:08 INFO - Successfully installed pip 05:33:08 INFO - Cleaning up... 05:33:08 INFO - Return code: 0 05:33:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:33:08 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')]} 05:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:08 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')]} 05:33:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:08 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 0xd571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf20a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7090>, '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 0x10c7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051', '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 05:33:08 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 05:33:08 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 05:33:08 INFO - Using env: {'DISPLAY': ':0', 05:33:08 INFO - 'HOME': '/home/cltbld', 05:33:08 INFO - 'LANG': 'en_US.UTF-8', 05:33:08 INFO - 'LANGUAGE': 'en_US:en', 05:33:08 INFO - 'LOGNAME': 'cltbld', 05:33:08 INFO - 'MAIL': '/var/mail/cltbld', 05:33:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:08 INFO - 'MOZ_NO_REMOTE': '1', 05:33:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:08 INFO - 'NO_EM_RESTART': '1', 05:33:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:08 INFO - 'PWD': '/builds/slave/test', 05:33:08 INFO - 'SHELL': '/bin/bash', 05:33:08 INFO - 'SHLVL': '1', 05:33:08 INFO - 'TERM': 'linux', 05:33:08 INFO - 'TMOUT': '86400', 05:33:08 INFO - 'USER': 'cltbld', 05:33:08 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051', 05:33:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:08 INFO - '_': '/tools/buildbot/bin/python'} 05:33:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:08 INFO - Downloading/unpacking psutil>=3.1.1 05:33:08 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 05:33:08 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 05:33:08 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 05:33:08 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 05:33:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:33:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:33:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:33:09 INFO - Installing collected packages: psutil 05:33:09 INFO - Running setup.py install for psutil 05:33:09 INFO - building 'psutil._psutil_linux' extension 05:33:09 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 05:33:11 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 05:33:11 INFO - building 'psutil._psutil_posix' extension 05:33:11 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 05:33:11 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 05:33:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:33:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:33:11 INFO - Successfully installed psutil 05:33:11 INFO - Cleaning up... 05:33:11 INFO - Return code: 0 05:33:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:33:11 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')]} 05:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:11 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')]} 05:33:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:11 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 0xd571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf20a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7090>, '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 0x10c7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051', '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 05:33:11 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 05:33:11 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 05:33:11 INFO - Using env: {'DISPLAY': ':0', 05:33:11 INFO - 'HOME': '/home/cltbld', 05:33:11 INFO - 'LANG': 'en_US.UTF-8', 05:33:11 INFO - 'LANGUAGE': 'en_US:en', 05:33:11 INFO - 'LOGNAME': 'cltbld', 05:33:11 INFO - 'MAIL': '/var/mail/cltbld', 05:33:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:11 INFO - 'MOZ_NO_REMOTE': '1', 05:33:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:11 INFO - 'NO_EM_RESTART': '1', 05:33:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:11 INFO - 'PWD': '/builds/slave/test', 05:33:11 INFO - 'SHELL': '/bin/bash', 05:33:11 INFO - 'SHLVL': '1', 05:33:11 INFO - 'TERM': 'linux', 05:33:11 INFO - 'TMOUT': '86400', 05:33:11 INFO - 'USER': 'cltbld', 05:33:11 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051', 05:33:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:11 INFO - '_': '/tools/buildbot/bin/python'} 05:33:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:33:11 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 05:33:11 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 05:33:11 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 05:33:11 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 05:33:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:33:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:33:12 INFO - Installing collected packages: mozsystemmonitor 05:33:12 INFO - Running setup.py install for mozsystemmonitor 05:33:13 INFO - Successfully installed mozsystemmonitor 05:33:13 INFO - Cleaning up... 05:33:13 INFO - Return code: 0 05:33:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:33:13 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')]} 05:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:13 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')]} 05:33:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:13 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 0xd571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf20a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7090>, '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 0x10c7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051', '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 05:33:13 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 05:33:13 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 05:33:13 INFO - Using env: {'DISPLAY': ':0', 05:33:13 INFO - 'HOME': '/home/cltbld', 05:33:13 INFO - 'LANG': 'en_US.UTF-8', 05:33:13 INFO - 'LANGUAGE': 'en_US:en', 05:33:13 INFO - 'LOGNAME': 'cltbld', 05:33:13 INFO - 'MAIL': '/var/mail/cltbld', 05:33:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:13 INFO - 'MOZ_NO_REMOTE': '1', 05:33:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:13 INFO - 'NO_EM_RESTART': '1', 05:33:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:13 INFO - 'PWD': '/builds/slave/test', 05:33:13 INFO - 'SHELL': '/bin/bash', 05:33:13 INFO - 'SHLVL': '1', 05:33:13 INFO - 'TERM': 'linux', 05:33:13 INFO - 'TMOUT': '86400', 05:33:13 INFO - 'USER': 'cltbld', 05:33:13 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051', 05:33:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:13 INFO - '_': '/tools/buildbot/bin/python'} 05:33:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:13 INFO - Downloading/unpacking jsonschema==2.5.1 05:33:13 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 05:33:13 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 05:33:13 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 05:33:13 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 05:33:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:33:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:33:14 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 05:33:14 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 05:33:14 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 05:33:14 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 05:33:14 INFO - Downloading functools32-3.2.3-2.tar.gz 05:33:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:33:14 INFO - warning: no files found matching '*.txt' 05:33:14 INFO - no previously-included directories found matching 'build' 05:33:14 INFO - no previously-included directories found matching 'dist' 05:33:14 INFO - no previously-included directories found matching '.git*' 05:33:14 INFO - Installing collected packages: jsonschema, functools32 05:33:14 INFO - Running setup.py install for functools32 05:33:14 INFO - warning: no files found matching '*.txt' 05:33:14 INFO - no previously-included directories found matching 'build' 05:33:14 INFO - no previously-included directories found matching 'dist' 05:33:14 INFO - no previously-included directories found matching '.git*' 05:33:14 INFO - Successfully installed jsonschema functools32 05:33:14 INFO - Cleaning up... 05:33:14 INFO - Return code: 0 05:33:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:33:14 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')]} 05:33:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:14 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')]} 05:33:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:14 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 0xd571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf20a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7090>, '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 0x10c7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051', '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 05:33:14 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 05:33:14 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 05:33:14 INFO - Using env: {'DISPLAY': ':0', 05:33:14 INFO - 'HOME': '/home/cltbld', 05:33:14 INFO - 'LANG': 'en_US.UTF-8', 05:33:14 INFO - 'LANGUAGE': 'en_US:en', 05:33:14 INFO - 'LOGNAME': 'cltbld', 05:33:14 INFO - 'MAIL': '/var/mail/cltbld', 05:33:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:14 INFO - 'MOZ_NO_REMOTE': '1', 05:33:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:14 INFO - 'NO_EM_RESTART': '1', 05:33:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:14 INFO - 'PWD': '/builds/slave/test', 05:33:14 INFO - 'SHELL': '/bin/bash', 05:33:14 INFO - 'SHLVL': '1', 05:33:14 INFO - 'TERM': 'linux', 05:33:14 INFO - 'TMOUT': '86400', 05:33:14 INFO - 'USER': 'cltbld', 05:33:14 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051', 05:33:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:14 INFO - '_': '/tools/buildbot/bin/python'} 05:33:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:33:14 INFO - Cleaning up... 05:33:15 INFO - Return code: 0 05:33:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:33:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:15 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 0xd571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf20a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7090>, '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 0x10c7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051', '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 05:33:15 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 05:33:15 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 05:33:15 INFO - Using env: {'DISPLAY': ':0', 05:33:15 INFO - 'HOME': '/home/cltbld', 05:33:15 INFO - 'LANG': 'en_US.UTF-8', 05:33:15 INFO - 'LANGUAGE': 'en_US:en', 05:33:15 INFO - 'LOGNAME': 'cltbld', 05:33:15 INFO - 'MAIL': '/var/mail/cltbld', 05:33:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:15 INFO - 'MOZ_NO_REMOTE': '1', 05:33:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:15 INFO - 'NO_EM_RESTART': '1', 05:33:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:15 INFO - 'PWD': '/builds/slave/test', 05:33:15 INFO - 'SHELL': '/bin/bash', 05:33:15 INFO - 'SHLVL': '1', 05:33:15 INFO - 'TERM': 'linux', 05:33:15 INFO - 'TMOUT': '86400', 05:33:15 INFO - 'USER': 'cltbld', 05:33:15 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051', 05:33:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:15 INFO - '_': '/tools/buildbot/bin/python'} 05:33:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:15 INFO - Downloading/unpacking blobuploader==1.2.4 05:33:15 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 05:33:15 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 05:33:15 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 05:33:15 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 05:33:16 INFO - Downloading blobuploader-1.2.4.tar.gz 05:33:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:33:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:33:16 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 05:33:16 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 05:33:16 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 05:33:16 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 05:33:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:33:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:33:16 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 05:33:16 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 05:33:16 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 05:33:16 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 05:33:16 INFO - Downloading docopt-0.6.1.tar.gz 05:33:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:33:16 INFO - Installing collected packages: blobuploader, requests, docopt 05:33:16 INFO - Running setup.py install for blobuploader 05:33:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:33:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:33:17 INFO - Running setup.py install for requests 05:33:17 INFO - Running setup.py install for docopt 05:33:17 INFO - Successfully installed blobuploader requests docopt 05:33:17 INFO - Cleaning up... 05:33:17 INFO - Return code: 0 05:33:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:33:17 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')]} 05:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:17 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')]} 05:33:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:17 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 0xd571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf20a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7090>, '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 0x10c7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051', '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 05:33:17 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 05:33:17 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 05:33:17 INFO - Using env: {'DISPLAY': ':0', 05:33:17 INFO - 'HOME': '/home/cltbld', 05:33:17 INFO - 'LANG': 'en_US.UTF-8', 05:33:17 INFO - 'LANGUAGE': 'en_US:en', 05:33:17 INFO - 'LOGNAME': 'cltbld', 05:33:17 INFO - 'MAIL': '/var/mail/cltbld', 05:33:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:17 INFO - 'MOZ_NO_REMOTE': '1', 05:33:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:17 INFO - 'NO_EM_RESTART': '1', 05:33:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:17 INFO - 'PWD': '/builds/slave/test', 05:33:17 INFO - 'SHELL': '/bin/bash', 05:33:17 INFO - 'SHLVL': '1', 05:33:17 INFO - 'TERM': 'linux', 05:33:17 INFO - 'TMOUT': '86400', 05:33:17 INFO - 'USER': 'cltbld', 05:33:17 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051', 05:33:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:17 INFO - '_': '/tools/buildbot/bin/python'} 05:33:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:33:17 INFO - Running setup.py (path:/tmp/pip-2pa6DD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:33:17 INFO - Running setup.py (path:/tmp/pip-jsk76Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:33:17 INFO - Running setup.py (path:/tmp/pip-1qUdi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:33:17 INFO - Running setup.py (path:/tmp/pip-G5ZT2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:33:18 INFO - Running setup.py (path:/tmp/pip-YQIlGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:33:18 INFO - Running setup.py (path:/tmp/pip-2_r6Cl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:33:18 INFO - Running setup.py (path:/tmp/pip-CDsR3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:33:18 INFO - Running setup.py (path:/tmp/pip-oJsJFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:33:18 INFO - Running setup.py (path:/tmp/pip-peEDNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:33:18 INFO - Running setup.py (path:/tmp/pip-Tn2A4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:33:18 INFO - Running setup.py (path:/tmp/pip-Mic6Xj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:33:18 INFO - Running setup.py (path:/tmp/pip-AhQ7su-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:33:18 INFO - Running setup.py (path:/tmp/pip-0XVweh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:33:18 INFO - Running setup.py (path:/tmp/pip-Hk8Jws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:18 INFO - Running setup.py (path:/tmp/pip-e0GCeh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:33:18 INFO - Running setup.py (path:/tmp/pip-z9Hoin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:33:18 INFO - Running setup.py (path:/tmp/pip-LVtOKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:33:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:33:18 INFO - Running setup.py install for manifestparser 05:33:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:33:19 INFO - Running setup.py install for mozcrash 05:33:19 INFO - Running setup.py install for mozdebug 05:33:19 INFO - Running setup.py install for mozdevice 05:33:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:33:19 INFO - Running setup.py install for mozfile 05:33:19 INFO - Running setup.py install for mozhttpd 05:33:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:33:19 INFO - Running setup.py install for mozinfo 05:33:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:33:19 INFO - Running setup.py install for mozInstall 05:33:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:33:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:33:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:33:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:33:19 INFO - Running setup.py install for mozleak 05:33:19 INFO - Running setup.py install for mozlog 05:33:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:33:19 INFO - Running setup.py install for moznetwork 05:33:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:33:20 INFO - Running setup.py install for mozprocess 05:33:20 INFO - Running setup.py install for mozprofile 05:33:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:33:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:33:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:33:20 INFO - Running setup.py install for mozrunner 05:33:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:33:20 INFO - Running setup.py install for mozscreenshot 05:33:20 INFO - Running setup.py install for moztest 05:33:20 INFO - Running setup.py install for mozversion 05:33:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:33:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:33:20 INFO - Cleaning up... 05:33:20 INFO - Return code: 0 05:33:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:33:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:20 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 0xd571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf20a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7090>, '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 0x10c7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051', '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 05:33:20 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 05:33:20 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 05:33:20 INFO - Using env: {'DISPLAY': ':0', 05:33:20 INFO - 'HOME': '/home/cltbld', 05:33:20 INFO - 'LANG': 'en_US.UTF-8', 05:33:20 INFO - 'LANGUAGE': 'en_US:en', 05:33:20 INFO - 'LOGNAME': 'cltbld', 05:33:20 INFO - 'MAIL': '/var/mail/cltbld', 05:33:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:20 INFO - 'MOZ_NO_REMOTE': '1', 05:33:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:20 INFO - 'NO_EM_RESTART': '1', 05:33:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:20 INFO - 'PWD': '/builds/slave/test', 05:33:20 INFO - 'SHELL': '/bin/bash', 05:33:20 INFO - 'SHLVL': '1', 05:33:20 INFO - 'TERM': 'linux', 05:33:20 INFO - 'TMOUT': '86400', 05:33:20 INFO - 'USER': 'cltbld', 05:33:20 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051', 05:33:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:20 INFO - '_': '/tools/buildbot/bin/python'} 05:33:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:33:20 INFO - Running setup.py (path:/tmp/pip-yYUBnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:33:21 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)) 05:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:33:21 INFO - Running setup.py (path:/tmp/pip-CNTUAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:33:21 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)) 05:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:33:21 INFO - Running setup.py (path:/tmp/pip-fmoLMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:33:21 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)) 05:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:33:21 INFO - Running setup.py (path:/tmp/pip-wHgZaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:33:21 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)) 05:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:33:21 INFO - Running setup.py (path:/tmp/pip-ORpFzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:33:21 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)) 05:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:33:21 INFO - Running setup.py (path:/tmp/pip-Rz2uUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:33:21 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)) 05:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:33:21 INFO - Running setup.py (path:/tmp/pip-9VhPvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:33:21 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)) 05:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:33:21 INFO - Running setup.py (path:/tmp/pip-TIBO1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:33:21 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)) 05:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:33:21 INFO - Running setup.py (path:/tmp/pip-fXeo1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:33:21 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)) 05:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:33:21 INFO - Running setup.py (path:/tmp/pip-vxd0aJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:33:21 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)) 05:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:33:21 INFO - Running setup.py (path:/tmp/pip-9zrkSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:33:21 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)) 05:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:33:21 INFO - Running setup.py (path:/tmp/pip-uxYw8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:33:21 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)) 05:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:33:21 INFO - Running setup.py (path:/tmp/pip-BAhJPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:33:21 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)) 05:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:33:21 INFO - Running setup.py (path:/tmp/pip-Tqrr5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:33:21 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)) 05:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:21 INFO - Running setup.py (path:/tmp/pip-tZNTgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:22 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)) 05:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:33:22 INFO - Running setup.py (path:/tmp/pip-3w6goF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:33:22 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)) 05:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:33:22 INFO - Running setup.py (path:/tmp/pip-U5769k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:33:22 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)) 05:33:22 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)) 05:33:22 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)) 05:33:22 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)) 05:33:22 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)) 05:33:22 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)) 05:33:22 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)) 05:33:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:23 INFO - Downloading blessings-1.6.tar.gz 05:33:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:33:23 INFO - Installing collected packages: blessings 05:33:23 INFO - Running setup.py install for blessings 05:33:23 INFO - Successfully installed blessings 05:33:23 INFO - Cleaning up... 05:33:23 INFO - Return code: 0 05:33:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:33:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:33:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:33:23 INFO - Reading from file tmpfile_stdout 05:33:23 INFO - Current package versions: 05:33:23 INFO - argparse == 1.2.1 05:33:23 INFO - blessings == 1.6 05:33:23 INFO - blobuploader == 1.2.4 05:33:23 INFO - docopt == 0.6.1 05:33:23 INFO - functools32 == 3.2.3-2 05:33:23 INFO - jsonschema == 2.5.1 05:33:23 INFO - manifestparser == 1.1 05:33:23 INFO - mozInstall == 1.13 05:33:23 INFO - mozcrash == 1.0 05:33:23 INFO - mozdebug == 0.1 05:33:23 INFO - mozdevice == 0.51 05:33:23 INFO - mozfile == 1.2 05:33:23 INFO - mozhttpd == 0.7 05:33:23 INFO - mozinfo == 0.10 05:33:23 INFO - mozleak == 0.1 05:33:23 INFO - mozlog == 3.5 05:33:23 INFO - moznetwork == 0.27 05:33:23 INFO - mozprocess == 0.25 05:33:23 INFO - mozprofile == 0.28 05:33:23 INFO - mozrunner == 6.13 05:33:23 INFO - mozscreenshot == 0.1 05:33:23 INFO - mozsystemmonitor == 0.3 05:33:23 INFO - moztest == 0.8 05:33:23 INFO - mozversion == 1.4 05:33:23 INFO - psutil == 3.1.1 05:33:23 INFO - requests == 1.2.3 05:33:23 INFO - wsgiref == 0.1.2 05:33:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:33:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:23 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 0xd571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf20a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7090>, '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 0x10c7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051', '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 05:33:23 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 05:33:23 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 05:33:23 INFO - Using env: {'DISPLAY': ':0', 05:33:23 INFO - 'HOME': '/home/cltbld', 05:33:23 INFO - 'LANG': 'en_US.UTF-8', 05:33:23 INFO - 'LANGUAGE': 'en_US:en', 05:33:23 INFO - 'LOGNAME': 'cltbld', 05:33:23 INFO - 'MAIL': '/var/mail/cltbld', 05:33:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:23 INFO - 'MOZ_NO_REMOTE': '1', 05:33:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:23 INFO - 'NO_EM_RESTART': '1', 05:33:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:23 INFO - 'PWD': '/builds/slave/test', 05:33:23 INFO - 'SHELL': '/bin/bash', 05:33:23 INFO - 'SHLVL': '1', 05:33:23 INFO - 'TERM': 'linux', 05:33:23 INFO - 'TMOUT': '86400', 05:33:23 INFO - 'USER': 'cltbld', 05:33:23 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051', 05:33:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:23 INFO - '_': '/tools/buildbot/bin/python'} 05:33:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:23 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)) 05:33:23 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)) 05:33:23 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)) 05:33:23 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)) 05:33:23 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)) 05:33:23 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)) 05:33:23 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)) 05:33:23 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)) 05:33:23 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)) 05:33:23 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 05:33:25 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)) 05:33:25 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)) 05:33:25 INFO - Installing collected packages: simplejson 05:33:25 INFO - Running setup.py install for simplejson 05:33:25 INFO - building 'simplejson._speedups' extension 05:33:25 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 05:33:26 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 05:33:26 INFO - Successfully installed simplejson 05:33:26 INFO - Cleaning up... 05:33:26 INFO - Return code: 0 05:33:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:33:26 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')]} 05:33:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:26 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')]} 05:33:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:26 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 0xd571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf20a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7090>, '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 0x10c7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051', '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 05:33:26 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 05:33:26 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 05:33:26 INFO - Using env: {'DISPLAY': ':0', 05:33:26 INFO - 'HOME': '/home/cltbld', 05:33:26 INFO - 'LANG': 'en_US.UTF-8', 05:33:26 INFO - 'LANGUAGE': 'en_US:en', 05:33:26 INFO - 'LOGNAME': 'cltbld', 05:33:26 INFO - 'MAIL': '/var/mail/cltbld', 05:33:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:26 INFO - 'MOZ_NO_REMOTE': '1', 05:33:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:26 INFO - 'NO_EM_RESTART': '1', 05:33:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:26 INFO - 'PWD': '/builds/slave/test', 05:33:26 INFO - 'SHELL': '/bin/bash', 05:33:26 INFO - 'SHLVL': '1', 05:33:26 INFO - 'TERM': 'linux', 05:33:26 INFO - 'TMOUT': '86400', 05:33:26 INFO - 'USER': 'cltbld', 05:33:26 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051', 05:33:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:26 INFO - '_': '/tools/buildbot/bin/python'} 05:33:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:33:26 INFO - Cleaning up... 05:33:26 INFO - Return code: 0 05:33:26 INFO - Running post-action listener: _resource_record_post_action 05:33:26 INFO - Running post-action listener: _start_resource_monitoring 05:33:26 INFO - Starting resource monitoring. 05:33:26 INFO - [mozharness: 2017-09-07 12:33:26.454097Z] Finished create-virtualenv step (success) 05:33:26 INFO - [mozharness: 2017-09-07 12:33:26.455028Z] Running install step. 05:33:26 INFO - Running pre-action listener: _resource_record_pre_action 05:33:26 INFO - Running main action method: install 05:33:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:33:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:33:26 INFO - Reading from file tmpfile_stdout 05:33:26 INFO - Detecting whether we're running mozinstall >=1.0... 05:33:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:33:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:33:26 INFO - Reading from file tmpfile_stdout 05:33:26 INFO - Output received: 05:33:26 INFO - Usage: mozinstall [options] installer 05:33:26 INFO - Options: 05:33:26 INFO - -h, --help show this help message and exit 05:33:26 INFO - -d DEST, --destination=DEST 05:33:26 INFO - Directory to install application into. [default: 05:33:26 INFO - "/builds/slave/test"] 05:33:26 INFO - --app=APP Application being installed. [default: firefox] 05:33:26 INFO - mkdir: /builds/slave/test/build/application 05:33:26 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'] 05:33:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:33:43 INFO - Reading from file tmpfile_stdout 05:33:43 INFO - Output received: 05:33:43 INFO - /builds/slave/test/build/application/firefox/firefox 05:33:43 INFO - Running post-action listener: _resource_record_post_action 05:33:43 INFO - [mozharness: 2017-09-07 12:33:43.279982Z] Finished install step (success) 05:33:43 INFO - [mozharness: 2017-09-07 12:33:43.280130Z] Running setup-mitmproxy step. 05:33:43 INFO - Running pre-action listener: _resource_record_pre_action 05:33:43 INFO - Running main action method: setup_mitmproxy 05:33:43 INFO - Skipping: mitmproxy is not required 05:33:43 INFO - Running post-action listener: _resource_record_post_action 05:33:43 INFO - [mozharness: 2017-09-07 12:33:43.280832Z] Finished setup-mitmproxy step (success) 05:33:43 INFO - [mozharness: 2017-09-07 12:33:43.280965Z] Running run-tests step. 05:33:43 INFO - Running pre-action listener: _resource_record_pre_action 05:33:43 INFO - Running pre-action listener: _set_gcov_prefix 05:33:43 INFO - Running main action method: run_tests 05:33:43 WARNING - Try message not found. 05:33:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:33:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:33:43 INFO - Python 2.7.3 05:33:43 INFO - Return code: 0 05:33:43 INFO - grabbing minidump binary from tooltool 05:33: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')]} 05:33:43 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7090>, '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 0x10c7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:33:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:33:43 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:33:43 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:33:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:33:43 INFO - Return code: 0 05:33:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:33:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:33:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:33:43 INFO - ENV: RUST_BACKTRACE is now full 05:33:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:33:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:33:43 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/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 05:33:43 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/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 05:33:43 INFO - Using env: {'DISPLAY': ':0', 05:33:43 INFO - 'HOME': '/home/cltbld', 05:33:43 INFO - 'LANG': 'en_US.UTF-8', 05:33:43 INFO - 'LANGUAGE': 'en_US:en', 05:33:43 INFO - 'LOGNAME': 'cltbld', 05:33:43 INFO - 'MAIL': '/var/mail/cltbld', 05:33:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:33:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:33:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:43 INFO - 'MOZ_NO_REMOTE': '1', 05:33:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:33:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:43 INFO - 'NO_EM_RESTART': '1', 05:33:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:43 INFO - 'PWD': '/builds/slave/test', 05:33:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:33:43 INFO - 'RUST_BACKTRACE': 'full', 05:33:43 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:33:43 INFO - 'SHELL': '/bin/bash', 05:33:43 INFO - 'SHLVL': '1', 05:33:43 INFO - 'STYLO_FORCE_ENABLED': '1', 05:33:43 INFO - 'STYLO_THREADS': '1', 05:33:43 INFO - 'TERM': 'linux', 05:33:43 INFO - 'TMOUT': '86400', 05:33:43 INFO - 'USER': 'cltbld', 05:33:43 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051', 05:33:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:43 INFO - '_': '/tools/buildbot/bin/python'} 05:33:43 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/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 05:33:43 INFO - mozversion application_buildid: 20170907103944 05:33:43 INFO - mozversion application_changeset: 37b95547f0d27565452136d16b2df2857be840f6 05:33:43 INFO - mozversion application_display_name: Nightly 05:33:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:33:43 INFO - mozversion application_name: Firefox 05:33:43 INFO - mozversion application_remotingname: firefox 05:33:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:33:43 INFO - mozversion application_vendor: Mozilla 05:33:43 INFO - mozversion application_version: 57.0a1 05:33:43 INFO - mozversion platform_buildid: 20170907103944 05:33:43 INFO - mozversion platform_changeset: 37b95547f0d27565452136d16b2df2857be840f6 05:33:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:33:43 INFO - mozversion platform_version: 57.0a1 05:33:43 INFO - using testdate: 1504787623 05:33:43 INFO - actual date: 1504787623 05:33:43 INFO - starting webserver on 'localhost:55233' 05:33:43 INFO - SUITE-START | Running 2 tests 05:33:43 INFO - TEST-START | dromaeo_css 05:33:43 INFO - Initialising browser for dromaeo_css test... 05:33:43 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55233/getInfo.html -profile /tmp/tmpK109yh/profile 05:33:43 INFO - TEST-INFO | started process 3811 (/builds/slave/test/build/application/firefox/firefox http://localhost:55233/getInfo.html) 05:33:53 INFO - TEST-INFO | 3811: exit 0 05:33:53 INFO - Browser initialized. 05:33:53 INFO - Running cycle 1/1 for dromaeo_css test... 05:33:53 INFO - Using env: {'DISPLAY': ':0', 05:33:53 INFO - 'HOME': '/home/cltbld', 05:33:53 INFO - 'JSGC_DISABLE_POISONING': '1', 05:33:53 INFO - 'LANG': 'en_US.UTF-8', 05:33:53 INFO - 'LANGUAGE': 'en_US:en', 05:33:53 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 05:33:53 INFO - 'LOGNAME': 'cltbld', 05:33:53 INFO - 'MAIL': '/var/mail/cltbld', 05:33:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:33:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:33:53 INFO - 'MOZ_CRASHREPORTER': '1', 05:33:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:53 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 05:33:53 INFO - 'MOZ_NO_REMOTE': '1', 05:33:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:33:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:53 INFO - 'NO_EM_RESTART': '1', 05:33:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:53 INFO - 'PWD': '/builds/slave/test', 05:33:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:33:53 INFO - 'RUST_BACKTRACE': 'full', 05:33:53 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:33:53 INFO - 'SHELL': '/bin/bash', 05:33:53 INFO - 'SHLVL': '1', 05:33:53 INFO - 'STYLO_FORCE_ENABLED': '1', 05:33:53 INFO - 'STYLO_THREADS': '1', 05:33:53 INFO - 'TERM': 'linux', 05:33:53 INFO - 'TMOUT': '86400', 05:33:53 INFO - 'USER': 'cltbld', 05:33:53 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051', 05:33:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:53 INFO - '_': '/tools/buildbot/bin/python'} 05:33:53 INFO - TEST-INFO | started process 4000 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK109yh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:33:54 INFO - PID 4000 | 05:33:54 INFO - PID 4000 | (/builds/slave/test/build/application/firefox/firefox:4051): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:33:54 INFO - PID 4000 | 05:34:04 INFO - PID 4000 | RSS: Main: 170405888 05:34:04 INFO - PID 4000 | 05:37:02 INFO - PID 4000 | Cycle 1(1): loaded http://localhost:55233/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55233/tests/dromaeo/cssquery-ext.html) 05:37:03 INFO - PID 4000 | RSS: Main: 174301184 05:37:03 INFO - PID 4000 | 05:40:05 INFO - PID 4000 | Cycle 1(1): loaded http://localhost:55233/tests/dromaeo/cssquery-ext.html (next: http://localhost:55233/tests/dromaeo/cssquery-jquery.html) 05:40:06 INFO - PID 4000 | RSS: Main: 168148992 05:40:06 INFO - PID 4000 | 05:43:07 INFO - PID 4000 | Cycle 1(1): loaded http://localhost:55233/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55233/tests/dromaeo/cssquery-mootools.html) 05:43:08 INFO - PID 4000 | RSS: Main: 173039616 05:43:08 INFO - PID 4000 | 05:46:10 INFO - PID 4000 | Cycle 1(1): loaded http://localhost:55233/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55233/tests/dromaeo/cssquery-prototype.html) 05:46:10 INFO - PID 4000 | RSS: Main: 169164800 05:46:10 INFO - PID 4000 | 05:49:14 INFO - PID 4000 | Cycle 1(1): loaded http://localhost:55233/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55233/tests/dromaeo/cssquery-yui.html) 05:49:14 INFO - PID 4000 | RSS: Main: 172998656 05:49:14 INFO - PID 4000 | 05:52:16 INFO - PID 4000 | Cycle 1(1): loaded http://localhost:55233/tests/dromaeo/cssquery-yui.html (next: http://localhost:55233/tests/dromaeo/cssquery-dojo.html) 05:52:16 INFO - PID 4000 | RSS: Main: 175714304 05:52:16 INFO - PID 4000 | 05:52:16 INFO - PID 4000 | __start_tp_report 05:52:16 INFO - PID 4000 | _x_x_mozilla_page_load 05:52:16 INFO - PID 4000 | _x_x_mozilla_page_load_details 05:52:16 INFO - PID 4000 | |i|pagename|runs| 05:52:16 INFO - PID 4000 | |0;dojo.html;3279.3441311737656;3303.405387030335;3312.370649576582;3327.7670563060597;3335.8498867550957;6313.053042043695;6415.45468635166;6428.614283143009;6455.096286519891;6479.676016199189;6375.968120159404;6432.935670643304;6441.066045423411;6459.063435801818;6584.012398140281;5948.494377977877;5965.284165900076;5982.8803423931495;6022.397760223987;6025.307089684698;1210.9425995201248;5519.806806761764;5810.941890581083;5955.761769529214;6062.42406971337;5904.084866845646;5930.318013428468;5943.554233432488;5986.191864098357;6012.098185272201;5912.704364781786;5937.168796368512;5989.221401217814;5999.820005399845;6016.037434010581;5878.030125029408;5894.17481552583;5962.403759624046;5982.222311099529;5990.101484777275;6428.357164283581;6428.5178611604315;6473.676316184172;6532.934670653281;6558.508111891627;6601.240857301424;6695.765648202289;6823.624700641462;6899.344562266577;6993.510454268203;6982.371586557234;7023.648817559101;7043.436525077981;7044.436445084381;7057.435405167575;6436.999999999954;6470.708818103197;6541.901871471931;6550.901736473957;6554.541182117254;7149.177844547944;7152.499325047197;7239.058922340062;7241.167265764399;7255.4921155518605;6525.543211975211;6650.3349665034075;6736.292689267654;6795.218549866829;6818.863622727517;6805.149356330458;6929.064576282138;6936.653167341613;6943.861122777516;6947.270536593584;6864.519483636098;6941.132358455193;6945.89581156283;6948.791536253921;6953.026576279325;6627;6702.19573651165;6861.4853885958755;6878.793636190822;6957.339052789976;5360.544353729899;5384.219288203267;5395.514403703685;5396.892062158735;5401.243825864303;4708.458527269339;4728.432588089451;4762.095201911695;4857.198562237262;4866.902661946741;5925.051991681396;5931.525477961753;5983.371745966698;6002.39976002405;6007.15899774032;6841.692123854438;6860.6912688929115;6934.341237582422;6947.166340039228;6961.23426423093;5784.421557844182;5893.5579831512805;5921.970390148022;5978.461938425563;5985.521158307412;5885.264341957255;5944.989351810203;5963.105534169822;5969.462748352669;5981.641101533922;6648.700808463534;6662.733490660319;6706.731730730814;6761.323867613298;6798;6901.206361268418;6937.826554336182;6951.026856240131;7009.404200642798;7027.086478757728;6336.809895703136;6438.67806609677;6599.835004124935;6648.700808463727;6760.560563563353;6803.183617965876;6810.046593476818;6858.794236172923;6859.965700171667;6861.897071544031;6970.268121847133;7018.33325834045;7047.7180912762915;7051.894221586577;7053.118360204974;6705.932940670531;6719;6730.629815360202;6810.148731408574;6832.726690932307;6468.870622587616;6612.206535215805;6613.074169616161;6635.834104147435;6671.366220209073;6648.434883034803;6653.268140504638;6719.697613607497;6723.7646682365885;6736.124303840469;6740.022696708852;6741.089952856498;6824.965875170592;6851.246362900177;6871.03805467225;6342.556021078481;6445.16212892321;6489.967550162219;6502.967485162544;6588.242352129567 05:52:16 INFO - PID 4000 | |1;ext.html;833.0960907415454;858.9012263589689;862.504060165405;865.2472349056322;867.5618812499687;42404;43254.56745432545;43409.13181736363;43456.78271608642;43684.34473482901;38617.806910965475;38678.61321386785;42370;43175.56824431755;43316;7807.6876924922935;7933.444658873881;7938.563379014152;7967.960160199191;7969.800754981143;7830.6084695764985;7929.1277959424415;7931.881021784649;7938.364930805522;7956.6817327306835;7987.5606841623685;7992.160823113577;7999.600019999006;8000.199980002011;8015.519068855858;7855.607219639024;7935.127136015062;7946.841063178733;7965.641546130438;7976.322012628933;7828.686852525892;7853.371730261622;7862.803429914241;7874.606269686493;7883.7240696575345;38434.615653843386;39040.609593904264;39196;39263.41104883429;39339.606603933884;3615.7288203384587;3651.94522082169;3652.086978255436;3653.251083527897;3654.634536546351;31489.21276968071;31602.841985789924;31678.208044799063;31723.52414713781;31846;5078.822241221539;5235;5258.0535503609335;5268.367795864482;5293.841184764463;180721;183735.99999999866;186763;186983;187449;49264;49434.25848612274;49565.75217123891;49706.50293497019;50019.24971125436;51600.48399516032;51682;51725.741371292905;51779;51791.115666325175;16124.516264511849;16238.675226495405;16239.431619893247;16266.674666506604;16281;13632.65918352049;13636.113652612548;13648.795268070988;13653.317334133253;13661.385237664328;13247.668808279677;13265.336733163304;13292.202467851766;13316.800247996287;13365.866341336656;5206.64627196924;5309.761060752276;5312.309399778082;5338.839834804962;5452;1022.3865680591734;1022.9079382855579;1027.7430642339416;1035.052926572178;1039.2465462539749;22219.444513887283;22373;23203.187888423825;28742.568861467094;29715.85142074319;1099.3568762273999;1108.5344155454568;1112.8720197177267;1126.4086354663866;1136.8408422820812;12429.37853107341;12820.679483013;12866.549670761478;12945.54690585825;13045.673858153623;248061;248106;248481;250933;251231;54866.725666371414;54874.17688734672;54875.451245487835;54893.45106548963;55072.17391739127;1460.350144185827;1478.9038712483655;1497.5133081748475;1497.7453832848441;1507.3895072495657;22981.310560683207;23064.538709226057;23121.88439057794;23155.3053408398;23363.415914602272;40182.39726404165;40315.596844031184;40421;40463.595364045985;40473.19053618852;205447;205710;206019;206457;207890;34228;34603.65396346105;38195.42706859455;38735.22529549337;38797.6120238794;45915.77042114768;47588.57234282977;48309;48405.51594484151;48501.5149848497;34444.82777586096;34653.653463465045;34727.65272347244;35004.12489687778;35149.121271968404;33738.325233495685;34084.25366048713;34130.82934585311;34287.48568771421;34950.30099398048;38930.4160437588;39311.60688393079;39316;39339.2132157361;39492.40761388524;33040.50439243365;33334.66665333316;33615.15962100967;33641.66358336385;34242.65757342494;24710.382240444134;24898.377540561632;24933.252002439956;25094.49811003806;25159.49681006406 05:52:16 INFO - PID 4000 | |2;jquery.html;563.7547666764955;576.4063015094453;581.4911952041963;585.6690969602172;595.6604735300879;22383.328500145002;23044.88477557612;23096.769032309672;23108.768912310912;23161.884190579065;23040;24639.507209855794;24851.627225591586;25032;25194.874025629848;6496.12302339184;6688.966555167217;6689.531732778707;6694.0962969999155;6708.396244338033;6386.552941294111;6595.53831231814;6644.900326495106;6651.534392592521;6697.799066028003;6604.108445359863;6608.636524991123;6618.669066546678;6625.403713665769;6626.635535045571;6370.968145159244;6633.601983880959;6634.933650663504;6638.800835974928;6666.6333351665635;6147.139400483936;6152.323244443108;6158.168647232611;6160.1375807387;6171.475424588871;28575.28561785972;28904;28986.42027159445;29008;29053.273668158254;2063.8039386258283;2085.95828083439;2091.0381224636535;2095.8847263400507;2097.328854766475;18588.163532640927;19038.238470461165;19211.51971200717;19261.61476770471;19330.80669193304;2332.696749422581;2379.9286021419384;2409.325388891113;2409.542186984467;2413.879306034691;118346;124840;137832;144767.27616361956;145123;14456.230811619434;14632.90253231012;14660.413583456755;14729.705405892037;14949.08492843885;22153.335399938027;22169.334919952427;22185.667214991787;22190.889045554668;22191.44521386978;10246.282760206714;10333.638322658671;10362.119219866245;10405.739856503647;10475.266731328733;9634.325597208268;9667.178289845302;9670.178034866974;9729.9027009729;9877.555510002067;8712.607932643046;8821.2060914518;8900.510471924106;8972.237359824358;9157.49633770149;2682.9463410732064;2695.7734230925275;2696.7438093381097;2721.8230814996964;2785.3175971886612;939.3424602778083;966.6858271061933;966.9564869580886;968.7578105473632;974.6004138303404;18734.501239900776;18826.62346753057;18966.810331896504;19130.808691912902;19379.127939242768;1014.5586669798661;1016.1667432705259;1019.2661283875746;1026.707388394319;1028.8713910761155;10198.796024079476;10330.380177189392;10458.111060559786;10498.947505262426;10658.307210031324;432747;437005;438740;439682;444715;117092;117635;121816;121949;122104.38947805203;1209.854817421915;1216.191232830158;1241.5716577780652;1250.9124361294805;1256.1018871506917;20255.4936126598;20467.4883127923;20531.076101575167;21064.789352106283;21408.57182856303;57952.42047579639;58871;59612;61460;62051.069233960625;79232.20767792479;79471;79757.60121199356;82344;84226;19870.403887883385;20879.164833406492;20979.685304720748;21097.05063272187;21121.6831747527;23063.769362306834;23314.65028024547;23603.29190124299;23763.524729504967;23803.64294535549;18152.818471815113;18514.814851851308;18595.34916277924;18748.06259686983;18794;16708.749368759236;16994.405195818086;17031.318747250465;17539.298428062735;17706.291748330437;18743.34398296053;18899.811001889804;18986.620267594295;19128.90435547869;19367.903160484108;20188;20304.289349872684;20312.59374812466;20356.389308320773;20377;17532.474025779247;18362.724559131355;18935.526611834815;19021.144048517574;19211 05:52:16 INFO - PID 4000 | |3;mootools.html;1363.40010395426;1433.7132573485305;1438.8057612222353;1446.3491428857014;1452.5642307307805;14696.632584185401;15307.693846123071;15312.0812751235;15352.155631440266;15374.154421506813;14952.401903923857;15158.090514569134;15158.469453569127;15167.317470713817;15168.469103581348;2711.4577084583066;2728.686201086871;2758.0622588319966;2767.986160069197;2783.1928740665185;2698.7031426543062;2721.2380533450664;2722.891084356633;2726.2775364528416;2731.808773385864;2695.986520067397;2719.687235967859;2791.804573679843;2793.1620513845864;2797.4125433658955;2820.6333176687103;2821.520341541943;2848.5442329227326;2853.857307134656;2857.1000134957526;2668.9199324020115;2678.665166854143;2691.87886545104;2742.2595899107127;2750.2024412920227;14411.639709007253;14628.195449250286;14632.195229262386;14648.560543183721;14649.707005859824;7673.50122242058;7914.3272821810215;7920.326772224368;7922.524648521107;7924.841503169904;5383.515483606455;5445.264889239981;5513.228148059275;5560.7219639017885;5600.859978500529;1836.669399508088;1849.3342396737298;1856.053412759489;1884.076802366844;1890.4801179675562;26193.476130477473;26700.198994030212;26774.464510709677;26789.598156027674;26801;6882.793516194522;6944.618046007417;6967.268436814163;7081.964590177016;7183.030290910765;19637.31269405564;19870.30453934134;19893.701594476093;19896;19898.60202795936;8039.598020098972;8238.134995825472;8238.423310368216;8245.95877020611;8255.628496717662;6975.825604359931;7099.290070992859;7231.746888858865;7338.596377199198;7342.889856652155;5318.946810531923;5446.428125046892;5482.095454250084;5518.117101263779;5554.91667624986;1718.2096235731453;1726.240454200148;1729.619483713581;1737.9405404595595;1749.9562510937074;898.1647068226612;931.2177770672668;933.262722449271;933.290699068699;946.4888959961544;7788.532688038623;7825.569593672402;8374.916250837536;8438.367122465717;8536.70121545743;686.543448606681;703.1175874277851;708.5606923707335;715.9654299537119;723.2550473012806;4529.411176547028;4571.519990401027;5381.408045115034;5387.4073851876265;5409.459054094559;20913.79086209149;21696.89151554232;21741.565168696536;21754.782452175594;21759.564808703737;21006.894965525076;21125.366239012856;21310;21574;22004;11158.665240042812;11380;11391.373474458984;11407.885921140849;11421;7675.616219188906;7764.6894124234395;7781.883271751041;7812.726554570563;7894.447388682737;18072.367467139113;18227.908860455613;18246.0876956149;18440;18631.906840465712;18873.622527549647;19026.42920712381;19092.713609295595;19331.613367732847;19417.902910485358;12044.518219271482;12435.440405181607;12483.812742809047;12506.68733281639;12566.371681416076;13634.181949083088;14240.287985600471;14331.426742930584;14332.713345733235;14362.210078445369;11330;11371.772564548828;11419.371934543347;11509.597164099552;11653.417329133339;11244.26912250701;11299.43502824872;11349.432528373713;11413.372264525198;11488.885111148782;10040.69877903664;10055.69832905014;10119.241056920613;10144.644937427154;10159;7284.125904891447;7300.96349518249;7319.487635865438;7340.816479588053;7368.59472729005;7232;7317.487775855852;7374.299441553044;7389.371903388273;7391.556506609621 05:52:16 INFO - PID 4000 | |4;prototype.html;490.2402366807796;512.2367672168469;521.759990404414;525.7161132988186;532.1724718063412;6346.778627480379;6426.164598602187;6437.839054023651;6483.643399613019;6531.877139929524;6246.187995560582;6253.374662533744;6356.52326075545;6373.904391434132;6401.199850018747;5224.660397074197;5281.524662780349;5294.10000299948;5300.655457395276;5347.385050719178;4911.238757992517;5062.417821950486;5228.640553456091;5300.496452836975;5354.982553314877;4987.551120399164;5025;5042.319286896277;5091.454272863568;5129.153689641204;4944.134776414113;4994.900101997958;5034.622403319729;5036.722980236085;5103.800606857386;4415.315626077963;4508.233600287959;4533.252013417782;4552.793509719927;4579.267317229261;6173.475254603364;6240.4071613196675;6279.277883043417;6311.211098612674;6329.556931014785;5713.14302854571;5771.682557459338;5784.913226301609;5785.566082543826;5790.392008839095;6606.174228221473;6649.567778094457;6678.43233325168;6686.632235227061;6698.464122870208;4934.407871055496;4957.900841983176;4985.376827896513;4987.975060124712;5003.649744517885;6755.763548275836;6863.416609588191;6887.862242755117;6979.720811167547;7092.503524753218;5494.76367817246;5502.862428439241;5516.889662206813;5524.171374293888;5560.471755183251;5602.467765562265;5613.887722245532;5621.747021384048;5630.634008789416;5649.943300745809;6095.268567771807;6123.785667501616;6133.558613725771;6150.415710507495;6164.722587483574;6738;6780.762673306509;6801.65991700413;6852.486063545154;6861.142357205349;1928.3250862198117;1943.4461178564325;1976.209516193534;1977.9703304450156;2002.8698134621202;1392.540461647654;1425.8094491099841;1443.9422423102958;1462.354850792858;1474.7566651502596;5784.21913041734;5789.102689083199;5849.607227807861;5852.473277405054;5907.616004959664;6660.267370589231;6769.932300677028;6804.489663275175;6850.794476165624;6858.348456896687;5759.452851979056;5833.154192642128;5849.824505264849;5899.793507227227;5927.8221653350465;3517.56030496188;3528.4530897710897;3558.3594952908725;3571.607123216444;3625.4380571011534;6561.1470508833545;6562.212534495891;6595.241547222035;6605.24039735427;6620.337966203341;6854.314568543105;6907.309269073053;6923.757668481579;6925.342092501204;6981.5461994970165;6528.281888992207;6611.801645950629;6669.166354205724;6674.566153200123;6677.432418244406;6772.11962444879;6813.4549236061985;6868.828279293058;6869.381755642016;6894.689738961659;6784.457243420416;6806.591604503746;6834.8633027340165;6883.382405134889;6887.414569761426;6446.67766611677;6515.315891831479;6595.670216489252;6669.633170175687;6693.497987650849;5391.622586418913;5431.212474191141;5464.863378415572;5495.8016793283;5499.587530935116;6556.967215163893;6630.46956243509;6715.5299129060495;6741.494387921024;6769.424598908951;6484.740610375721;6522.05430212607;6558.8360290993105;6569.572977756622;6680.06278179342;6459.289478157493;6478.2550006749825;6524.217093948757;6592.472602191718;6647.867042659023;6305.527085468517;6412.775552855627;6426.646534440463;6471.352864713679;6594.505412094208;6635.900461493178;6652.268250492345;6715.899261510984;6764.661766911733;6787.762428314985;6417.518686098468;6451.258105317948;6471.967640161957;6484.708188131451;6537.607743535403 05:52:16 INFO - PID 4000 | |5;yui.html;906.4108329585772;913.6025828764488;925.5742358515087;931.4550987672216;950.5247376311846;19201.327953521628;20186.798132018695;20287.797122028776;20301;20304.796952030476;17917.193726282316;18596.628067438643;18759.43721688348;18823.435296941112;18985.715214271764;960.1598601223947;979.5102448775613;981.2444417798326;982.327105932435;986.842105263158;978.6868202175307;999.1157825324567;1001.2640709078821;1017.4912543728136;1020.2807021050179;1043.4469731042523;1048.2033654422655;1053.2995557953989;1054.8470471781586;1054.8734151901783;993.5926270229207;1029.073833549811;1042.8748550173952;1050.3592808386877;1057.471264367816;747.7083937264471;753.4913933095194;753.506453273107;756.4591317208223;756.7956651704064;19179.52051198717;19270.61458770817;19311.613767724568;19342.709859352122;19344.32294869687;21427.46431339229;22763.203287884844;22776;22786;22844.086236550516;17505.7374139388;18341;18431.72352414715;18457.077146142638;18513.352032678926;3579.534660494145;3607.2244467439627;3608.1340478285283;3613.512175856278;3648.6351364863567;138511.30744346214;141763.29118354342;142870.28564857214;143882.28058859744;145536;16334.75497867533;16776.748348774778;16878.156092195342;16893.577660558338;16900.070496122586;28737.137885863456;28741.28146796347;28818.567721484196;28854.855725721238;29025.41949161005;8317.667293308199;8434.451760635538;8517.06312305646;8533.317334613215;8534.658613655385;4029.5366032906004;4142.2751018572235;4146.564610715892;4147.004718867511;4152.356384760367;5333.919991200135;5432.212329212242;5441.29263195782;5445.782168713286;5462.808801691922;933.0576118120612;957.4011400960413;974.0600320690568;979.715882394112;980.9852852207223;694.1635329428027;709.4501761135058;714.9821254468679;716.2880715090937;724.0225695311393;11639.359835209145;12611;12626.684332891751;13111.868881311255;13164.539241126706;630.6594439002979;637.1366797988751;642.1908395421802;650.2619526837074;653.5882394091692;5734.627249228787;5814.534837213013;6320.273168585672;6321.65230912295;6472.967635161888;118463;120852;121708;121867.39066304611;127019;98576.50711746396;101993.49003254937;104863;107115.46442267738;109354;92479.53760231155;95267.52366238124;96779.51610241903;97918.51040744894;98542.52186217213;12619.242845429304;13155.210687358407;13251.536196233086;13547.661308466973;13680;42674.78662606667;43991.78004109959;44237;44825.327620085074;45090.77454612706;77162.61418692871;79902;80041;81704;84106.57946710472;18808.341708040152;19156.904215478833;19671.803281966997;19704.507387315432;19786.10962506662;21945.780542194374;22487;22491.325260242218;22505.09979600863;22773.658395124417;19509.12208950629;19688;19745.308914187935;20203.090860911587;20404.28584999518;19013.809861901205;19592.60814783668;19827.900860495603;19971.400857974284;20313.79686203119;18552.81447185511;18676.159572819528;19143;19221.807781922562;19442.319518816774;12438.689032773891;12955.222686638832;13188.27464489424;13443.663908402368;13528.323583820966;13563.59309220725;13991;14210.431582736988;15032.849671503582;15077.924610376878 05:52:16 INFO - PID 4000 | __end_tp_report 05:52:16 INFO - PID 4000 | __start_cc_report 05:52:16 INFO - PID 4000 | _x_x_mozilla_cycle_collect,369 05:52:16 INFO - PID 4000 | __end_cc_report 05:52:16 INFO - PID 4000 | __startTimestamp1504788736603__endTimestamp 05:52:16 INFO - PID 4000 | 05:52:16 INFO - PID 4000 | ------- Summary: start ------- 05:52:16 INFO - PID 4000 | Number of tests: 6 05:52:16 INFO - PID 4000 | 05:52:16 INFO - PID 4000 | [#0] dojo.html Cycles:165 Average:6324.25 Median:6584.01 stddev:854.15 (13.0%) stddev-sans-first:822.69 05:52:16 INFO - PID 4000 | Values: 3279.3 3303.4 3312.4 3327.8 3335.8 6313.1 6415.5 6428.6 6455.1 6479.7 6376.0 6432.9 6441.1 6459.1 6584.0 5948.5 5965.3 5982.9 6022.4 6025.3 1210.9 5519.8 5810.9 5955.8 6062.4 5904.1 5930.3 5943.6 5986.2 6012.1 5912.7 5937.2 5989.2 5999.8 6016.0 5878.0 5894.2 5962.4 5982.2 5990.1 6428.4 6428.5 6473.7 6532.9 6558.5 6601.2 6695.8 6823.6 6899.3 6993.5 6982.4 7023.6 7043.4 7044.4 7057.4 6437.0 6470.7 6541.9 6550.9 6554.5 7149.2 7152.5 7239.1 7241.2 7255.5 6525.5 6650.3 6736.3 6795.2 6818.9 6805.1 6929.1 6936.7 6943.9 6947.3 6864.5 6941.1 6945.9 6948.8 6953.0 6627.0 6702.2 6861.5 6878.8 6957.3 5360.5 5384.2 5395.5 5396.9 5401.2 4708.5 4728.4 4762.1 4857.2 4866.9 5925.1 5931.5 5983.4 6002.4 6007.2 6841.7 6860.7 6934.3 6947.2 6961.2 5784.4 5893.6 5922.0 5978.5 5985.5 5885.3 5945.0 5963.1 5969.5 5981.6 6648.7 6662.7 6706.7 6761.3 6798.0 6901.2 6937.8 6951.0 7009.4 7027.1 6336.8 6438.7 6599.8 6648.7 6760.6 6803.2 6810.0 6858.8 6860.0 6861.9 6970.3 7018.3 7047.7 7051.9 7053.1 6705.9 6719.0 6730.6 6810.1 6832.7 6468.9 6612.2 6613.1 6635.8 6671.4 6648.4 6653.3 6719.7 6723.8 6736.1 6740.0 6741.1 6825.0 6851.2 6871.0 6342.6 6445.2 6490.0 6503.0 6588.2 05:52:16 INFO - PID 4000 | 05:52:16 INFO - PID 4000 | [#1] ext.html Cycles:180 Average:39077.93 Median:3653.94 stddev:55838.08 (1528.2%) stddev-sans-first:55920.87 05:52:16 INFO - PID 4000 | Values: 833.1 858.9 862.5 865.2 867.6 42404.0 43254.6 43409.1 43456.8 43684.3 38617.8 38678.6 42370.0 43175.6 43316.0 7807.7 7933.4 7938.6 7968.0 7969.8 7830.6 7929.1 7931.9 7938.4 7956.7 7987.6 7992.2 7999.6 8000.2 8015.5 7855.6 7935.1 7946.8 7965.6 7976.3 7828.7 7853.4 7862.8 7874.6 7883.7 38434.6 39040.6 39196.0 39263.4 39339.6 3615.7 3651.9 3652.1 3653.3 3654.6 31489.2 31602.8 31678.2 31723.5 31846.0 5078.8 5235.0 5258.1 5268.4 5293.8 180721.0 183736.0 186763.0 186983.0 187449.0 49264.0 49434.3 49565.8 49706.5 50019.2 51600.5 51682.0 51725.7 51779.0 51791.1 16124.5 16238.7 16239.4 16266.7 16281.0 13632.7 13636.1 13648.8 13653.3 13661.4 13247.7 13265.3 13292.2 13316.8 13365.9 5206.6 5309.8 5312.3 5338.8 5452.0 1022.4 1022.9 1027.7 1035.1 1039.2 22219.4 22373.0 23203.2 28742.6 29715.9 1099.4 1108.5 1112.9 1126.4 1136.8 12429.4 12820.7 12866.5 12945.5 13045.7 248061.0 248106.0 248481.0 250933.0 251231.0 54866.7 54874.2 54875.5 54893.5 55072.2 1460.4 1478.9 1497.5 1497.7 1507.4 22981.3 23064.5 23121.9 23155.3 23363.4 40182.4 40315.6 40421.0 40463.6 40473.2 205447.0 205710.0 206019.0 206457.0 207890.0 34228.0 34603.7 38195.4 38735.2 38797.6 45915.8 47588.6 48309.0 48405.5 48501.5 34444.8 34653.7 34727.7 35004.1 35149.1 33738.3 34084.3 34130.8 34287.5 34950.3 38930.4 39311.6 39316.0 39339.2 39492.4 33040.5 33334.7 33615.2 33641.7 34242.7 24710.4 24898.4 24933.3 25094.5 25159.5 05:52:16 INFO - PID 4000 | 05:52:16 INFO - PID 4000 | [#2] jquery.html Cycles:180 Average:34084.00 Median:22711.66 stddev:74830.68 (329.5%) stddev-sans-first:74998.28 05:52:16 INFO - PID 4000 | Values: 563.8 576.4 581.5 585.7 595.7 22383.3 23044.9 23096.8 23108.8 23161.9 23040.0 24639.5 24851.6 25032.0 25194.9 6496.1 6689.0 6689.5 6694.1 6708.4 6386.6 6595.5 6644.9 6651.5 6697.8 6604.1 6608.6 6618.7 6625.4 6626.6 6371.0 6633.6 6634.9 6638.8 6666.6 6147.1 6152.3 6158.2 6160.1 6171.5 28575.3 28904.0 28986.4 29008.0 29053.3 2063.8 2086.0 2091.0 2095.9 2097.3 18588.2 19038.2 19211.5 19261.6 19330.8 2332.7 2379.9 2409.3 2409.5 2413.9 118346.0 124840.0 137832.0 144767.3 145123.0 14456.2 14632.9 14660.4 14729.7 14949.1 22153.3 22169.3 22185.7 22190.9 22191.4 10246.3 10333.6 10362.1 10405.7 10475.3 9634.3 9667.2 9670.2 9729.9 9877.6 8712.6 8821.2 8900.5 8972.2 9157.5 2682.9 2695.8 2696.7 2721.8 2785.3 939.3 966.7 967.0 968.8 974.6 18734.5 18826.6 18966.8 19130.8 19379.1 1014.6 1016.2 1019.3 1026.7 1028.9 10198.8 10330.4 10458.1 10498.9 10658.3 432747.0 437005.0 438740.0 439682.0 444715.0 117092.0 117635.0 121816.0 121949.0 122104.4 1209.9 1216.2 1241.6 1250.9 1256.1 20255.5 20467.5 20531.1 21064.8 21408.6 57952.4 58871.0 59612.0 61460.0 62051.1 79232.2 79471.0 79757.6 82344.0 84226.0 19870.4 20879.2 20979.7 21097.1 21121.7 23063.8 23314.7 23603.3 23763.5 23803.6 18152.8 18514.8 18595.3 18748.1 18794.0 16708.7 16994.4 17031.3 17539.3 17706.3 18743.3 18899.8 18986.6 19128.9 19367.9 20188.0 20304.3 20312.6 20356.4 20377.0 17532.5 18362.7 18935.5 19021.1 19211.0 05:52:16 INFO - PID 4000 | 05:52:16 INFO - PID 4000 | [#3] mootools.html Cycles:180 Average:9447.37 Median:26795.30 stddev:6759.85 (25.2%) stddev-sans-first:6751.53 05:52:16 INFO - PID 4000 | Values: 1363.4 1433.7 1438.8 1446.3 1452.6 14696.6 15307.7 15312.1 15352.2 15374.2 14952.4 15158.1 15158.5 15167.3 15168.5 2711.5 2728.7 2758.1 2768.0 2783.2 2698.7 2721.2 2722.9 2726.3 2731.8 2696.0 2719.7 2791.8 2793.2 2797.4 2820.6 2821.5 2848.5 2853.9 2857.1 2668.9 2678.7 2691.9 2742.3 2750.2 14411.6 14628.2 14632.2 14648.6 14649.7 7673.5 7914.3 7920.3 7922.5 7924.8 5383.5 5445.3 5513.2 5560.7 5600.9 1836.7 1849.3 1856.1 1884.1 1890.5 26193.5 26700.2 26774.5 26789.6 26801.0 6882.8 6944.6 6967.3 7082.0 7183.0 19637.3 19870.3 19893.7 19896.0 19898.6 8039.6 8238.1 8238.4 8246.0 8255.6 6975.8 7099.3 7231.7 7338.6 7342.9 5318.9 5446.4 5482.1 5518.1 5554.9 1718.2 1726.2 1729.6 1737.9 1750.0 898.2 931.2 933.3 933.3 946.5 7788.5 7825.6 8374.9 8438.4 8536.7 686.5 703.1 708.6 716.0 723.3 4529.4 4571.5 5381.4 5387.4 5409.5 20913.8 21696.9 21741.6 21754.8 21759.6 21006.9 21125.4 21310.0 21574.0 22004.0 11158.7 11380.0 11391.4 11407.9 11421.0 7675.6 7764.7 7781.9 7812.7 7894.4 18072.4 18227.9 18246.1 18440.0 18631.9 18873.6 19026.4 19092.7 19331.6 19417.9 12044.5 12435.4 12483.8 12506.7 12566.4 13634.2 14240.3 14331.4 14332.7 14362.2 11330.0 11371.8 11419.4 11509.6 11653.4 11244.3 11299.4 11349.4 11413.4 11488.9 10040.7 10055.7 10119.2 10144.6 10159.0 7284.1 7301.0 7319.5 7340.8 7368.6 7232.0 7317.5 7374.3 7389.4 7391.6 05:52:16 INFO - PID 4000 | 05:52:16 INFO - PID 4000 | [#4] prototype.html Cycles:180 Average:5659.42 Median:6308.37 stddev:1535.39 (24.3%) stddev-sans-first:1489.87 05:52:16 INFO - PID 4000 | Values: 490.2 512.2 521.8 525.7 532.2 6346.8 6426.2 6437.8 6483.6 6531.9 6246.2 6253.4 6356.5 6373.9 6401.2 5224.7 5281.5 5294.1 5300.7 5347.4 4911.2 5062.4 5228.6 5300.5 5355.0 4987.6 5025.0 5042.3 5091.5 5129.2 4944.1 4994.9 5034.6 5036.7 5103.8 4415.3 4508.2 4533.3 4552.8 4579.3 6173.5 6240.4 6279.3 6311.2 6329.6 5713.1 5771.7 5784.9 5785.6 5790.4 6606.2 6649.6 6678.4 6686.6 6698.5 4934.4 4957.9 4985.4 4988.0 5003.6 6755.8 6863.4 6887.9 6979.7 7092.5 5494.8 5502.9 5516.9 5524.2 5560.5 5602.5 5613.9 5621.7 5630.6 5649.9 6095.3 6123.8 6133.6 6150.4 6164.7 6738.0 6780.8 6801.7 6852.5 6861.1 1928.3 1943.4 1976.2 1978.0 2002.9 1392.5 1425.8 1443.9 1462.4 1474.8 5784.2 5789.1 5849.6 5852.5 5907.6 6660.3 6769.9 6804.5 6850.8 6858.3 5759.5 5833.2 5849.8 5899.8 5927.8 3517.6 3528.5 3558.4 3571.6 3625.4 6561.1 6562.2 6595.2 6605.2 6620.3 6854.3 6907.3 6923.8 6925.3 6981.5 6528.3 6611.8 6669.2 6674.6 6677.4 6772.1 6813.5 6868.8 6869.4 6894.7 6784.5 6806.6 6834.9 6883.4 6887.4 6446.7 6515.3 6595.7 6669.6 6693.5 5391.6 5431.2 5464.9 5495.8 5499.6 6557.0 6630.5 6715.5 6741.5 6769.4 6484.7 6522.1 6558.8 6569.6 6680.1 6459.3 6478.3 6524.2 6592.5 6647.9 6305.5 6412.8 6426.6 6471.4 6594.5 6635.9 6652.3 6715.9 6764.7 6787.8 6417.5 6451.3 6472.0 6484.7 6537.6 05:52:16 INFO - PID 4000 | 05:52:16 INFO - PID 4000 | [#5] yui.html Cycles:180 Average:25662.84 Median:20915.88 stddev:35887.15 (171.6%) stddev-sans-first:35939.68 05:52:16 INFO - PID 4000 | Values: 906.4 913.6 925.6 931.5 950.5 19201.3 20186.8 20287.8 20301.0 20304.8 17917.2 18596.6 18759.4 18823.4 18985.7 960.2 979.5 981.2 982.3 986.8 978.7 999.1 1001.3 1017.5 1020.3 1043.4 1048.2 1053.3 1054.8 1054.9 993.6 1029.1 1042.9 1050.4 1057.5 747.7 753.5 753.5 756.5 756.8 19179.5 19270.6 19311.6 19342.7 19344.3 21427.5 22763.2 22776.0 22786.0 22844.1 17505.7 18341.0 18431.7 18457.1 18513.4 3579.5 3607.2 3608.1 3613.5 3648.6 138511.3 141763.3 142870.3 143882.3 145536.0 16334.8 16776.7 16878.2 16893.6 16900.1 28737.1 28741.3 28818.6 28854.9 29025.4 8317.7 8434.5 8517.1 8533.3 8534.7 4029.5 4142.3 4146.6 4147.0 4152.4 5333.9 5432.2 5441.3 5445.8 5462.8 933.1 957.4 974.1 979.7 981.0 694.2 709.5 715.0 716.3 724.0 11639.4 12611.0 12626.7 13111.9 13164.5 630.7 637.1 642.2 650.3 653.6 5734.6 5814.5 6320.3 6321.7 6473.0 118463.0 120852.0 121708.0 121867.4 127019.0 98576.5 101993.5 104863.0 107115.5 109354.0 92479.5 95267.5 96779.5 97918.5 98542.5 12619.2 13155.2 13251.5 13547.7 13680.0 42674.8 43991.8 44237.0 44825.3 45090.8 77162.6 79902.0 80041.0 81704.0 84106.6 18808.3 19156.9 19671.8 19704.5 19786.1 21945.8 22487.0 22491.3 22505.1 22773.7 19509.1 19688.0 19745.3 20203.1 20404.3 19013.8 19592.6 19827.9 19971.4 20313.8 18552.8 18676.2 19143.0 19221.8 19442.3 12438.7 12955.2 13188.3 13443.7 13528.3 13563.6 13991.0 14210.4 15032.8 15077.9 05:52:16 INFO - PID 4000 | -------- Summary: end -------- 05:52:16 INFO - PID 4000 | 05:52:17 INFO - TEST-INFO | 4000: exit 0 05:52:17 INFO - TEST-OK | dromaeo_css | took 1113516ms 05:52:17 INFO - TEST-START | kraken 05:52:17 INFO - Initialising browser for kraken test... 05:52:17 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55233/getInfo.html -profile /tmp/tmpD0qcrV/profile 05:52:17 INFO - TEST-INFO | started process 4422 (/builds/slave/test/build/application/firefox/firefox http://localhost:55233/getInfo.html) 05:52:22 INFO - TEST-INFO | 4422: exit 0 05:52:22 INFO - Browser initialized. 05:52:22 INFO - Running cycle 1/1 for kraken test... 05:52:22 INFO - Using env: {'DISPLAY': ':0', 05:52:22 INFO - 'HOME': '/home/cltbld', 05:52:22 INFO - 'JSGC_DISABLE_POISONING': '1', 05:52:22 INFO - 'LANG': 'en_US.UTF-8', 05:52:22 INFO - 'LANGUAGE': 'en_US:en', 05:52:22 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 05:52:22 INFO - 'LOGNAME': 'cltbld', 05:52:22 INFO - 'MAIL': '/var/mail/cltbld', 05:52:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:52:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:52:22 INFO - 'MOZ_CRASHREPORTER': '1', 05:52:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:22 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 05:52:22 INFO - 'MOZ_NO_REMOTE': '1', 05:52:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:52:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:22 INFO - 'NO_EM_RESTART': '1', 05:52:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:22 INFO - 'PWD': '/builds/slave/test', 05:52:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:52:22 INFO - 'RUST_BACKTRACE': 'full', 05:52:22 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:52:22 INFO - 'SHELL': '/bin/bash', 05:52:22 INFO - 'SHLVL': '1', 05:52:22 INFO - 'STYLO_FORCE_ENABLED': '1', 05:52:22 INFO - 'STYLO_THREADS': '1', 05:52:22 INFO - 'TERM': 'linux', 05:52:22 INFO - 'TMOUT': '86400', 05:52:22 INFO - 'USER': 'cltbld', 05:52:22 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051', 05:52:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:22 INFO - '_': '/tools/buildbot/bin/python'} 05:52:22 INFO - TEST-INFO | started process 4604 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD0qcrV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:52:23 INFO - PID 4604 | 05:52:23 INFO - PID 4604 | (/builds/slave/test/build/application/firefox/firefox:4655): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:52:23 INFO - PID 4604 | 05:52:34 INFO - PID 4604 | RSS: Main: 172138496 05:52:34 INFO - PID 4604 | 05:52:36 INFO - PID 4604 | Cycle 1(1): loaded http://localhost:55233/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55233/tests/kraken/driver.html?testName=audio-beat-detection) 05:52:37 INFO - PID 4604 | RSS: Main: 178204672 05:52:37 INFO - PID 4604 | 05:52:40 INFO - PID 4604 | Cycle 1(1): loaded http://localhost:55233/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55233/tests/kraken/driver.html?testName=audio-dft) 05:52:41 INFO - PID 4604 | RSS: Main: 178491392 05:52:41 INFO - PID 4604 | 05:52:44 INFO - PID 4604 | Cycle 1(1): loaded http://localhost:55233/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55233/tests/kraken/driver.html?testName=audio-fft) 05:52:44 INFO - PID 4604 | RSS: Main: 173060096 05:52:44 INFO - PID 4604 | 05:52:46 INFO - PID 4604 | Cycle 1(1): loaded http://localhost:55233/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55233/tests/kraken/driver.html?testName=audio-oscillator) 05:52:47 INFO - PID 4604 | RSS: Main: 173903872 05:52:47 INFO - PID 4604 | 05:52:49 INFO - PID 4604 | Cycle 1(1): loaded http://localhost:55233/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55233/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:52:50 INFO - PID 4604 | RSS: Main: 173821952 05:52:50 INFO - PID 4604 | 05:52:53 INFO - PID 4604 | Cycle 1(1): loaded http://localhost:55233/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55233/tests/kraken/driver.html?testName=imaging-darkroom) 05:52:54 INFO - PID 4604 | RSS: Main: 176836608 05:52:54 INFO - PID 4604 | 05:52:57 INFO - PID 4604 | Cycle 1(1): loaded http://localhost:55233/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55233/tests/kraken/driver.html?testName=imaging-desaturate) 05:52:58 INFO - PID 4604 | RSS: Main: 176558080 05:52:58 INFO - PID 4604 | 05:53:01 INFO - PID 4604 | Cycle 1(1): loaded http://localhost:55233/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55233/tests/kraken/driver.html?testName=json-parse-financial) 05:53:01 INFO - PID 4604 | RSS: Main: 176914432 05:53:01 INFO - PID 4604 | 05:53:03 INFO - PID 4604 | Cycle 1(1): loaded http://localhost:55233/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55233/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:53:03 INFO - PID 4604 | RSS: Main: 177065984 05:53:03 INFO - PID 4604 | 05:53:05 INFO - PID 4604 | Cycle 1(1): loaded http://localhost:55233/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55233/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:53:06 INFO - PID 4604 | RSS: Main: 177274880 05:53:06 INFO - PID 4604 | 05:53:08 INFO - PID 4604 | Cycle 1(1): loaded http://localhost:55233/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55233/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:53:09 INFO - PID 4604 | RSS: Main: 174673920 05:53:09 INFO - PID 4604 | 05:53:11 INFO - PID 4604 | Cycle 1(1): loaded http://localhost:55233/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55233/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:53:12 INFO - PID 4604 | RSS: Main: 174407680 05:53:12 INFO - PID 4604 | 05:53:15 INFO - PID 4604 | Cycle 1(1): loaded http://localhost:55233/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55233/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:53:15 INFO - PID 4604 | RSS: Main: 174481408 05:53:15 INFO - PID 4604 | 05:53:17 INFO - PID 4604 | Cycle 1(1): loaded http://localhost:55233/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55233/tests/kraken/driver.html?testName=ai-astar) 05:53:17 INFO - PID 4604 | RSS: Main: 176025600 05:53:17 INFO - PID 4604 | 05:53:17 INFO - PID 4604 | __start_tp_report 05:53:17 INFO - PID 4604 | _x_x_mozilla_page_load 05:53:17 INFO - PID 4604 | _x_x_mozilla_page_load_details 05:53:17 INFO - PID 4604 | |i|pagename|runs| 05:53:17 INFO - PID 4604 | |0;ai-astar;110;106;107;107;97;109;109;107;107;109 05:53:17 INFO - PID 4604 | |1;audio-beat-detection;116;120;117;119;122;118;121;119;148;123 05:53:17 INFO - PID 4604 | |2;audio-dft;162;162;163;163;161;162;169;166;163;168 05:53:17 INFO - PID 4604 | |3;audio-fft;74;74;75;76;75;73;74;72;74;75 05:53:17 INFO - PID 4604 | |4;audio-oscillator;80;79;79;79;79;87;80;79;82;80 05:53:17 INFO - PID 4604 | |5;imaging-gaussian-blur;110;113;110;113;114;113;116;117;114;116 05:53:17 INFO - PID 4604 | |6;imaging-darkroom;150;149;149;149;148;148;148;149;148;149 05:53:17 INFO - PID 4604 | |7;imaging-desaturate;94;95;94;94;94;94;94;94;95;94 05:53:17 INFO - PID 4604 | |8;json-parse-financial;53;54;49;51;51;50;52;51;54;54 05:53:17 INFO - PID 4604 | |9;json-stringify-tinderbox;38;38;38;38;38;38;37;38;39;39 05:53:17 INFO - PID 4604 | |10;stanford-crypto-aes;75;75;76;77;73;77;76;74;77;75 05:53:17 INFO - PID 4604 | |11;stanford-crypto-ccm;123;115;113;129;121;125;124;123;114;130 05:53:17 INFO - PID 4604 | |12;stanford-crypto-pbkdf2;175;171;176;169;175;177;175;174;171;171 05:53:17 INFO - PID 4604 | |13;stanford-crypto-sha256-iterative;63;62;64;66;69;63;65;63;64;68 05:53:17 INFO - PID 4604 | __end_tp_report 05:53:17 INFO - PID 4604 | __start_cc_report 05:53:17 INFO - PID 4604 | _x_x_mozilla_cycle_collect,944 05:53:17 INFO - PID 4604 | __end_cc_report 05:53:17 INFO - PID 4604 | __startTimestamp1504788797984__endTimestamp 05:53:17 INFO - PID 4604 | 05:53:17 INFO - PID 4604 | ------- Summary: start ------- 05:53:17 INFO - PID 4604 | Number of tests: 14 05:53:17 INFO - PID 4604 | 05:53:17 INFO - PID 4604 | [#0] ai-astar Cycles:10 Average:106.80 Median:109.00 stddev:3.68 (3.4%) stddev-sans-first:3.71 05:53:17 INFO - PID 4604 | Values: 110.0 106.0 107.0 107.0 97.0 109.0 109.0 107.0 107.0 109.0 05:53:17 INFO - PID 4604 | 05:53:17 INFO - PID 4604 | [#1] audio-beat-detection Cycles:10 Average:122.30 Median:120.50 stddev:9.29 (7.7%) stddev-sans-first:9.57 05:53:17 INFO - PID 4604 | Values: 116.0 120.0 117.0 119.0 122.0 118.0 121.0 119.0 148.0 123.0 05:53:17 INFO - PID 4604 | 05:53:17 INFO - PID 4604 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.00 stddev:2.77 (1.7%) stddev-sans-first:2.85 05:53:17 INFO - PID 4604 | Values: 162.0 162.0 163.0 163.0 161.0 162.0 169.0 166.0 163.0 168.0 05:53:17 INFO - PID 4604 | 05:53:17 INFO - PID 4604 | [#3] audio-fft Cycles:10 Average:74.20 Median:74.50 stddev:1.14 (1.5%) stddev-sans-first:1.20 05:53:17 INFO - PID 4604 | Values: 74.0 74.0 75.0 76.0 75.0 73.0 74.0 72.0 74.0 75.0 05:53:17 INFO - PID 4604 | 05:53:17 INFO - PID 4604 | [#4] audio-oscillator Cycles:10 Average:80.40 Median:80.00 stddev:2.50 (3.1%) stddev-sans-first:2.65 05:53:17 INFO - PID 4604 | Values: 80.0 79.0 79.0 79.0 79.0 87.0 80.0 79.0 82.0 80.0 05:53:17 INFO - PID 4604 | 05:53:17 INFO - PID 4604 | [#5] imaging-gaussian-blur Cycles:10 Average:113.60 Median:114.00 stddev:2.37 (2.1%) stddev-sans-first:2.12 05:53:17 INFO - PID 4604 | Values: 110.0 113.0 110.0 113.0 114.0 113.0 116.0 117.0 114.0 116.0 05:53:17 INFO - PID 4604 | 05:53:17 INFO - PID 4604 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:149.00 stddev:0.67 (0.5%) stddev-sans-first:0.53 05:53:17 INFO - PID 4604 | Values: 150.0 149.0 149.0 149.0 148.0 148.0 148.0 149.0 148.0 149.0 05:53:17 INFO - PID 4604 | 05:53:17 INFO - PID 4604 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:53:17 INFO - PID 4604 | Values: 94.0 95.0 94.0 94.0 94.0 94.0 94.0 94.0 95.0 94.0 05:53:17 INFO - PID 4604 | 05:53:17 INFO - PID 4604 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:52.50 stddev:1.79 (3.4%) stddev-sans-first:1.86 05:53:18 INFO - PID 4604 | Values: 53.0 54.0 49.0 51.0 51.0 50.0 52.0 51.0 54.0 54.0 05:53:18 INFO - PID 4604 | 05:53:18 INFO - PID 4604 | [#9] json-stringify-tinderbox Cycles:10 Average:38.10 Median:38.00 stddev:0.57 (1.5%) stddev-sans-first:0.60 05:53:18 INFO - PID 4604 | Values: 38.0 38.0 38.0 38.0 38.0 38.0 37.0 38.0 39.0 39.0 05:53:18 INFO - PID 4604 | 05:53:18 INFO - PID 4604 | [#10] stanford-crypto-aes Cycles:10 Average:75.50 Median:76.00 stddev:1.35 (1.8%) stddev-sans-first:1.42 05:53:18 INFO - PID 4604 | Values: 75.0 75.0 76.0 77.0 73.0 77.0 76.0 74.0 77.0 75.0 05:53:18 INFO - PID 4604 | 05:53:18 INFO - PID 4604 | [#11] stanford-crypto-ccm Cycles:10 Average:121.70 Median:123.50 stddev:5.98 (4.8%) stddev-sans-first:6.33 05:53:18 INFO - PID 4604 | Values: 123.0 115.0 113.0 129.0 121.0 125.0 124.0 123.0 114.0 130.0 05:53:18 INFO - PID 4604 | 05:53:18 INFO - PID 4604 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.40 Median:175.00 stddev:2.67 (1.5%) stddev-sans-first:2.77 05:53:18 INFO - PID 4604 | Values: 175.0 171.0 176.0 169.0 175.0 177.0 175.0 174.0 171.0 171.0 05:53:18 INFO - PID 4604 | 05:53:18 INFO - PID 4604 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:64.50 stddev:2.31 (3.6%) stddev-sans-first:2.37 05:53:18 INFO - PID 4604 | Values: 63.0 62.0 64.0 66.0 69.0 63.0 65.0 63.0 64.0 68.0 05:53:18 INFO - PID 4604 | -------- Summary: end -------- 05:53:18 INFO - PID 4604 | 05:53:18 INFO - PID 4604 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 05:53:18 INFO - TEST-INFO | 4604: exit 0 05:53:18 INFO - TEST-OK | kraken | took 61613ms 05:53:18 INFO - SUITE-END | took 1175s 05:53:19 INFO - Completed test suite (00:19:35) 05:53:19 INFO - javascript benchmark 05:53:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8757.445386786265, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3279.3441311737656, 3303.405387030335, 3312.370649576582, 3327.7670563060597, 3335.8498867550957, 6313.053042043695, 6415.45468635166, 6428.614283143009, 6455.096286519891, 6479.676016199189, 6375.968120159404, 6432.935670643304, 6441.066045423411, 6459.063435801818, 6584.012398140281, 5948.494377977877, 5965.284165900076, 5982.8803423931495, 6022.397760223987, 6025.307089684698, 1210.9425995201248, 5519.806806761764, 5810.941890581083, 5955.761769529214, 6062.42406971337, 5904.084866845646, 5930.318013428468, 5943.554233432488, 5986.191864098357, 6012.098185272201, 5912.704364781786, 5937.168796368512, 5989.221401217814, 5999.820005399845, 6016.037434010581, 5878.030125029408, 5894.17481552583, 5962.403759624046, 5982.222311099529, 5990.101484777275, 6428.357164283581, 6428.5178611604315, 6473.676316184172, 6532.934670653281, 6558.508111891627, 6601.240857301424, 6695.765648202289, 6823.624700641462, 6899.344562266577, 6993.510454268203, 6982.371586557234, 7023.648817559101, 7043.436525077981, 7044.436445084381, 7057.435405167575, 6436.999999999954, 6470.708818103197, 6541.901871471931, 6550.901736473957, 6554.541182117254, 7149.177844547944, 7152.499325047197, 7239.058922340062, 7241.167265764399, 7255.4921155518605, 6525.543211975211, 6650.3349665034075, 6736.292689267654, 6795.218549866829, 6818.863622727517, 6805.149356330458, 6929.064576282138, 6936.653167341613, 6943.861122777516, 6947.270536593584, 6864.519483636098, 6941.132358455193, 6945.89581156283, 6948.791536253921, 6953.026576279325, 6627.0, 6702.19573651165, 6861.4853885958755, 6878.793636190822, 6957.339052789976, 5360.544353729899, 5384.219288203267, 5395.514403703685, 5396.892062158735, 5401.243825864303, 4708.458527269339, 4728.432588089451, 4762.095201911695, 4857.198562237262, 4866.902661946741, 5925.051991681396, 5931.525477961753, 5983.371745966698, 6002.39976002405, 6007.15899774032, 6841.692123854438, 6860.6912688929115, 6934.341237582422, 6947.166340039228, 6961.23426423093, 5784.421557844182, 5893.5579831512805, 5921.970390148022, 5978.461938425563, 5985.521158307412, 5885.264341957255, 5944.989351810203, 5963.105534169822, 5969.462748352669, 5981.641101533922, 6648.700808463534, 6662.733490660319, 6706.731730730814, 6761.323867613298, 6798.0, 6901.206361268418, 6937.826554336182, 6951.026856240131, 7009.404200642798, 7027.086478757728, 6336.809895703136, 6438.67806609677, 6599.835004124935, 6648.700808463727, 6760.560563563353, 6803.183617965876, 6810.046593476818, 6858.794236172923, 6859.965700171667, 6861.897071544031, 6970.268121847133, 7018.33325834045, 7047.7180912762915, 7051.894221586577, 7053.118360204974, 6705.932940670531, 6719.0, 6730.629815360202, 6810.148731408574, 6832.726690932307, 6468.870622587616, 6612.206535215805, 6613.074169616161, 6635.834104147435, 6671.366220209073, 6648.434883034803, 6653.268140504638, 6719.697613607497, 6723.7646682365885, 6736.124303840469, 6740.022696708852, 6741.089952856498, 6824.965875170592, 6851.246362900177, 6871.03805467225, 6342.556021078481, 6445.16212892321, 6489.967550162219, 6502.967485162544, 6588.242352129567], "value": 6263.282871749331, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [833.0960907415454, 858.9012263589689, 862.504060165405, 865.2472349056322, 867.5618812499687, 42404.0, 43254.56745432545, 43409.13181736363, 43456.78271608642, 43684.34473482901, 38617.806910965475, 38678.61321386785, 42370.0, 43175.56824431755, 43316.0, 7807.6876924922935, 7933.444658873881, 7938.563379014152, 7967.960160199191, 7969.800754981143, 7830.6084695764985, 7929.1277959424415, 7931.881021784649, 7938.364930805522, 7956.6817327306835, 7987.5606841623685, 7992.160823113577, 7999.600019999006, 8000.199980002011, 8015.519068855858, 7855.607219639024, 7935.127136015062, 7946.841063178733, 7965.641546130438, 7976.322012628933, 7828.686852525892, 7853.371730261622, 7862.803429914241, 7874.606269686493, 7883.7240696575345, 38434.615653843386, 39040.609593904264, 39196.0, 39263.41104883429, 39339.606603933884, 3615.7288203384587, 3651.94522082169, 3652.086978255436, 3653.251083527897, 3654.634536546351, 31489.21276968071, 31602.841985789924, 31678.208044799063, 31723.52414713781, 31846.0, 5078.822241221539, 5235.0, 5258.0535503609335, 5268.367795864482, 5293.841184764463, 180721.0, 183735.99999999866, 186763.0, 186983.0, 187449.0, 49264.0, 49434.25848612274, 49565.75217123891, 49706.50293497019, 50019.24971125436, 51600.48399516032, 51682.0, 51725.741371292905, 51779.0, 51791.115666325175, 16124.516264511849, 16238.675226495405, 16239.431619893247, 16266.674666506604, 16281.0, 13632.65918352049, 13636.113652612548, 13648.795268070988, 13653.317334133253, 13661.385237664328, 13247.668808279677, 13265.336733163304, 13292.202467851766, 13316.800247996287, 13365.866341336656, 5206.64627196924, 5309.761060752276, 5312.309399778082, 5338.839834804962, 5452.0, 1022.3865680591734, 1022.9079382855579, 1027.7430642339416, 1035.052926572178, 1039.2465462539749, 22219.444513887283, 22373.0, 23203.187888423825, 28742.568861467094, 29715.85142074319, 1099.3568762273999, 1108.5344155454568, 1112.8720197177267, 1126.4086354663866, 1136.8408422820812, 12429.37853107341, 12820.679483013, 12866.549670761478, 12945.54690585825, 13045.673858153623, 248061.0, 248106.0, 248481.0, 250933.0, 251231.0, 54866.725666371414, 54874.17688734672, 54875.451245487835, 54893.45106548963, 55072.17391739127, 1460.350144185827, 1478.9038712483655, 1497.5133081748475, 1497.7453832848441, 1507.3895072495657, 22981.310560683207, 23064.538709226057, 23121.88439057794, 23155.3053408398, 23363.415914602272, 40182.39726404165, 40315.596844031184, 40421.0, 40463.595364045985, 40473.19053618852, 205447.0, 205710.0, 206019.0, 206457.0, 207890.0, 34228.0, 34603.65396346105, 38195.42706859455, 38735.22529549337, 38797.6120238794, 45915.77042114768, 47588.57234282977, 48309.0, 48405.51594484151, 48501.5149848497, 34444.82777586096, 34653.653463465045, 34727.65272347244, 35004.12489687778, 35149.121271968404, 33738.325233495685, 34084.25366048713, 34130.82934585311, 34287.48568771421, 34950.30099398048, 38930.4160437588, 39311.60688393079, 39316.0, 39339.2132157361, 39492.40761388524, 33040.50439243365, 33334.66665333316, 33615.15962100967, 33641.66358336385, 34242.65757342494, 24710.382240444134, 24898.377540561632, 24933.252002439956, 25094.49811003806, 25159.49681006406], "value": 17703.601389562675, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.7547666764955, 576.4063015094453, 581.4911952041963, 585.6690969602172, 595.6604735300879, 22383.328500145002, 23044.88477557612, 23096.769032309672, 23108.768912310912, 23161.884190579065, 23040.0, 24639.507209855794, 24851.627225591586, 25032.0, 25194.874025629848, 6496.12302339184, 6688.966555167217, 6689.531732778707, 6694.0962969999155, 6708.396244338033, 6386.552941294111, 6595.53831231814, 6644.900326495106, 6651.534392592521, 6697.799066028003, 6604.108445359863, 6608.636524991123, 6618.669066546678, 6625.403713665769, 6626.635535045571, 6370.968145159244, 6633.601983880959, 6634.933650663504, 6638.800835974928, 6666.6333351665635, 6147.139400483936, 6152.323244443108, 6158.168647232611, 6160.1375807387, 6171.475424588871, 28575.28561785972, 28904.0, 28986.42027159445, 29008.0, 29053.273668158254, 2063.8039386258283, 2085.95828083439, 2091.0381224636535, 2095.8847263400507, 2097.328854766475, 18588.163532640927, 19038.238470461165, 19211.51971200717, 19261.61476770471, 19330.80669193304, 2332.696749422581, 2379.9286021419384, 2409.325388891113, 2409.542186984467, 2413.879306034691, 118346.0, 124840.0, 137832.0, 144767.27616361956, 145123.0, 14456.230811619434, 14632.90253231012, 14660.413583456755, 14729.705405892037, 14949.08492843885, 22153.335399938027, 22169.334919952427, 22185.667214991787, 22190.889045554668, 22191.44521386978, 10246.282760206714, 10333.638322658671, 10362.119219866245, 10405.739856503647, 10475.266731328733, 9634.325597208268, 9667.178289845302, 9670.178034866974, 9729.9027009729, 9877.555510002067, 8712.607932643046, 8821.2060914518, 8900.510471924106, 8972.237359824358, 9157.49633770149, 2682.9463410732064, 2695.7734230925275, 2696.7438093381097, 2721.8230814996964, 2785.3175971886612, 939.3424602778083, 966.6858271061933, 966.9564869580886, 968.7578105473632, 974.6004138303404, 18734.501239900776, 18826.62346753057, 18966.810331896504, 19130.808691912902, 19379.127939242768, 1014.5586669798661, 1016.1667432705259, 1019.2661283875746, 1026.707388394319, 1028.8713910761155, 10198.796024079476, 10330.380177189392, 10458.111060559786, 10498.947505262426, 10658.307210031324, 432747.0, 437005.0, 438740.0, 439682.0, 444715.0, 117092.0, 117635.0, 121816.0, 121949.0, 122104.38947805203, 1209.854817421915, 1216.191232830158, 1241.5716577780652, 1250.9124361294805, 1256.1018871506917, 20255.4936126598, 20467.4883127923, 20531.076101575167, 21064.789352106283, 21408.57182856303, 57952.42047579639, 58871.0, 59612.0, 61460.0, 62051.069233960625, 79232.20767792479, 79471.0, 79757.60121199356, 82344.0, 84226.0, 19870.403887883385, 20879.164833406492, 20979.685304720748, 21097.05063272187, 21121.6831747527, 23063.769362306834, 23314.65028024547, 23603.29190124299, 23763.524729504967, 23803.64294535549, 18152.818471815113, 18514.814851851308, 18595.34916277924, 18748.06259686983, 18794.0, 16708.749368759236, 16994.405195818086, 17031.318747250465, 17539.298428062735, 17706.291748330437, 18743.34398296053, 18899.811001889804, 18986.620267594295, 19128.90435547869, 19367.903160484108, 20188.0, 20304.289349872684, 20312.59374812466, 20356.389308320773, 20377.0, 17532.474025779247, 18362.724559131355, 18935.526611834815, 19021.144048517574, 19211.0], "value": 12280.685973939615, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1363.40010395426, 1433.7132573485305, 1438.8057612222353, 1446.3491428857014, 1452.5642307307805, 14696.632584185401, 15307.693846123071, 15312.0812751235, 15352.155631440266, 15374.154421506813, 14952.401903923857, 15158.090514569134, 15158.469453569127, 15167.317470713817, 15168.469103581348, 2711.4577084583066, 2728.686201086871, 2758.0622588319966, 2767.986160069197, 2783.1928740665185, 2698.7031426543062, 2721.2380533450664, 2722.891084356633, 2726.2775364528416, 2731.808773385864, 2695.986520067397, 2719.687235967859, 2791.804573679843, 2793.1620513845864, 2797.4125433658955, 2820.6333176687103, 2821.520341541943, 2848.5442329227326, 2853.857307134656, 2857.1000134957526, 2668.9199324020115, 2678.665166854143, 2691.87886545104, 2742.2595899107127, 2750.2024412920227, 14411.639709007253, 14628.195449250286, 14632.195229262386, 14648.560543183721, 14649.707005859824, 7673.50122242058, 7914.3272821810215, 7920.326772224368, 7922.524648521107, 7924.841503169904, 5383.515483606455, 5445.264889239981, 5513.228148059275, 5560.7219639017885, 5600.859978500529, 1836.669399508088, 1849.3342396737298, 1856.053412759489, 1884.076802366844, 1890.4801179675562, 26193.476130477473, 26700.198994030212, 26774.464510709677, 26789.598156027674, 26801.0, 6882.793516194522, 6944.618046007417, 6967.268436814163, 7081.964590177016, 7183.030290910765, 19637.31269405564, 19870.30453934134, 19893.701594476093, 19896.0, 19898.60202795936, 8039.598020098972, 8238.134995825472, 8238.423310368216, 8245.95877020611, 8255.628496717662, 6975.825604359931, 7099.290070992859, 7231.746888858865, 7338.596377199198, 7342.889856652155, 5318.946810531923, 5446.428125046892, 5482.095454250084, 5518.117101263779, 5554.91667624986, 1718.2096235731453, 1726.240454200148, 1729.619483713581, 1737.9405404595595, 1749.9562510937074, 898.1647068226612, 931.2177770672668, 933.262722449271, 933.290699068699, 946.4888959961544, 7788.532688038623, 7825.569593672402, 8374.916250837536, 8438.367122465717, 8536.70121545743, 686.543448606681, 703.1175874277851, 708.5606923707335, 715.9654299537119, 723.2550473012806, 4529.411176547028, 4571.519990401027, 5381.408045115034, 5387.4073851876265, 5409.459054094559, 20913.79086209149, 21696.89151554232, 21741.565168696536, 21754.782452175594, 21759.564808703737, 21006.894965525076, 21125.366239012856, 21310.0, 21574.0, 22004.0, 11158.665240042812, 11380.0, 11391.373474458984, 11407.885921140849, 11421.0, 7675.616219188906, 7764.6894124234395, 7781.883271751041, 7812.726554570563, 7894.447388682737, 18072.367467139113, 18227.908860455613, 18246.0876956149, 18440.0, 18631.906840465712, 18873.622527549647, 19026.42920712381, 19092.713609295595, 19331.613367732847, 19417.902910485358, 12044.518219271482, 12435.440405181607, 12483.812742809047, 12506.68733281639, 12566.371681416076, 13634.181949083088, 14240.287985600471, 14331.426742930584, 14332.713345733235, 14362.210078445369, 11330.0, 11371.772564548828, 11419.371934543347, 11509.597164099552, 11653.417329133339, 11244.26912250701, 11299.43502824872, 11349.432528373713, 11413.372264525198, 11488.885111148782, 10040.69877903664, 10055.69832905014, 10119.241056920613, 10144.644937427154, 10159.0, 7284.125904891447, 7300.96349518249, 7319.487635865438, 7340.816479588053, 7368.59472729005, 7232.0, 7317.487775855852, 7374.299441553044, 7389.371903388273, 7391.556506609621], "value": 6722.353280662327, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.2402366807796, 512.2367672168469, 521.759990404414, 525.7161132988186, 532.1724718063412, 6346.778627480379, 6426.164598602187, 6437.839054023651, 6483.643399613019, 6531.877139929524, 6246.187995560582, 6253.374662533744, 6356.52326075545, 6373.904391434132, 6401.199850018747, 5224.660397074197, 5281.524662780349, 5294.10000299948, 5300.655457395276, 5347.385050719178, 4911.238757992517, 5062.417821950486, 5228.640553456091, 5300.496452836975, 5354.982553314877, 4987.551120399164, 5025.0, 5042.319286896277, 5091.454272863568, 5129.153689641204, 4944.134776414113, 4994.900101997958, 5034.622403319729, 5036.722980236085, 5103.800606857386, 4415.315626077963, 4508.233600287959, 4533.252013417782, 4552.793509719927, 4579.267317229261, 6173.475254603364, 6240.4071613196675, 6279.277883043417, 6311.211098612674, 6329.556931014785, 5713.14302854571, 5771.682557459338, 5784.913226301609, 5785.566082543826, 5790.392008839095, 6606.174228221473, 6649.567778094457, 6678.43233325168, 6686.632235227061, 6698.464122870208, 4934.407871055496, 4957.900841983176, 4985.376827896513, 4987.975060124712, 5003.649744517885, 6755.763548275836, 6863.416609588191, 6887.862242755117, 6979.720811167547, 7092.503524753218, 5494.76367817246, 5502.862428439241, 5516.889662206813, 5524.171374293888, 5560.471755183251, 5602.467765562265, 5613.887722245532, 5621.747021384048, 5630.634008789416, 5649.943300745809, 6095.268567771807, 6123.785667501616, 6133.558613725771, 6150.415710507495, 6164.722587483574, 6738.0, 6780.762673306509, 6801.65991700413, 6852.486063545154, 6861.142357205349, 1928.3250862198117, 1943.4461178564325, 1976.209516193534, 1977.9703304450156, 2002.8698134621202, 1392.540461647654, 1425.8094491099841, 1443.9422423102958, 1462.354850792858, 1474.7566651502596, 5784.21913041734, 5789.102689083199, 5849.607227807861, 5852.473277405054, 5907.616004959664, 6660.267370589231, 6769.932300677028, 6804.489663275175, 6850.794476165624, 6858.348456896687, 5759.452851979056, 5833.154192642128, 5849.824505264849, 5899.793507227227, 5927.8221653350465, 3517.56030496188, 3528.4530897710897, 3558.3594952908725, 3571.607123216444, 3625.4380571011534, 6561.1470508833545, 6562.212534495891, 6595.241547222035, 6605.24039735427, 6620.337966203341, 6854.314568543105, 6907.309269073053, 6923.757668481579, 6925.342092501204, 6981.5461994970165, 6528.281888992207, 6611.801645950629, 6669.166354205724, 6674.566153200123, 6677.432418244406, 6772.11962444879, 6813.4549236061985, 6868.828279293058, 6869.381755642016, 6894.689738961659, 6784.457243420416, 6806.591604503746, 6834.8633027340165, 6883.382405134889, 6887.414569761426, 6446.67766611677, 6515.315891831479, 6595.670216489252, 6669.633170175687, 6693.497987650849, 5391.622586418913, 5431.212474191141, 5464.863378415572, 5495.8016793283, 5499.587530935116, 6556.967215163893, 6630.46956243509, 6715.5299129060495, 6741.494387921024, 6769.424598908951, 6484.740610375721, 6522.05430212607, 6558.8360290993105, 6569.572977756622, 6680.06278179342, 6459.289478157493, 6478.2550006749825, 6524.217093948757, 6592.472602191718, 6647.867042659023, 6305.527085468517, 6412.775552855627, 6426.646534440463, 6471.352864713679, 6594.505412094208, 6635.900461493178, 6652.268250492345, 6715.899261510984, 6764.661766911733, 6787.762428314985, 6417.518686098468, 6451.258105317948, 6471.967640161957, 6484.708188131451, 6537.607743535403], "value": 5218.4179521421, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [906.4108329585772, 913.6025828764488, 925.5742358515087, 931.4550987672216, 950.5247376311846, 19201.327953521628, 20186.798132018695, 20287.797122028776, 20301.0, 20304.796952030476, 17917.193726282316, 18596.628067438643, 18759.43721688348, 18823.435296941112, 18985.715214271764, 960.1598601223947, 979.5102448775613, 981.2444417798326, 982.327105932435, 986.842105263158, 978.6868202175307, 999.1157825324567, 1001.2640709078821, 1017.4912543728136, 1020.2807021050179, 1043.4469731042523, 1048.2033654422655, 1053.2995557953989, 1054.8470471781586, 1054.8734151901783, 993.5926270229207, 1029.073833549811, 1042.8748550173952, 1050.3592808386877, 1057.471264367816, 747.7083937264471, 753.4913933095194, 753.506453273107, 756.4591317208223, 756.7956651704064, 19179.52051198717, 19270.61458770817, 19311.613767724568, 19342.709859352122, 19344.32294869687, 21427.46431339229, 22763.203287884844, 22776.0, 22786.0, 22844.086236550516, 17505.7374139388, 18341.0, 18431.72352414715, 18457.077146142638, 18513.352032678926, 3579.534660494145, 3607.2244467439627, 3608.1340478285283, 3613.512175856278, 3648.6351364863567, 138511.30744346214, 141763.29118354342, 142870.28564857214, 143882.28058859744, 145536.0, 16334.75497867533, 16776.748348774778, 16878.156092195342, 16893.577660558338, 16900.070496122586, 28737.137885863456, 28741.28146796347, 28818.567721484196, 28854.855725721238, 29025.41949161005, 8317.667293308199, 8434.451760635538, 8517.06312305646, 8533.317334613215, 8534.658613655385, 4029.5366032906004, 4142.2751018572235, 4146.564610715892, 4147.004718867511, 4152.356384760367, 5333.919991200135, 5432.212329212242, 5441.29263195782, 5445.782168713286, 5462.808801691922, 933.0576118120612, 957.4011400960413, 974.0600320690568, 979.715882394112, 980.9852852207223, 694.1635329428027, 709.4501761135058, 714.9821254468679, 716.2880715090937, 724.0225695311393, 11639.359835209145, 12611.0, 12626.684332891751, 13111.868881311255, 13164.539241126706, 630.6594439002979, 637.1366797988751, 642.1908395421802, 650.2619526837074, 653.5882394091692, 5734.627249228787, 5814.534837213013, 6320.273168585672, 6321.65230912295, 6472.967635161888, 118463.0, 120852.0, 121708.0, 121867.39066304611, 127019.0, 98576.50711746396, 101993.49003254937, 104863.0, 107115.46442267738, 109354.0, 92479.53760231155, 95267.52366238124, 96779.51610241903, 97918.51040744894, 98542.52186217213, 12619.242845429304, 13155.210687358407, 13251.536196233086, 13547.661308466973, 13680.0, 42674.78662606667, 43991.78004109959, 44237.0, 44825.327620085074, 45090.77454612706, 77162.61418692871, 79902.0, 80041.0, 81704.0, 84106.57946710472, 18808.341708040152, 19156.904215478833, 19671.803281966997, 19704.507387315432, 19786.10962506662, 21945.780542194374, 22487.0, 22491.325260242218, 22505.09979600863, 22773.658395124417, 19509.12208950629, 19688.0, 19745.308914187935, 20203.090860911587, 20404.28584999518, 19013.809861901205, 19592.60814783668, 19827.900860495603, 19971.400857974284, 20313.79686203119, 18552.81447185511, 18676.159572819528, 19143.0, 19221.807781922562, 19442.319518816774, 12438.689032773891, 12955.222686638832, 13188.27464489424, 13443.663908402368, 13528.323583820966, 13563.59309220725, 13991.0, 14210.431582736988, 15032.849671503582, 15077.924610376878], "value": 9442.623145444462, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1429.4000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 106.0, 107.0, 107.0, 97.0, 109.0, 109.0, 107.0, 107.0, 109.0], "value": 106.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 120.0, 117.0, 119.0, 122.0, 118.0, 121.0, 119.0, 148.0, 123.0], "value": 122.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 163.0, 161.0, 162.0, 169.0, 166.0, 163.0, 168.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 76.0, 75.0, 73.0, 74.0, 72.0, 74.0, 75.0], "value": 74.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 79.0, 79.0, 87.0, 80.0, 79.0, 82.0, 80.0], "value": 80.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 110.0, 113.0, 114.0, 113.0, 116.0, 117.0, 114.0, 116.0], "value": 113.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 149.0, 149.0, 148.0, 148.0, 148.0, 149.0, 148.0, 149.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 49.0, 51.0, 51.0, 50.0, 52.0, 51.0, 54.0, 54.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 37.0, 38.0, 39.0, 39.0], "value": 38.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 77.0, 73.0, 77.0, 76.0, 74.0, 77.0, 75.0], "value": 75.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 115.0, 113.0, 129.0, 121.0, 125.0, 124.0, 123.0, 114.0, 130.0], "value": 121.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 171.0, 176.0, 169.0, 175.0, 177.0, 175.0, 174.0, 171.0, 171.0], "value": 173.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 64.0, 66.0, 69.0, 63.0, 65.0, 63.0, 64.0, 68.0], "value": 64.7, "unit": "score"}]}]} 05:53:19 INFO - Return code: 0 05:53:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:53:19 INFO - # TBPL SUCCESS # 05:53:19 INFO - Running post-action listener: _package_coverage_data 05:53:19 INFO - Running post-action listener: _resource_record_post_action 05:53:19 INFO - [mozharness: 2017-09-07 12:53:19.269776Z] Finished run-tests step (success) 05:53:19 INFO - Running post-run listener: _resource_record_post_run 05:53:19 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 11341824; Write bytes: 405667840; Read time: 3852; Write time: 543032 05:53:19 INFO - TinderboxPrint: CPU usage
13.2% 05:53:19 INFO - TinderboxPrint: I/O read bytes / time
11,341,824 / 3,852 05:53:19 INFO - TinderboxPrint: I/O write bytes / time
405,667,840 / 543,032 05:53:19 INFO - TinderboxPrint: CPU idle
8,250.8 (86.8%) 05:53:19 INFO - TinderboxPrint: CPU user
1,192.4 (12.5%) 05:53:19 INFO - TinderboxPrint: Swap in / out
0 / 0 05:53:19 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 116752384; Read time: 208; Write time: 138968 05:53:19 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:53:19 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 9592832; Write bytes: 288915456; Read time: 3568; Write time: 404064 05:53:19 INFO - Running post-run listener: _upload_blobber_files 05:53:19 INFO - Blob upload gear active. 05:53:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:53:19 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 05:53:19 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'] 05:53:19 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 05:53:20 INFO - (blobuploader) - INFO - Open directory for files ... 05:53:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:53:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:53:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:21 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:53:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:21 INFO - (blobuploader) - INFO - Done attempting. 05:53:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:53:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:53:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:53:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:22 INFO - (blobuploader) - INFO - Done attempting. 05:53:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:53:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:53:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:53:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:23 INFO - (blobuploader) - INFO - Done attempting. 05:53:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:53:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:53:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:53:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:30 INFO - (blobuploader) - INFO - Done attempting. 05:53:30 INFO - (blobuploader) - INFO - Iteration through files over. 05:53:30 INFO - Return code: 0 05:53:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:53:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:53:30 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a50fc91e7b9e3487c5533feedc08c8dd5c4323a83f06bc0c71eae77f789dabcdff375ab1ee337a112b3dd5bd368408f67cea51b5fefb1f9533ea592aa775dd0f", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bfb275b2800e04980824fb72f3000974c4a75dfc1d4151f46194a6f8d47dec3db626e020f85a939f53cfa8b547461418b3f5960b06bbc3a6980492784f375a66", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0f971b0448d15af31c856f6703ed4713b7e2c10e4f3075eff60b61ce46820ca4be7d35651b1f16c26d9b0d98c54dd828a7b451ce284a6b831fd6eb7733ef7c9b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03140b504df954440571f76fbb715dcb80fafeeb511b17053986cf532f43117b3d5ec4831267d56c882b1af63e133163c85518343df05ae3c756991db63643c8"} 05:53:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:53:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:53:30 INFO - Contents: 05:53:30 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a50fc91e7b9e3487c5533feedc08c8dd5c4323a83f06bc0c71eae77f789dabcdff375ab1ee337a112b3dd5bd368408f67cea51b5fefb1f9533ea592aa775dd0f", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bfb275b2800e04980824fb72f3000974c4a75dfc1d4151f46194a6f8d47dec3db626e020f85a939f53cfa8b547461418b3f5960b06bbc3a6980492784f375a66", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0f971b0448d15af31c856f6703ed4713b7e2c10e4f3075eff60b61ce46820ca4be7d35651b1f16c26d9b0d98c54dd828a7b451ce284a6b831fd6eb7733ef7c9b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03140b504df954440571f76fbb715dcb80fafeeb511b17053986cf532f43117b3d5ec4831267d56c882b1af63e133163c85518343df05ae3c756991db63643c8"} 05:53:30 INFO - Running post-run listener: copy_logs_to_upload_dir 05:53:30 INFO - Copying logs to upload dir... 05:53:30 INFO - mkdir: /builds/slave/test/build/upload/logs 05:53:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.510627 ========= master_lag: -0.15 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-09-07 05:53:29.898678) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-07 05:53:29.906071) ========= 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=14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a50fc91e7b9e3487c5533feedc08c8dd5c4323a83f06bc0c71eae77f789dabcdff375ab1ee337a112b3dd5bd368408f67cea51b5fefb1f9533ea592aa775dd0f", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bfb275b2800e04980824fb72f3000974c4a75dfc1d4151f46194a6f8d47dec3db626e020f85a939f53cfa8b547461418b3f5960b06bbc3a6980492784f375a66", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0f971b0448d15af31c856f6703ed4713b7e2c10e4f3075eff60b61ce46820ca4be7d35651b1f16c26d9b0d98c54dd828a7b451ce284a6b831fd6eb7733ef7c9b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03140b504df954440571f76fbb715dcb80fafeeb511b17053986cf532f43117b3d5ec4831267d56c882b1af63e133163c85518343df05ae3c756991db63643c8"} build_url:https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011306 build_url: 'https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a50fc91e7b9e3487c5533feedc08c8dd5c4323a83f06bc0c71eae77f789dabcdff375ab1ee337a112b3dd5bd368408f67cea51b5fefb1f9533ea592aa775dd0f", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bfb275b2800e04980824fb72f3000974c4a75dfc1d4151f46194a6f8d47dec3db626e020f85a939f53cfa8b547461418b3f5960b06bbc3a6980492784f375a66", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0f971b0448d15af31c856f6703ed4713b7e2c10e4f3075eff60b61ce46820ca4be7d35651b1f16c26d9b0d98c54dd828a7b451ce284a6b831fd6eb7733ef7c9b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03140b504df954440571f76fbb715dcb80fafeeb511b17053986cf532f43117b3d5ec4831267d56c882b1af63e133163c85518343df05ae3c756991db63643c8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-07 05:53:29.933993) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 05:53:29.934318) ========= 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=14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004417 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 05:53:30.016596) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-07 05:53:30.019916) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-07 05:53:30.020203) ========= ========= Total master_lag: 0.04 =========