builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-064 starttime: 1504085663.53 results: success (0) revision: ae9e6b6d31321f119f1e07823f93137f58771377 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-30 02:34:23.527355) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-30 02:34:23.527792) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-30 02:34:23.528068) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-30 02:34:23.548291) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 02:34:23.548569) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1504084557.548086-1771277551 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-30 02:34:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.9M=0s 2017-08-30 02:34:23 (34.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.094179 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 02:34:23.657551) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 02:34:23.657850) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1504084557.548086-1771277551 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016926 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 02:34:23.707988) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 02:34:23.708294) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ae9e6b6d31321f119f1e07823f93137f58771377 --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 ae9e6b6d31321f119f1e07823f93137f58771377 --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=a12cd81e0ef515edd9e0d800000001bb-1504084557.548086-1771277551 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-30 02:34:23,826 truncating revision to first 12 chars 2017-08-30 02:34:23,826 Setting DEBUG logging. 2017-08-30 02:34:23,826 attempt 1/10 2017-08-30 02:34:23,826 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ae9e6b6d3132?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-30 02:34:24,137 unpacking tar archive at: mozilla-central-ae9e6b6d3132/testing/mozharness/ program finished with exit code 0 elapsedTime=0.658470 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 02:34:24.383079) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-30 02:34:24.383383) ========= script_repo_revision: ae9e6b6d31321f119f1e07823f93137f58771377 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-30 02:34:24.383776) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-30 02:34:24.384057) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-30 02:34:24.394243) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-08-30 02:34:24.394647) ========= /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=a12cd81e0ef515edd9e0d800000001bb-1504084557.548086-1771277551 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:34:24 INFO - MultiFileLogger online at 20170830 02:34:24 in /builds/slave/test 02:34:24 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 02:34:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:34:24 INFO - {'append_to_log': False, 02:34:24 INFO - 'base_work_dir': '/builds/slave/test', 02:34:24 INFO - 'blob_upload_branch': 'Firefox', 02:34:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:34:24 INFO - 'branch': 'Firefox', 02:34:24 INFO - 'buildbot_json_path': 'buildprops.json', 02:34:24 INFO - 'code_coverage': False, 02:34:24 INFO - 'config_files': ('talos/linux_config.py',), 02:34:24 INFO - 'default_actions': ('clobber', 02:34:24 INFO - 'read-buildbot-config', 02:34:24 INFO - 'download-and-extract', 02:34:24 INFO - 'populate-webroot', 02:34:24 INFO - 'create-virtualenv', 02:34:24 INFO - 'install', 02:34:24 INFO - 'setup-mitmproxy', 02:34:24 INFO - 'run-tests'), 02:34:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:34:24 INFO - 'disable_ccov_upload': False, 02:34:24 INFO - 'disable_stylo': False, 02:34:24 INFO - 'download_minidump_stackwalk': True, 02:34:24 INFO - 'download_symbols': 'ondemand', 02:34:24 INFO - 'enable_stylo': False, 02:34:24 INFO - 'enable_webrender': False, 02:34:24 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 02:34:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:34:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:34:24 INFO - 'gecko_profile': False, 02:34:24 INFO - 'gecko_profile_interval': 0, 02:34:24 INFO - 'installer_path': 'installer.exe', 02:34:24 INFO - 'log_level': 'info', 02:34:24 INFO - 'log_name': 'talos', 02:34:24 INFO - 'log_to_console': True, 02:34:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:34:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:34:24 INFO - 'opt_config_files': (), 02:34:24 INFO - 'pip_index': False, 02:34:24 INFO - 'suite': 'dromaeojs-e10s', 02:34:24 INFO - 'system_bits': '32', 02:34:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:34:24 INFO - 'title': 'talos-linux64-ix-064', 02:34:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:34:24 INFO - 'use_talos_json': True, 02:34:24 INFO - 'verify': 'False', 02:34:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:34:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:34:24 INFO - 'work_dir': 'build'} 02:34:24 INFO - [mozharness: 2017-08-30 09:34:24.647368Z] Running clobber step. 02:34:24 INFO - Running pre-action listener: _resource_record_pre_action 02:34:24 INFO - Running main action method: clobber 02:34:24 INFO - rmtree: /builds/slave/test/build 02:34:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:34:25 INFO - Running post-action listener: _resource_record_post_action 02:34:25 INFO - [mozharness: 2017-08-30 09:34:25.671278Z] Finished clobber step (success) 02:34:25 INFO - [mozharness: 2017-08-30 09:34:25.671374Z] Running read-buildbot-config step. 02:34:25 INFO - Running pre-action listener: _resource_record_pre_action 02:34:25 INFO - Running main action method: read_buildbot_config 02:34:25 INFO - Using buildbot properties: 02:34:25 INFO - { 02:34:25 INFO - "project": "", 02:34:25 INFO - "product": "firefox", 02:34:25 INFO - "who": "archaeopteryx@coole-files.de", 02:34:25 INFO - "installer_path": "public/build/target.tar.bz2", 02:34:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 02:34:25 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 02:34:25 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 02:34:25 INFO - "stage_platform": "linux64-stylosequential", 02:34:25 INFO - "basedir": "/builds/slave/test", 02:34:25 INFO - "buildnumber": 219, 02:34:25 INFO - "platform": "ubuntu64_hw_styloseq", 02:34:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:34:25 INFO - "slavebuilddir": "test", 02:34:25 INFO - "taskId": "FJbCnHQHREKnkVVBs_6CSw", 02:34:25 INFO - "branch": "mozilla-central", 02:34:25 INFO - "script_repo_revision": "production", 02:34:25 INFO - "revision": "ae9e6b6d31321f119f1e07823f93137f58771377", 02:34:25 INFO - "slavename": "talos-linux64-ix-064", 02:34:25 INFO - "repo_path": "mozilla-central" 02:34:25 INFO - } 02:34:25 INFO - Finding installer, test and symbols from parent task. 02:34:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FJbCnHQHREKnkVVBs_6CSw'}, attempt #1 02:34:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FJbCnHQHREKnkVVBs_6CSw'}, attempt #1 02:34:26 INFO - Task dependencies: J0iXTyotRpC2k_2r2yxREQ 02:34:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J0iXTyotRpC2k_2r2yxREQ'}, attempt #1 02:34:27 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/J0iXTyotRpC2k_2r2yxREQ/artifacts/public/build/target.tar.bz2 02:34:27 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/J0iXTyotRpC2k_2r2yxREQ/artifacts/public/build/target.test_packages.json 02:34:27 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/J0iXTyotRpC2k_2r2yxREQ/artifacts/public/build/target.crashreporter-symbols.zip 02:34:27 INFO - Running post-action listener: _resource_record_post_action 02:34:27 INFO - [mozharness: 2017-08-30 09:34:27.359333Z] Finished read-buildbot-config step (success) 02:34:27 INFO - [mozharness: 2017-08-30 09:34:27.359549Z] Running download-and-extract step. 02:34:27 INFO - Running pre-action listener: _resource_record_pre_action 02:34:27 INFO - Running main action method: download_and_extract 02:34:27 INFO - mkdir: /builds/slave/test/build/tests 02:34:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:34:27 INFO - trying https://queue.taskcluster.net/v1/task/J0iXTyotRpC2k_2r2yxREQ/artifacts/public/build/target.test_packages.json 02:34:27 INFO - Downloading https://queue.taskcluster.net/v1/task/J0iXTyotRpC2k_2r2yxREQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:34:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J0iXTyotRpC2k_2r2yxREQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:34:27 INFO - Downloaded 989 bytes. 02:34:27 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:34:27 INFO - Using the following test package requirements: 02:34:27 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:34:27 INFO - u'common': [u'target.common.tests.zip'], 02:34:27 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:34:27 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:34:27 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:34:27 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:34:27 INFO - u'mozbase': [u'target.common.tests.zip'], 02:34:27 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:34:27 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:34:27 INFO - u'web-platform': [u'target.common.tests.zip', 02:34:27 INFO - u'target.web-platform.tests.tar.gz'], 02:34:27 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:34:27 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:34:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J0iXTyotRpC2k_2r2yxREQ/artifacts/public/build/target.common.tests.zip 02:34:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J0iXTyotRpC2k_2r2yxREQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:34:27 INFO - Fetch https://queue.taskcluster.net/v1/task/J0iXTyotRpC2k_2r2yxREQ/artifacts/public/build/target.common.tests.zip into memory 02:34:28 INFO - Content-Length response header: 54962237 02:34:28 INFO - Bytes received: 54962237 02:34:39 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:34:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J0iXTyotRpC2k_2r2yxREQ/artifacts/public/build/target.common.tests.zip 02:34:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J0iXTyotRpC2k_2r2yxREQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:34:39 INFO - Fetch https://queue.taskcluster.net/v1/task/J0iXTyotRpC2k_2r2yxREQ/artifacts/public/build/target.common.tests.zip into memory 02:34:41 INFO - Content-Length response header: 54962237 02:34:41 INFO - Bytes received: 54962237 02:34:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J0iXTyotRpC2k_2r2yxREQ/artifacts/public/build/target.talos.tests.zip 02:34:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J0iXTyotRpC2k_2r2yxREQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:34:53 INFO - Fetch https://queue.taskcluster.net/v1/task/J0iXTyotRpC2k_2r2yxREQ/artifacts/public/build/target.talos.tests.zip into memory 02:34:53 INFO - Content-Length response header: 14496610 02:34:53 INFO - Bytes received: 14496610 02:34:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:34:54 INFO - trying https://queue.taskcluster.net/v1/task/J0iXTyotRpC2k_2r2yxREQ/artifacts/public/build/target.tar.bz2 02:34:54 INFO - Downloading https://queue.taskcluster.net/v1/task/J0iXTyotRpC2k_2r2yxREQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:34:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J0iXTyotRpC2k_2r2yxREQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:34:55 INFO - Downloaded 62644302 bytes. 02:34:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J0iXTyotRpC2k_2r2yxREQ/artifacts/public/build/target.tar.bz2 02:34:55 INFO - mkdir: /builds/slave/test/properties 02:34:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:34:55 INFO - Writing to file /builds/slave/test/properties/build_url 02:34:55 INFO - Contents: 02:34:55 INFO - build_url:https://queue.taskcluster.net/v1/task/J0iXTyotRpC2k_2r2yxREQ/artifacts/public/build/target.tar.bz2 02:34:55 INFO - Running post-action listener: _resource_record_post_action 02:34:55 INFO - Running post-action listener: find_tests_for_verification 02:34:55 INFO - Running post-action listener: set_extra_try_arguments 02:34:55 INFO - [mozharness: 2017-08-30 09:34:55.999460Z] Finished download-and-extract step (success) 02:34:55 INFO - [mozharness: 2017-08-30 09:34:55.999687Z] Running populate-webroot step. 02:34:55 INFO - Running pre-action listener: _resource_record_pre_action 02:34:56 INFO - Running main action method: populate_webroot 02:34:56 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:34:56 INFO - 'chromez-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:34:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:34:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:34:56 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:34:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:34:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:34:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:34:56 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:34:56 INFO - 'talos_options': ['--enable-stylo'], 02:34:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:34:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:34:56 INFO - 'tests': ['damp', 'tps']}, 02:34:56 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:34:56 INFO - 'talos_options': ['--enable-stylo'], 02:34:56 INFO - 'tests': ['damp', 'tps']}, 02:34:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:34:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:34:56 INFO - 'g4-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:34:56 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 02:34:56 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:34:56 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:34:56 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:34:56 INFO - 'talos_options': ['--enable-stylo'], 02:34:56 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:34:56 INFO - 'other-e10s': {'tests': ['a11yr', 02:34:56 INFO - 'ts_paint', 02:34:56 INFO - 'tpaint', 02:34:56 INFO - 'sessionrestore', 02:34:56 INFO - 'sessionrestore_many_windows', 02:34:56 INFO - 'sessionrestore_no_auto_restore', 02:34:56 INFO - 'tabpaint']}, 02:34:56 INFO - 'other-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:34:56 INFO - 'tests': ['a11yr', 02:34:56 INFO - 'ts_paint', 02:34:56 INFO - 'tpaint', 02:34:56 INFO - 'sessionrestore', 02:34:56 INFO - 'sessionrestore_many_windows', 02:34:56 INFO - 'sessionrestore_no_auto_restore', 02:34:56 INFO - 'tabpaint']}, 02:34:56 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 02:34:56 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 02:34:56 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:34:56 INFO - 'tests': ['bloom_basic_singleton']}, 02:34:56 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:34:56 INFO - 'tests': ['bloom_basic']}, 02:34:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:34:56 INFO - 'tsvgr_opacity', 02:34:56 INFO - 'tart', 02:34:56 INFO - 'tscrollx', 02:34:56 INFO - 'tsvg_static']}, 02:34:56 INFO - 'svgr-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:34:56 INFO - 'tests': ['tsvgx', 02:34:56 INFO - 'tsvgr_opacity', 02:34:56 INFO - 'tart', 02:34:56 INFO - 'tscrollx', 02:34:56 INFO - 'tsvg_static']}, 02:34:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:34:56 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:34:56 INFO - 'talos_options': ['--enable-stylo'], 02:34:56 INFO - 'tests': ['tp5o']}, 02:34:56 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:34:56 INFO - 'talos_options': ['--mitmproxy', 02:34:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:34:56 INFO - '--firstNonBlankPaint'], 02:34:56 INFO - 'tests': ['tp6_google', 02:34:56 INFO - 'tp6_youtube', 02:34:56 INFO - 'tp6_amazon', 02:34:56 INFO - 'tp6_facebook']}, 02:34:56 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:34:56 INFO - 'talos_options': ['--enable-stylo', 02:34:56 INFO - '--mitmproxy', 02:34:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:34:56 INFO - '--firstNonBlankPaint'], 02:34:56 INFO - 'tests': ['tp6_google', 02:34:56 INFO - 'tp6_youtube', 02:34:56 INFO - 'tp6_amazon', 02:34:56 INFO - 'tp6_facebook']}, 02:34:56 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:34:56 INFO - 'talos_options': ['--enable-stylo', 02:34:56 INFO - '--stylo-threads=1', 02:34:56 INFO - '--mitmproxy', 02:34:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:34:56 INFO - '--firstNonBlankPaint'], 02:34:56 INFO - 'tests': ['tp6_google', 02:34:56 INFO - 'tp6_youtube', 02:34:56 INFO - 'tp6_amazon', 02:34:56 INFO - 'tp6_facebook']}, 02:34:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:34:56 INFO - 'talos_options': ['--xperf_path', 02:34:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:34:56 INFO - 'tests': ['tp5n']}, 02:34:56 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:34:56 INFO - 'talos_options': ['--enable-stylo', 02:34:56 INFO - '--xperf_path', 02:34:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:34:56 INFO - 'tests': ['tp5n']}}} 02:34:56 INFO - Running post-action listener: _resource_record_post_action 02:34:56 INFO - [mozharness: 2017-08-30 09:34:56.014798Z] Finished populate-webroot step (success) 02:34:56 INFO - [mozharness: 2017-08-30 09:34:56.014887Z] Running create-virtualenv step. 02:34:56 INFO - Running pre-action listener: _resource_record_pre_action 02:34:56 INFO - Running main action method: create_virtualenv 02:34:56 INFO - Creating virtualenv /builds/slave/test/build/venv 02:34:56 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:34:56 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 02:34:56 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:34:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:34:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:34:56 INFO - Installing distribute.............................................................................................................................................................................................done. 02:34:56 INFO - Installing pip...............done. 02:34:56 INFO - Return code: 0 02:34:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:34:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:34:57 INFO - Reading from file tmpfile_stdout 02:34:57 INFO - Output received: 02:34:57 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 02:34:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:34:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:34:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18b01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a78a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c1fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1c580>, '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 0x1c1d480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c1d910>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1504084557.548086-1771277551', '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 02:34:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:34:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:34:57 INFO - Using env: {'DISPLAY': ':0', 02:34:57 INFO - 'HOME': '/home/cltbld', 02:34:57 INFO - 'LANG': 'en_US.UTF-8', 02:34:57 INFO - 'LANGUAGE': 'en_US:en', 02:34:57 INFO - 'LOGNAME': 'cltbld', 02:34:57 INFO - 'MAIL': '/var/mail/cltbld', 02:34:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:57 INFO - 'MOZ_NO_REMOTE': '1', 02:34:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:34:57 INFO - 'NO_EM_RESTART': '1', 02:34:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:34:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:57 INFO - 'PWD': '/builds/slave/test', 02:34:57 INFO - 'SHELL': '/bin/bash', 02:34:57 INFO - 'SHLVL': '1', 02:34:57 INFO - 'TERM': 'linux', 02:34:57 INFO - 'TMOUT': '86400', 02:34:57 INFO - 'USER': 'cltbld', 02:34:57 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1504084557.548086-1771277551', 02:34:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:57 INFO - '_': '/tools/buildbot/bin/python'} 02:34:58 INFO - Ignoring indexes: http://pypi.python.org/simple/ 02:34:58 INFO - Downloading/unpacking pip>=1.5 02:34:58 INFO - Running setup.py egg_info for package pip 02:34:58 INFO - warning: no files found matching 'pip/cacert.pem' 02:34:58 INFO - warning: no files found matching '*.html' under directory 'docs' 02:34:58 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:34:58 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:34:58 INFO - Installing collected packages: pip 02:34:58 INFO - Found existing installation: pip 1.1 02:34:58 INFO - Uninstalling pip: 02:34:58 INFO - Successfully uninstalled pip 02:34:58 INFO - Running setup.py install for pip 02:34:58 INFO - warning: no files found matching 'pip/cacert.pem' 02:34:58 INFO - warning: no files found matching '*.html' under directory 'docs' 02:34:58 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:34:58 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:34:58 INFO - Installing pip script to /builds/slave/test/build/venv/bin 02:34:58 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 02:34:58 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 02:34:58 INFO - Successfully installed pip 02:34:58 INFO - Cleaning up... 02:34:58 INFO - Return code: 0 02:34:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:34:58 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')]} 02:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:58 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')]} 02:34:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:58 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 0x18b01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a78a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c1fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1c580>, '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 0x1c1d480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c1d910>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1504084557.548086-1771277551', '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 02:34:58 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 02:34:58 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 02:34:58 INFO - Using env: {'DISPLAY': ':0', 02:34:58 INFO - 'HOME': '/home/cltbld', 02:34:58 INFO - 'LANG': 'en_US.UTF-8', 02:34:58 INFO - 'LANGUAGE': 'en_US:en', 02:34:58 INFO - 'LOGNAME': 'cltbld', 02:34:58 INFO - 'MAIL': '/var/mail/cltbld', 02:34:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:58 INFO - 'MOZ_NO_REMOTE': '1', 02:34:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:34:58 INFO - 'NO_EM_RESTART': '1', 02:34:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:34:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:58 INFO - 'PWD': '/builds/slave/test', 02:34:58 INFO - 'SHELL': '/bin/bash', 02:34:58 INFO - 'SHLVL': '1', 02:34:58 INFO - 'TERM': 'linux', 02:34:58 INFO - 'TMOUT': '86400', 02:34:58 INFO - 'USER': 'cltbld', 02:34:58 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1504084557.548086-1771277551', 02:34:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:58 INFO - '_': '/tools/buildbot/bin/python'} 02:34:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:58 INFO - Downloading/unpacking psutil>=3.1.1 02:34:58 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 02:34:58 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 02:34:58 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 02:34:58 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 02:34:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:34:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:34:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:34:59 INFO - Installing collected packages: psutil 02:34:59 INFO - Running setup.py install for psutil 02:34:59 INFO - building 'psutil._psutil_linux' extension 02:34:59 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 02:34:59 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 02:34:59 INFO - building 'psutil._psutil_posix' extension 02:34:59 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 02:35:00 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 02:35:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:35:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:35:00 INFO - Successfully installed psutil 02:35:00 INFO - Cleaning up... 02:35:00 INFO - Return code: 0 02:35:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:35:00 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')]} 02:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:35:00 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')]} 02:35:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:35:00 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 0x18b01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a78a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c1fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1c580>, '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 0x1c1d480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c1d910>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1504084557.548086-1771277551', '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 02:35:00 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 02:35:00 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 02:35:00 INFO - Using env: {'DISPLAY': ':0', 02:35:00 INFO - 'HOME': '/home/cltbld', 02:35:00 INFO - 'LANG': 'en_US.UTF-8', 02:35:00 INFO - 'LANGUAGE': 'en_US:en', 02:35:00 INFO - 'LOGNAME': 'cltbld', 02:35:00 INFO - 'MAIL': '/var/mail/cltbld', 02:35:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:35:00 INFO - 'MOZ_NO_REMOTE': '1', 02:35:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:35:00 INFO - 'NO_EM_RESTART': '1', 02:35:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:35:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:35:00 INFO - 'PWD': '/builds/slave/test', 02:35:00 INFO - 'SHELL': '/bin/bash', 02:35:00 INFO - 'SHLVL': '1', 02:35:00 INFO - 'TERM': 'linux', 02:35:00 INFO - 'TMOUT': '86400', 02:35:00 INFO - 'USER': 'cltbld', 02:35:00 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1504084557.548086-1771277551', 02:35:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:35:00 INFO - '_': '/tools/buildbot/bin/python'} 02:35:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:35:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:35:00 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 02:35:00 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 02:35:00 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 02:35:00 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 02:35:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:35:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:35:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:35:01 INFO - Installing collected packages: mozsystemmonitor 02:35:01 INFO - Running setup.py install for mozsystemmonitor 02:35:01 INFO - Successfully installed mozsystemmonitor 02:35:01 INFO - Cleaning up... 02:35:01 INFO - Return code: 0 02:35:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:35:01 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')]} 02:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:35:01 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')]} 02:35:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:35:01 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 0x18b01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a78a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c1fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1c580>, '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 0x1c1d480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c1d910>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1504084557.548086-1771277551', '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 02:35:01 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 02:35:01 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 02:35:01 INFO - Using env: {'DISPLAY': ':0', 02:35:01 INFO - 'HOME': '/home/cltbld', 02:35:01 INFO - 'LANG': 'en_US.UTF-8', 02:35:01 INFO - 'LANGUAGE': 'en_US:en', 02:35:01 INFO - 'LOGNAME': 'cltbld', 02:35:01 INFO - 'MAIL': '/var/mail/cltbld', 02:35:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:35:01 INFO - 'MOZ_NO_REMOTE': '1', 02:35:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:35:01 INFO - 'NO_EM_RESTART': '1', 02:35:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:35:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:35:01 INFO - 'PWD': '/builds/slave/test', 02:35:01 INFO - 'SHELL': '/bin/bash', 02:35:01 INFO - 'SHLVL': '1', 02:35:01 INFO - 'TERM': 'linux', 02:35:01 INFO - 'TMOUT': '86400', 02:35:01 INFO - 'USER': 'cltbld', 02:35:01 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1504084557.548086-1771277551', 02:35:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:35:01 INFO - '_': '/tools/buildbot/bin/python'} 02:35:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:35:01 INFO - Downloading/unpacking jsonschema==2.5.1 02:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:35:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:03 INFO - Downloading functools32-3.2.3-2.tar.gz 02:35:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:35:03 INFO - warning: no files found matching '*.txt' 02:35:03 INFO - no previously-included directories found matching 'build' 02:35:03 INFO - no previously-included directories found matching 'dist' 02:35:03 INFO - no previously-included directories found matching '.git*' 02:35:03 INFO - Installing collected packages: jsonschema, functools32 02:35:03 INFO - Running setup.py install for functools32 02:35:03 INFO - warning: no files found matching '*.txt' 02:35:03 INFO - no previously-included directories found matching 'build' 02:35:03 INFO - no previously-included directories found matching 'dist' 02:35:03 INFO - no previously-included directories found matching '.git*' 02:35:03 INFO - Successfully installed jsonschema functools32 02:35:03 INFO - Cleaning up... 02:35:03 INFO - Return code: 0 02:35:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:35:03 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')]} 02:35:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:35:03 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')]} 02:35:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:35:03 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 0x18b01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a78a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c1fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1c580>, '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 0x1c1d480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c1d910>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1504084557.548086-1771277551', '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 02:35:03 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 02:35:03 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 02:35:03 INFO - Using env: {'DISPLAY': ':0', 02:35:03 INFO - 'HOME': '/home/cltbld', 02:35:03 INFO - 'LANG': 'en_US.UTF-8', 02:35:03 INFO - 'LANGUAGE': 'en_US:en', 02:35:03 INFO - 'LOGNAME': 'cltbld', 02:35:03 INFO - 'MAIL': '/var/mail/cltbld', 02:35:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:35:03 INFO - 'MOZ_NO_REMOTE': '1', 02:35:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:35:03 INFO - 'NO_EM_RESTART': '1', 02:35:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:35:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:35:03 INFO - 'PWD': '/builds/slave/test', 02:35:03 INFO - 'SHELL': '/bin/bash', 02:35:03 INFO - 'SHLVL': '1', 02:35:03 INFO - 'TERM': 'linux', 02:35:03 INFO - 'TMOUT': '86400', 02:35:03 INFO - 'USER': 'cltbld', 02:35:03 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1504084557.548086-1771277551', 02:35:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:35:03 INFO - '_': '/tools/buildbot/bin/python'} 02:35:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:35:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:35:03 INFO - Cleaning up... 02:35:03 INFO - Return code: 0 02:35:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:35:03 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')]} 02:35:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:35:03 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')]} 02:35:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:35:03 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 0x18b01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a78a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c1fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1c580>, '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 0x1c1d480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c1d910>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1504084557.548086-1771277551', '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 02:35:03 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 02:35:03 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 02:35:03 INFO - Using env: {'DISPLAY': ':0', 02:35:03 INFO - 'HOME': '/home/cltbld', 02:35:03 INFO - 'LANG': 'en_US.UTF-8', 02:35:03 INFO - 'LANGUAGE': 'en_US:en', 02:35:03 INFO - 'LOGNAME': 'cltbld', 02:35:03 INFO - 'MAIL': '/var/mail/cltbld', 02:35:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:35:03 INFO - 'MOZ_NO_REMOTE': '1', 02:35:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:35:03 INFO - 'NO_EM_RESTART': '1', 02:35:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:35:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:35:03 INFO - 'PWD': '/builds/slave/test', 02:35:03 INFO - 'SHELL': '/bin/bash', 02:35:03 INFO - 'SHLVL': '1', 02:35:03 INFO - 'TERM': 'linux', 02:35:03 INFO - 'TMOUT': '86400', 02:35:03 INFO - 'USER': 'cltbld', 02:35:03 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1504084557.548086-1771277551', 02:35:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:35:03 INFO - '_': '/tools/buildbot/bin/python'} 02:35:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:35:03 INFO - Downloading/unpacking blobuploader==1.2.4 02:35:03 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 02:35:03 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 02:35:03 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 02:35:03 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 02:35:04 INFO - Downloading blobuploader-1.2.4.tar.gz 02:35:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:35:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:35:04 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 02:35:04 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 02:35:04 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 02:35:04 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 02:35:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:35:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:35:05 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 02:35:05 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 02:35:05 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 02:35:05 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 02:35:05 INFO - Downloading docopt-0.6.1.tar.gz 02:35:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:35:05 INFO - Installing collected packages: blobuploader, requests, docopt 02:35:05 INFO - Running setup.py install for blobuploader 02:35:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:35:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:35:05 INFO - Running setup.py install for requests 02:35:05 INFO - Running setup.py install for docopt 02:35:06 INFO - Successfully installed blobuploader requests docopt 02:35:06 INFO - Cleaning up... 02:35:06 INFO - Return code: 0 02:35:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:35:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:35:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:35:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:35:06 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 0x18b01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a78a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c1fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1c580>, '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 0x1c1d480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c1d910>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1504084557.548086-1771277551', '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 02:35:06 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 02:35:06 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 02:35:06 INFO - Using env: {'DISPLAY': ':0', 02:35:06 INFO - 'HOME': '/home/cltbld', 02:35:06 INFO - 'LANG': 'en_US.UTF-8', 02:35:06 INFO - 'LANGUAGE': 'en_US:en', 02:35:06 INFO - 'LOGNAME': 'cltbld', 02:35:06 INFO - 'MAIL': '/var/mail/cltbld', 02:35:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:35:06 INFO - 'MOZ_NO_REMOTE': '1', 02:35:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:35:06 INFO - 'NO_EM_RESTART': '1', 02:35:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:35:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:35:06 INFO - 'PWD': '/builds/slave/test', 02:35:06 INFO - 'SHELL': '/bin/bash', 02:35:06 INFO - 'SHLVL': '1', 02:35:06 INFO - 'TERM': 'linux', 02:35:06 INFO - 'TMOUT': '86400', 02:35:06 INFO - 'USER': 'cltbld', 02:35:06 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1504084557.548086-1771277551', 02:35:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:35:06 INFO - '_': '/tools/buildbot/bin/python'} 02:35:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:35:06 INFO - Running setup.py (path:/tmp/pip-3zpgCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:35:06 INFO - Running setup.py (path:/tmp/pip-WR9Xk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:35:06 INFO - Running setup.py (path:/tmp/pip-MaYtkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:35:06 INFO - Running setup.py (path:/tmp/pip-54Rv0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:35:06 INFO - Running setup.py (path:/tmp/pip-19_DWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:35:06 INFO - Running setup.py (path:/tmp/pip-QcUhJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:35:06 INFO - Running setup.py (path:/tmp/pip-sSi9at-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:35:06 INFO - Running setup.py (path:/tmp/pip-6uHLzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:35:06 INFO - Running setup.py (path:/tmp/pip-iVVVaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:35:06 INFO - Running setup.py (path:/tmp/pip-kRP0T5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:35:06 INFO - Running setup.py (path:/tmp/pip-sQv03e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:35:07 INFO - Running setup.py (path:/tmp/pip-Ua7iX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:35:07 INFO - Running setup.py (path:/tmp/pip-v55HFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:35:07 INFO - Running setup.py (path:/tmp/pip-tHOJGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:35:07 INFO - Running setup.py (path:/tmp/pip-JORQwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:35:07 INFO - Running setup.py (path:/tmp/pip-Kv1Hla-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:35:07 INFO - Running setup.py (path:/tmp/pip-Zsd0oo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:35:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:35:07 INFO - Running setup.py install for manifestparser 02:35:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:35:07 INFO - Running setup.py install for mozcrash 02:35:07 INFO - Running setup.py install for mozdebug 02:35:07 INFO - Running setup.py install for mozdevice 02:35:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:35:07 INFO - Running setup.py install for mozfile 02:35:07 INFO - Running setup.py install for mozhttpd 02:35:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:35:08 INFO - Running setup.py install for mozinfo 02:35:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:35:08 INFO - Running setup.py install for mozInstall 02:35:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:35:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:35:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:35:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:35:08 INFO - Running setup.py install for mozleak 02:35:08 INFO - Running setup.py install for mozlog 02:35:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:35:08 INFO - Running setup.py install for moznetwork 02:35:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:35:08 INFO - Running setup.py install for mozprocess 02:35:08 INFO - Running setup.py install for mozprofile 02:35:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:35:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:35:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:35:08 INFO - Running setup.py install for mozrunner 02:35:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:35:08 INFO - Running setup.py install for mozscreenshot 02:35:09 INFO - Running setup.py install for moztest 02:35:09 INFO - Running setup.py install for mozversion 02:35:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:35:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:35:09 INFO - Cleaning up... 02:35:09 INFO - Return code: 0 02:35:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:35:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:35:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:35:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:35:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:35:09 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 0x18b01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a78a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c1fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1c580>, '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 0x1c1d480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c1d910>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1504084557.548086-1771277551', '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 02:35:09 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 02:35:09 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 02:35:09 INFO - Using env: {'DISPLAY': ':0', 02:35:09 INFO - 'HOME': '/home/cltbld', 02:35:09 INFO - 'LANG': 'en_US.UTF-8', 02:35:09 INFO - 'LANGUAGE': 'en_US:en', 02:35:09 INFO - 'LOGNAME': 'cltbld', 02:35:09 INFO - 'MAIL': '/var/mail/cltbld', 02:35:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:35:09 INFO - 'MOZ_NO_REMOTE': '1', 02:35:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:35:09 INFO - 'NO_EM_RESTART': '1', 02:35:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:35:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:35:09 INFO - 'PWD': '/builds/slave/test', 02:35:09 INFO - 'SHELL': '/bin/bash', 02:35:09 INFO - 'SHLVL': '1', 02:35:09 INFO - 'TERM': 'linux', 02:35:09 INFO - 'TMOUT': '86400', 02:35:09 INFO - 'USER': 'cltbld', 02:35:09 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1504084557.548086-1771277551', 02:35:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:35:09 INFO - '_': '/tools/buildbot/bin/python'} 02:35:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:35:09 INFO - Running setup.py (path:/tmp/pip-Ncu1xQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:35:09 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)) 02:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:35:09 INFO - Running setup.py (path:/tmp/pip-i5vxcx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:35:09 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)) 02:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:35:09 INFO - Running setup.py (path:/tmp/pip-YqfGRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:35:09 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)) 02:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:35:09 INFO - Running setup.py (path:/tmp/pip-yz2pN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:35:09 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)) 02:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:35:09 INFO - Running setup.py (path:/tmp/pip-K0dFBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:35:09 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)) 02:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:35:09 INFO - Running setup.py (path:/tmp/pip-9RJeFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:35:09 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)) 02:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:35:09 INFO - Running setup.py (path:/tmp/pip-wRbPnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:35:09 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)) 02:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:35:09 INFO - Running setup.py (path:/tmp/pip-5N_ap_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:35:10 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)) 02:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:35:10 INFO - Running setup.py (path:/tmp/pip-BjiHKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:35:10 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)) 02:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:35:10 INFO - Running setup.py (path:/tmp/pip-_z3wQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:35:10 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)) 02:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:35:10 INFO - Running setup.py (path:/tmp/pip-4Ug7Lx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:35:10 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)) 02:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:35:10 INFO - Running setup.py (path:/tmp/pip-rrgTyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:35:10 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)) 02:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:35:10 INFO - Running setup.py (path:/tmp/pip-hwvX5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:35:10 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)) 02:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:35:10 INFO - Running setup.py (path:/tmp/pip-WQbIAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:35:10 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)) 02:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:35:10 INFO - Running setup.py (path:/tmp/pip-sMS50A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:35:10 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)) 02:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:35:10 INFO - Running setup.py (path:/tmp/pip-6VIYXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:35:10 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)) 02:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:35:10 INFO - Running setup.py (path:/tmp/pip-ZYP4Ds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:35:10 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)) 02:35:10 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)) 02:35:10 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)) 02:35:10 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)) 02:35:10 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)) 02:35:10 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)) 02:35:10 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)) 02:35:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:35:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:11 INFO - Downloading blessings-1.6.tar.gz 02:35:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:35:11 INFO - Installing collected packages: blessings 02:35:11 INFO - Running setup.py install for blessings 02:35:11 INFO - Successfully installed blessings 02:35:11 INFO - Cleaning up... 02:35:12 INFO - Return code: 0 02:35:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:35:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:35:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:35:12 INFO - Reading from file tmpfile_stdout 02:35:12 INFO - Current package versions: 02:35:12 INFO - argparse == 1.2.1 02:35:12 INFO - blessings == 1.6 02:35:12 INFO - blobuploader == 1.2.4 02:35:12 INFO - docopt == 0.6.1 02:35:12 INFO - functools32 == 3.2.3-2 02:35:12 INFO - jsonschema == 2.5.1 02:35:12 INFO - manifestparser == 1.1 02:35:12 INFO - mozInstall == 1.13 02:35:12 INFO - mozcrash == 1.0 02:35:12 INFO - mozdebug == 0.1 02:35:12 INFO - mozdevice == 0.51 02:35:12 INFO - mozfile == 1.2 02:35:12 INFO - mozhttpd == 0.7 02:35:12 INFO - mozinfo == 0.10 02:35:12 INFO - mozleak == 0.1 02:35:12 INFO - mozlog == 3.5 02:35:12 INFO - moznetwork == 0.27 02:35:12 INFO - mozprocess == 0.25 02:35:12 INFO - mozprofile == 0.28 02:35:12 INFO - mozrunner == 6.13 02:35:12 INFO - mozscreenshot == 0.1 02:35:12 INFO - mozsystemmonitor == 0.3 02:35:12 INFO - moztest == 0.8 02:35:12 INFO - mozversion == 1.4 02:35:12 INFO - psutil == 3.1.1 02:35:12 INFO - requests == 1.2.3 02:35:12 INFO - wsgiref == 0.1.2 02:35:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:35:12 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')]} 02:35:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:35:12 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')]} 02:35:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:35:12 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 0x18b01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a78a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c1fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1c580>, '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 0x1c1d480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c1d910>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1504084557.548086-1771277551', '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 02:35:12 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 02:35:12 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 02:35:12 INFO - Using env: {'DISPLAY': ':0', 02:35:12 INFO - 'HOME': '/home/cltbld', 02:35:12 INFO - 'LANG': 'en_US.UTF-8', 02:35:12 INFO - 'LANGUAGE': 'en_US:en', 02:35:12 INFO - 'LOGNAME': 'cltbld', 02:35:12 INFO - 'MAIL': '/var/mail/cltbld', 02:35:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:35:12 INFO - 'MOZ_NO_REMOTE': '1', 02:35:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:35:12 INFO - 'NO_EM_RESTART': '1', 02:35:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:35:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:35:12 INFO - 'PWD': '/builds/slave/test', 02:35:12 INFO - 'SHELL': '/bin/bash', 02:35:12 INFO - 'SHLVL': '1', 02:35:12 INFO - 'TERM': 'linux', 02:35:12 INFO - 'TMOUT': '86400', 02:35:12 INFO - 'USER': 'cltbld', 02:35:12 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1504084557.548086-1771277551', 02:35:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:35:12 INFO - '_': '/tools/buildbot/bin/python'} 02:35:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:35:12 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)) 02:35:12 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)) 02:35:12 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)) 02:35:12 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)) 02:35:12 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)) 02:35:12 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)) 02:35:12 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)) 02:35:12 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)) 02:35:12 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)) 02:35:12 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:35:12 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 02:35:12 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 02:35:12 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 02:35:12 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 02:35:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 02:35:13 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)) 02:35:13 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)) 02:35:13 INFO - Installing collected packages: simplejson 02:35:13 INFO - Running setup.py install for simplejson 02:35:13 INFO - building 'simplejson._speedups' extension 02:35:13 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 02:35:14 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 02:35:14 INFO - Successfully installed simplejson 02:35:14 INFO - Cleaning up... 02:35:14 INFO - Return code: 0 02:35:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:35: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')]} 02:35:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:35: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')]} 02:35:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:35: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18b01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a78a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c1fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1c580>, '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 0x1c1d480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c1d910>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1504084557.548086-1771277551', '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 02:35: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', 'jsonschema'] in /builds/slave/test/build 02:35: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 jsonschema 02:35:14 INFO - Using env: {'DISPLAY': ':0', 02:35:14 INFO - 'HOME': '/home/cltbld', 02:35:14 INFO - 'LANG': 'en_US.UTF-8', 02:35:14 INFO - 'LANGUAGE': 'en_US:en', 02:35:14 INFO - 'LOGNAME': 'cltbld', 02:35:14 INFO - 'MAIL': '/var/mail/cltbld', 02:35:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:35:14 INFO - 'MOZ_NO_REMOTE': '1', 02:35:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:35:14 INFO - 'NO_EM_RESTART': '1', 02:35:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:35:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:35:14 INFO - 'PWD': '/builds/slave/test', 02:35:14 INFO - 'SHELL': '/bin/bash', 02:35:14 INFO - 'SHLVL': '1', 02:35:14 INFO - 'TERM': 'linux', 02:35:14 INFO - 'TMOUT': '86400', 02:35:14 INFO - 'USER': 'cltbld', 02:35:14 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1504084557.548086-1771277551', 02:35:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:35:14 INFO - '_': '/tools/buildbot/bin/python'} 02:35:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:35:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:35:14 INFO - Cleaning up... 02:35:14 INFO - Return code: 0 02:35:14 INFO - Running post-action listener: _resource_record_post_action 02:35:14 INFO - Running post-action listener: _start_resource_monitoring 02:35:14 INFO - Starting resource monitoring. 02:35:14 INFO - [mozharness: 2017-08-30 09:35:14.940283Z] Finished create-virtualenv step (success) 02:35:14 INFO - [mozharness: 2017-08-30 09:35:14.940755Z] Running install step. 02:35:14 INFO - Running pre-action listener: _resource_record_pre_action 02:35:14 INFO - Running main action method: install 02:35:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:35:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:35:15 INFO - Reading from file tmpfile_stdout 02:35:15 INFO - Detecting whether we're running mozinstall >=1.0... 02:35:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:35:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:35:15 INFO - Reading from file tmpfile_stdout 02:35:15 INFO - Output received: 02:35:15 INFO - Usage: mozinstall [options] installer 02:35:15 INFO - Options: 02:35:15 INFO - -h, --help show this help message and exit 02:35:15 INFO - -d DEST, --destination=DEST 02:35:15 INFO - Directory to install application into. [default: 02:35:15 INFO - "/builds/slave/test"] 02:35:15 INFO - --app=APP Application being installed. [default: firefox] 02:35:15 INFO - mkdir: /builds/slave/test/build/application 02:35:15 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'] 02:35:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:35:31 INFO - Reading from file tmpfile_stdout 02:35:31 INFO - Output received: 02:35:31 INFO - /builds/slave/test/build/application/firefox/firefox 02:35:31 INFO - Running post-action listener: _resource_record_post_action 02:35:31 INFO - [mozharness: 2017-08-30 09:35:31.772507Z] Finished install step (success) 02:35:31 INFO - [mozharness: 2017-08-30 09:35:31.772731Z] Running setup-mitmproxy step. 02:35:31 INFO - Running pre-action listener: _resource_record_pre_action 02:35:31 INFO - Running main action method: setup_mitmproxy 02:35:31 INFO - Skipping: mitmproxy is not required 02:35:31 INFO - Running post-action listener: _resource_record_post_action 02:35:31 INFO - [mozharness: 2017-08-30 09:35:31.773504Z] Finished setup-mitmproxy step (success) 02:35:31 INFO - [mozharness: 2017-08-30 09:35:31.773720Z] Running run-tests step. 02:35:31 INFO - Running pre-action listener: _resource_record_pre_action 02:35:31 INFO - Running pre-action listener: _set_gcov_prefix 02:35:31 INFO - Running main action method: run_tests 02:35:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:35:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:35:31 INFO - Python 2.7.3 02:35:31 INFO - Return code: 0 02:35:31 INFO - grabbing minidump binary from tooltool 02:35:31 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')]} 02:35:31 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 0x1c1c580>, '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 0x1c1d480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c1d910>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:35:31 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 02:35:31 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 02:35:31 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 02:35:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:35:31 INFO - Return code: 0 02:35:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:35:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:35:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:35:31 INFO - ENV: RUST_BACKTRACE is now full 02:35:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:35:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:35:31 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/J0iXTyotRpC2k_2r2yxREQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 02:35:31 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/J0iXTyotRpC2k_2r2yxREQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 02:35:31 INFO - Using env: {'DISPLAY': ':0', 02:35:31 INFO - 'HOME': '/home/cltbld', 02:35:31 INFO - 'LANG': 'en_US.UTF-8', 02:35:31 INFO - 'LANGUAGE': 'en_US:en', 02:35:31 INFO - 'LOGNAME': 'cltbld', 02:35:31 INFO - 'MAIL': '/var/mail/cltbld', 02:35:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:35:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:35:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:35:31 INFO - 'MOZ_NO_REMOTE': '1', 02:35:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:35:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:35:31 INFO - 'NO_EM_RESTART': '1', 02:35:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:35:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:35:31 INFO - 'PWD': '/builds/slave/test', 02:35:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:35:31 INFO - 'RUST_BACKTRACE': 'full', 02:35:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:35:31 INFO - 'SHELL': '/bin/bash', 02:35:31 INFO - 'SHLVL': '1', 02:35:31 INFO - 'STYLO_FORCE_ENABLED': '1', 02:35:31 INFO - 'STYLO_THREADS': '1', 02:35:31 INFO - 'TERM': 'linux', 02:35:31 INFO - 'TMOUT': '86400', 02:35:31 INFO - 'USER': 'cltbld', 02:35:31 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1504084557.548086-1771277551', 02:35:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:35:31 INFO - '_': '/tools/buildbot/bin/python'} 02:35:31 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/J0iXTyotRpC2k_2r2yxREQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 02:35:32 INFO - mozversion application_buildid: 20170830084509 02:35:32 INFO - mozversion application_changeset: ae9e6b6d31321f119f1e07823f93137f58771377 02:35:32 INFO - mozversion application_display_name: Nightly 02:35:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:35:32 INFO - mozversion application_name: Firefox 02:35:32 INFO - mozversion application_remotingname: firefox 02:35:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:35:32 INFO - mozversion application_vendor: Mozilla 02:35:32 INFO - mozversion application_version: 57.0a1 02:35:32 INFO - mozversion platform_buildid: 20170830084509 02:35:32 INFO - mozversion platform_changeset: ae9e6b6d31321f119f1e07823f93137f58771377 02:35:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:35:32 INFO - mozversion platform_version: 57.0a1 02:35:32 INFO - using testdate: 1504085732 02:35:32 INFO - actual date: 1504085732 02:35:32 INFO - starting webserver on 'localhost:47261' 02:35:32 INFO - SUITE-START | Running 2 tests 02:35:32 INFO - TEST-START | dromaeo_css 02:35:32 INFO - Initialising browser for dromaeo_css test... 02:35:32 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47261/getInfo.html -profile /tmp/tmpiEl6sp/profile 02:35:32 INFO - TEST-INFO | started process 7240 (/builds/slave/test/build/application/firefox/firefox http://localhost:47261/getInfo.html) 02:35:37 INFO - TEST-INFO | 7240: exit 0 02:35:37 INFO - Browser initialized. 02:35:37 INFO - Running cycle 1/1 for dromaeo_css test... 02:35:37 INFO - Using env: {'DISPLAY': ':0', 02:35:37 INFO - 'HOME': '/home/cltbld', 02:35:37 INFO - 'JSGC_DISABLE_POISONING': '1', 02:35:37 INFO - 'LANG': 'en_US.UTF-8', 02:35:37 INFO - 'LANGUAGE': 'en_US:en', 02:35:37 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 02:35:37 INFO - 'LOGNAME': 'cltbld', 02:35:37 INFO - 'MAIL': '/var/mail/cltbld', 02:35:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:35:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:35:37 INFO - 'MOZ_CRASHREPORTER': '1', 02:35:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:35:37 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 02:35:37 INFO - 'MOZ_NO_REMOTE': '1', 02:35:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:35:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:35:37 INFO - 'NO_EM_RESTART': '1', 02:35:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:35:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:35:37 INFO - 'PWD': '/builds/slave/test', 02:35:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:35:37 INFO - 'RUST_BACKTRACE': 'full', 02:35:37 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:35:37 INFO - 'SHELL': '/bin/bash', 02:35:37 INFO - 'SHLVL': '1', 02:35:37 INFO - 'STYLO_FORCE_ENABLED': '1', 02:35:37 INFO - 'STYLO_THREADS': '1', 02:35:37 INFO - 'TERM': 'linux', 02:35:37 INFO - 'TMOUT': '86400', 02:35:37 INFO - 'USER': 'cltbld', 02:35:37 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1504084557.548086-1771277551', 02:35:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:35:37 INFO - '_': '/tools/buildbot/bin/python'} 02:35:37 INFO - TEST-INFO | started process 7425 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiEl6sp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:35:38 INFO - PID 7425 | 02:35:38 INFO - PID 7425 | (/builds/slave/test/build/application/firefox/firefox:7476): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:35:38 INFO - PID 7425 | 02:35:49 INFO - PID 7425 | RSS: Main: 172584960 02:35:49 INFO - PID 7425 | 02:38:48 INFO - PID 7425 | Cycle 1(1): loaded http://localhost:47261/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47261/tests/dromaeo/cssquery-ext.html) 02:38:49 INFO - PID 7425 | RSS: Main: 174764032 02:38:49 INFO - PID 7425 | 02:41:51 INFO - PID 7425 | Cycle 1(1): loaded http://localhost:47261/tests/dromaeo/cssquery-ext.html (next: http://localhost:47261/tests/dromaeo/cssquery-jquery.html) 02:41:51 INFO - PID 7425 | RSS: Main: 171483136 02:41:51 INFO - PID 7425 | 02:44:53 INFO - PID 7425 | Cycle 1(1): loaded http://localhost:47261/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47261/tests/dromaeo/cssquery-mootools.html) 02:44:54 INFO - PID 7425 | RSS: Main: 174641152 02:44:54 INFO - PID 7425 | 02:47:55 INFO - PID 7425 | Cycle 1(1): loaded http://localhost:47261/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47261/tests/dromaeo/cssquery-prototype.html) 02:47:56 INFO - PID 7425 | RSS: Main: 172249088 02:47:56 INFO - PID 7425 | 02:51:00 INFO - PID 7425 | Cycle 1(1): loaded http://localhost:47261/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47261/tests/dromaeo/cssquery-yui.html) 02:51:00 INFO - PID 7425 | RSS: Main: 173350912 02:51:00 INFO - PID 7425 | 02:54:02 INFO - PID 7425 | Cycle 1(1): loaded http://localhost:47261/tests/dromaeo/cssquery-yui.html (next: http://localhost:47261/tests/dromaeo/cssquery-dojo.html) 02:54:02 INFO - PID 7425 | RSS: Main: 176099328 02:54:02 INFO - PID 7425 | 02:54:02 INFO - PID 7425 | __start_tp_report 02:54:02 INFO - PID 7425 | _x_x_mozilla_page_load 02:54:02 INFO - PID 7425 | _x_x_mozilla_page_load_details 02:54:02 INFO - PID 7425 | |i|pagename|runs| 02:54:02 INFO - PID 7425 | |0;dojo.html;3384.0524653097127;3396;3403.591569011719;3412.164019815146;3414.419548676725;6453.967730161355;6532.51006174537;6553.246376666685;6595.934040659592;6603.504737144709;6356.555041147121;6405.743770249196;6410.743570257184;6426.903596446045;6459.6447195404235;5904.143899134644;5911.46796788289;5940.465358117768;6014.91731488332;6093.451589356957;6054.6367217966845;6063.393660633946;6070.908936365958;6120.602160859552;6120.785772497963;947.2715845849765;5885.411458854123;6020.45815876571;6062.636241825482;6099.57302988791;5897.4102589741115;5903.586748927577;5969.074793407029;6057.575969682124;6086.513078953717;5869.911951320733;5876.7355469004;5955.315138759055;5961.165436838846;6004.96997515014;6474.320196379406;6491.350864913518;6506.804795856132;6595.340465953366;6624.93375066248;6993.950907363886;7003.859922801566;7064.116985376828;7090.50366474347;7112.395446387063;6881.346272104142;6972.267911869231;7046.788596342118;7054.717811287543;7149.070620819312;6430.90353644691;6460.030995350688;6460.192475940507;6461.450776684034;6462.579932304385;7209.459290553229;7262.20115787263;7287.234840341794;7289.380402665727;7289.854202915912;6877.6217308048535;6897.41371983377;6978.930210697929;6985.231624521299;6986.336298051677;7013.684384202723;7042.647867606599;7085.751998680124;7117.074780278531;7152.856942861114;6833.248342682301;6916.031755554226;6944.340287672663;6963.7562685305775;7063.081799366049;7023.8244043898285;7028.437724981989;7028.753993610199;7049.154101507852;7053.365197132282;5524.558035357162;5547.11246200606;5559.444055594408;5563.13771365439;5567.192757050205;4757.904841903142;4768.427788665383;4770.427548694179;4789.712617242976;4793.544613261734;6059.484943779828;6174.783882564088;6189.226346706661;6193.071039344044;6193.256809182927;7041.5422997505;7052.471064670171;7125.608091555015;7138.643067846587;7165.534240274365;5971.880562388728;6056.364081771439;6101.176341193971;6112.17485639433;6183.876322473615;6082.148499210114;6092.573519853568;6113.6331820090045;6114.296855861544;6122.234720659918;6718.428933540606;6721.8655626887185;6751.459883209332;6769.627670478171;6771.424428923597;6995.195552511526;7003.4397248219;7005.334493223238;7114.501984861217;7115.181754098345;6656.800295991128;6666.2333831609985;6738.35985581369;6753.1220941277315;6768.695408706719;6744.527883048336;6855.485838562028;6902.068220790129;6975.476839237179;6984.720611175496;7110.431165506644;7128.037714908628;7140.964295178491;7149.356557909813;7153;6809.591424514545;6822.556533825285;6879.5184337095925;6881.243063263138;6894.207166175954;6559.836004099936;6803.353681400259;6818.18181818185;6914;6918;6583.111279977334;6589.47284217271;6604.174478190226;6607.339266073354;6632.104665870239;6705;6778;6836.145481814773;6872;6982.301769822977;6349.14286571307;6447.129637499065;6488.902666459912;6601.966990165019;6741.1236539249585 02:54:02 INFO - PID 7425 | |1;ext.html;792.7740593930728;856.5973992223654;883.019847968755;883.580299357805;1127.7011591928135;29579.704202957964;31048.223794405123;40564.594354056484;40891.38662920051;41163.58836411635;41816.79091604538;42246.366304505456;42358.788206058925;42409.15181696364;42470.787646061726;7499.250074992512;7689.50018248812;7692.499987500794;7692.7692169235015;7695.422843286748;7519.097708274987;7620.847583048336;7621.885671714928;7623.352015078725;7624.466287359887;7623.275788800082;7669.233076692342;7670.846583068335;7672.194419585919;7676.5394076355315;7599.81000474987;7604.429667774939;7608.7336943207;7631.961840190819;7632.427567932399;7538.208488108779;7601.277878601524;7601.619919004028;7602.619869006528;7637.198094200085;36505;36529;36567.26865462676;36639.63360366389;36677.083072923124;3537.168765340143;3589.174489867319;3591.8024508652015;3593.6765691087926;3595.622459641726;30850.691493085007;30908.69091309103;30972.380552388826;30977.845110774528;31001.689983100106;5097.464766199532;5128.692278463304;5196.844094677166;5220.660657057279;5229.320188375486;177554.11222943803;178934.10532947382;180150.09924950422;180250.09874950672;180804;44693.6479764019;44873.775631121636;45001.324980125326;45034.32448513275;45121.77439112849;46984.295235571495;47044.29433558499;47091;47148.764256178496;47207.527924721;14123.505677301246;15817.604559886095;16067.919660401623;16081.43714969994;16090.195490225442;11774.823377649342;13277.66805829862;13480.797788033187;13502.662433439242;13516.526921557896;13883.37524811386;13936.651583710489;14005.859941400658;14027.719445611236;14106.153630782186;5527.39198688144;5656.802011929645;5663.150527420919;5730.541556675539;5797;1001.7946321004176;1023.8413045977736;1024.7489365105596;1038.200585549123;1049.6483677967813;22074.779252207594;22720.772792272197;22840.200592979167;23001.769982299964;23106.7689323108;1106.25880659958;1109.3454861631515;1128.5316593613722;1134.0700625487186;1139.3904261220207;11879.40602969848;12251.203671761306;15982.840171598367;16246.512604621881;16629.16854157287;234458;236478;236577;237360;237919;53692.46307536953;54466.45533544693;54527.72736136294;54860.451395486336;55039.44960550343;1439.5681295611275;1446.5587995661215;1456.8033315502485;1457.8760805331453;1463.3488097796378;27489.72510274872;27601.447971040867;27918.86040569784;28405.573916391684;28912.566311505765;45533.31700024436;45756.31365529453;46230.7688461569;46252.30621540747;46272.53727462817;200032;200972;201530;202161;203478;33561.49657755087;34346.31307373789;34440.65559344374;34669;34742;42951.92620184521;43253.56746432495;43568;43750.56249437465;43810.78094609634;32089.679103209604;32090.839545802122;32320.35359292848;32526.02421927346;32647.836760816044;31660.525092123175;31770.36459270848;31853.36293274075;32201.838990804896;32858.34283314368;35826.820865895505;35894.28211435809;36166.63833361633;36418.81790591136;36422;33089;33983.320333592696;34540.65459345374;34552.654473454946;34659.4801077979;24517.520000399003;24812.627810582493;24956.50086998286;24964.875175624005;25305.098164182953 02:54:02 INFO - PID 7425 | |2;jquery.html;561.1134407635935;565.9830205093843;569.6126633888955;574.8993926062938;579.5769088565347;21804.236851710193;22532.211372601963;22537.774622253815;22546.54906901861;22575.54848903025;23624.291271261845;24630.137945171922;25793.48413031738;25828.612570811452;25902.09342673007;6517.8370540736505;6652.866942661144;6667.799966001027;6673.93326066738;6675.899861502081;6051.697415129248;6540.803775886731;6590.637514936677;6608.603483790964;6620.172478440195;6335.588186767845;6576.835579110537;6590.967045164767;6591.209054913417;6597.835054123638;6575.145231119947;6580.473562115068;6582.605043697394;6582.93417065828;6585.012248162766;6116.052011938156;6118.632882027093;6120.632762034248;6122.969385153046;6128;28368.71631283702;29203.415931681247;29669;29761.404771904658;29862.552061719092;1996.7703714072777;2038.1236068490543;2038.5820906714089;2040.3368905105751;2040.4694779357326;19363.322283720143;19774.3078992236;19776.110075046658;19898.20407183711;19931.601367972704;2457.69278840145;2463.7782599566126;2515.308290220186;2525.671662683858;2527.330257481769;135981.3200933989;137641.3117934404;137823.31088344596;137912.620873791;138190.3090484541;14352.856471435152;14818.184999825113;14978.47575334858;15016;15294.694106117815;22202.66695999561;22966;23002.53994920126;23540.64689029666;23561;9839;9914.652987145559;10070.8489372658;10128.848067278997;10298.17614590831;9383.812323753487;9451.527423628791;9482.241420686329;9518.476483793458;9600;9067;9097.226735727538;9116.361854670242;9122.452652840851;9328.860067098998;2575.2702135735803;2633.723459036812;2651.138380026499;2681.0508440715057;2711.4577084582766;967.1489089601247;983.8783786483415;991.7867658453467;993.9453330066916;1011.3022014809904;19380.868104508492;19435;19706.211751530063;20284.087216075313;20320.491987700425;1049.1082579807255;1053.5311786255043;1061.554147258138;1063.2822844579878;1074.537948682074;11142.944285278521;13216.339183040809;14039.649008774863;14132.364043618061;14293.64265893361;507063;511089;511647;512384;532334;121784;123398.38300808439;124088.37955810163;124405.37797310956;126212;1229.3853073463267;1270.4283072617175;1280.0719478378287;1286.2861112082883;1286.8327117474669;21360.14559417668;21687.891560542095;21809;21855.453613659785;21878;49987.25019124789;52049;53069.469305306455;61956.38043619506;62167;67273.3272667267;69002;69261.30738692549;69603;70274.64862675859;14696.265186740835;15054.645081942239;15057.17185554805;15076.698466030399;15141.242937853283;22736.317910462712;23731.644025339978;23802.40493987664;23814.285571432883;23874.641880372157;17685.204165812313;17807.109644517983;17972.281108756026;18014.2794288227;18019.2792288307;15887.205639718199;15974.520764377086;16948.40680576174;16979.066151361792;17285;18061.638767224846;18281.725774113133;18324.633507329512;18340;18406.35577754826;14075.718485630436;14351.425942962165;14353.138811671333;14376.856231437552;14390.568282951528;18126.093695315445;18141.183646736194;18141.365052223107;18188.90905545464;18198.181081851613 02:54:02 INFO - PID 7425 | |3;mootools.html;1361.1832900259844;1446.5226475263164;1450.0791997081853;1453.5784622459494;1454.3237394611504;14910.701785964287;14939.17834519101;15459.613509662264;15540.06759594425;15549.378024878992;15649.765253521206;15984.920075399607;16012.359505619761;16035.759463608027;16037.316081811417;2839.616651752013;2897.3915477749697;2899.4201159768027;2901.3907079513224;2902.8548572571285;2715.4026114254834;2880.927976800576;2886.538153895377;2893.956590651142;2894.652641683001;2799.0343331550584;2818.8308701477877;2819.3374556979093;2823.3929705113396;2854.158023383107;2798.916032519028;2802.4395120975887;2816.690164081949;2820.8025438219433;2823.6470441194647;2651.9204423867313;2727.5226835303943;2742.3829638331417;2742.4103817679097;2750.683671377797;14948.103113813206;15286.847131528653;15297.770533442008;15303.770443443358;15314.617134571614;8012.158723334024;8260.669573217065;8266.380021498351;8267.421280510367;8278.461899976483;5337.332833395825;5557.972210138923;5598.272224610774;5646.322441307028;5734.082546792493;1945.4649971257875;1946.4355336952267;1947.6299503094508;1960.1571324330532;1983.3851506033031;26457;27096.45807083847;27098.322541936413;27118.45763084747;27212.59181112285;7142.857142857114;7265.673044712895;7303.196648368676;7353.742619008309;7525.510841795375;20760.377188684364;20777.68833467469;20794.688079678817;20866.895665521577;20905.477363066046;7743.9612801936755;8356.582170891432;8369.163083691705;8369.3304535637;8379.664813407395;7393.29763672461;7428.33145016951;7483.438742094365;7511.211322811136;7512.47412681118;5668.121441176624;5801.6519008859605;5838.474537291664;5876.676782776903;5884.6469211847425;1565.1000674612144;1615.4103752130388;1618.166644178249;1792.8834625749284;1868.3274021352302;893.687209476691;910.1808372464702;926.4950601921969;928.1090153452626;935.2704890185666;8174;8334.291585215324;8343.290820280345;8452.366072544584;8472.74581762548;976.7558110472382;992.538469611634;994.110271307176;997.4464172384396;1005.6128390569537;4824.179889418807;4912.263160525878;4956.083124621884;4974.850754477371;5021.121303771825;21210.575788484144;21628.45928851791;21834.454138646663;21933.122675092818;21971.890140549196;20632.277870274767;21374.251901183696;22061.779382206292;22239.221627243292;22260;10628.627998020032;10750.139988800876;10759.623413180658;10761.139108871272;10913.56345746177;8099.83800324002;8298.751037468886;8581;8709.477431354138;8716.607752651273;18247.726284105484;18268.634627307645;18277.26890924348;18313;18773.34293299728;19027.52431189176;19148.617027659646;19165.904170479058;19238.903805480884;19309.710354344414;11242.943785281348;11442.427878606202;11457.369844658624;11462.140339474407;11467.369294688871;13516.594502164951;13846.10000349974;13863.930680346937;13930.512432064828;13942;9652.75868103303;9731.17285030752;9790.118889299998;10767.246292759432;11147.83278250843;10186.949065254923;10246.53890574911;10294.742631434274;10356.948215259177;10586.89413105859;9022.864657030019;9188.448693078437;9190;9205.30960177976;9237.58430870599;6607.80176594703;6850.349216824394;6871.896921546081;7233.565986040854;7305.963470182615;7263.673134709056;7297.343239108506;7333.853322933618;7344.155422126524;7385.5937923412575 02:54:02 INFO - PID 7425 | |4;prototype.html;494.80207916833285;497.9775910084047;534.8743045384334;538.3324677400025;540.5081375947889;6343.333949935254;6394.424501794838;6417.711202995864;6430.710618022188;6441.774537891175;6069.1199776032445;6184.165137706408;6260.968695156518;6276.246850377961;6307.936920630792;5088.54203121719;5089.160288552384;5089.236614507835;5117.232415137741;5122.436531981479;5073.264376665381;5096.285935509639;5099.184130539114;5102.438731739506;5115.360579927509;4901.8039278429;5059.949400505985;5065.138926382524;5073.391193056838;5079.23811428285;4929.186684197103;4959.2809042688605;5013.448520662724;5034.974825125888;5060.5951523878;4457.576530229623;4525.841595544141;4534.38785763921;4547.226971414867;4550.180967425862;6198.411150940653;6226.533010024266;6230.127782110508;6230.158928544633;6231.3145553989025;5693.28833895763;5716.428357164292;5839.620424672383;5841.240638716982;5843.824685259449;6580.21037475506;6600.966995165041;6616.437602803768;6621.172353455818;6627.713438863584;4875.414950205963;4878.365812444395;4917.188663870493;4937.654364194508;4946.826861059882;6898.724051037952;7038.59228154361;7078.327558881898;7094.53885497441;7111.324424179695;5032.84901452957;5059.772310246048;5063.468335824759;5096.490350964948;5125.641205115606;5057.7724002419245;5074.543291103819;5096.923546146811;5100.923486147711;5115.488451154929;5756.884862302731;5796.1305804129715;5812.099124635688;5815.5929084963645;5851.122331650201;6638.5684930479365;6655.833604159935;6664.566803157779;6675.696884574814;6745.392914637608;1672.6989141954566;1684.553593297777;1717.7938647362396;1756.4906177208723;1783.4114742135064;1207.8550573931184;1230.809224570193;1241.509603706549;1241.7330273991136;1261.779188641984;5922.022866227025;5925.288965324189;5961.433663801932;5978.282606087298;5984.820455386345;6528.37980391862;6757.054012438262;6763.637453842244;6788.015737718102;6847.417969472551;5869.765209391662;5906.464319277019;5927.2590926134235;5956.970215148896;5987.491063259672;3543.645635436436;3554.804485753257;3588.6770190682964;3609.7473176877893;3640.2719456108885;6420.807375778734;6422.454091402283;6470.676466176672;6531.8367040823405;6562.442192413699;6912.723491060402;6965.895511567331;6981.2669669684965;7060.964695176492;7071.222165561784;6422.6467544285515;6464.030395440722;6479.157709497829;6522.184726909137;6530.412262896267;6713.765018224339;6775.966120169368;6848.452123829982;6895.9314903544855;6899.275576064641;6709.322669332471;6755.290694477206;6760.7800823243715;6807.625580593115;6830.31696830313;6403.807885763435;6462.289148193789;6464.644444555594;6477.255115661571;6562.77030303937;4961.82633607822;4984.950150498448;5009.674371165863;5014.27007682349;5043.798248070036;6835.829104272433;6887.20797108339;6890.2420733718245;6890.276520965226;6927.376536111774;6558.868822623425;6616.470682345497;6638.83402914931;6638.83402914931;6684.498662600422;6453.806385808433;6457.225132984072;6565.606063636197;6645.235797883112;6663.900041499284;6323.494120470259;6328.589056356933;6463.353664633499;6481.805545833632;6578.967105164635;6565.770198043046;6570.737170513126;6640.966795165993;6670.866582668416;6719.899201512079;6308.52686048539;6365.96817015912;6439.839004024937;6451.1936007999;6496.382843629847 02:54:02 INFO - PID 7425 | |5;yui.html;898.3531857062912;912.9680461183858;926.6247169896191;931.2829121576386;933.0343094896783;15793.052416854996;16211.675766484677;16230.269637866295;16251;17519.562010949732;18014.369497067604;18093.366732164377;18099.90950045248;18109.7283540747;18125;973.1096047116897;995.4027583449908;996.4967691315875;997.1175509673955;1000.0499525450814;900.4912224593083;981.9901800982005;986.1765425869407;986.4377304936189;990.3711143423942;1014.614446510325;1023.5803320638539;1024.262530977695;1024.9897501024968;1025.1440047560259;1022.4580972084807;1031.2523420520138;1031.2729525684374;1031.3554028732042;1031.5925209542227;757.6060448566715;763.5723994563062;764.9847003059907;765.3762183820169;766.1610536462565;16888.40890568824;17239.913800430917;17692.734608980874;17737.55656108595;17761.46715598534;20967.685484717742;21111.8944405277;21412;21486.785132148634;21702.13191472339;16614.335426582922;17097.829021709873;17134.914325428417;17201.311947522085;17341.306347746075;3675.2098298865603;3715.4241092630414;3716.2939041582013;3718.7396882218254;3719.851205951759;119176;121464.99999999911;123216.38391808073;123997.38001310026;125474;15903.52289431319;16814.91592542054;17137.485875423758;17240.482785516455;17256.396026139024;29762.25594360115;29885.252868678457;30140;30186;30218.395632087235;8729.214370706666;8813.515256660945;8839.558022098998;8841.867371989425;8876.20114189726;3879.922401551953;3989.162275922031;3994.021464741099;3998.6801055915457;4042.8989275267763;4341.370501277297;5227.424983251915;5892.646441213541;5906.793262235801;5927.199828023248;1115.3530952047793;1132.4394424759796;1145.0953746540306;1153.8846115388562;1154.1055681846635;673.4343151752552;685.8251145957748;695.422799076765;699.755085719994;701.3512500936613;11295.209335346612;11586.073114150848;11635.88364116365;11671;12600;693.3794254142514;699.1260923845193;705.1291654806311;707.1478867964091;718.8059224009488;5440.537554307849;5514.889702205934;5545.334559852843;5603.635763675348;5675.744591493392;109562.45218773856;109651.45174274077;110333.44833275782;113602;115961;87865.5606721975;88973;89363.65954510687;89459;91987.54006229926;81571.5921420401;83471.58264208761;83585.58207208925;86263.56868215618;86582.56708716541;11686.357250351311;11885.28688278706;12066.879331206575;12187.085968552217;12369.319687417279;39155.804220978716;39578;39641;40116.59883401245;40305.79847100863;64795;66955.66522167358;67535;69597.65201173961;74190.62904685442;18236.908815455838;18523.35168269104;18663;18667;18793.812061879205;20121.496962576053;20821.479463013548;20861.269855554983;20894.1642334311;20937.26719564808;17509.912450437667;18079.548011299295;18113.094345282945;18189.636207276046;18224.45326640203;17635.647287054442;18364.908175459037;18385.448436546925;18462.907685462025;18542.165602547648;16722.247498862336;16897;17170.914145429193;17288.827111728722;17383.652326953135;12995.155314904501;13172.407241673956;13256.867431325949;13542.796858047333;13748.862511375159;13695.86304136946;14060.437582496994;14129.434822606981;14178.361973711002;14609.196494192922 02:54:02 INFO - PID 7425 | __end_tp_report 02:54:02 INFO - PID 7425 | __start_cc_report 02:54:02 INFO - PID 7425 | _x_x_mozilla_cycle_collect,360 02:54:02 INFO - PID 7425 | __end_cc_report 02:54:02 INFO - PID 7425 | __startTimestamp1504086842874__endTimestamp 02:54:02 INFO - PID 7425 | 02:54:02 INFO - PID 7425 | ------- Summary: start ------- 02:54:02 INFO - PID 7425 | Number of tests: 6 02:54:02 INFO - PID 7425 | 02:54:02 INFO - PID 7425 | [#0] dojo.html Cycles:165 Average:6413.06 Median:6624.93 stddev:873.86 (13.2%) stddev-sans-first:843.61 02:54:02 INFO - PID 7425 | Values: 3384.1 3396.0 3403.6 3412.2 3414.4 6454.0 6532.5 6553.2 6595.9 6603.5 6356.6 6405.7 6410.7 6426.9 6459.6 5904.1 5911.5 5940.5 6014.9 6093.5 6054.6 6063.4 6070.9 6120.6 6120.8 947.3 5885.4 6020.5 6062.6 6099.6 5897.4 5903.6 5969.1 6057.6 6086.5 5869.9 5876.7 5955.3 5961.2 6005.0 6474.3 6491.4 6506.8 6595.3 6624.9 6994.0 7003.9 7064.1 7090.5 7112.4 6881.3 6972.3 7046.8 7054.7 7149.1 6430.9 6460.0 6460.2 6461.5 6462.6 7209.5 7262.2 7287.2 7289.4 7289.9 6877.6 6897.4 6978.9 6985.2 6986.3 7013.7 7042.6 7085.8 7117.1 7152.9 6833.2 6916.0 6944.3 6963.8 7063.1 7023.8 7028.4 7028.8 7049.2 7053.4 5524.6 5547.1 5559.4 5563.1 5567.2 4757.9 4768.4 4770.4 4789.7 4793.5 6059.5 6174.8 6189.2 6193.1 6193.3 7041.5 7052.5 7125.6 7138.6 7165.5 5971.9 6056.4 6101.2 6112.2 6183.9 6082.1 6092.6 6113.6 6114.3 6122.2 6718.4 6721.9 6751.5 6769.6 6771.4 6995.2 7003.4 7005.3 7114.5 7115.2 6656.8 6666.2 6738.4 6753.1 6768.7 6744.5 6855.5 6902.1 6975.5 6984.7 7110.4 7128.0 7141.0 7149.4 7153.0 6809.6 6822.6 6879.5 6881.2 6894.2 6559.8 6803.4 6818.2 6914.0 6918.0 6583.1 6589.5 6604.2 6607.3 6632.1 6705.0 6778.0 6836.1 6872.0 6982.3 6349.1 6447.1 6488.9 6602.0 6741.1 02:54:02 INFO - PID 7425 | 02:54:02 INFO - PID 7425 | [#1] ext.html Cycles:180 Average:37761.20 Median:34664.24 stddev:53650.00 (154.8%) stddev-sans-first:53728.69 02:54:02 INFO - PID 7425 | Values: 792.8 856.6 883.0 883.6 1127.7 29579.7 31048.2 40564.6 40891.4 41163.6 41816.8 42246.4 42358.8 42409.2 42470.8 7499.3 7689.5 7692.5 7692.8 7695.4 7519.1 7620.8 7621.9 7623.4 7624.5 7623.3 7669.2 7670.8 7672.2 7676.5 7599.8 7604.4 7608.7 7632.0 7632.4 7538.2 7601.3 7601.6 7602.6 7637.2 36505.0 36529.0 36567.3 36639.6 36677.1 3537.2 3589.2 3591.8 3593.7 3595.6 30850.7 30908.7 30972.4 30977.8 31001.7 5097.5 5128.7 5196.8 5220.7 5229.3 177554.1 178934.1 180150.1 180250.1 180804.0 44693.6 44873.8 45001.3 45034.3 45121.8 46984.3 47044.3 47091.0 47148.8 47207.5 14123.5 15817.6 16067.9 16081.4 16090.2 11774.8 13277.7 13480.8 13502.7 13516.5 13883.4 13936.7 14005.9 14027.7 14106.2 5527.4 5656.8 5663.2 5730.5 5797.0 1001.8 1023.8 1024.7 1038.2 1049.6 22074.8 22720.8 22840.2 23001.8 23106.8 1106.3 1109.3 1128.5 1134.1 1139.4 11879.4 12251.2 15982.8 16246.5 16629.2 234458.0 236478.0 236577.0 237360.0 237919.0 53692.5 54466.5 54527.7 54860.5 55039.4 1439.6 1446.6 1456.8 1457.9 1463.3 27489.7 27601.4 27918.9 28405.6 28912.6 45533.3 45756.3 46230.8 46252.3 46272.5 200032.0 200972.0 201530.0 202161.0 203478.0 33561.5 34346.3 34440.7 34669.0 34742.0 42951.9 43253.6 43568.0 43750.6 43810.8 32089.7 32090.8 32320.4 32526.0 32647.8 31660.5 31770.4 31853.4 32201.8 32858.3 35826.8 35894.3 36166.6 36418.8 36422.0 33089.0 33983.3 34540.7 34552.7 34659.5 24517.5 24812.6 24956.5 24964.9 25305.1 02:54:02 INFO - PID 7425 | 02:54:02 INFO - PID 7425 | [#2] jquery.html Cycles:180 Average:35745.26 Median:22851.16 stddev:86578.07 (378.9%) stddev-sans-first:86780.65 02:54:02 INFO - PID 7425 | Values: 561.1 566.0 569.6 574.9 579.6 21804.2 22532.2 22537.8 22546.5 22575.5 23624.3 24630.1 25793.5 25828.6 25902.1 6517.8 6652.9 6667.8 6673.9 6675.9 6051.7 6540.8 6590.6 6608.6 6620.2 6335.6 6576.8 6591.0 6591.2 6597.8 6575.1 6580.5 6582.6 6582.9 6585.0 6116.1 6118.6 6120.6 6123.0 6128.0 28368.7 29203.4 29669.0 29761.4 29862.6 1996.8 2038.1 2038.6 2040.3 2040.5 19363.3 19774.3 19776.1 19898.2 19931.6 2457.7 2463.8 2515.3 2525.7 2527.3 135981.3 137641.3 137823.3 137912.6 138190.3 14352.9 14818.2 14978.5 15016.0 15294.7 22202.7 22966.0 23002.5 23540.6 23561.0 9839.0 9914.7 10070.8 10128.8 10298.2 9383.8 9451.5 9482.2 9518.5 9600.0 9067.0 9097.2 9116.4 9122.5 9328.9 2575.3 2633.7 2651.1 2681.1 2711.5 967.1 983.9 991.8 993.9 1011.3 19380.9 19435.0 19706.2 20284.1 20320.5 1049.1 1053.5 1061.6 1063.3 1074.5 11142.9 13216.3 14039.6 14132.4 14293.6 507063.0 511089.0 511647.0 512384.0 532334.0 121784.0 123398.4 124088.4 124405.4 126212.0 1229.4 1270.4 1280.1 1286.3 1286.8 21360.1 21687.9 21809.0 21855.5 21878.0 49987.3 52049.0 53069.5 61956.4 62167.0 67273.3 69002.0 69261.3 69603.0 70274.6 14696.3 15054.6 15057.2 15076.7 15141.2 22736.3 23731.6 23802.4 23814.3 23874.6 17685.2 17807.1 17972.3 18014.3 18019.3 15887.2 15974.5 16948.4 16979.1 17285.0 18061.6 18281.7 18324.6 18340.0 18406.4 14075.7 14351.4 14353.1 14376.9 14390.6 18126.1 18141.2 18141.4 18188.9 18198.2 02:54:02 INFO - PID 7425 | 02:54:02 INFO - PID 7425 | [#3] mootools.html Cycles:180 Average:9465.94 Median:2800.74 stddev:6823.82 (243.6%) stddev-sans-first:6815.80 02:54:02 INFO - PID 7425 | Values: 1361.2 1446.5 1450.1 1453.6 1454.3 14910.7 14939.2 15459.6 15540.1 15549.4 15649.8 15984.9 16012.4 16035.8 16037.3 2839.6 2897.4 2899.4 2901.4 2902.9 2715.4 2880.9 2886.5 2894.0 2894.7 2799.0 2818.8 2819.3 2823.4 2854.2 2798.9 2802.4 2816.7 2820.8 2823.6 2651.9 2727.5 2742.4 2742.4 2750.7 14948.1 15286.8 15297.8 15303.8 15314.6 8012.2 8260.7 8266.4 8267.4 8278.5 5337.3 5558.0 5598.3 5646.3 5734.1 1945.5 1946.4 1947.6 1960.2 1983.4 26457.0 27096.5 27098.3 27118.5 27212.6 7142.9 7265.7 7303.2 7353.7 7525.5 20760.4 20777.7 20794.7 20866.9 20905.5 7744.0 8356.6 8369.2 8369.3 8379.7 7393.3 7428.3 7483.4 7511.2 7512.5 5668.1 5801.7 5838.5 5876.7 5884.6 1565.1 1615.4 1618.2 1792.9 1868.3 893.7 910.2 926.5 928.1 935.3 8174.0 8334.3 8343.3 8452.4 8472.7 976.8 992.5 994.1 997.4 1005.6 4824.2 4912.3 4956.1 4974.9 5021.1 21210.6 21628.5 21834.5 21933.1 21971.9 20632.3 21374.3 22061.8 22239.2 22260.0 10628.6 10750.1 10759.6 10761.1 10913.6 8099.8 8298.8 8581.0 8709.5 8716.6 18247.7 18268.6 18277.3 18313.0 18773.3 19027.5 19148.6 19165.9 19238.9 19309.7 11242.9 11442.4 11457.4 11462.1 11467.4 13516.6 13846.1 13863.9 13930.5 13942.0 9652.8 9731.2 9790.1 10767.2 11147.8 10186.9 10246.5 10294.7 10356.9 10586.9 9022.9 9188.4 9190.0 9205.3 9237.6 6607.8 6850.3 6871.9 7233.6 7306.0 7263.7 7297.3 7333.9 7344.2 7385.6 02:54:02 INFO - PID 7425 | 02:54:02 INFO - PID 7425 | [#4] prototype.html Cycles:180 Average:5580.17 Median:6230.74 stddev:1569.62 (25.2%) stddev-sans-first:1526.91 02:54:02 INFO - PID 7425 | Values: 494.8 498.0 534.9 538.3 540.5 6343.3 6394.4 6417.7 6430.7 6441.8 6069.1 6184.2 6261.0 6276.2 6307.9 5088.5 5089.2 5089.2 5117.2 5122.4 5073.3 5096.3 5099.2 5102.4 5115.4 4901.8 5059.9 5065.1 5073.4 5079.2 4929.2 4959.3 5013.4 5035.0 5060.6 4457.6 4525.8 4534.4 4547.2 4550.2 6198.4 6226.5 6230.1 6230.2 6231.3 5693.3 5716.4 5839.6 5841.2 5843.8 6580.2 6601.0 6616.4 6621.2 6627.7 4875.4 4878.4 4917.2 4937.7 4946.8 6898.7 7038.6 7078.3 7094.5 7111.3 5032.8 5059.8 5063.5 5096.5 5125.6 5057.8 5074.5 5096.9 5100.9 5115.5 5756.9 5796.1 5812.1 5815.6 5851.1 6638.6 6655.8 6664.6 6675.7 6745.4 1672.7 1684.6 1717.8 1756.5 1783.4 1207.9 1230.8 1241.5 1241.7 1261.8 5922.0 5925.3 5961.4 5978.3 5984.8 6528.4 6757.1 6763.6 6788.0 6847.4 5869.8 5906.5 5927.3 5957.0 5987.5 3543.6 3554.8 3588.7 3609.7 3640.3 6420.8 6422.5 6470.7 6531.8 6562.4 6912.7 6965.9 6981.3 7061.0 7071.2 6422.6 6464.0 6479.2 6522.2 6530.4 6713.8 6776.0 6848.5 6895.9 6899.3 6709.3 6755.3 6760.8 6807.6 6830.3 6403.8 6462.3 6464.6 6477.3 6562.8 4961.8 4985.0 5009.7 5014.3 5043.8 6835.8 6887.2 6890.2 6890.3 6927.4 6558.9 6616.5 6638.8 6638.8 6684.5 6453.8 6457.2 6565.6 6645.2 6663.9 6323.5 6328.6 6463.4 6481.8 6579.0 6565.8 6570.7 6641.0 6670.9 6719.9 6308.5 6366.0 6439.8 6451.2 6496.4 02:54:02 INFO - PID 7425 | 02:54:02 INFO - PID 7425 | [#5] yui.html Cycles:180 Average:23158.19 Median:19457.65 stddev:31303.49 (160.9%) stddev-sans-first:31346.68 02:54:02 INFO - PID 7425 | Values: 898.4 913.0 926.6 931.3 933.0 15793.1 16211.7 16230.3 16251.0 17519.6 18014.4 18093.4 18099.9 18109.7 18125.0 973.1 995.4 996.5 997.1 1000.0 900.5 982.0 986.2 986.4 990.4 1014.6 1023.6 1024.3 1025.0 1025.1 1022.5 1031.3 1031.3 1031.4 1031.6 757.6 763.6 765.0 765.4 766.2 16888.4 17239.9 17692.7 17737.6 17761.5 20967.7 21111.9 21412.0 21486.8 21702.1 16614.3 17097.8 17134.9 17201.3 17341.3 3675.2 3715.4 3716.3 3718.7 3719.9 119176.0 121465.0 123216.4 123997.4 125474.0 15903.5 16814.9 17137.5 17240.5 17256.4 29762.3 29885.3 30140.0 30186.0 30218.4 8729.2 8813.5 8839.6 8841.9 8876.2 3879.9 3989.2 3994.0 3998.7 4042.9 4341.4 5227.4 5892.6 5906.8 5927.2 1115.4 1132.4 1145.1 1153.9 1154.1 673.4 685.8 695.4 699.8 701.4 11295.2 11586.1 11635.9 11671.0 12600.0 693.4 699.1 705.1 707.1 718.8 5440.5 5514.9 5545.3 5603.6 5675.7 109562.5 109651.5 110333.4 113602.0 115961.0 87865.6 88973.0 89363.7 89459.0 91987.5 81571.6 83471.6 83585.6 86263.6 86582.6 11686.4 11885.3 12066.9 12187.1 12369.3 39155.8 39578.0 39641.0 40116.6 40305.8 64795.0 66955.7 67535.0 69597.7 74190.6 18236.9 18523.4 18663.0 18667.0 18793.8 20121.5 20821.5 20861.3 20894.2 20937.3 17509.9 18079.5 18113.1 18189.6 18224.5 17635.6 18364.9 18385.4 18462.9 18542.2 16722.2 16897.0 17170.9 17288.8 17383.7 12995.2 13172.4 13256.9 13542.8 13748.9 13695.9 14060.4 14129.4 14178.4 14609.2 02:54:02 INFO - PID 7425 | -------- Summary: end -------- 02:54:02 INFO - PID 7425 | 02:54:03 INFO - TEST-INFO | 7425: exit 0 02:54:03 INFO - TEST-OK | dromaeo_css | took 1111464ms 02:54:03 INFO - TEST-START | kraken 02:54:03 INFO - Initialising browser for kraken test... 02:54:03 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47261/getInfo.html -profile /tmp/tmp9xi1ZM/profile 02:54:03 INFO - TEST-INFO | started process 7793 (/builds/slave/test/build/application/firefox/firefox http://localhost:47261/getInfo.html) 02:54:09 INFO - TEST-INFO | 7793: exit 0 02:54:09 INFO - Browser initialized. 02:54:09 INFO - Running cycle 1/1 for kraken test... 02:54:09 INFO - Using env: {'DISPLAY': ':0', 02:54:09 INFO - 'HOME': '/home/cltbld', 02:54:09 INFO - 'JSGC_DISABLE_POISONING': '1', 02:54:09 INFO - 'LANG': 'en_US.UTF-8', 02:54:09 INFO - 'LANGUAGE': 'en_US:en', 02:54:09 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 02:54:09 INFO - 'LOGNAME': 'cltbld', 02:54:09 INFO - 'MAIL': '/var/mail/cltbld', 02:54:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:54:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:54:09 INFO - 'MOZ_CRASHREPORTER': '1', 02:54:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:09 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 02:54:09 INFO - 'MOZ_NO_REMOTE': '1', 02:54:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:54:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:09 INFO - 'NO_EM_RESTART': '1', 02:54:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:09 INFO - 'PWD': '/builds/slave/test', 02:54:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:54:09 INFO - 'RUST_BACKTRACE': 'full', 02:54:09 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:54:09 INFO - 'SHELL': '/bin/bash', 02:54:09 INFO - 'SHLVL': '1', 02:54:09 INFO - 'STYLO_FORCE_ENABLED': '1', 02:54:09 INFO - 'STYLO_THREADS': '1', 02:54:09 INFO - 'TERM': 'linux', 02:54:09 INFO - 'TMOUT': '86400', 02:54:09 INFO - 'USER': 'cltbld', 02:54:09 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1504084557.548086-1771277551', 02:54:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:09 INFO - '_': '/tools/buildbot/bin/python'} 02:54:09 INFO - TEST-INFO | started process 7980 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9xi1ZM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:54:10 INFO - PID 7980 | 02:54:10 INFO - PID 7980 | (/builds/slave/test/build/application/firefox/firefox:8031): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:54:10 INFO - PID 7980 | 02:54:21 INFO - PID 7980 | RSS: Main: 171315200 02:54:21 INFO - PID 7980 | 02:54:23 INFO - PID 7980 | Cycle 1(1): loaded http://localhost:47261/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47261/tests/kraken/driver.html?testName=audio-beat-detection) 02:54:24 INFO - PID 7980 | RSS: Main: 175906816 02:54:24 INFO - PID 7980 | 02:54:27 INFO - PID 7980 | Cycle 1(1): loaded http://localhost:47261/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47261/tests/kraken/driver.html?testName=audio-dft) 02:54:27 INFO - PID 7980 | RSS: Main: 180256768 02:54:27 INFO - PID 7980 | 02:54:30 INFO - PID 7980 | Cycle 1(1): loaded http://localhost:47261/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47261/tests/kraken/driver.html?testName=audio-fft) 02:54:31 INFO - PID 7980 | RSS: Main: 173572096 02:54:31 INFO - PID 7980 | 02:54:33 INFO - PID 7980 | Cycle 1(1): loaded http://localhost:47261/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47261/tests/kraken/driver.html?testName=audio-oscillator) 02:54:34 INFO - PID 7980 | RSS: Main: 174276608 02:54:34 INFO - PID 7980 | 02:54:36 INFO - PID 7980 | Cycle 1(1): loaded http://localhost:47261/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47261/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:54:37 INFO - PID 7980 | RSS: Main: 174256128 02:54:37 INFO - PID 7980 | 02:54:40 INFO - PID 7980 | Cycle 1(1): loaded http://localhost:47261/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47261/tests/kraken/driver.html?testName=imaging-darkroom) 02:54:40 INFO - PID 7980 | RSS: Main: 175419392 02:54:40 INFO - PID 7980 | 02:54:44 INFO - PID 7980 | Cycle 1(1): loaded http://localhost:47261/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47261/tests/kraken/driver.html?testName=imaging-desaturate) 02:54:44 INFO - PID 7980 | RSS: Main: 175251456 02:54:44 INFO - PID 7980 | 02:54:47 INFO - PID 7980 | Cycle 1(1): loaded http://localhost:47261/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47261/tests/kraken/driver.html?testName=json-parse-financial) 02:54:48 INFO - PID 7980 | RSS: Main: 175570944 02:54:48 INFO - PID 7980 | 02:54:50 INFO - PID 7980 | Cycle 1(1): loaded http://localhost:47261/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47261/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:54:50 INFO - PID 7980 | RSS: Main: 175304704 02:54:50 INFO - PID 7980 | 02:54:52 INFO - PID 7980 | Cycle 1(1): loaded http://localhost:47261/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47261/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:54:53 INFO - PID 7980 | RSS: Main: 176463872 02:54:53 INFO - PID 7980 | 02:54:55 INFO - PID 7980 | Cycle 1(1): loaded http://localhost:47261/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47261/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:54:55 INFO - PID 7980 | RSS: Main: 172572672 02:54:55 INFO - PID 7980 | 02:54:58 INFO - PID 7980 | Cycle 1(1): loaded http://localhost:47261/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47261/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:54:59 INFO - PID 7980 | RSS: Main: 172625920 02:54:59 INFO - PID 7980 | 02:55:02 INFO - PID 7980 | Cycle 1(1): loaded http://localhost:47261/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47261/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:55:02 INFO - PID 7980 | RSS: Main: 172785664 02:55:02 INFO - PID 7980 | 02:55:04 INFO - PID 7980 | Cycle 1(1): loaded http://localhost:47261/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47261/tests/kraken/driver.html?testName=ai-astar) 02:55:04 INFO - PID 7980 | RSS: Main: 174628864 02:55:04 INFO - PID 7980 | 02:55:04 INFO - PID 7980 | __start_tp_report 02:55:04 INFO - PID 7980 | _x_x_mozilla_page_load 02:55:04 INFO - PID 7980 | _x_x_mozilla_page_load_details 02:55:04 INFO - PID 7980 | |i|pagename|runs| 02:55:04 INFO - PID 7980 | |0;ai-astar;99;107;101;106;106;118;116;100;110;108 02:55:04 INFO - PID 7980 | |1;audio-beat-detection;147;122;146;173;118;143;142;128;172;122 02:55:04 INFO - PID 7980 | |2;audio-dft;163;164;165;162;162;161;163;170;162;162 02:55:04 INFO - PID 7980 | |3;audio-fft;76;75;74;161;76;73;74;91;103;74 02:55:04 INFO - PID 7980 | |4;audio-oscillator;78;79;129;81;80;78;123;79;79;138 02:55:04 INFO - PID 7980 | |5;imaging-gaussian-blur;114;114;121;114;114;115;113;114;116;114 02:55:04 INFO - PID 7980 | |6;imaging-darkroom;149;149;148;147;149;149;148;149;148;147 02:55:04 INFO - PID 7980 | |7;imaging-desaturate;94;94;93;94;94;95;94;94;94;94 02:55:04 INFO - PID 7980 | |8;json-parse-financial;52;54;53;52;53;53;52;53;51;51 02:55:04 INFO - PID 7980 | |9;json-stringify-tinderbox;39;39;39;39;39;39;38;40;39;39 02:55:04 INFO - PID 7980 | |10;stanford-crypto-aes;78;75;73;75;75;75;74;75;75;75 02:55:04 INFO - PID 7980 | |11;stanford-crypto-ccm;119;121;132;129;133;123;125;127;119;162 02:55:04 INFO - PID 7980 | |12;stanford-crypto-pbkdf2;170;171;173;173;177;172;172;182;176;170 02:55:04 INFO - PID 7980 | |13;stanford-crypto-sha256-iterative;68;68;66;64;71;64;65;66;63;63 02:55:04 INFO - PID 7980 | __end_tp_report 02:55:04 INFO - PID 7980 | __start_cc_report 02:55:04 INFO - PID 7980 | _x_x_mozilla_cycle_collect,931 02:55:04 INFO - PID 7980 | __end_cc_report 02:55:04 INFO - PID 7980 | __startTimestamp1504086904831__endTimestamp 02:55:04 INFO - PID 7980 | 02:55:04 INFO - PID 7980 | ------- Summary: start ------- 02:55:04 INFO - PID 7980 | Number of tests: 14 02:55:04 INFO - PID 7980 | 02:55:04 INFO - PID 7980 | [#0] ai-astar Cycles:10 Average:107.10 Median:109.00 stddev:6.35 (5.8%) stddev-sans-first:6.02 02:55:04 INFO - PID 7980 | Values: 99.0 107.0 101.0 106.0 106.0 118.0 116.0 100.0 110.0 108.0 02:55:04 INFO - PID 7980 | 02:55:04 INFO - PID 7980 | [#1] audio-beat-detection Cycles:10 Average:141.30 Median:144.50 stddev:19.64 (13.6%) stddev-sans-first:20.72 02:55:04 INFO - PID 7980 | Values: 147.0 122.0 146.0 173.0 118.0 143.0 142.0 128.0 172.0 122.0 02:55:04 INFO - PID 7980 | 02:55:04 INFO - PID 7980 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.00 stddev:2.59 (1.6%) stddev-sans-first:2.74 02:55:04 INFO - PID 7980 | Values: 163.0 164.0 165.0 162.0 162.0 161.0 163.0 170.0 162.0 162.0 02:55:04 INFO - PID 7980 | 02:55:04 INFO - PID 7980 | [#3] audio-fft Cycles:10 Average:87.70 Median:74.50 stddev:27.55 (37.0%) stddev-sans-first:28.90 02:55:04 INFO - PID 7980 | Values: 76.0 75.0 74.0 161.0 76.0 73.0 74.0 91.0 103.0 74.0 02:55:04 INFO - PID 7980 | 02:55:04 INFO - PID 7980 | [#4] audio-oscillator Cycles:10 Average:94.40 Median:79.00 stddev:24.84 (31.4%) stddev-sans-first:25.63 02:55:04 INFO - PID 7980 | Values: 78.0 79.0 129.0 81.0 80.0 78.0 123.0 79.0 79.0 138.0 02:55:04 INFO - PID 7980 | 02:55:04 INFO - PID 7980 | [#5] imaging-gaussian-blur Cycles:10 Average:114.90 Median:114.00 stddev:2.28 (2.0%) stddev-sans-first:2.40 02:55:04 INFO - PID 7980 | Values: 114.0 114.0 121.0 114.0 114.0 115.0 113.0 114.0 116.0 114.0 02:55:04 INFO - PID 7980 | 02:55:04 INFO - PID 7980 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:149.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 02:55:04 INFO - PID 7980 | Values: 149.0 149.0 148.0 147.0 149.0 149.0 148.0 149.0 148.0 147.0 02:55:04 INFO - PID 7980 | 02:55:04 INFO - PID 7980 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 02:55:04 INFO - PID 7980 | Values: 94.0 94.0 93.0 94.0 94.0 95.0 94.0 94.0 94.0 94.0 02:55:04 INFO - PID 7980 | 02:55:04 INFO - PID 7980 | [#8] json-parse-financial Cycles:10 Average:52.40 Median:53.00 stddev:0.97 (1.8%) stddev-sans-first:1.01 02:55:04 INFO - PID 7980 | Values: 52.0 54.0 53.0 52.0 53.0 53.0 52.0 53.0 51.0 51.0 02:55:04 INFO - PID 7980 | 02:55:04 INFO - PID 7980 | [#9] json-stringify-tinderbox Cycles:10 Average:39.00 Median:39.00 stddev:0.47 (1.2%) stddev-sans-first:0.50 02:55:04 INFO - PID 7980 | Values: 39.0 39.0 39.0 39.0 39.0 39.0 38.0 40.0 39.0 39.0 02:55:04 INFO - PID 7980 | 02:55:04 INFO - PID 7980 | [#10] stanford-crypto-aes Cycles:10 Average:75.00 Median:75.00 stddev:1.25 (1.7%) stddev-sans-first:0.71 02:55:04 INFO - PID 7980 | Values: 78.0 75.0 73.0 75.0 75.0 75.0 74.0 75.0 75.0 75.0 02:55:04 INFO - PID 7980 | 02:55:04 INFO - PID 7980 | [#11] stanford-crypto-ccm Cycles:10 Average:129.00 Median:128.00 stddev:12.62 (9.9%) stddev-sans-first:12.86 02:55:04 INFO - PID 7980 | Values: 119.0 121.0 132.0 129.0 133.0 123.0 125.0 127.0 119.0 162.0 02:55:04 INFO - PID 7980 | 02:55:04 INFO - PID 7980 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.60 Median:173.00 stddev:3.75 (2.2%) stddev-sans-first:3.74 02:55:04 INFO - PID 7980 | Values: 170.0 171.0 173.0 173.0 177.0 172.0 172.0 182.0 176.0 170.0 02:55:04 INFO - PID 7980 | 02:55:04 INFO - PID 7980 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:2.57 (3.9%) stddev-sans-first:2.60 02:55:04 INFO - PID 7980 | Values: 68.0 68.0 66.0 64.0 71.0 64.0 65.0 66.0 63.0 63.0 02:55:04 INFO - PID 7980 | -------- Summary: end -------- 02:55:04 INFO - PID 7980 | 02:55:05 INFO - PID 7980 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 02:55:05 INFO - TEST-INFO | 7980: exit 0 02:55:05 INFO - TEST-OK | kraken | took 61966ms 02:55:05 INFO - SUITE-END | took 1173s 02:55:05 INFO - Completed test suite (00:19:33) 02:55:05 INFO - javascript benchmark 02:55:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8656.43728854968, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3384.0524653097127, 3396.0, 3403.591569011719, 3412.164019815146, 3414.419548676725, 6453.967730161355, 6532.51006174537, 6553.246376666685, 6595.934040659592, 6603.504737144709, 6356.555041147121, 6405.743770249196, 6410.743570257184, 6426.903596446045, 6459.6447195404235, 5904.143899134644, 5911.46796788289, 5940.465358117768, 6014.91731488332, 6093.451589356957, 6054.6367217966845, 6063.393660633946, 6070.908936365958, 6120.602160859552, 6120.785772497963, 947.2715845849765, 5885.411458854123, 6020.45815876571, 6062.636241825482, 6099.57302988791, 5897.4102589741115, 5903.586748927577, 5969.074793407029, 6057.575969682124, 6086.513078953717, 5869.911951320733, 5876.7355469004, 5955.315138759055, 5961.165436838846, 6004.96997515014, 6474.320196379406, 6491.350864913518, 6506.804795856132, 6595.340465953366, 6624.93375066248, 6993.950907363886, 7003.859922801566, 7064.116985376828, 7090.50366474347, 7112.395446387063, 6881.346272104142, 6972.267911869231, 7046.788596342118, 7054.717811287543, 7149.070620819312, 6430.90353644691, 6460.030995350688, 6460.192475940507, 6461.450776684034, 6462.579932304385, 7209.459290553229, 7262.20115787263, 7287.234840341794, 7289.380402665727, 7289.854202915912, 6877.6217308048535, 6897.41371983377, 6978.930210697929, 6985.231624521299, 6986.336298051677, 7013.684384202723, 7042.647867606599, 7085.751998680124, 7117.074780278531, 7152.856942861114, 6833.248342682301, 6916.031755554226, 6944.340287672663, 6963.7562685305775, 7063.081799366049, 7023.8244043898285, 7028.437724981989, 7028.753993610199, 7049.154101507852, 7053.365197132282, 5524.558035357162, 5547.11246200606, 5559.444055594408, 5563.13771365439, 5567.192757050205, 4757.904841903142, 4768.427788665383, 4770.427548694179, 4789.712617242976, 4793.544613261734, 6059.484943779828, 6174.783882564088, 6189.226346706661, 6193.071039344044, 6193.256809182927, 7041.5422997505, 7052.471064670171, 7125.608091555015, 7138.643067846587, 7165.534240274365, 5971.880562388728, 6056.364081771439, 6101.176341193971, 6112.17485639433, 6183.876322473615, 6082.148499210114, 6092.573519853568, 6113.6331820090045, 6114.296855861544, 6122.234720659918, 6718.428933540606, 6721.8655626887185, 6751.459883209332, 6769.627670478171, 6771.424428923597, 6995.195552511526, 7003.4397248219, 7005.334493223238, 7114.501984861217, 7115.181754098345, 6656.800295991128, 6666.2333831609985, 6738.35985581369, 6753.1220941277315, 6768.695408706719, 6744.527883048336, 6855.485838562028, 6902.068220790129, 6975.476839237179, 6984.720611175496, 7110.431165506644, 7128.037714908628, 7140.964295178491, 7149.356557909813, 7153.0, 6809.591424514545, 6822.556533825285, 6879.5184337095925, 6881.243063263138, 6894.207166175954, 6559.836004099936, 6803.353681400259, 6818.18181818185, 6914.0, 6918.0, 6583.111279977334, 6589.47284217271, 6604.174478190226, 6607.339266073354, 6632.104665870239, 6705.0, 6778.0, 6836.145481814773, 6872.0, 6982.301769822977, 6349.14286571307, 6447.129637499065, 6488.902666459912, 6601.966990165019, 6741.1236539249585], "value": 6351.973146968962, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [792.7740593930728, 856.5973992223654, 883.019847968755, 883.580299357805, 1127.7011591928135, 29579.704202957964, 31048.223794405123, 40564.594354056484, 40891.38662920051, 41163.58836411635, 41816.79091604538, 42246.366304505456, 42358.788206058925, 42409.15181696364, 42470.787646061726, 7499.250074992512, 7689.50018248812, 7692.499987500794, 7692.7692169235015, 7695.422843286748, 7519.097708274987, 7620.847583048336, 7621.885671714928, 7623.352015078725, 7624.466287359887, 7623.275788800082, 7669.233076692342, 7670.846583068335, 7672.194419585919, 7676.5394076355315, 7599.81000474987, 7604.429667774939, 7608.7336943207, 7631.961840190819, 7632.427567932399, 7538.208488108779, 7601.277878601524, 7601.619919004028, 7602.619869006528, 7637.198094200085, 36505.0, 36529.0, 36567.26865462676, 36639.63360366389, 36677.083072923124, 3537.168765340143, 3589.174489867319, 3591.8024508652015, 3593.6765691087926, 3595.622459641726, 30850.691493085007, 30908.69091309103, 30972.380552388826, 30977.845110774528, 31001.689983100106, 5097.464766199532, 5128.692278463304, 5196.844094677166, 5220.660657057279, 5229.320188375486, 177554.11222943803, 178934.10532947382, 180150.09924950422, 180250.09874950672, 180804.0, 44693.6479764019, 44873.775631121636, 45001.324980125326, 45034.32448513275, 45121.77439112849, 46984.295235571495, 47044.29433558499, 47091.0, 47148.764256178496, 47207.527924721, 14123.505677301246, 15817.604559886095, 16067.919660401623, 16081.43714969994, 16090.195490225442, 11774.823377649342, 13277.66805829862, 13480.797788033187, 13502.662433439242, 13516.526921557896, 13883.37524811386, 13936.651583710489, 14005.859941400658, 14027.719445611236, 14106.153630782186, 5527.39198688144, 5656.802011929645, 5663.150527420919, 5730.541556675539, 5797.0, 1001.7946321004176, 1023.8413045977736, 1024.7489365105596, 1038.200585549123, 1049.6483677967813, 22074.779252207594, 22720.772792272197, 22840.200592979167, 23001.769982299964, 23106.7689323108, 1106.25880659958, 1109.3454861631515, 1128.5316593613722, 1134.0700625487186, 1139.3904261220207, 11879.40602969848, 12251.203671761306, 15982.840171598367, 16246.512604621881, 16629.16854157287, 234458.0, 236478.0, 236577.0, 237360.0, 237919.0, 53692.46307536953, 54466.45533544693, 54527.72736136294, 54860.451395486336, 55039.44960550343, 1439.5681295611275, 1446.5587995661215, 1456.8033315502485, 1457.8760805331453, 1463.3488097796378, 27489.72510274872, 27601.447971040867, 27918.86040569784, 28405.573916391684, 28912.566311505765, 45533.31700024436, 45756.31365529453, 46230.7688461569, 46252.30621540747, 46272.53727462817, 200032.0, 200972.0, 201530.0, 202161.0, 203478.0, 33561.49657755087, 34346.31307373789, 34440.65559344374, 34669.0, 34742.0, 42951.92620184521, 43253.56746432495, 43568.0, 43750.56249437465, 43810.78094609634, 32089.679103209604, 32090.839545802122, 32320.35359292848, 32526.02421927346, 32647.836760816044, 31660.525092123175, 31770.36459270848, 31853.36293274075, 32201.838990804896, 32858.34283314368, 35826.820865895505, 35894.28211435809, 36166.63833361633, 36418.81790591136, 36422.0, 33089.0, 33983.320333592696, 34540.65459345374, 34552.654473454946, 34659.4801077979, 24517.520000399003, 24812.627810582493, 24956.50086998286, 24964.875175624005, 25305.098164182953], "value": 17360.812446074546, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.1134407635935, 565.9830205093843, 569.6126633888955, 574.8993926062938, 579.5769088565347, 21804.236851710193, 22532.211372601963, 22537.774622253815, 22546.54906901861, 22575.54848903025, 23624.291271261845, 24630.137945171922, 25793.48413031738, 25828.612570811452, 25902.09342673007, 6517.8370540736505, 6652.866942661144, 6667.799966001027, 6673.93326066738, 6675.899861502081, 6051.697415129248, 6540.803775886731, 6590.637514936677, 6608.603483790964, 6620.172478440195, 6335.588186767845, 6576.835579110537, 6590.967045164767, 6591.209054913417, 6597.835054123638, 6575.145231119947, 6580.473562115068, 6582.605043697394, 6582.93417065828, 6585.012248162766, 6116.052011938156, 6118.632882027093, 6120.632762034248, 6122.969385153046, 6128.0, 28368.71631283702, 29203.415931681247, 29669.0, 29761.404771904658, 29862.552061719092, 1996.7703714072777, 2038.1236068490543, 2038.5820906714089, 2040.3368905105751, 2040.4694779357326, 19363.322283720143, 19774.3078992236, 19776.110075046658, 19898.20407183711, 19931.601367972704, 2457.69278840145, 2463.7782599566126, 2515.308290220186, 2525.671662683858, 2527.330257481769, 135981.3200933989, 137641.3117934404, 137823.31088344596, 137912.620873791, 138190.3090484541, 14352.856471435152, 14818.184999825113, 14978.47575334858, 15016.0, 15294.694106117815, 22202.66695999561, 22966.0, 23002.53994920126, 23540.64689029666, 23561.0, 9839.0, 9914.652987145559, 10070.8489372658, 10128.848067278997, 10298.17614590831, 9383.812323753487, 9451.527423628791, 9482.241420686329, 9518.476483793458, 9600.0, 9067.0, 9097.226735727538, 9116.361854670242, 9122.452652840851, 9328.860067098998, 2575.2702135735803, 2633.723459036812, 2651.138380026499, 2681.0508440715057, 2711.4577084582766, 967.1489089601247, 983.8783786483415, 991.7867658453467, 993.9453330066916, 1011.3022014809904, 19380.868104508492, 19435.0, 19706.211751530063, 20284.087216075313, 20320.491987700425, 1049.1082579807255, 1053.5311786255043, 1061.554147258138, 1063.2822844579878, 1074.537948682074, 11142.944285278521, 13216.339183040809, 14039.649008774863, 14132.364043618061, 14293.64265893361, 507063.0, 511089.0, 511647.0, 512384.0, 532334.0, 121784.0, 123398.38300808439, 124088.37955810163, 124405.37797310956, 126212.0, 1229.3853073463267, 1270.4283072617175, 1280.0719478378287, 1286.2861112082883, 1286.8327117474669, 21360.14559417668, 21687.891560542095, 21809.0, 21855.453613659785, 21878.0, 49987.25019124789, 52049.0, 53069.469305306455, 61956.38043619506, 62167.0, 67273.3272667267, 69002.0, 69261.30738692549, 69603.0, 70274.64862675859, 14696.265186740835, 15054.645081942239, 15057.17185554805, 15076.698466030399, 15141.242937853283, 22736.317910462712, 23731.644025339978, 23802.40493987664, 23814.285571432883, 23874.641880372157, 17685.204165812313, 17807.109644517983, 17972.281108756026, 18014.2794288227, 18019.2792288307, 15887.205639718199, 15974.520764377086, 16948.40680576174, 16979.066151361792, 17285.0, 18061.638767224846, 18281.725774113133, 18324.633507329512, 18340.0, 18406.35577754826, 14075.718485630436, 14351.425942962165, 14353.138811671333, 14376.856231437552, 14390.568282951528, 18126.093695315445, 18141.183646736194, 18141.365052223107, 18188.90905545464, 18198.181081851613], "value": 12150.643256980382, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1361.1832900259844, 1446.5226475263164, 1450.0791997081853, 1453.5784622459494, 1454.3237394611504, 14910.701785964287, 14939.17834519101, 15459.613509662264, 15540.06759594425, 15549.378024878992, 15649.765253521206, 15984.920075399607, 16012.359505619761, 16035.759463608027, 16037.316081811417, 2839.616651752013, 2897.3915477749697, 2899.4201159768027, 2901.3907079513224, 2902.8548572571285, 2715.4026114254834, 2880.927976800576, 2886.538153895377, 2893.956590651142, 2894.652641683001, 2799.0343331550584, 2818.8308701477877, 2819.3374556979093, 2823.3929705113396, 2854.158023383107, 2798.916032519028, 2802.4395120975887, 2816.690164081949, 2820.8025438219433, 2823.6470441194647, 2651.9204423867313, 2727.5226835303943, 2742.3829638331417, 2742.4103817679097, 2750.683671377797, 14948.103113813206, 15286.847131528653, 15297.770533442008, 15303.770443443358, 15314.617134571614, 8012.158723334024, 8260.669573217065, 8266.380021498351, 8267.421280510367, 8278.461899976483, 5337.332833395825, 5557.972210138923, 5598.272224610774, 5646.322441307028, 5734.082546792493, 1945.4649971257875, 1946.4355336952267, 1947.6299503094508, 1960.1571324330532, 1983.3851506033031, 26457.0, 27096.45807083847, 27098.322541936413, 27118.45763084747, 27212.59181112285, 7142.857142857114, 7265.673044712895, 7303.196648368676, 7353.742619008309, 7525.510841795375, 20760.377188684364, 20777.68833467469, 20794.688079678817, 20866.895665521577, 20905.477363066046, 7743.9612801936755, 8356.582170891432, 8369.163083691705, 8369.3304535637, 8379.664813407395, 7393.29763672461, 7428.33145016951, 7483.438742094365, 7511.211322811136, 7512.47412681118, 5668.121441176624, 5801.6519008859605, 5838.474537291664, 5876.676782776903, 5884.6469211847425, 1565.1000674612144, 1615.4103752130388, 1618.166644178249, 1792.8834625749284, 1868.3274021352302, 893.687209476691, 910.1808372464702, 926.4950601921969, 928.1090153452626, 935.2704890185666, 8174.0, 8334.291585215324, 8343.290820280345, 8452.366072544584, 8472.74581762548, 976.7558110472382, 992.538469611634, 994.110271307176, 997.4464172384396, 1005.6128390569537, 4824.179889418807, 4912.263160525878, 4956.083124621884, 4974.850754477371, 5021.121303771825, 21210.575788484144, 21628.45928851791, 21834.454138646663, 21933.122675092818, 21971.890140549196, 20632.277870274767, 21374.251901183696, 22061.779382206292, 22239.221627243292, 22260.0, 10628.627998020032, 10750.139988800876, 10759.623413180658, 10761.139108871272, 10913.56345746177, 8099.83800324002, 8298.751037468886, 8581.0, 8709.477431354138, 8716.607752651273, 18247.726284105484, 18268.634627307645, 18277.26890924348, 18313.0, 18773.34293299728, 19027.52431189176, 19148.617027659646, 19165.904170479058, 19238.903805480884, 19309.710354344414, 11242.943785281348, 11442.427878606202, 11457.369844658624, 11462.140339474407, 11467.369294688871, 13516.594502164951, 13846.10000349974, 13863.930680346937, 13930.512432064828, 13942.0, 9652.75868103303, 9731.17285030752, 9790.118889299998, 10767.246292759432, 11147.83278250843, 10186.949065254923, 10246.53890574911, 10294.742631434274, 10356.948215259177, 10586.89413105859, 9022.864657030019, 9188.448693078437, 9190.0, 9205.30960177976, 9237.58430870599, 6607.80176594703, 6850.349216824394, 6871.896921546081, 7233.565986040854, 7305.963470182615, 7263.673134709056, 7297.343239108506, 7333.853322933618, 7344.155422126524, 7385.5937923412575], "value": 6802.288951146304, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [494.80207916833285, 497.9775910084047, 534.8743045384334, 538.3324677400025, 540.5081375947889, 6343.333949935254, 6394.424501794838, 6417.711202995864, 6430.710618022188, 6441.774537891175, 6069.1199776032445, 6184.165137706408, 6260.968695156518, 6276.246850377961, 6307.936920630792, 5088.54203121719, 5089.160288552384, 5089.236614507835, 5117.232415137741, 5122.436531981479, 5073.264376665381, 5096.285935509639, 5099.184130539114, 5102.438731739506, 5115.360579927509, 4901.8039278429, 5059.949400505985, 5065.138926382524, 5073.391193056838, 5079.23811428285, 4929.186684197103, 4959.2809042688605, 5013.448520662724, 5034.974825125888, 5060.5951523878, 4457.576530229623, 4525.841595544141, 4534.38785763921, 4547.226971414867, 4550.180967425862, 6198.411150940653, 6226.533010024266, 6230.127782110508, 6230.158928544633, 6231.3145553989025, 5693.28833895763, 5716.428357164292, 5839.620424672383, 5841.240638716982, 5843.824685259449, 6580.21037475506, 6600.966995165041, 6616.437602803768, 6621.172353455818, 6627.713438863584, 4875.414950205963, 4878.365812444395, 4917.188663870493, 4937.654364194508, 4946.826861059882, 6898.724051037952, 7038.59228154361, 7078.327558881898, 7094.53885497441, 7111.324424179695, 5032.84901452957, 5059.772310246048, 5063.468335824759, 5096.490350964948, 5125.641205115606, 5057.7724002419245, 5074.543291103819, 5096.923546146811, 5100.923486147711, 5115.488451154929, 5756.884862302731, 5796.1305804129715, 5812.099124635688, 5815.5929084963645, 5851.122331650201, 6638.5684930479365, 6655.833604159935, 6664.566803157779, 6675.696884574814, 6745.392914637608, 1672.6989141954566, 1684.553593297777, 1717.7938647362396, 1756.4906177208723, 1783.4114742135064, 1207.8550573931184, 1230.809224570193, 1241.509603706549, 1241.7330273991136, 1261.779188641984, 5922.022866227025, 5925.288965324189, 5961.433663801932, 5978.282606087298, 5984.820455386345, 6528.37980391862, 6757.054012438262, 6763.637453842244, 6788.015737718102, 6847.417969472551, 5869.765209391662, 5906.464319277019, 5927.2590926134235, 5956.970215148896, 5987.491063259672, 3543.645635436436, 3554.804485753257, 3588.6770190682964, 3609.7473176877893, 3640.2719456108885, 6420.807375778734, 6422.454091402283, 6470.676466176672, 6531.8367040823405, 6562.442192413699, 6912.723491060402, 6965.895511567331, 6981.2669669684965, 7060.964695176492, 7071.222165561784, 6422.6467544285515, 6464.030395440722, 6479.157709497829, 6522.184726909137, 6530.412262896267, 6713.765018224339, 6775.966120169368, 6848.452123829982, 6895.9314903544855, 6899.275576064641, 6709.322669332471, 6755.290694477206, 6760.7800823243715, 6807.625580593115, 6830.31696830313, 6403.807885763435, 6462.289148193789, 6464.644444555594, 6477.255115661571, 6562.77030303937, 4961.82633607822, 4984.950150498448, 5009.674371165863, 5014.27007682349, 5043.798248070036, 6835.829104272433, 6887.20797108339, 6890.2420733718245, 6890.276520965226, 6927.376536111774, 6558.868822623425, 6616.470682345497, 6638.83402914931, 6638.83402914931, 6684.498662600422, 6453.806385808433, 6457.225132984072, 6565.606063636197, 6645.235797883112, 6663.900041499284, 6323.494120470259, 6328.589056356933, 6463.353664633499, 6481.805545833632, 6578.967105164635, 6565.770198043046, 6570.737170513126, 6640.966795165993, 6670.866582668416, 6719.899201512079, 6308.52686048539, 6365.96817015912, 6439.839004024937, 6451.1936007999, 6496.382843629847], "value": 5116.4337770314105, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [898.3531857062912, 912.9680461183858, 926.6247169896191, 931.2829121576386, 933.0343094896783, 15793.052416854996, 16211.675766484677, 16230.269637866295, 16251.0, 17519.562010949732, 18014.369497067604, 18093.366732164377, 18099.90950045248, 18109.7283540747, 18125.0, 973.1096047116897, 995.4027583449908, 996.4967691315875, 997.1175509673955, 1000.0499525450814, 900.4912224593083, 981.9901800982005, 986.1765425869407, 986.4377304936189, 990.3711143423942, 1014.614446510325, 1023.5803320638539, 1024.262530977695, 1024.9897501024968, 1025.1440047560259, 1022.4580972084807, 1031.2523420520138, 1031.2729525684374, 1031.3554028732042, 1031.5925209542227, 757.6060448566715, 763.5723994563062, 764.9847003059907, 765.3762183820169, 766.1610536462565, 16888.40890568824, 17239.913800430917, 17692.734608980874, 17737.55656108595, 17761.46715598534, 20967.685484717742, 21111.8944405277, 21412.0, 21486.785132148634, 21702.13191472339, 16614.335426582922, 17097.829021709873, 17134.914325428417, 17201.311947522085, 17341.306347746075, 3675.2098298865603, 3715.4241092630414, 3716.2939041582013, 3718.7396882218254, 3719.851205951759, 119176.0, 121464.99999999911, 123216.38391808073, 123997.38001310026, 125474.0, 15903.52289431319, 16814.91592542054, 17137.485875423758, 17240.482785516455, 17256.396026139024, 29762.25594360115, 29885.252868678457, 30140.0, 30186.0, 30218.395632087235, 8729.214370706666, 8813.515256660945, 8839.558022098998, 8841.867371989425, 8876.20114189726, 3879.922401551953, 3989.162275922031, 3994.021464741099, 3998.6801055915457, 4042.8989275267763, 4341.370501277297, 5227.424983251915, 5892.646441213541, 5906.793262235801, 5927.199828023248, 1115.3530952047793, 1132.4394424759796, 1145.0953746540306, 1153.8846115388562, 1154.1055681846635, 673.4343151752552, 685.8251145957748, 695.422799076765, 699.755085719994, 701.3512500936613, 11295.209335346612, 11586.073114150848, 11635.88364116365, 11671.0, 12600.0, 693.3794254142514, 699.1260923845193, 705.1291654806311, 707.1478867964091, 718.8059224009488, 5440.537554307849, 5514.889702205934, 5545.334559852843, 5603.635763675348, 5675.744591493392, 109562.45218773856, 109651.45174274077, 110333.44833275782, 113602.0, 115961.0, 87865.5606721975, 88973.0, 89363.65954510687, 89459.0, 91987.54006229926, 81571.5921420401, 83471.58264208761, 83585.58207208925, 86263.56868215618, 86582.56708716541, 11686.357250351311, 11885.28688278706, 12066.879331206575, 12187.085968552217, 12369.319687417279, 39155.804220978716, 39578.0, 39641.0, 40116.59883401245, 40305.79847100863, 64795.0, 66955.66522167358, 67535.0, 69597.65201173961, 74190.62904685442, 18236.908815455838, 18523.35168269104, 18663.0, 18667.0, 18793.812061879205, 20121.496962576053, 20821.479463013548, 20861.269855554983, 20894.1642334311, 20937.26719564808, 17509.912450437667, 18079.548011299295, 18113.094345282945, 18189.636207276046, 18224.45326640203, 17635.647287054442, 18364.908175459037, 18385.448436546925, 18462.907685462025, 18542.165602547648, 16722.247498862336, 16897.0, 17170.914145429193, 17288.827111728722, 17383.652326953135, 12995.155314904501, 13172.407241673956, 13256.867431325949, 13542.796858047333, 13748.862511375159, 13695.86304136946, 14060.437582496994, 14129.434822606981, 14178.361973711002, 14609.196494192922], "value": 9022.143968135802, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1485.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 107.0, 101.0, 106.0, 106.0, 118.0, 116.0, 100.0, 110.0, 108.0], "value": 107.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 122.0, 146.0, 173.0, 118.0, 143.0, 142.0, 128.0, 172.0, 122.0], "value": 141.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 165.0, 162.0, 162.0, 161.0, 163.0, 170.0, 162.0, 162.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 161.0, 76.0, 73.0, 74.0, 91.0, 103.0, 74.0], "value": 87.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 129.0, 81.0, 80.0, 78.0, 123.0, 79.0, 79.0, 138.0], "value": 94.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 121.0, 114.0, 114.0, 115.0, 113.0, 114.0, 116.0, 114.0], "value": 114.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 148.0, 147.0, 149.0, 149.0, 148.0, 149.0, 148.0, 147.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 54.0, 53.0, 52.0, 53.0, 53.0, 52.0, 53.0, 51.0, 51.0], "value": 52.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 39.0, 39.0, 39.0, 39.0, 39.0, 38.0, 40.0, 39.0, 39.0], "value": 39.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 73.0, 75.0, 75.0, 75.0, 74.0, 75.0, 75.0, 75.0], "value": 75.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 121.0, 132.0, 129.0, 133.0, 123.0, 125.0, 127.0, 119.0, 162.0], "value": 129.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 171.0, 173.0, 173.0, 177.0, 172.0, 172.0, 182.0, 176.0, 170.0], "value": 173.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 66.0, 64.0, 71.0, 64.0, 65.0, 66.0, 63.0, 63.0], "value": 65.8, "unit": "score"}]}]} 02:55:06 INFO - Return code: 0 02:55:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:55:06 INFO - # TBPL SUCCESS # 02:55:06 INFO - Running post-action listener: _package_coverage_data 02:55:06 INFO - Running post-action listener: _resource_record_post_action 02:55:06 INFO - [mozharness: 2017-08-30 09:55:06.111468Z] Finished run-tests step (success) 02:55:06 INFO - Running post-run listener: _resource_record_post_run 02:55:06 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 8192; Write bytes: 388808704; Read time: 328; Write time: 380440 02:55:06 INFO - TinderboxPrint: CPU usage
13.1% 02:55:06 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 328 02:55:06 INFO - TinderboxPrint: I/O write bytes / time
388,808,704 / 380,440 02:55:06 INFO - TinderboxPrint: CPU idle
8,248.2 (86.8%) 02:55:06 INFO - TinderboxPrint: CPU user
1,193.8 (12.6%) 02:55:06 INFO - TinderboxPrint: Swap in / out
0 / 0 02:55:06 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 106135552; Read time: 0; Write time: 133208 02:55:06 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 02:55:06 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 8192; Write bytes: 282673152; Read time: 328; Write time: 247232 02:55:06 INFO - Running post-run listener: _upload_blobber_files 02:55:06 INFO - Blob upload gear active. 02:55:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:55:06 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 02:55:06 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'] 02:55:06 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 02:55:07 INFO - (blobuploader) - INFO - Open directory for files ... 02:55:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:55:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:55:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:55:08 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:55:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:55:08 INFO - (blobuploader) - INFO - Done attempting. 02:55:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:55:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:55:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:55:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:55:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:55:09 INFO - (blobuploader) - INFO - Done attempting. 02:55:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:55:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:55:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:55:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:55:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:55:16 INFO - (blobuploader) - INFO - Done attempting. 02:55:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:55:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:55:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:55:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:55:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:55:18 INFO - (blobuploader) - INFO - Done attempting. 02:55:18 INFO - (blobuploader) - INFO - Iteration through files over. 02:55:18 INFO - Return code: 0 02:55:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:55:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:55:18 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03c93c11faecda1f122bf8404faeb60eaa1818adc7af11112a9f819ed7f8125aa86e52dbd7e413f42bfe85dfa06188c50428860a11d8c43f2232ab6f17bbfa04", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/67f949f4dd73e1df7e0a5743bbd3b923da034bc718cdb0663d1ff284f866f2adf5894a8d141647c09de050e4514ed69ad6169be4f234321fe915849e7e0b29c1", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35261ef0a067ebb7e80d6bd33313a092f1a9f73aaf30eb9084a8c160f8a09b1e68fd71ecfd7f97ee0a79d9c583c263be69f158f603a456f80a9e08c330d00989", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac5ff1e37054ebfd81b6bc26160ccaf858fda6fac9906886c580f7b41304cc223ca8ae163be5b41abd1980c4c2f81b04ccfb5221380acbcf64c8ab1e12ce8907"} 02:55:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:55:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:55:18 INFO - Contents: 02:55:18 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03c93c11faecda1f122bf8404faeb60eaa1818adc7af11112a9f819ed7f8125aa86e52dbd7e413f42bfe85dfa06188c50428860a11d8c43f2232ab6f17bbfa04", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/67f949f4dd73e1df7e0a5743bbd3b923da034bc718cdb0663d1ff284f866f2adf5894a8d141647c09de050e4514ed69ad6169be4f234321fe915849e7e0b29c1", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35261ef0a067ebb7e80d6bd33313a092f1a9f73aaf30eb9084a8c160f8a09b1e68fd71ecfd7f97ee0a79d9c583c263be69f158f603a456f80a9e08c330d00989", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac5ff1e37054ebfd81b6bc26160ccaf858fda6fac9906886c580f7b41304cc223ca8ae163be5b41abd1980c4c2f81b04ccfb5221380acbcf64c8ab1e12ce8907"} 02:55:18 INFO - Running post-run listener: copy_logs_to_upload_dir 02:55:18 INFO - Copying logs to upload dir... 02:55:18 INFO - mkdir: /builds/slave/test/build/upload/logs 02:55:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.690659 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-08-30 02:55:18.118472) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-30 02:55:18.122190) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1504084557.548086-1771277551 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/03c93c11faecda1f122bf8404faeb60eaa1818adc7af11112a9f819ed7f8125aa86e52dbd7e413f42bfe85dfa06188c50428860a11d8c43f2232ab6f17bbfa04", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/67f949f4dd73e1df7e0a5743bbd3b923da034bc718cdb0663d1ff284f866f2adf5894a8d141647c09de050e4514ed69ad6169be4f234321fe915849e7e0b29c1", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35261ef0a067ebb7e80d6bd33313a092f1a9f73aaf30eb9084a8c160f8a09b1e68fd71ecfd7f97ee0a79d9c583c263be69f158f603a456f80a9e08c330d00989", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac5ff1e37054ebfd81b6bc26160ccaf858fda6fac9906886c580f7b41304cc223ca8ae163be5b41abd1980c4c2f81b04ccfb5221380acbcf64c8ab1e12ce8907"} build_url:https://queue.taskcluster.net/v1/task/J0iXTyotRpC2k_2r2yxREQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011268 build_url: 'https://queue.taskcluster.net/v1/task/J0iXTyotRpC2k_2r2yxREQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03c93c11faecda1f122bf8404faeb60eaa1818adc7af11112a9f819ed7f8125aa86e52dbd7e413f42bfe85dfa06188c50428860a11d8c43f2232ab6f17bbfa04", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/67f949f4dd73e1df7e0a5743bbd3b923da034bc718cdb0663d1ff284f866f2adf5894a8d141647c09de050e4514ed69ad6169be4f234321fe915849e7e0b29c1", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35261ef0a067ebb7e80d6bd33313a092f1a9f73aaf30eb9084a8c160f8a09b1e68fd71ecfd7f97ee0a79d9c583c263be69f158f603a456f80a9e08c330d00989", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac5ff1e37054ebfd81b6bc26160ccaf858fda6fac9906886c580f7b41304cc223ca8ae163be5b41abd1980c4c2f81b04ccfb5221380acbcf64c8ab1e12ce8907"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-30 02:55:18.149402) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 02:55:18.149793) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1504084557.548086-1771277551 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 02:55:18.234812) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-30 02:55:18.235267) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-30 02:55:18.235747) ========= ========= Total master_lag: 0.19 =========