builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-065 starttime: 1504863497.13 results: success (0) revision: dd75dcec7da162d8ceaaf0883e0e7561bd772992 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-08 02:38:17.133874) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-08 02:38:17.134370) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-08 02:38:17.134982) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-08 02:38:17.190537) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 02:38:17.193852) ========= 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=523ca41ca1e0623de333ad52000001bf-1504861648.512952-963811676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-08 02:38:17-- 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% 41.9M=0s 2017-09-08 02:38:17 (41.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.132135 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 02:38:17.366825) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 02:38:17.367142) ========= 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=523ca41ca1e0623de333ad52000001bf-1504861648.512952-963811676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018354 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 02:38:17.429967) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 12 secs) (at 2017-09-08 02:38:17.430352) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev dd75dcec7da162d8ceaaf0883e0e7561bd772992 --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 dd75dcec7da162d8ceaaf0883e0e7561bd772992 --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=523ca41ca1e0623de333ad52000001bf-1504861648.512952-963811676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-08 02:38:17,688 truncating revision to first 12 chars 2017-09-08 02:38:17,688 Setting DEBUG logging. 2017-09-08 02:38:17,688 attempt 1/10 2017-09-08 02:38:17,688 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/dd75dcec7da1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-08 02:38:18,245 attempt 1/10 2017-09-08 02:38:18,898 current task status: no status available at this point. state: STARTED 2017-09-08 02:38:18,898 sleeping for 10.00s (attempt 1/10) 2017-09-08 02:38:28,908 attempt 2/10 2017-09-08 02:38:29,446 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-09-08 02:38:29,622 unpacking tar archive at: mozilla-central-dd75dcec7da1/testing/mozharness/ program finished with exit code 0 elapsedTime=12.362466 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 12 secs) (at 2017-09-08 02:38:29.812212) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-08 02:38:29.812653) ========= script_repo_revision: dd75dcec7da162d8ceaaf0883e0e7561bd772992 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-08 02:38:29.813139) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-08 02:38:29.813467) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-08 02:38:29.827109) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-09-08 02:38:29.827547) ========= /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=523ca41ca1e0623de333ad52000001bf-1504861648.512952-963811676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:38:30 INFO - MultiFileLogger online at 20170908 02:38:30 in /builds/slave/test 02:38:30 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:38:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:38:30 INFO - {'append_to_log': False, 02:38:30 INFO - 'base_work_dir': '/builds/slave/test', 02:38:30 INFO - 'blob_upload_branch': 'Firefox', 02:38:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:38:30 INFO - 'branch': 'Firefox', 02:38:30 INFO - 'buildbot_json_path': 'buildprops.json', 02:38:30 INFO - 'code_coverage': False, 02:38:30 INFO - 'config_files': ('talos/linux_config.py',), 02:38:30 INFO - 'default_actions': ('clobber', 02:38:30 INFO - 'read-buildbot-config', 02:38:30 INFO - 'download-and-extract', 02:38:30 INFO - 'populate-webroot', 02:38:30 INFO - 'create-virtualenv', 02:38:30 INFO - 'install', 02:38:30 INFO - 'setup-mitmproxy', 02:38:30 INFO - 'run-tests'), 02:38:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:38:30 INFO - 'disable_ccov_upload': False, 02:38:30 INFO - 'disable_stylo': False, 02:38:30 INFO - 'download_minidump_stackwalk': True, 02:38:30 INFO - 'download_symbols': 'ondemand', 02:38:30 INFO - 'enable_stylo': False, 02:38:30 INFO - 'enable_webrender': False, 02:38:30 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 02:38:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:38:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:38:30 INFO - 'gecko_profile': False, 02:38:30 INFO - 'gecko_profile_interval': 0, 02:38:30 INFO - 'installer_path': 'installer.exe', 02:38:30 INFO - 'log_level': 'info', 02:38:30 INFO - 'log_name': 'talos', 02:38:30 INFO - 'log_to_console': True, 02:38:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:38:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:38:30 INFO - 'opt_config_files': (), 02:38:30 INFO - 'pip_index': False, 02:38:30 INFO - 'suite': 'dromaeojs-e10s', 02:38:30 INFO - 'system_bits': '32', 02:38:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:38:30 INFO - 'title': 'talos-linux64-ix-065', 02:38:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:38:30 INFO - 'use_talos_json': True, 02:38:30 INFO - 'verify': 'False', 02:38:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:38:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:38:30 INFO - 'work_dir': 'build'} 02:38:30 INFO - [mozharness: 2017-09-08 09:38:30.228685Z] Running clobber step. 02:38:30 INFO - Running pre-action listener: _resource_record_pre_action 02:38:30 INFO - Running main action method: clobber 02:38:30 INFO - rmtree: /builds/slave/test/build 02:38:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:38:31 INFO - Running post-action listener: _resource_record_post_action 02:38:31 INFO - [mozharness: 2017-09-08 09:38:31.763461Z] Finished clobber step (success) 02:38:31 INFO - [mozharness: 2017-09-08 09:38:31.763559Z] Running read-buildbot-config step. 02:38:31 INFO - Running pre-action listener: _resource_record_pre_action 02:38:31 INFO - Running main action method: read_buildbot_config 02:38:31 INFO - Using buildbot properties: 02:38:31 INFO - { 02:38:31 INFO - "project": "", 02:38:31 INFO - "product": "firefox", 02:38:31 INFO - "who": "archaeopteryx@coole-files.de", 02:38:31 INFO - "installer_path": "public/build/target.tar.bz2", 02:38:31 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 02:38:31 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 02:38:31 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 02:38:31 INFO - "stage_platform": "linux64-stylosequential", 02:38:31 INFO - "basedir": "/builds/slave/test", 02:38:31 INFO - "buildnumber": 65, 02:38:31 INFO - "platform": "ubuntu64_hw_styloseq", 02:38:31 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:38:31 INFO - "slavebuilddir": "test", 02:38:31 INFO - "taskId": "W9Atd_4yTkav1XUNJSCz1A", 02:38:31 INFO - "branch": "mozilla-central", 02:38:31 INFO - "script_repo_revision": "production", 02:38:31 INFO - "revision": "dd75dcec7da162d8ceaaf0883e0e7561bd772992", 02:38:31 INFO - "slavename": "talos-linux64-ix-065", 02:38:31 INFO - "repo_path": "mozilla-central" 02:38:31 INFO - } 02:38:31 INFO - Finding installer, test and symbols from parent task. 02:38:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W9Atd_4yTkav1XUNJSCz1A'}, attempt #1 02:38:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W9Atd_4yTkav1XUNJSCz1A'}, attempt #1 02:38:32 INFO - Task dependencies: bhya0MgVT7S5tIHCfYUKiw 02:38:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw'}, attempt #1 02:38:33 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.tar.bz2 02:38:33 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.test_packages.json 02:38:33 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.crashreporter-symbols.zip 02:38:33 INFO - Running post-action listener: _resource_record_post_action 02:38:33 INFO - [mozharness: 2017-09-08 09:38:33.074781Z] Finished read-buildbot-config step (success) 02:38:33 INFO - [mozharness: 2017-09-08 09:38:33.074996Z] Running download-and-extract step. 02:38:33 INFO - Running pre-action listener: _resource_record_pre_action 02:38:33 INFO - Running main action method: download_and_extract 02:38:33 INFO - mkdir: /builds/slave/test/build/tests 02:38:33 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:38:33 INFO - trying https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.test_packages.json 02:38:33 INFO - Downloading https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:38:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:38:33 INFO - Downloaded 989 bytes. 02:38:33 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:38:33 INFO - Using the following test package requirements: 02:38:33 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:38:33 INFO - u'common': [u'target.common.tests.zip'], 02:38:33 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:38:33 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:38:33 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:38:33 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:38:33 INFO - u'mozbase': [u'target.common.tests.zip'], 02:38:33 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:38:33 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:38:33 INFO - u'web-platform': [u'target.common.tests.zip', 02:38:33 INFO - u'target.web-platform.tests.tar.gz'], 02:38:33 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:38:33 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:38:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.common.tests.zip 02:38:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:38:33 INFO - Fetch https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.common.tests.zip into memory 02:38:34 INFO - Content-Length response header: 55023700 02:38:34 INFO - Bytes received: 55023700 02:38:45 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:38:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.common.tests.zip 02:38:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:38:45 INFO - Fetch https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.common.tests.zip into memory 02:38:46 INFO - Content-Length response header: 55023700 02:38:46 INFO - Bytes received: 55023700 02:38:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.talos.tests.zip 02:38:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:38:58 INFO - Fetch https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.talos.tests.zip into memory 02:38:59 INFO - Content-Length response header: 14496665 02:38:59 INFO - Bytes received: 14496665 02:38:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:59 INFO - trying https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.tar.bz2 02:38:59 INFO - Downloading https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:38:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:39:00 INFO - Downloaded 62722712 bytes. 02:39:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.tar.bz2 02:39:00 INFO - mkdir: /builds/slave/test/properties 02:39:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:39:00 INFO - Writing to file /builds/slave/test/properties/build_url 02:39:00 INFO - Contents: 02:39:00 INFO - build_url:https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.tar.bz2 02:39:00 INFO - Running post-action listener: _resource_record_post_action 02:39:00 INFO - Running post-action listener: find_tests_for_verification 02:39:00 INFO - Running post-action listener: set_extra_try_arguments 02:39:00 INFO - [mozharness: 2017-09-08 09:39:00.841738Z] Finished download-and-extract step (success) 02:39:00 INFO - [mozharness: 2017-09-08 09:39:00.841838Z] Running populate-webroot step. 02:39:00 INFO - Running pre-action listener: _resource_record_pre_action 02:39:00 INFO - Running main action method: populate_webroot 02:39:00 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:39:00 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:39:00 INFO - 'tests': ['tresize', 02:39:00 INFO - 'tcanvasmark']}, 02:39:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:39:00 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:39:00 INFO - 'tests': ['dromaeo_css', 02:39:00 INFO - 'kraken']}, 02:39:00 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:39:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:39:00 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:39:00 INFO - 'talos_options': ['--disable-stylo'], 02:39:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:39:00 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:39:00 INFO - 'tests': ['damp', 'tps']}, 02:39:00 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:39:00 INFO - 'talos_options': ['--disable-stylo'], 02:39:00 INFO - 'tests': ['damp', 'tps']}, 02:39:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:39:00 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:39:00 INFO - 'tests': ['dromaeo_dom']}, 02:39:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:39:00 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:39:00 INFO - 'tests': ['basic_compositor_video', 02:39:00 INFO - 'glvideo']}, 02:39:00 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:39:00 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:39:00 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:39:00 INFO - 'talos_options': ['--disable-stylo'], 02:39:00 INFO - 'tests': ['ts_paint_webext', 02:39:00 INFO - 'tp5o_webext']}, 02:39:00 INFO - 'other-e10s': {'tests': ['a11yr', 02:39:00 INFO - 'ts_paint', 02:39:00 INFO - 'tpaint', 02:39:00 INFO - 'sessionrestore', 02:39:00 INFO - 'sessionrestore_many_windows', 02:39:00 INFO - 'sessionrestore_no_auto_restore', 02:39:00 INFO - 'tabpaint']}, 02:39:00 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:39:00 INFO - 'tests': ['a11yr', 02:39:00 INFO - 'ts_paint', 02:39:00 INFO - 'tpaint', 02:39:00 INFO - 'sessionrestore', 02:39:00 INFO - 'sessionrestore_many_windows', 02:39:00 INFO - 'sessionrestore_no_auto_restore', 02:39:00 INFO - 'tabpaint']}, 02:39:00 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 02:39:00 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 02:39:00 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:39:00 INFO - 'tests': ['bloom_basic_singleton']}, 02:39:00 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:39:00 INFO - 'tests': ['bloom_basic']}, 02:39:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:39:00 INFO - 'tsvgr_opacity', 02:39:00 INFO - 'tart', 02:39:00 INFO - 'tscrollx', 02:39:00 INFO - 'tsvg_static']}, 02:39:00 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:39:00 INFO - 'tests': ['tsvgx', 02:39:00 INFO - 'tsvgr_opacity', 02:39:00 INFO - 'tart', 02:39:00 INFO - 'tscrollx', 02:39:00 INFO - 'tsvg_static']}, 02:39:00 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:39:00 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:39:00 INFO - 'talos_options': ['--disable-stylo'], 02:39:00 INFO - 'tests': ['tp5o']}, 02:39:00 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:39:00 INFO - 'talos_options': ['--mitmproxy', 02:39:00 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:39:00 INFO - '--firstNonBlankPaint'], 02:39:00 INFO - 'tests': ['tp6_google', 02:39:00 INFO - 'tp6_youtube', 02:39:00 INFO - 'tp6_amazon', 02:39:00 INFO - 'tp6_facebook']}, 02:39:00 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:39:00 INFO - 'talos_options': ['--disable-stylo', 02:39:00 INFO - '--mitmproxy', 02:39:00 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:39:00 INFO - '--firstNonBlankPaint'], 02:39:00 INFO - 'tests': ['tp6_google', 02:39:00 INFO - 'tp6_youtube', 02:39:00 INFO - 'tp6_amazon', 02:39:00 INFO - 'tp6_facebook']}, 02:39:00 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:39:00 INFO - 'talos_options': ['--stylo-threads=1', 02:39:00 INFO - '--mitmproxy', 02:39:00 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:39:00 INFO - '--firstNonBlankPaint'], 02:39:00 INFO - 'tests': ['tp6_google', 02:39:00 INFO - 'tp6_youtube', 02:39:00 INFO - 'tp6_amazon', 02:39:00 INFO - 'tp6_facebook']}, 02:39:00 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:39:00 INFO - 'talos_options': ['--xperf_path', 02:39:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:39:00 INFO - 'tests': ['tp5n']}, 02:39:00 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:39:00 INFO - 'talos_options': ['--disable-stylo', 02:39:00 INFO - '--xperf_path', 02:39:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:39:00 INFO - 'tests': ['tp5n']}}} 02:39:00 INFO - Running post-action listener: _resource_record_post_action 02:39:00 INFO - [mozharness: 2017-09-08 09:39:00.856693Z] Finished populate-webroot step (success) 02:39:00 INFO - [mozharness: 2017-09-08 09:39:00.856782Z] Running create-virtualenv step. 02:39:00 INFO - Running pre-action listener: _resource_record_pre_action 02:39:00 INFO - Running main action method: create_virtualenv 02:39:00 INFO - Creating virtualenv /builds/slave/test/build/venv 02:39:00 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:39:00 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 02:39:00 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:39:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:39:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:39:01 INFO - Installing distribute.............................................................................................................................................................................................done. 02:39:01 INFO - Installing pip...............done. 02:39:01 INFO - Return code: 0 02:39:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:39:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:39:01 INFO - Reading from file tmpfile_stdout 02:39:01 INFO - Output received: 02:39:01 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:39:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:39: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:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39: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:39:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b5090>, '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 0x27b5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27aff90>, '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': '523ca41ca1e0623de333ad52000001bf-1504861648.512952-963811676', '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:39: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', 'pip>=1.5'] in /builds/slave/test/build 02:39: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 pip>=1.5 02:39:01 INFO - Using env: {'DISPLAY': ':0', 02:39:01 INFO - 'HOME': '/home/cltbld', 02:39:01 INFO - 'LANG': 'en_US.UTF-8', 02:39:01 INFO - 'LANGUAGE': 'en_US:en', 02:39:01 INFO - 'LOGNAME': 'cltbld', 02:39:01 INFO - 'MAIL': '/var/mail/cltbld', 02:39:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:01 INFO - 'MOZ_NO_REMOTE': '1', 02:39:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:01 INFO - 'NO_EM_RESTART': '1', 02:39:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:01 INFO - 'PWD': '/builds/slave/test', 02:39:01 INFO - 'SHELL': '/bin/bash', 02:39:01 INFO - 'SHLVL': '1', 02:39:01 INFO - 'TERM': 'linux', 02:39:01 INFO - 'TMOUT': '86400', 02:39:01 INFO - 'USER': 'cltbld', 02:39:01 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1504861648.512952-963811676', 02:39:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:01 INFO - '_': '/tools/buildbot/bin/python'} 02:39:03 INFO - Ignoring indexes: http://pypi.python.org/simple/ 02:39:03 INFO - Downloading/unpacking pip>=1.5 02:39:03 INFO - Running setup.py egg_info for package pip 02:39:03 INFO - warning: no files found matching 'pip/cacert.pem' 02:39:03 INFO - warning: no files found matching '*.html' under directory 'docs' 02:39:03 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:39:03 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:39:03 INFO - Installing collected packages: pip 02:39:03 INFO - Found existing installation: pip 1.1 02:39:03 INFO - Uninstalling pip: 02:39:03 INFO - Successfully uninstalled pip 02:39:03 INFO - Running setup.py install for pip 02:39:03 INFO - warning: no files found matching 'pip/cacert.pem' 02:39:03 INFO - warning: no files found matching '*.html' under directory 'docs' 02:39:03 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:39:03 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:39:03 INFO - Installing pip script to /builds/slave/test/build/venv/bin 02:39:03 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 02:39:03 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 02:39:03 INFO - Successfully installed pip 02:39:03 INFO - Cleaning up... 02:39:03 INFO - Return code: 0 02:39:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:39: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:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39: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:39:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39: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', '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 0x24451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b5090>, '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 0x27b5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27aff90>, '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': '523ca41ca1e0623de333ad52000001bf-1504861648.512952-963811676', '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:39: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', 'psutil>=3.1.1'] in /builds/slave/test/build 02:39: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 psutil>=3.1.1 02:39:03 INFO - Using env: {'DISPLAY': ':0', 02:39:03 INFO - 'HOME': '/home/cltbld', 02:39:03 INFO - 'LANG': 'en_US.UTF-8', 02:39:03 INFO - 'LANGUAGE': 'en_US:en', 02:39:03 INFO - 'LOGNAME': 'cltbld', 02:39:03 INFO - 'MAIL': '/var/mail/cltbld', 02:39:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:03 INFO - 'MOZ_NO_REMOTE': '1', 02:39:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:03 INFO - 'NO_EM_RESTART': '1', 02:39:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:03 INFO - 'PWD': '/builds/slave/test', 02:39:03 INFO - 'SHELL': '/bin/bash', 02:39:03 INFO - 'SHLVL': '1', 02:39:03 INFO - 'TERM': 'linux', 02:39:03 INFO - 'TMOUT': '86400', 02:39:03 INFO - 'USER': 'cltbld', 02:39:03 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1504861648.512952-963811676', 02:39:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:03 INFO - '_': '/tools/buildbot/bin/python'} 02:39:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:03 INFO - Downloading/unpacking psutil>=3.1.1 02:39: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:39: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:39: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:39: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:39:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:39:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:39:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:39:04 INFO - Installing collected packages: psutil 02:39:04 INFO - Running setup.py install for psutil 02:39:04 INFO - building 'psutil._psutil_linux' extension 02:39:04 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:39:04 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:39:04 INFO - building 'psutil._psutil_posix' extension 02:39:04 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:39:04 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:39:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:39:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:39:05 INFO - Successfully installed psutil 02:39:05 INFO - Cleaning up... 02:39:05 INFO - Return code: 0 02:39:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b5090>, '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 0x27b5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27aff90>, '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': '523ca41ca1e0623de333ad52000001bf-1504861648.512952-963811676', '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:39:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:39:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:39:05 INFO - Using env: {'DISPLAY': ':0', 02:39:05 INFO - 'HOME': '/home/cltbld', 02:39:05 INFO - 'LANG': 'en_US.UTF-8', 02:39:05 INFO - 'LANGUAGE': 'en_US:en', 02:39:05 INFO - 'LOGNAME': 'cltbld', 02:39:05 INFO - 'MAIL': '/var/mail/cltbld', 02:39:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:05 INFO - 'MOZ_NO_REMOTE': '1', 02:39:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:05 INFO - 'NO_EM_RESTART': '1', 02:39:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:05 INFO - 'PWD': '/builds/slave/test', 02:39:05 INFO - 'SHELL': '/bin/bash', 02:39:05 INFO - 'SHLVL': '1', 02:39:05 INFO - 'TERM': 'linux', 02:39:05 INFO - 'TMOUT': '86400', 02:39:05 INFO - 'USER': 'cltbld', 02:39:05 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1504861648.512952-963811676', 02:39:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:05 INFO - '_': '/tools/buildbot/bin/python'} 02:39:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:39: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:39: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:39: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:39: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:39:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:39:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:39:06 INFO - Installing collected packages: mozsystemmonitor 02:39:06 INFO - Running setup.py install for mozsystemmonitor 02:39:06 INFO - Successfully installed mozsystemmonitor 02:39:06 INFO - Cleaning up... 02:39:06 INFO - Return code: 0 02:39:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:39: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:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39: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:39:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:06 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 0x24451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b5090>, '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 0x27b5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27aff90>, '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': '523ca41ca1e0623de333ad52000001bf-1504861648.512952-963811676', '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:39:06 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:39:06 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:39:06 INFO - Using env: {'DISPLAY': ':0', 02:39:06 INFO - 'HOME': '/home/cltbld', 02:39:06 INFO - 'LANG': 'en_US.UTF-8', 02:39:06 INFO - 'LANGUAGE': 'en_US:en', 02:39:06 INFO - 'LOGNAME': 'cltbld', 02:39:06 INFO - 'MAIL': '/var/mail/cltbld', 02:39:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:06 INFO - 'MOZ_NO_REMOTE': '1', 02:39:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:06 INFO - 'NO_EM_RESTART': '1', 02:39:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:06 INFO - 'PWD': '/builds/slave/test', 02:39:06 INFO - 'SHELL': '/bin/bash', 02:39:06 INFO - 'SHLVL': '1', 02:39:06 INFO - 'TERM': 'linux', 02:39:06 INFO - 'TMOUT': '86400', 02:39:06 INFO - 'USER': 'cltbld', 02:39:06 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1504861648.512952-963811676', 02:39:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:06 INFO - '_': '/tools/buildbot/bin/python'} 02:39:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:06 INFO - Downloading/unpacking jsonschema==2.5.1 02:39:06 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:39:06 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:39:06 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:39:06 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:39:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:39:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:39:07 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:39:07 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:39:07 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:39:07 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:39:07 INFO - Downloading functools32-3.2.3-2.tar.gz 02:39:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:39:08 INFO - warning: no files found matching '*.txt' 02:39:08 INFO - no previously-included directories found matching 'build' 02:39:08 INFO - no previously-included directories found matching 'dist' 02:39:08 INFO - no previously-included directories found matching '.git*' 02:39:08 INFO - Installing collected packages: jsonschema, functools32 02:39:08 INFO - Running setup.py install for functools32 02:39:08 INFO - warning: no files found matching '*.txt' 02:39:08 INFO - no previously-included directories found matching 'build' 02:39:08 INFO - no previously-included directories found matching 'dist' 02:39:08 INFO - no previously-included directories found matching '.git*' 02:39:08 INFO - Successfully installed jsonschema functools32 02:39:08 INFO - Cleaning up... 02:39:08 INFO - Return code: 0 02:39:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:39:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x24451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b5090>, '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 0x27b5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27aff90>, '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': '523ca41ca1e0623de333ad52000001bf-1504861648.512952-963811676', '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:39:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:39:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:39:08 INFO - Using env: {'DISPLAY': ':0', 02:39:08 INFO - 'HOME': '/home/cltbld', 02:39:08 INFO - 'LANG': 'en_US.UTF-8', 02:39:08 INFO - 'LANGUAGE': 'en_US:en', 02:39:08 INFO - 'LOGNAME': 'cltbld', 02:39:08 INFO - 'MAIL': '/var/mail/cltbld', 02:39:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:08 INFO - 'MOZ_NO_REMOTE': '1', 02:39:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:08 INFO - 'NO_EM_RESTART': '1', 02:39:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:08 INFO - 'PWD': '/builds/slave/test', 02:39:08 INFO - 'SHELL': '/bin/bash', 02:39:08 INFO - 'SHLVL': '1', 02:39:08 INFO - 'TERM': 'linux', 02:39:08 INFO - 'TMOUT': '86400', 02:39:08 INFO - 'USER': 'cltbld', 02:39:08 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1504861648.512952-963811676', 02:39:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:08 INFO - '_': '/tools/buildbot/bin/python'} 02:39:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:39:08 INFO - Cleaning up... 02:39:08 INFO - Return code: 0 02:39:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:39:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x24451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b5090>, '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 0x27b5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27aff90>, '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': '523ca41ca1e0623de333ad52000001bf-1504861648.512952-963811676', '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:39:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:39:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:39:08 INFO - Using env: {'DISPLAY': ':0', 02:39:08 INFO - 'HOME': '/home/cltbld', 02:39:08 INFO - 'LANG': 'en_US.UTF-8', 02:39:08 INFO - 'LANGUAGE': 'en_US:en', 02:39:08 INFO - 'LOGNAME': 'cltbld', 02:39:08 INFO - 'MAIL': '/var/mail/cltbld', 02:39:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:08 INFO - 'MOZ_NO_REMOTE': '1', 02:39:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:08 INFO - 'NO_EM_RESTART': '1', 02:39:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:08 INFO - 'PWD': '/builds/slave/test', 02:39:08 INFO - 'SHELL': '/bin/bash', 02:39:08 INFO - 'SHLVL': '1', 02:39:08 INFO - 'TERM': 'linux', 02:39:08 INFO - 'TMOUT': '86400', 02:39:08 INFO - 'USER': 'cltbld', 02:39:08 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1504861648.512952-963811676', 02:39:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:08 INFO - '_': '/tools/buildbot/bin/python'} 02:39:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:08 INFO - Downloading/unpacking blobuploader==1.2.4 02:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:09 INFO - Downloading blobuploader-1.2.4.tar.gz 02:39:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:39:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:39:09 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:39:09 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:39:09 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:39:09 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:39:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:39:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:39: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:39: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:39: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:39: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:39:10 INFO - Downloading docopt-0.6.1.tar.gz 02:39:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:39:10 INFO - Installing collected packages: blobuploader, requests, docopt 02:39:10 INFO - Running setup.py install for blobuploader 02:39:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:39:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:39:10 INFO - Running setup.py install for requests 02:39:10 INFO - Running setup.py install for docopt 02:39:10 INFO - Successfully installed blobuploader requests docopt 02:39:10 INFO - Cleaning up... 02:39:10 INFO - Return code: 0 02:39:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:10 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 0x24451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b5090>, '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 0x27b5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27aff90>, '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': '523ca41ca1e0623de333ad52000001bf-1504861648.512952-963811676', '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:39:10 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:39:10 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:39:10 INFO - Using env: {'DISPLAY': ':0', 02:39:10 INFO - 'HOME': '/home/cltbld', 02:39:10 INFO - 'LANG': 'en_US.UTF-8', 02:39:10 INFO - 'LANGUAGE': 'en_US:en', 02:39:10 INFO - 'LOGNAME': 'cltbld', 02:39:10 INFO - 'MAIL': '/var/mail/cltbld', 02:39:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:10 INFO - 'MOZ_NO_REMOTE': '1', 02:39:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:10 INFO - 'NO_EM_RESTART': '1', 02:39:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:10 INFO - 'PWD': '/builds/slave/test', 02:39:10 INFO - 'SHELL': '/bin/bash', 02:39:10 INFO - 'SHLVL': '1', 02:39:10 INFO - 'TERM': 'linux', 02:39:10 INFO - 'TMOUT': '86400', 02:39:10 INFO - 'USER': 'cltbld', 02:39:10 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1504861648.512952-963811676', 02:39:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:10 INFO - '_': '/tools/buildbot/bin/python'} 02:39:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:39:11 INFO - Running setup.py (path:/tmp/pip-IVjm3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:39:11 INFO - Running setup.py (path:/tmp/pip-b0SvCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:39:11 INFO - Running setup.py (path:/tmp/pip-9LPrTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:39:11 INFO - Running setup.py (path:/tmp/pip-qLnJOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:39:11 INFO - Running setup.py (path:/tmp/pip-VDK78R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:39:11 INFO - Running setup.py (path:/tmp/pip-AKKRyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:39:11 INFO - Running setup.py (path:/tmp/pip-b8XCU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:39:11 INFO - Running setup.py (path:/tmp/pip-yIkC2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:39:11 INFO - Running setup.py (path:/tmp/pip-40LWmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:39:11 INFO - Running setup.py (path:/tmp/pip-1MsKGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:39:11 INFO - Running setup.py (path:/tmp/pip-azridM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:39:11 INFO - Running setup.py (path:/tmp/pip-CFs7Vp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:39:11 INFO - Running setup.py (path:/tmp/pip-MeKCvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:39:12 INFO - Running setup.py (path:/tmp/pip-nM1VgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:39:12 INFO - Running setup.py (path:/tmp/pip-TBXTNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:39:12 INFO - Running setup.py (path:/tmp/pip-muQb9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:39:12 INFO - Running setup.py (path:/tmp/pip-X3f8pR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:39:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:39:12 INFO - Running setup.py install for manifestparser 02:39:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:39:12 INFO - Running setup.py install for mozcrash 02:39:12 INFO - Running setup.py install for mozdebug 02:39:12 INFO - Running setup.py install for mozdevice 02:39:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:39:12 INFO - Running setup.py install for mozfile 02:39:12 INFO - Running setup.py install for mozhttpd 02:39:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:39:12 INFO - Running setup.py install for mozinfo 02:39:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:39:13 INFO - Running setup.py install for mozInstall 02:39:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:39:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:39:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:39:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:39:13 INFO - Running setup.py install for mozleak 02:39:13 INFO - Running setup.py install for mozlog 02:39:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:39:13 INFO - Running setup.py install for moznetwork 02:39:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:39:13 INFO - Running setup.py install for mozprocess 02:39:13 INFO - Running setup.py install for mozprofile 02:39:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:39:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:39:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:39:13 INFO - Running setup.py install for mozrunner 02:39:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:39:13 INFO - Running setup.py install for mozscreenshot 02:39:13 INFO - Running setup.py install for moztest 02:39:13 INFO - Running setup.py install for mozversion 02:39:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:39:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:39:14 INFO - Cleaning up... 02:39:14 INFO - Return code: 0 02:39:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:39: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:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39: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:39:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:14 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 0x24451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b5090>, '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 0x27b5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27aff90>, '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': '523ca41ca1e0623de333ad52000001bf-1504861648.512952-963811676', '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:39:14 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:39:14 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:39:14 INFO - Using env: {'DISPLAY': ':0', 02:39:14 INFO - 'HOME': '/home/cltbld', 02:39:14 INFO - 'LANG': 'en_US.UTF-8', 02:39:14 INFO - 'LANGUAGE': 'en_US:en', 02:39:14 INFO - 'LOGNAME': 'cltbld', 02:39:14 INFO - 'MAIL': '/var/mail/cltbld', 02:39:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:14 INFO - 'MOZ_NO_REMOTE': '1', 02:39:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:14 INFO - 'NO_EM_RESTART': '1', 02:39:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:14 INFO - 'PWD': '/builds/slave/test', 02:39:14 INFO - 'SHELL': '/bin/bash', 02:39:14 INFO - 'SHLVL': '1', 02:39:14 INFO - 'TERM': 'linux', 02:39:14 INFO - 'TMOUT': '86400', 02:39:14 INFO - 'USER': 'cltbld', 02:39:14 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1504861648.512952-963811676', 02:39:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:14 INFO - '_': '/tools/buildbot/bin/python'} 02:39:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:39:14 INFO - Running setup.py (path:/tmp/pip-2yJ0KW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:39:14 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:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:39:14 INFO - Running setup.py (path:/tmp/pip-NOumEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:39:14 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:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:39:14 INFO - Running setup.py (path:/tmp/pip-aSsCec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:39:14 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:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:39:14 INFO - Running setup.py (path:/tmp/pip-klrxXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:39:14 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:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:39:14 INFO - Running setup.py (path:/tmp/pip-WU36es-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:39:14 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:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:39:14 INFO - Running setup.py (path:/tmp/pip-QwgRuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:39:14 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:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:39:14 INFO - Running setup.py (path:/tmp/pip-LSdInD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:39:14 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:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:39:14 INFO - Running setup.py (path:/tmp/pip-bUUfJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:39:14 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:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:39:14 INFO - Running setup.py (path:/tmp/pip-lz3aAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:39:14 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:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:39:14 INFO - Running setup.py (path:/tmp/pip-zNnQi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:39:15 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:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:39:15 INFO - Running setup.py (path:/tmp/pip-KQyx8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:39:15 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:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:39:15 INFO - Running setup.py (path:/tmp/pip-xz8obi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:39:15 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:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:39:15 INFO - Running setup.py (path:/tmp/pip-y3HYQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:39:15 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:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:39:15 INFO - Running setup.py (path:/tmp/pip-IeKLKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:39:15 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:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:39:15 INFO - Running setup.py (path:/tmp/pip-9OXP6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:39:15 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:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:39:15 INFO - Running setup.py (path:/tmp/pip-zZ1VpJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:39:15 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:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:39:15 INFO - Running setup.py (path:/tmp/pip-To9a88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:39:15 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:39:15 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:39:15 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:39:15 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:39:15 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:39:15 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:39:15 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:39:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:16 INFO - Downloading blessings-1.6.tar.gz 02:39:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:39:16 INFO - Installing collected packages: blessings 02:39:16 INFO - Running setup.py install for blessings 02:39:16 INFO - Successfully installed blessings 02:39:16 INFO - Cleaning up... 02:39:16 INFO - Return code: 0 02:39:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:39:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:39:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:39:17 INFO - Reading from file tmpfile_stdout 02:39:17 INFO - Current package versions: 02:39:17 INFO - argparse == 1.2.1 02:39:17 INFO - blessings == 1.6 02:39:17 INFO - blobuploader == 1.2.4 02:39:17 INFO - docopt == 0.6.1 02:39:17 INFO - functools32 == 3.2.3-2 02:39:17 INFO - jsonschema == 2.5.1 02:39:17 INFO - manifestparser == 1.1 02:39:17 INFO - mozInstall == 1.13 02:39:17 INFO - mozcrash == 1.0 02:39:17 INFO - mozdebug == 0.1 02:39:17 INFO - mozdevice == 0.51 02:39:17 INFO - mozfile == 1.2 02:39:17 INFO - mozhttpd == 0.7 02:39:17 INFO - mozinfo == 0.10 02:39:17 INFO - mozleak == 0.1 02:39:17 INFO - mozlog == 3.5 02:39:17 INFO - moznetwork == 0.27 02:39:17 INFO - mozprocess == 0.25 02:39:17 INFO - mozprofile == 0.28 02:39:17 INFO - mozrunner == 6.13 02:39:17 INFO - mozscreenshot == 0.1 02:39:17 INFO - mozsystemmonitor == 0.3 02:39:17 INFO - moztest == 0.8 02:39:17 INFO - mozversion == 1.4 02:39:17 INFO - psutil == 3.1.1 02:39:17 INFO - requests == 1.2.3 02:39:17 INFO - wsgiref == 0.1.2 02:39:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:39:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:17 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 0x24451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b5090>, '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 0x27b5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27aff90>, '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': '523ca41ca1e0623de333ad52000001bf-1504861648.512952-963811676', '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:39:17 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:39:17 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:39:17 INFO - Using env: {'DISPLAY': ':0', 02:39:17 INFO - 'HOME': '/home/cltbld', 02:39:17 INFO - 'LANG': 'en_US.UTF-8', 02:39:17 INFO - 'LANGUAGE': 'en_US:en', 02:39:17 INFO - 'LOGNAME': 'cltbld', 02:39:17 INFO - 'MAIL': '/var/mail/cltbld', 02:39:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:17 INFO - 'MOZ_NO_REMOTE': '1', 02:39:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:17 INFO - 'NO_EM_RESTART': '1', 02:39:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:17 INFO - 'PWD': '/builds/slave/test', 02:39:17 INFO - 'SHELL': '/bin/bash', 02:39:17 INFO - 'SHLVL': '1', 02:39:17 INFO - 'TERM': 'linux', 02:39:17 INFO - 'TMOUT': '86400', 02:39:17 INFO - 'USER': 'cltbld', 02:39:17 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1504861648.512952-963811676', 02:39:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:17 INFO - '_': '/tools/buildbot/bin/python'} 02:39:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:17 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:39:17 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:39:17 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:39:17 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:39:17 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:39:17 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:39:17 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:39:17 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:39:17 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:39:17 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:39:17 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:39:17 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:39:17 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:39:17 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:39:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 02:39:18 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:39:18 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:39:18 INFO - Installing collected packages: simplejson 02:39:18 INFO - Running setup.py install for simplejson 02:39:18 INFO - building 'simplejson._speedups' extension 02:39:18 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:39:19 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:39:19 INFO - Successfully installed simplejson 02:39:19 INFO - Cleaning up... 02:39:19 INFO - Return code: 0 02:39:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:39:19 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:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:19 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:39:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:19 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 0x24451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b5090>, '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 0x27b5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27aff90>, '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': '523ca41ca1e0623de333ad52000001bf-1504861648.512952-963811676', '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:39:19 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:39:19 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:39:19 INFO - Using env: {'DISPLAY': ':0', 02:39:19 INFO - 'HOME': '/home/cltbld', 02:39:19 INFO - 'LANG': 'en_US.UTF-8', 02:39:19 INFO - 'LANGUAGE': 'en_US:en', 02:39:19 INFO - 'LOGNAME': 'cltbld', 02:39:19 INFO - 'MAIL': '/var/mail/cltbld', 02:39:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:19 INFO - 'MOZ_NO_REMOTE': '1', 02:39:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:19 INFO - 'NO_EM_RESTART': '1', 02:39:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:19 INFO - 'PWD': '/builds/slave/test', 02:39:19 INFO - 'SHELL': '/bin/bash', 02:39:19 INFO - 'SHLVL': '1', 02:39:19 INFO - 'TERM': 'linux', 02:39:19 INFO - 'TMOUT': '86400', 02:39:19 INFO - 'USER': 'cltbld', 02:39:19 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1504861648.512952-963811676', 02:39:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:19 INFO - '_': '/tools/buildbot/bin/python'} 02:39:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:39:19 INFO - Cleaning up... 02:39:19 INFO - Return code: 0 02:39:19 INFO - Running post-action listener: _resource_record_post_action 02:39:19 INFO - Running post-action listener: _start_resource_monitoring 02:39:19 INFO - Starting resource monitoring. 02:39:19 INFO - [mozharness: 2017-09-08 09:39:19.764071Z] Finished create-virtualenv step (success) 02:39:19 INFO - [mozharness: 2017-09-08 09:39:19.764582Z] Running install step. 02:39:19 INFO - Running pre-action listener: _resource_record_pre_action 02:39:19 INFO - Running main action method: install 02:39:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:39:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:39:19 INFO - Reading from file tmpfile_stdout 02:39:19 INFO - Detecting whether we're running mozinstall >=1.0... 02:39:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:39:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:39:20 INFO - Reading from file tmpfile_stdout 02:39:20 INFO - Output received: 02:39:20 INFO - Usage: mozinstall [options] installer 02:39:20 INFO - Options: 02:39:20 INFO - -h, --help show this help message and exit 02:39:20 INFO - -d DEST, --destination=DEST 02:39:20 INFO - Directory to install application into. [default: 02:39:20 INFO - "/builds/slave/test"] 02:39:20 INFO - --app=APP Application being installed. [default: firefox] 02:39:20 INFO - mkdir: /builds/slave/test/build/application 02:39:20 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:39:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:39:36 INFO - Reading from file tmpfile_stdout 02:39:36 INFO - Output received: 02:39:36 INFO - /builds/slave/test/build/application/firefox/firefox 02:39:36 INFO - Running post-action listener: _resource_record_post_action 02:39:36 INFO - [mozharness: 2017-09-08 09:39:36.666688Z] Finished install step (success) 02:39:36 INFO - [mozharness: 2017-09-08 09:39:36.666832Z] Running setup-mitmproxy step. 02:39:36 INFO - Running pre-action listener: _resource_record_pre_action 02:39:36 INFO - Running main action method: setup_mitmproxy 02:39:36 INFO - Skipping: mitmproxy is not required 02:39:36 INFO - Running post-action listener: _resource_record_post_action 02:39:36 INFO - [mozharness: 2017-09-08 09:39:36.667757Z] Finished setup-mitmproxy step (success) 02:39:36 INFO - [mozharness: 2017-09-08 09:39:36.667976Z] Running run-tests step. 02:39:36 INFO - Running pre-action listener: _resource_record_pre_action 02:39:36 INFO - Running pre-action listener: _set_gcov_prefix 02:39:36 INFO - Running main action method: run_tests 02:39:36 WARNING - Try message not found. 02:39:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:39:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:39:36 INFO - Python 2.7.3 02:39:36 INFO - Return code: 0 02:39:36 INFO - grabbing minidump binary from tooltool 02:39:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:36 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 0x27b5090>, '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 0x27b5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27aff90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:39:36 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:39:36 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:39:36 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:39:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:39:36 INFO - Return code: 0 02:39:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:39:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:39:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:39:36 INFO - ENV: RUST_BACKTRACE is now full 02:39:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:39:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:39:36 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/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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:39:36 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/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-065 --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:39:36 INFO - Using env: {'DISPLAY': ':0', 02:39:36 INFO - 'HOME': '/home/cltbld', 02:39:36 INFO - 'LANG': 'en_US.UTF-8', 02:39:36 INFO - 'LANGUAGE': 'en_US:en', 02:39:36 INFO - 'LOGNAME': 'cltbld', 02:39:36 INFO - 'MAIL': '/var/mail/cltbld', 02:39:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:39:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:39:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:36 INFO - 'MOZ_NO_REMOTE': '1', 02:39:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:39:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:36 INFO - 'NO_EM_RESTART': '1', 02:39:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:36 INFO - 'PWD': '/builds/slave/test', 02:39:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:39:36 INFO - 'RUST_BACKTRACE': 'full', 02:39:36 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:39:36 INFO - 'SHELL': '/bin/bash', 02:39:36 INFO - 'SHLVL': '1', 02:39:36 INFO - 'STYLO_FORCE_ENABLED': '1', 02:39:36 INFO - 'STYLO_THREADS': '1', 02:39:36 INFO - 'TERM': 'linux', 02:39:36 INFO - 'TMOUT': '86400', 02:39:36 INFO - 'USER': 'cltbld', 02:39:36 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1504861648.512952-963811676', 02:39:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:36 INFO - '_': '/tools/buildbot/bin/python'} 02:39:36 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/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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:39:37 INFO - mozversion application_buildid: 20170908085005 02:39:37 INFO - mozversion application_changeset: dd75dcec7da162d8ceaaf0883e0e7561bd772992 02:39:37 INFO - mozversion application_display_name: Nightly 02:39:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:39:37 INFO - mozversion application_name: Firefox 02:39:37 INFO - mozversion application_remotingname: firefox 02:39:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:39:37 INFO - mozversion application_vendor: Mozilla 02:39:37 INFO - mozversion application_version: 57.0a1 02:39:37 INFO - mozversion platform_buildid: 20170908085005 02:39:37 INFO - mozversion platform_changeset: dd75dcec7da162d8ceaaf0883e0e7561bd772992 02:39:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:39:37 INFO - mozversion platform_version: 57.0a1 02:39:37 INFO - using testdate: 1504863577 02:39:37 INFO - actual date: 1504863577 02:39:37 INFO - starting webserver on 'localhost:58957' 02:39:37 INFO - SUITE-START | Running 2 tests 02:39:37 INFO - TEST-START | dromaeo_css 02:39:37 INFO - Initialising browser for dromaeo_css test... 02:39:37 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58957/getInfo.html -profile /tmp/tmpE1w4yK/profile 02:39:37 INFO - TEST-INFO | started process 10295 (/builds/slave/test/build/application/firefox/firefox http://localhost:58957/getInfo.html) 02:39:42 INFO - TEST-INFO | 10295: exit 0 02:39:42 INFO - Browser initialized. 02:39:42 INFO - Running cycle 1/1 for dromaeo_css test... 02:39:42 INFO - Using env: {'DISPLAY': ':0', 02:39:42 INFO - 'HOME': '/home/cltbld', 02:39:42 INFO - 'JSGC_DISABLE_POISONING': '1', 02:39:42 INFO - 'LANG': 'en_US.UTF-8', 02:39:42 INFO - 'LANGUAGE': 'en_US:en', 02:39:42 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 02:39:42 INFO - 'LOGNAME': 'cltbld', 02:39:42 INFO - 'MAIL': '/var/mail/cltbld', 02:39:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:39:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:39:42 INFO - 'MOZ_CRASHREPORTER': '1', 02:39:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:42 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 02:39:42 INFO - 'MOZ_NO_REMOTE': '1', 02:39:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:39:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:42 INFO - 'NO_EM_RESTART': '1', 02:39:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:42 INFO - 'PWD': '/builds/slave/test', 02:39:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:39:42 INFO - 'RUST_BACKTRACE': 'full', 02:39:42 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:39:42 INFO - 'SHELL': '/bin/bash', 02:39:42 INFO - 'SHLVL': '1', 02:39:42 INFO - 'STYLO_FORCE_ENABLED': '1', 02:39:42 INFO - 'STYLO_THREADS': '1', 02:39:42 INFO - 'TERM': 'linux', 02:39:42 INFO - 'TMOUT': '86400', 02:39:42 INFO - 'USER': 'cltbld', 02:39:42 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1504861648.512952-963811676', 02:39:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:42 INFO - '_': '/tools/buildbot/bin/python'} 02:39:42 INFO - TEST-INFO | started process 10479 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE1w4yK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:39:43 INFO - PID 10479 | 02:39:43 INFO - PID 10479 | (/builds/slave/test/build/application/firefox/firefox:10530): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:39:43 INFO - PID 10479 | 02:39:54 INFO - PID 10479 | RSS: Main: 170770432 02:39:54 INFO - PID 10479 | 02:42:51 INFO - PID 10479 | Cycle 1(1): loaded http://localhost:58957/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58957/tests/dromaeo/cssquery-ext.html) 02:42:52 INFO - PID 10479 | RSS: Main: 174120960 02:42:52 INFO - PID 10479 | 02:45:54 INFO - PID 10479 | Cycle 1(1): loaded http://localhost:58957/tests/dromaeo/cssquery-ext.html (next: http://localhost:58957/tests/dromaeo/cssquery-jquery.html) 02:45:55 INFO - PID 10479 | RSS: Main: 170348544 02:45:55 INFO - PID 10479 | 02:48:56 INFO - PID 10479 | Cycle 1(1): loaded http://localhost:58957/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58957/tests/dromaeo/cssquery-mootools.html) 02:48:57 INFO - PID 10479 | RSS: Main: 173035520 02:48:57 INFO - PID 10479 | 02:51:59 INFO - PID 10479 | Cycle 1(1): loaded http://localhost:58957/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58957/tests/dromaeo/cssquery-prototype.html) 02:51:59 INFO - PID 10479 | RSS: Main: 171286528 02:51:59 INFO - PID 10479 | 02:55:02 INFO - PID 10479 | Cycle 1(1): loaded http://localhost:58957/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58957/tests/dromaeo/cssquery-yui.html) 02:55:03 INFO - PID 10479 | RSS: Main: 173625344 02:55:03 INFO - PID 10479 | 02:58:05 INFO - PID 10479 | Cycle 1(1): loaded http://localhost:58957/tests/dromaeo/cssquery-yui.html (next: http://localhost:58957/tests/dromaeo/cssquery-dojo.html) 02:58:05 INFO - PID 10479 | RSS: Main: 175865856 02:58:05 INFO - PID 10479 | 02:58:05 INFO - PID 10479 | __start_tp_report 02:58:05 INFO - PID 10479 | _x_x_mozilla_page_load 02:58:05 INFO - PID 10479 | _x_x_mozilla_page_load_details 02:58:05 INFO - PID 10479 | |i|pagename|runs| 02:58:05 INFO - PID 10479 | |0;dojo.html;3070.524068769341;3099.271671157277;3108.6735892731263;3142.9842850785744;3153.1959350365655;6126.111713801496;6287.15123458333;6325.7153428095735;6334.271558770737;6423.100765892773;6230.7196176172065;6249.406306400896;6252;6261.248650161987;6280.434760871521;5763.654180749148;5766.336871259796;5771.913421298663;5784.508316793078;5816.214811000525;5808.477237048664;5817.0983497557945;5820.417958204188;5825.446582574648;5853.239078919734;5843.328017278003;5895.380984996578;5905.320888097859;5928.199693041449;5960.731767070492;5831.475167234969;5864.726027397284;5897;5921.496672782819;5981.282246130449;5515.61390702651;5717.342505611867;5722.799702010409;5782.681952492611;5795.971020144914;5691.174779656926;6206.6586337751405;6269.059641053878;6344.6510441925675;6349.4602958748565;6742.4268937140405;6757.290484499106;6838.452923766136;6853.451723862079;6861.622610756406;6635.502337324671;6700.899486507707;6743.662816859187;6745.494087943375;6791.252962174157;6254.718537665816;6264.812055638293;6271.184745982993;6273.278572964076;6275.215598050244;6931.965340173267;6995.230524642286;6995.650217489207;7065.152181738122;7076.504644674927;6551.1155993941165;6632.336766323426;6701.363370479797;6719.664016799141;6745.089412929192;6575.835604109936;6744.763933262312;6776.11910451648;6824.863502730017;6859.897101543481;6545.476361891037;6570.967145164339;6572.737090516422;6592.736290548421;6628.900566491507;6591.406773390418;6624.701888415033;6631.3700198481065;6631.767888123893;6635.767748128889;5180.7150606717;5265.947340526623;5317.1492561190025;5322.973385133049;5327.493888080626;4557.612602928788;4621.491635920046;4661.790219440133;4677.742724150136;4682.789274482657;5637.351704553947;5725.77096916127;5728.742206600713;5787.363390027093;5794.797182098607;6663.433608143265;6663.533552651268;6675.732970681119;6676.6327851967635;6698.5980841149685;5639.295088113986;5684.63049901755;5721.342045664718;5726.942730572724;5730.74211660468;5788.9131663024245;5869.4717475427415;5877.735501902424;5895.115732640138;5895.322037965603;6521.804345869631;6529.216494020748;6604.570702904296;6615.437687796495;6619.139511863427;6611.33886611335;6756.932430675631;6782.152230971129;6867.725290988305;6868.793936181923;6472.967635161794;6474;6497.772577959749;6502.479801615765;6511.218653761579;6616.206055273398;6636.435902948304;6641.302663220486;6647.202335719551;6667.333266673294;6780.627065511444;6892.172939247323;6897.310268973062;6908.654567271516;6911.896321555281;6513.54405191632;6546.410823025951;6586.176727909012;6641.0038494226255;6669.666516674244;6520.315366886409;6541.70562324687;6588.736450541925;6620.90068648961;6623.470122390294;6517.511186660925;6523.412892839668;6534.313897040743;6537;6540.542162048611;6562;6632.635205063768;6645.966770166118;6653.434458071119;6713.1944166700305;6365.490760739037;6465.482761379172;6468.2561505427475;6472.385123413268;6478.2550006749825 02:58:05 INFO - PID 10479 | |1;ext.html;827.7268501394541;865.6580650642996;874.6719980007497;875.8073223890742;890.020976925382;39344.40983385248;40101.79949100254;40169.79915100424;40269.19461610766;40637.59362406375;37156.814215928884;40158.397624035664;40586.79706601463;40635;40788.38817417734;7600.429967752427;7770.4172187085915;7771.961140194291;7798.7660370188705;7805.141434442206;7597.962010189941;7723.073231212263;7726.768196954073;7735.4585179037485;7737.883931741028;7719.845603087935;7722.884156737653;7723.53658780475;7759.340456061242;7774.416918731118;7673.2326767323375;7733.342665873408;7743;7746.186650401683;7752.806179845493;7614.428917831185;7673.501222420525;7684.154742978268;7684.615769211573;7696.769096927102;37099.62900371016;37113.25773484542;37278.627213727785;37329.81335093307;37410.62589374099;3558.217192217708;3588.318219538279;3590.317839610466;3595.209054008114;3597.37046016946;29792.70207297921;29796.70203297961;29835.403291934257;29931.551026734618;29951.400971980656;4992.475790042066;5129.230615407681;5149.407818100892;5170;5175.249588809602;175908;176692.1165394165;176775;178100;190009.9999999986;47366;47403.28895066577;47590.28614570784;47692.284615730794;47766;49084;49110.75444622754;49166.50833491691;49177.50822491729;49225.50774492209;15196.772048419283;15321.540353789404;15487.690246195012;15501.844981550266;15511.37954481808;12555.372231388394;12561.246325220516;12568.748625027449;12569;12577.559785407468;13387.866121338857;13454.32728363578;13556.322183890767;13558.796618050737;13634.863651363557;5064.974675126675;5127.359245041551;5184.7407629618365;5222.3733152022005;5246.606504512177;989.7327721515151;1010.5604062232952;1011.5296387179997;1020.8366661334151;1021.7752094539189;22447.21434749776;22599.661005084938;22683.659745103836;22823.087076516753;22975.19586814487;1071.3839542263229;1093.748437859281;1095.457748414524;1098.0995583621514;1110.8500352452315;11945.16383853122;12042.318950617886;12090.274583525017;12098.153129280865;12270.018398528096;226876;227722;228118;228579;229509;49605.751971240636;49628.25557616639;49724.50275497271;49730;49746.25380619294;1413.6253892718437;1435.6052085676522;1451.985480145206;1457.883369330451;1472.6612879037882;21507.784922151204;21778.237761678265;22214.666779998635;22259.220927267466;22396;35648.287034258654;35810.64189358073;35840.10399739923;35898.64101358953;35979.46030809592;194688;195311;195551;195749;196405;31676.049718508482;32536.67463325431;32629.34741305208;32742.181445464055;32826.34347313088;40255.798721006206;40433.39349909813;40445.59554404418;40513;40635;30184.396312074074;30281.394372112874;30517.542236866022;30676.84661576678;31079.84460077685;30065.549016765202;30286.939957101396;30379.69620303857;30386.84806575953;31188;34233.31533369368;34336.48495272623;34496.96509104731;34587.827060865544;34671.30657386889;29699.55450668285;29757.256068598457;29986;30092.849535752182;30403.39193216079;22114.44713882166;22552.436189095402;22609.321720348416;22767.203147889744;22816.885915570318 02:58:05 INFO - PID 10479 | |2;jquery.html;569.9145128230764;574.9770009199632;577.7082573300484;578.3002566894061;578.7222133375976;21485;22010;22274.665880011813;22293.33120006398;22313.330600081983;23156.65265021026;24195;24225.39436514088;24532.264032079067;24648.630270545957;6435.613863168213;6663.533552651316;6667.233268174149;6668.833279168035;6675.7997260082275;6200.193974783295;6522.869542609145;6592.439642630358;6607.504437167232;6620.668966551677;6402.487800975934;6411.455026322768;6423.486121110323;6425.164728585278;6426.646534440627;6432.839179020515;6439.452646525051;6442.162518872564;6442.516811239176;6444.420002199801;5863.76544938202;5939.910901336483;6083.726232319512;6106.633601983851;6106.877862442726;27343.86328068367;27850.5822412664;27868.721312787016;27873.303167420774;27941.580876286873;1951.9219231230734;1971.5563998100456;1975.7925417831063;1979.8515111366705;1981.4055783264962;18525;19231.326903558307;19295.51761205967;19511.414657560297;19547.804521954742;2405.9639105413435;2457.103157347573;2487.3781554611346;2501.9374515637255;2527.2165628654993;120864.39567802193;126050;126392;126468;140414.2979285097;20047.899760501397;20241.49396265076;20545.48636284105;21373.358799236048;21440.78559214419;39948.40077398841;39962.80018599889;40150;40200.39699404511;40301.79849100736;11124.443777811077;11133.721656958478;11213.3832639204;11276.379799111128;11410.315381077162;9357.438553686801;9358.15776580111;9499.38254013487;9531.38046027006;9584.233261339075;11249.550017999189;11392.601258955896;11411.429428528707;11453.541858325574;11514.654560363202;4006.358982562776;4206.26390381682;4207.26372884744;4252.829886804493;4284.357346398003;948.7296120605732;976.5215044628081;980.2207245239908;989.5448093876897;995.2187532786728;18732.250709971722;19117;19155;19159.61680766377;19599.804001960085;1034.9016843399866;1042.6663467690419;1045.8431235314763;1047.6647472808781;1048.5072016152396;10264.486775661187;10419.895801042045;10553.314034587727;10633.72395312552;10711.571537138583;429168;434705;443325;451891;454841;106724;106981.46509267404;107110;109984;111325;1024.8513965475113;1083.9403832789271;1163.4182908545727;1197.8143387774908;1200.2678366196612;19766.20935162635;19889.801101989375;20003.09986050602;20024.59950801005;20269;54537.72731136319;54876;55115.17327240014;55483.445165547826;56201.156982644476;65148.67425663031;65450;65955;66142;66219;19317.710234346214;19708.21167153298;19808;19852.801471985094;19943.800561994194;22045.559088817812;22208.777912221318;22343.888280558494;22495.212667556556;22540.32379028632;17652.293908243526;17921.462356129337;18018.639627207645;18047.097645117956;18144.45566633003;15450.9227453862;16355;16373.09947952874;16392;16500.17499125063;16369.836301636831;16545.338186472887;16586.917065414596;16642.916785415997;17634.91182544079;17620.29518819233;17734.556636083686;17757.200925958623;17776.55558611045;17805;16930.153492325582;16974.660506789547;17018.234179461706;17059.573510661838;17347.219375127897 02:58:05 INFO - PID 10479 | |3;mootools.html;1331.2411925202634;1395.1629022586444;1396.204163626732;1403.571910567277;1414.3918115210456;14909.254537273133;15515.146666933315;15529.92235038826;15534.533963981085;15544.84455155448;14996.775048374284;15235.542933712006;15266.923665381686;15267.694646107071;15268.38926442941;2719.157061311;2730.0308390521377;2775.528160212769;2776.430831679501;2776.5557510798276;2682.5305571525005;2705.418335057972;2722.5507791214427;2724.182745176449;2735.7127501612345;2767.9446411071767;2806.200232933614;2806.873690683914;2807.03157410694;2810.3255218747454;2656.9468610627873;2689.2066840282164;2694.6227528146073;2707.4991126641635;2707.796915231356;2598.792096632265;2609.7912167026784;2610.582306830917;2613.2160351894545;2625.12058460416;14876.851231487763;15216.695666086727;15242.085474871543;15295.388184472607;15298.847011529853;7660.578668173248;7979.760607181794;7980.800479987989;7985.5208687478935;7988.241117093867;5263.710286025591;5399.83800485986;5497.19642982078;5582.7766889324375;5598.720063996784;1878.4176905159309;1880.4264699266719;1912.3306842605116;1920.0687666481745;1926.4413320137144;25976.61035084494;26015.349616259555;26224.344391390176;26233.081842135434;26257.73742262572;6487.091807147003;6630.900536491957;6721.899171512431;6760.898586521206;6789.219239787389;17183.484495464905;17282.567935801453;17313.134343283036;17320.480385588202;17328.30686772515;7696.268854458817;7871.134175240719;7891.171427000198;7892.250236227549;7900.407469439815;7155.7794955370155;7250.3112204340505;7333.303336183054;7340.0457940467395;7347.8163045924275;5129.333186685707;5230.712310822942;5264.473552644705;5269.789208431696;5270.156774915995;1305.9412326445142;1354.6545630864066;1529.1742459071977;1529.2888806704714;1548.6283292009837;850.4429598612918;872.5898827551041;896.2695403246333;913.4154141349542;915.7619019055094;8177.304929080976;8489.4481858679;8550.572471376407;8632.395732298679;8671.956640216758;709.7515869445652;710.4990981358234;767.4244316762428;783.9098503672037;993.6720882108887;5018.623603229772;5293.497117773805;5307.681539107666;5400.432954539795;5562.610617256753;20809.58380832375;21637.78362216389;21737.891310543346;21813.23653672114;21949;21179.576408471745;21685.783142168693;21744.456388590414;21748.673769893463;21818.672719909213;11174.944125279322;11340.6030788922;11409.714757131138;11468.827967580326;11485.885141148648;8368.079511253878;8385.161483851565;8415.032271288881;8437.831243374976;8556.486610803371;18070.367537136663;18351.541211469284;18493.53766155803;18721.344752933583;19143;19124.904375478032;19159.425217243504;19202;19275.8072419274;19287.710684339465;10439.634612788515;10598.470076496298;10609.522571484456;10618.787624247627;10623.628173014216;13676.247806370347;13863.861361386256;13907.51323703706;14033.087849289763;14044.087134336236;10243.282970192015;10543.578256869947;11058.060064894575;11115;11305.491252893804;10673.146148308271;10756.085732712494;10819.188560858125;10852.131829453783;10939.124870010539;9775.462349570842;9903.059209375098;9928.702138935843;9939.105480506789;9943.353682010646;7436.96281518589;7473.327400533978;7483.780816448791;7513.2111128330735;7561.357284630868;7460.7015719372785;7488.9625551871895;7511.32398084175;7571.129320128035;7669.7315593953945 02:58:05 INFO - PID 10479 | |4;prototype.html;501.3875950466026;520.1080147546957;522.7334059629587;531.8085489223881;535.8231783511441;6317.399847014538;6399.144248168037;6404.935950640498;6440.484761219103;6450.258220304667;6203.689815509229;6219.129321894939;6222.968885155579;6238.937610623892;6243.968780156093;5131.846044618667;5190.792368305263;5216.02686468713;5221.112410890139;5226.111561034633;5075.766662668414;5153.948460515403;5163.070647283487;5207.557357624606;5217.50433708797;5096.904165604395;5135;5156.8710782230555;5223.399309079447;5249.790008399659;5144.922826157611;5163.483651634844;5224.8693782655355;5227.242049902781;5250.897311564576;4767.952320476786;4806.591439727627;4836.854894353175;4841.298011788271;4841.951580484185;6113.694315284218;6162.4453799157845;6163.291221509539;6177.351378105324;6311.589746666498;5903.085021821582;5999.520038396918;6006.579539432241;6019.578629495937;6071.969640151815;6592.703328350236;6668.366505182;6682.532222744409;6708.631025293607;6753.45972322213;5231.869203269911;5258.947410525884;5284.392294886099;5285.233641122054;5289.471052894718;6570.269406027653;6803.625800580966;6853.520253582251;6907.654617269167;6973.79078627642;5398.973005134949;5432.103702888979;5450.700211488327;5470.261514695545;5481.163810123573;5461.678786515715;5496.203050557727;5544.500994910397;5562.694051827108;5564.888702225933;5946.524278057745;5952.583319167703;5991.221141251696;5993.760249589967;6031.457168854824;6644.83387915306;6663.633500157441;6684.83287917806;6724.865502690017;6750.594964302158;1889.1404410992966;1893.1859300500641;1900.8689829551395;1952.1215453046186;1953.9706904396446;1340.8602687715559;1399.6780740429758;1423.5658124272197;1426.3937826423728;1441.4594527052354;5641.351244606841;5678.3186017678145;5701.666733282652;5744.942550574524;5786.264120763838;6615.966920165369;6620.834479137964;6648.700808463631;6665.266820649725;6719.770018566261;5665.405132461115;5677.545796336283;5678.14827775837;5754.769809207669;5769.807473160172;3489.5114683944266;3585.964140358563;3587.551556055493;3597.082743900341;3604.6034936157525;6354.4281014708895;6367.204099487564;6426.132472116298;6448.709808058648;6537;6800.387965083068;6836.794896153124;6880.69036893331;6942.93057069433;6952.617606031616;6403.519736019724;6426.389492998158;6483.7730679425995;6520.18497687789;6539.5422320438065;6706.698198580978;6715.3620406061345;6752.8649427010205;6774.187097548326;6776.966115169393;6605.273419923708;6633.3035031321015;6642.6014439133805;6655.134832471747;6748.628825414453;6434.163558737334;6486.805395838132;6491;6505.837354066186;6518.445932095825;5438.782448702008;5438.972805135949;5448.972755136199;5452.781888724407;5458.536024437808;6331.2085989251345;6609.405153536205;6736.7642132525125;6807.813194885209;6816.318368163343;6424.935750642434;6444.9033264502;6451.3226111257645;6527.5757075789925;6585;6469.77355792545;6475.111290975472;6524.771632992823;6545.705443254969;6592.80221593353;6408.839779005562;6424.518161138027;6496.317886622026;6537;6553.541252112497;6539.70571324282;6572.868542629216;6600.372964568358;6616.66916654175;6651.26836048044;6330.335314791881;6342.016987366966;6368.395002474757;6396.936030639634;6439.7424103035355 02:58:05 INFO - PID 10479 | |5;yui.html;891.0599317719807;908.055622152961;912.411494585992;913.3697748553498;944.0323668240053;19013.904930475346;19632.803671963276;19642.803571964276;19651.5087122822;19713.901430492846;16564.585885352873;16633.33466661335;16665.33338666452;16755.83244167558;16766.245518951648;948.8292107420662;949.1931857920747;949.9240060795154;949.9952500237489;952.3143336797494;957.760559860035;965.2374624046995;968.6754937096081;969.8981606931277;970.5195928015606;1001.5843424978625;1005.7334806276342;1015.1523477895965;1033.57106800678;1045.4041196517987;1026.0304012707993;1026.0765311219886;1026.0765311219925;1026.928115031948;1040.032769524342;721.6644260418931;734.7685479074128;745.3403737692128;748.3377211168101;756.2701992577189;19851;20051.498712532157;20052.1979120835;20058.097385617682;20059.1976320947;20745.8962705187;20827.479313017146;21952.670709939364;22110.88944555283;22176.667349989762;15591.22043897812;15599.844001559952;15715.607109822231;15754.606134846721;15867.52397428079;3819.4079917612817;3830.636089571486;3830.9233815323537;3835.5972622874474;3843.8654647087496;104823.47588262086;135332.32333838366;137884;141168;143332;17060.914695426443;17565.560860978323;17662.205200765995;17681.7347739784;17730.734038989427;31919.840400797846;32765;33026.504602430985;33060;33075.173120671694;9129.224015958718;9192.126747959066;9239.953800230956;9244.630214791467;9248.167664910055;4225.471816022997;4293.463317085364;4310.245707001262;4318.632916202095;4318.913621727548;4881.658283920163;4935.481774413706;4960.851174464772;4961.305417241589;4964.35463389757;1015.939043657383;1055.9894401056044;1058.0794708603564;1064.4039337970762;1064.9414282214552;561.9550435965112;564.8136115082013;566.1875209074908;571.0577547047405;585.1953563849706;11864.406779661154;11968.940155299342;12302.200356976768;13547;13557.864421355858;589.6992533807789;591.7839988404202;592.8517870532366;604.5375287904757;614.717230074162;5493.890122197614;5555.138953462219;5640.407757185519;5653.038983372837;5718.656880587178;122069;124748;125260.37369813092;127634;128357;109034;110299;110330;111437.44281278542;112527.87472125338;92207;94276;95381.52309238548;95717.52141239388;97750;10132.290739648153;10280.177585793268;10305.124064454605;10452.007059329351;10623.097036751962;42392.788036059625;44140.33789493224;44868.55131448644;44938;45892.54107459016;56326.155107672595;56436.435635643116;56607.15089273747;58042.709786450796;59023.704881475314;15285;15586.610334741723;15703.371865125268;15733.213339333217;15825.287862046465;16782.580435488722;16927.661446771242;16989.49031529056;17087.145642718064;17193.14034298305;16282.10448425348;16475.093869837274;16518.917405412896;16618.086005269826;16705.415310464075;15999.600009999844;16322.347106116098;16331.510054698378;16466.341346346013;16484.83515164833;15251.694966100395;15262.618434539225;15314.923425382802;15392.692146157238;15431.768523471932;10465.790684186122;10466.00572945569;10559.472026398804;10658.62694805678;10734.248602597743;10815.513301901276;10930.234883558393;10949.582431178358;11050.944745276222;11118.61084862026 02:58:05 INFO - PID 10479 | __end_tp_report 02:58:05 INFO - PID 10479 | __start_cc_report 02:58:05 INFO - PID 10479 | _x_x_mozilla_cycle_collect,353 02:58:05 INFO - PID 10479 | __end_cc_report 02:58:05 INFO - PID 10479 | __startTimestamp1504864685337__endTimestamp 02:58:05 INFO - PID 10479 | 02:58:05 INFO - PID 10479 | ------- Summary: start ------- 02:58:05 INFO - PID 10479 | Number of tests: 6 02:58:05 INFO - PID 10479 | 02:58:05 INFO - PID 10479 | [#0] dojo.html Cycles:165 Average:6195.88 Median:6497.77 stddev:751.76 (11.6%) stddev-sans-first:712.96 02:58:05 INFO - PID 10479 | Values: 3070.5 3099.3 3108.7 3143.0 3153.2 6126.1 6287.2 6325.7 6334.3 6423.1 6230.7 6249.4 6252.0 6261.2 6280.4 5763.7 5766.3 5771.9 5784.5 5816.2 5808.5 5817.1 5820.4 5825.4 5853.2 5843.3 5895.4 5905.3 5928.2 5960.7 5831.5 5864.7 5897.0 5921.5 5981.3 5515.6 5717.3 5722.8 5782.7 5796.0 5691.2 6206.7 6269.1 6344.7 6349.5 6742.4 6757.3 6838.5 6853.5 6861.6 6635.5 6700.9 6743.7 6745.5 6791.3 6254.7 6264.8 6271.2 6273.3 6275.2 6932.0 6995.2 6995.7 7065.2 7076.5 6551.1 6632.3 6701.4 6719.7 6745.1 6575.8 6744.8 6776.1 6824.9 6859.9 6545.5 6571.0 6572.7 6592.7 6628.9 6591.4 6624.7 6631.4 6631.8 6635.8 5180.7 5265.9 5317.1 5323.0 5327.5 4557.6 4621.5 4661.8 4677.7 4682.8 5637.4 5725.8 5728.7 5787.4 5794.8 6663.4 6663.5 6675.7 6676.6 6698.6 5639.3 5684.6 5721.3 5726.9 5730.7 5788.9 5869.5 5877.7 5895.1 5895.3 6521.8 6529.2 6604.6 6615.4 6619.1 6611.3 6756.9 6782.2 6867.7 6868.8 6473.0 6474.0 6497.8 6502.5 6511.2 6616.2 6636.4 6641.3 6647.2 6667.3 6780.6 6892.2 6897.3 6908.7 6911.9 6513.5 6546.4 6586.2 6641.0 6669.7 6520.3 6541.7 6588.7 6620.9 6623.5 6517.5 6523.4 6534.3 6537.0 6540.5 6562.0 6632.6 6646.0 6653.4 6713.2 6365.5 6465.5 6468.3 6472.4 6478.3 02:58:05 INFO - PID 10479 | 02:58:05 INFO - PID 10479 | [#1] ext.html Cycles:180 Average:36352.59 Median:34416.73 stddev:52352.92 (152.1%) stddev-sans-first:52431.83 02:58:05 INFO - PID 10479 | Values: 827.7 865.7 874.7 875.8 890.0 39344.4 40101.8 40169.8 40269.2 40637.6 37156.8 40158.4 40586.8 40635.0 40788.4 7600.4 7770.4 7772.0 7798.8 7805.1 7598.0 7723.1 7726.8 7735.5 7737.9 7719.8 7722.9 7723.5 7759.3 7774.4 7673.2 7733.3 7743.0 7746.2 7752.8 7614.4 7673.5 7684.2 7684.6 7696.8 37099.6 37113.3 37278.6 37329.8 37410.6 3558.2 3588.3 3590.3 3595.2 3597.4 29792.7 29796.7 29835.4 29931.6 29951.4 4992.5 5129.2 5149.4 5170.0 5175.2 175908.0 176692.1 176775.0 178100.0 190010.0 47366.0 47403.3 47590.3 47692.3 47766.0 49084.0 49110.8 49166.5 49177.5 49225.5 15196.8 15321.5 15487.7 15501.8 15511.4 12555.4 12561.2 12568.7 12569.0 12577.6 13387.9 13454.3 13556.3 13558.8 13634.9 5065.0 5127.4 5184.7 5222.4 5246.6 989.7 1010.6 1011.5 1020.8 1021.8 22447.2 22599.7 22683.7 22823.1 22975.2 1071.4 1093.7 1095.5 1098.1 1110.9 11945.2 12042.3 12090.3 12098.2 12270.0 226876.0 227722.0 228118.0 228579.0 229509.0 49605.8 49628.3 49724.5 49730.0 49746.3 1413.6 1435.6 1452.0 1457.9 1472.7 21507.8 21778.2 22214.7 22259.2 22396.0 35648.3 35810.6 35840.1 35898.6 35979.5 194688.0 195311.0 195551.0 195749.0 196405.0 31676.0 32536.7 32629.3 32742.2 32826.3 40255.8 40433.4 40445.6 40513.0 40635.0 30184.4 30281.4 30517.5 30676.8 31079.8 30065.5 30286.9 30379.7 30386.8 31188.0 34233.3 34336.5 34497.0 34587.8 34671.3 29699.6 29757.3 29986.0 30092.8 30403.4 22114.4 22552.4 22609.3 22767.2 22816.9 02:58:05 INFO - PID 10479 | 02:58:05 INFO - PID 10479 | [#2] jquery.html Cycles:180 Average:33563.02 Median:21747.50 stddev:74602.95 (343.0%) stddev-sans-first:74771.11 02:58:05 INFO - PID 10479 | Values: 569.9 575.0 577.7 578.3 578.7 21485.0 22010.0 22274.7 22293.3 22313.3 23156.7 24195.0 24225.4 24532.3 24648.6 6435.6 6663.5 6667.2 6668.8 6675.8 6200.2 6522.9 6592.4 6607.5 6620.7 6402.5 6411.5 6423.5 6425.2 6426.6 6432.8 6439.5 6442.2 6442.5 6444.4 5863.8 5939.9 6083.7 6106.6 6106.9 27343.9 27850.6 27868.7 27873.3 27941.6 1951.9 1971.6 1975.8 1979.9 1981.4 18525.0 19231.3 19295.5 19511.4 19547.8 2406.0 2457.1 2487.4 2501.9 2527.2 120864.4 126050.0 126392.0 126468.0 140414.3 20047.9 20241.5 20545.5 21373.4 21440.8 39948.4 39962.8 40150.0 40200.4 40301.8 11124.4 11133.7 11213.4 11276.4 11410.3 9357.4 9358.2 9499.4 9531.4 9584.2 11249.6 11392.6 11411.4 11453.5 11514.7 4006.4 4206.3 4207.3 4252.8 4284.4 948.7 976.5 980.2 989.5 995.2 18732.3 19117.0 19155.0 19159.6 19599.8 1034.9 1042.7 1045.8 1047.7 1048.5 10264.5 10419.9 10553.3 10633.7 10711.6 429168.0 434705.0 443325.0 451891.0 454841.0 106724.0 106981.5 107110.0 109984.0 111325.0 1024.9 1083.9 1163.4 1197.8 1200.3 19766.2 19889.8 20003.1 20024.6 20269.0 54537.7 54876.0 55115.2 55483.4 56201.2 65148.7 65450.0 65955.0 66142.0 66219.0 19317.7 19708.2 19808.0 19852.8 19943.8 22045.6 22208.8 22343.9 22495.2 22540.3 17652.3 17921.5 18018.6 18047.1 18144.5 15450.9 16355.0 16373.1 16392.0 16500.2 16369.8 16545.3 16586.9 16642.9 17634.9 17620.3 17734.6 17757.2 17776.6 17805.0 16930.2 16974.7 17018.2 17059.6 17347.2 02:58:05 INFO - PID 10479 | 02:58:05 INFO - PID 10479 | [#3] mootools.html Cycles:180 Average:9315.47 Median:2669.74 stddev:6649.53 (249.1%) stddev-sans-first:6641.12 02:58:05 INFO - PID 10479 | Values: 1331.2 1395.2 1396.2 1403.6 1414.4 14909.3 15515.1 15529.9 15534.5 15544.8 14996.8 15235.5 15266.9 15267.7 15268.4 2719.2 2730.0 2775.5 2776.4 2776.6 2682.5 2705.4 2722.6 2724.2 2735.7 2767.9 2806.2 2806.9 2807.0 2810.3 2656.9 2689.2 2694.6 2707.5 2707.8 2598.8 2609.8 2610.6 2613.2 2625.1 14876.9 15216.7 15242.1 15295.4 15298.8 7660.6 7979.8 7980.8 7985.5 7988.2 5263.7 5399.8 5497.2 5582.8 5598.7 1878.4 1880.4 1912.3 1920.1 1926.4 25976.6 26015.3 26224.3 26233.1 26257.7 6487.1 6630.9 6721.9 6760.9 6789.2 17183.5 17282.6 17313.1 17320.5 17328.3 7696.3 7871.1 7891.2 7892.3 7900.4 7155.8 7250.3 7333.3 7340.0 7347.8 5129.3 5230.7 5264.5 5269.8 5270.2 1305.9 1354.7 1529.2 1529.3 1548.6 850.4 872.6 896.3 913.4 915.8 8177.3 8489.4 8550.6 8632.4 8672.0 709.8 710.5 767.4 783.9 993.7 5018.6 5293.5 5307.7 5400.4 5562.6 20809.6 21637.8 21737.9 21813.2 21949.0 21179.6 21685.8 21744.5 21748.7 21818.7 11174.9 11340.6 11409.7 11468.8 11485.9 8368.1 8385.2 8415.0 8437.8 8556.5 18070.4 18351.5 18493.5 18721.3 19143.0 19124.9 19159.4 19202.0 19275.8 19287.7 10439.6 10598.5 10609.5 10618.8 10623.6 13676.2 13863.9 13907.5 14033.1 14044.1 10243.3 10543.6 11058.1 11115.0 11305.5 10673.1 10756.1 10819.2 10852.1 10939.1 9775.5 9903.1 9928.7 9939.1 9943.4 7437.0 7473.3 7483.8 7513.2 7561.4 7460.7 7489.0 7511.3 7571.1 7669.7 02:58:05 INFO - PID 10479 | 02:58:05 INFO - PID 10479 | [#4] prototype.html Cycles:180 Average:5625.82 Median:6221.05 stddev:1501.54 (24.1%) stddev-sans-first:1455.66 02:58:05 INFO - PID 10479 | Values: 501.4 520.1 522.7 531.8 535.8 6317.4 6399.1 6404.9 6440.5 6450.3 6203.7 6219.1 6223.0 6238.9 6244.0 5131.8 5190.8 5216.0 5221.1 5226.1 5075.8 5153.9 5163.1 5207.6 5217.5 5096.9 5135.0 5156.9 5223.4 5249.8 5144.9 5163.5 5224.9 5227.2 5250.9 4768.0 4806.6 4836.9 4841.3 4842.0 6113.7 6162.4 6163.3 6177.4 6311.6 5903.1 5999.5 6006.6 6019.6 6072.0 6592.7 6668.4 6682.5 6708.6 6753.5 5231.9 5258.9 5284.4 5285.2 5289.5 6570.3 6803.6 6853.5 6907.7 6973.8 5399.0 5432.1 5450.7 5470.3 5481.2 5461.7 5496.2 5544.5 5562.7 5564.9 5946.5 5952.6 5991.2 5993.8 6031.5 6644.8 6663.6 6684.8 6724.9 6750.6 1889.1 1893.2 1900.9 1952.1 1954.0 1340.9 1399.7 1423.6 1426.4 1441.5 5641.4 5678.3 5701.7 5744.9 5786.3 6616.0 6620.8 6648.7 6665.3 6719.8 5665.4 5677.5 5678.1 5754.8 5769.8 3489.5 3586.0 3587.6 3597.1 3604.6 6354.4 6367.2 6426.1 6448.7 6537.0 6800.4 6836.8 6880.7 6942.9 6952.6 6403.5 6426.4 6483.8 6520.2 6539.5 6706.7 6715.4 6752.9 6774.2 6777.0 6605.3 6633.3 6642.6 6655.1 6748.6 6434.2 6486.8 6491.0 6505.8 6518.4 5438.8 5439.0 5449.0 5452.8 5458.5 6331.2 6609.4 6736.8 6807.8 6816.3 6424.9 6444.9 6451.3 6527.6 6585.0 6469.8 6475.1 6524.8 6545.7 6592.8 6408.8 6424.5 6496.3 6537.0 6553.5 6539.7 6572.9 6600.4 6616.7 6651.3 6330.3 6342.0 6368.4 6396.9 6439.7 02:58:05 INFO - PID 10479 | 02:58:05 INFO - PID 10479 | [#5] yui.html Cycles:180 Average:24181.36 Median:19323.35 stddev:35135.67 (181.8%) stddev-sans-first:35190.71 02:58:05 INFO - PID 10479 | Values: 891.1 908.1 912.4 913.4 944.0 19013.9 19632.8 19642.8 19651.5 19713.9 16564.6 16633.3 16665.3 16755.8 16766.2 948.8 949.2 949.9 950.0 952.3 957.8 965.2 968.7 969.9 970.5 1001.6 1005.7 1015.2 1033.6 1045.4 1026.0 1026.1 1026.1 1026.9 1040.0 721.7 734.8 745.3 748.3 756.3 19851.0 20051.5 20052.2 20058.1 20059.2 20745.9 20827.5 21952.7 22110.9 22176.7 15591.2 15599.8 15715.6 15754.6 15867.5 3819.4 3830.6 3830.9 3835.6 3843.9 104823.5 135332.3 137884.0 141168.0 143332.0 17060.9 17565.6 17662.2 17681.7 17730.7 31919.8 32765.0 33026.5 33060.0 33075.2 9129.2 9192.1 9240.0 9244.6 9248.2 4225.5 4293.5 4310.2 4318.6 4318.9 4881.7 4935.5 4960.9 4961.3 4964.4 1015.9 1056.0 1058.1 1064.4 1064.9 562.0 564.8 566.2 571.1 585.2 11864.4 11968.9 12302.2 13547.0 13557.9 589.7 591.8 592.9 604.5 614.7 5493.9 5555.1 5640.4 5653.0 5718.7 122069.0 124748.0 125260.4 127634.0 128357.0 109034.0 110299.0 110330.0 111437.4 112527.9 92207.0 94276.0 95381.5 95717.5 97750.0 10132.3 10280.2 10305.1 10452.0 10623.1 42392.8 44140.3 44868.6 44938.0 45892.5 56326.2 56436.4 56607.2 58042.7 59023.7 15285.0 15586.6 15703.4 15733.2 15825.3 16782.6 16927.7 16989.5 17087.1 17193.1 16282.1 16475.1 16518.9 16618.1 16705.4 15999.6 16322.3 16331.5 16466.3 16484.8 15251.7 15262.6 15314.9 15392.7 15431.8 10465.8 10466.0 10559.5 10658.6 10734.2 10815.5 10930.2 10949.6 11050.9 11118.6 02:58:05 INFO - PID 10479 | -------- Summary: end -------- 02:58:05 INFO - PID 10479 | 02:58:06 INFO - TEST-INFO | 10479: exit 0 02:58:06 INFO - TEST-OK | dromaeo_css | took 1109065ms 02:58:06 INFO - TEST-START | kraken 02:58:06 INFO - Initialising browser for kraken test... 02:58:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58957/getInfo.html -profile /tmp/tmp_tLKgt/profile 02:58:06 INFO - TEST-INFO | started process 10852 (/builds/slave/test/build/application/firefox/firefox http://localhost:58957/getInfo.html) 02:58:11 INFO - TEST-INFO | 10852: exit 0 02:58:11 INFO - Browser initialized. 02:58:11 INFO - Running cycle 1/1 for kraken test... 02:58:11 INFO - Using env: {'DISPLAY': ':0', 02:58:11 INFO - 'HOME': '/home/cltbld', 02:58:11 INFO - 'JSGC_DISABLE_POISONING': '1', 02:58:11 INFO - 'LANG': 'en_US.UTF-8', 02:58:11 INFO - 'LANGUAGE': 'en_US:en', 02:58:11 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 02:58:11 INFO - 'LOGNAME': 'cltbld', 02:58:11 INFO - 'MAIL': '/var/mail/cltbld', 02:58:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:58:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:58:11 INFO - 'MOZ_CRASHREPORTER': '1', 02:58:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:11 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 02:58:11 INFO - 'MOZ_NO_REMOTE': '1', 02:58:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:58:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:11 INFO - 'NO_EM_RESTART': '1', 02:58:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:11 INFO - 'PWD': '/builds/slave/test', 02:58:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:58:11 INFO - 'RUST_BACKTRACE': 'full', 02:58:11 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:58:11 INFO - 'SHELL': '/bin/bash', 02:58:11 INFO - 'SHLVL': '1', 02:58:11 INFO - 'STYLO_FORCE_ENABLED': '1', 02:58:11 INFO - 'STYLO_THREADS': '1', 02:58:11 INFO - 'TERM': 'linux', 02:58:11 INFO - 'TMOUT': '86400', 02:58:11 INFO - 'USER': 'cltbld', 02:58:11 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1504861648.512952-963811676', 02:58:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:11 INFO - '_': '/tools/buildbot/bin/python'} 02:58:11 INFO - TEST-INFO | started process 11037 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_tLKgt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:58:12 INFO - PID 11037 | 02:58:12 INFO - PID 11037 | (/builds/slave/test/build/application/firefox/firefox:11088): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:58:12 INFO - PID 11037 | 02:58:22 INFO - PID 11037 | RSS: Main: 172408832 02:58:22 INFO - PID 11037 | 02:58:25 INFO - PID 11037 | Cycle 1(1): loaded http://localhost:58957/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58957/tests/kraken/driver.html?testName=audio-beat-detection) 02:58:26 INFO - PID 11037 | RSS: Main: 178364416 02:58:26 INFO - PID 11037 | 02:58:28 INFO - PID 11037 | Cycle 1(1): loaded http://localhost:58957/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58957/tests/kraken/driver.html?testName=audio-dft) 02:58:29 INFO - PID 11037 | RSS: Main: 179294208 02:58:29 INFO - PID 11037 | 02:58:32 INFO - PID 11037 | Cycle 1(1): loaded http://localhost:58957/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58957/tests/kraken/driver.html?testName=audio-fft) 02:58:33 INFO - PID 11037 | RSS: Main: 173506560 02:58:33 INFO - PID 11037 | 02:58:35 INFO - PID 11037 | Cycle 1(1): loaded http://localhost:58957/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58957/tests/kraken/driver.html?testName=audio-oscillator) 02:58:35 INFO - PID 11037 | RSS: Main: 174309376 02:58:35 INFO - PID 11037 | 02:58:37 INFO - PID 11037 | Cycle 1(1): loaded http://localhost:58957/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58957/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:58:38 INFO - PID 11037 | RSS: Main: 174755840 02:58:38 INFO - PID 11037 | 02:58:41 INFO - PID 11037 | Cycle 1(1): loaded http://localhost:58957/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58957/tests/kraken/driver.html?testName=imaging-darkroom) 02:58:42 INFO - PID 11037 | RSS: Main: 176992256 02:58:42 INFO - PID 11037 | 02:58:45 INFO - PID 11037 | Cycle 1(1): loaded http://localhost:58957/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58957/tests/kraken/driver.html?testName=imaging-desaturate) 02:58:46 INFO - PID 11037 | RSS: Main: 176975872 02:58:46 INFO - PID 11037 | 02:58:49 INFO - PID 11037 | Cycle 1(1): loaded http://localhost:58957/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58957/tests/kraken/driver.html?testName=json-parse-financial) 02:58:49 INFO - PID 11037 | RSS: Main: 177205248 02:58:49 INFO - PID 11037 | 02:58:51 INFO - PID 11037 | Cycle 1(1): loaded http://localhost:58957/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58957/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:58:52 INFO - PID 11037 | RSS: Main: 176898048 02:58:52 INFO - PID 11037 | 02:58:53 INFO - PID 11037 | Cycle 1(1): loaded http://localhost:58957/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58957/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:58:54 INFO - PID 11037 | RSS: Main: 177364992 02:58:54 INFO - PID 11037 | 02:58:56 INFO - PID 11037 | Cycle 1(1): loaded http://localhost:58957/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58957/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:58:57 INFO - PID 11037 | RSS: Main: 173993984 02:58:57 INFO - PID 11037 | 02:59:00 INFO - PID 11037 | Cycle 1(1): loaded http://localhost:58957/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58957/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:59:00 INFO - PID 11037 | RSS: Main: 174645248 02:59:00 INFO - PID 11037 | 02:59:03 INFO - PID 11037 | Cycle 1(1): loaded http://localhost:58957/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58957/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:59:04 INFO - PID 11037 | RSS: Main: 174284800 02:59:04 INFO - PID 11037 | 02:59:06 INFO - PID 11037 | Cycle 1(1): loaded http://localhost:58957/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58957/tests/kraken/driver.html?testName=ai-astar) 02:59:06 INFO - PID 11037 | RSS: Main: 175812608 02:59:06 INFO - PID 11037 | 02:59:06 INFO - PID 11037 | __start_tp_report 02:59:06 INFO - PID 11037 | _x_x_mozilla_page_load 02:59:06 INFO - PID 11037 | _x_x_mozilla_page_load_details 02:59:06 INFO - PID 11037 | |i|pagename|runs| 02:59:06 INFO - PID 11037 | |0;ai-astar;110;109;108;108;107;109;107;110;108;109 02:59:06 INFO - PID 11037 | |1;audio-beat-detection;121;129;119;116;124;121;119;122;115;116 02:59:06 INFO - PID 11037 | |2;audio-dft;163;162;162;163;162;161;171;168;163;167 02:59:06 INFO - PID 11037 | |3;audio-fft;73;74;74;74;73;74;72;76;82;76 02:59:06 INFO - PID 11037 | |4;audio-oscillator;80;80;79;79;79;80;79;80;81;79 02:59:06 INFO - PID 11037 | |5;imaging-gaussian-blur;117;114;115;114;114;114;113;113;113;114 02:59:06 INFO - PID 11037 | |6;imaging-darkroom;147;147;149;148;148;148;148;151;148;150 02:59:06 INFO - PID 11037 | |7;imaging-desaturate;94;94;94;94;94;94;94;101;99;100 02:59:06 INFO - PID 11037 | |8;json-parse-financial;56;58;58;53;54;53;54;54;54;55 02:59:06 INFO - PID 11037 | |9;json-stringify-tinderbox;38;42;37;38;38;38;39;38;38;38 02:59:06 INFO - PID 11037 | |10;stanford-crypto-aes;77;75;75;76;77;79;75;76;74;76 02:59:06 INFO - PID 11037 | |11;stanford-crypto-ccm;137;128;118;125;122;123;124;130;135;125 02:59:06 INFO - PID 11037 | |12;stanford-crypto-pbkdf2;169;178;172;170;167;170;181;177;171;173 02:59:06 INFO - PID 11037 | |13;stanford-crypto-sha256-iterative;67;63;64;64;65;62;67;65;71;69 02:59:06 INFO - PID 11037 | __end_tp_report 02:59:06 INFO - PID 11037 | __start_cc_report 02:59:06 INFO - PID 11037 | _x_x_mozilla_cycle_collect,966 02:59:06 INFO - PID 11037 | __end_cc_report 02:59:06 INFO - PID 11037 | __startTimestamp1504864746338__endTimestamp 02:59:06 INFO - PID 11037 | 02:59:06 INFO - PID 11037 | ------- Summary: start ------- 02:59:06 INFO - PID 11037 | Number of tests: 14 02:59:06 INFO - PID 11037 | 02:59:06 INFO - PID 11037 | [#0] ai-astar Cycles:10 Average:108.50 Median:109.00 stddev:1.08 (1.0%) stddev-sans-first:1.00 02:59:06 INFO - PID 11037 | Values: 110.0 109.0 108.0 108.0 107.0 109.0 107.0 110.0 108.0 109.0 02:59:06 INFO - PID 11037 | 02:59:06 INFO - PID 11037 | [#1] audio-beat-detection Cycles:10 Average:120.20 Median:121.00 stddev:4.24 (3.5%) stddev-sans-first:4.48 02:59:06 INFO - PID 11037 | Values: 121.0 129.0 119.0 116.0 124.0 121.0 119.0 122.0 115.0 116.0 02:59:06 INFO - PID 11037 | 02:59:06 INFO - PID 11037 | [#2] audio-dft Cycles:10 Average:164.20 Median:163.00 stddev:3.29 (2.0%) stddev-sans-first:3.46 02:59:06 INFO - PID 11037 | Values: 163.0 162.0 162.0 163.0 162.0 161.0 171.0 168.0 163.0 167.0 02:59:06 INFO - PID 11037 | 02:59:06 INFO - PID 11037 | [#3] audio-fft Cycles:10 Average:74.80 Median:74.00 stddev:2.82 (3.8%) stddev-sans-first:2.92 02:59:06 INFO - PID 11037 | Values: 73.0 74.0 74.0 74.0 73.0 74.0 72.0 76.0 82.0 76.0 02:59:06 INFO - PID 11037 | 02:59:06 INFO - PID 11037 | [#4] audio-oscillator Cycles:10 Average:79.60 Median:80.00 stddev:0.70 (0.9%) stddev-sans-first:0.73 02:59:06 INFO - PID 11037 | Values: 80.0 80.0 79.0 79.0 79.0 80.0 79.0 80.0 81.0 79.0 02:59:06 INFO - PID 11037 | 02:59:06 INFO - PID 11037 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:1.20 (1.1%) stddev-sans-first:0.67 02:59:06 INFO - PID 11037 | Values: 117.0 114.0 115.0 114.0 114.0 114.0 113.0 113.0 113.0 114.0 02:59:06 INFO - PID 11037 | 02:59:06 INFO - PID 11037 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.00 stddev:1.26 (0.9%) stddev-sans-first:1.24 02:59:06 INFO - PID 11037 | Values: 147.0 147.0 149.0 148.0 148.0 148.0 148.0 151.0 148.0 150.0 02:59:06 INFO - PID 11037 | 02:59:06 INFO - PID 11037 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:94.00 stddev:2.94 (3.1%) stddev-sans-first:3.04 02:59:06 INFO - PID 11037 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 94.0 101.0 99.0 100.0 02:59:06 INFO - PID 11037 | 02:59:06 INFO - PID 11037 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:54.50 stddev:1.85 (3.4%) stddev-sans-first:1.92 02:59:06 INFO - PID 11037 | Values: 56.0 58.0 58.0 53.0 54.0 53.0 54.0 54.0 54.0 55.0 02:59:06 INFO - PID 11037 | 02:59:06 INFO - PID 11037 | [#9] json-stringify-tinderbox Cycles:10 Average:38.40 Median:38.00 stddev:1.35 (3.6%) stddev-sans-first:1.42 02:59:06 INFO - PID 11037 | Values: 38.0 42.0 37.0 38.0 38.0 38.0 39.0 38.0 38.0 38.0 02:59:06 INFO - PID 11037 | 02:59:06 INFO - PID 11037 | [#10] stanford-crypto-aes Cycles:10 Average:76.00 Median:76.00 stddev:1.41 (1.9%) stddev-sans-first:1.45 02:59:06 INFO - PID 11037 | Values: 77.0 75.0 75.0 76.0 77.0 79.0 75.0 76.0 74.0 76.0 02:59:06 INFO - PID 11037 | 02:59:06 INFO - PID 11037 | [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:126.50 stddev:5.89 (4.7%) stddev-sans-first:4.93 02:59:06 INFO - PID 11037 | Values: 137.0 128.0 118.0 125.0 122.0 123.0 124.0 130.0 135.0 125.0 02:59:06 INFO - PID 11037 | 02:59:06 INFO - PID 11037 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.80 Median:172.50 stddev:4.47 (2.6%) stddev-sans-first:4.52 02:59:06 INFO - PID 11037 | Values: 169.0 178.0 172.0 170.0 167.0 170.0 181.0 177.0 171.0 173.0 02:59:06 INFO - PID 11037 | 02:59:06 INFO - PID 11037 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:66.00 stddev:2.79 (4.2%) stddev-sans-first:2.92 02:59:06 INFO - PID 11037 | Values: 67.0 63.0 64.0 64.0 65.0 62.0 67.0 65.0 71.0 69.0 02:59:06 INFO - PID 11037 | -------- Summary: end -------- 02:59:06 INFO - PID 11037 | 02:59:06 INFO - PID 11037 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 02:59:07 INFO - TEST-INFO | 11037: exit 0 02:59:07 INFO - TEST-OK | kraken | took 60974ms 02:59:07 INFO - SUITE-END | took 1170s 02:59:07 INFO - Completed test suite (00:19:30) 02:59:07 INFO - javascript benchmark 02:59:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8528.148450310546, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3070.524068769341, 3099.271671157277, 3108.6735892731263, 3142.9842850785744, 3153.1959350365655, 6126.111713801496, 6287.15123458333, 6325.7153428095735, 6334.271558770737, 6423.100765892773, 6230.7196176172065, 6249.406306400896, 6252.0, 6261.248650161987, 6280.434760871521, 5763.654180749148, 5766.336871259796, 5771.913421298663, 5784.508316793078, 5816.214811000525, 5808.477237048664, 5817.0983497557945, 5820.417958204188, 5825.446582574648, 5853.239078919734, 5843.328017278003, 5895.380984996578, 5905.320888097859, 5928.199693041449, 5960.731767070492, 5831.475167234969, 5864.726027397284, 5897.0, 5921.496672782819, 5981.282246130449, 5515.61390702651, 5717.342505611867, 5722.799702010409, 5782.681952492611, 5795.971020144914, 5691.174779656926, 6206.6586337751405, 6269.059641053878, 6344.6510441925675, 6349.4602958748565, 6742.4268937140405, 6757.290484499106, 6838.452923766136, 6853.451723862079, 6861.622610756406, 6635.502337324671, 6700.899486507707, 6743.662816859187, 6745.494087943375, 6791.252962174157, 6254.718537665816, 6264.812055638293, 6271.184745982993, 6273.278572964076, 6275.215598050244, 6931.965340173267, 6995.230524642286, 6995.650217489207, 7065.152181738122, 7076.504644674927, 6551.1155993941165, 6632.336766323426, 6701.363370479797, 6719.664016799141, 6745.089412929192, 6575.835604109936, 6744.763933262312, 6776.11910451648, 6824.863502730017, 6859.897101543481, 6545.476361891037, 6570.967145164339, 6572.737090516422, 6592.736290548421, 6628.900566491507, 6591.406773390418, 6624.701888415033, 6631.3700198481065, 6631.767888123893, 6635.767748128889, 5180.7150606717, 5265.947340526623, 5317.1492561190025, 5322.973385133049, 5327.493888080626, 4557.612602928788, 4621.491635920046, 4661.790219440133, 4677.742724150136, 4682.789274482657, 5637.351704553947, 5725.77096916127, 5728.742206600713, 5787.363390027093, 5794.797182098607, 6663.433608143265, 6663.533552651268, 6675.732970681119, 6676.6327851967635, 6698.5980841149685, 5639.295088113986, 5684.63049901755, 5721.342045664718, 5726.942730572724, 5730.74211660468, 5788.9131663024245, 5869.4717475427415, 5877.735501902424, 5895.115732640138, 5895.322037965603, 6521.804345869631, 6529.216494020748, 6604.570702904296, 6615.437687796495, 6619.139511863427, 6611.33886611335, 6756.932430675631, 6782.152230971129, 6867.725290988305, 6868.793936181923, 6472.967635161794, 6474.0, 6497.772577959749, 6502.479801615765, 6511.218653761579, 6616.206055273398, 6636.435902948304, 6641.302663220486, 6647.202335719551, 6667.333266673294, 6780.627065511444, 6892.172939247323, 6897.310268973062, 6908.654567271516, 6911.896321555281, 6513.54405191632, 6546.410823025951, 6586.176727909012, 6641.0038494226255, 6669.666516674244, 6520.315366886409, 6541.70562324687, 6588.736450541925, 6620.90068648961, 6623.470122390294, 6517.511186660925, 6523.412892839668, 6534.313897040743, 6537.0, 6540.542162048611, 6562.0, 6632.635205063768, 6645.966770166118, 6653.434458071119, 6713.1944166700305, 6365.490760739037, 6465.482761379172, 6468.2561505427475, 6472.385123413268, 6478.2550006749825], "value": 6137.643710087413, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [827.7268501394541, 865.6580650642996, 874.6719980007497, 875.8073223890742, 890.020976925382, 39344.40983385248, 40101.79949100254, 40169.79915100424, 40269.19461610766, 40637.59362406375, 37156.814215928884, 40158.397624035664, 40586.79706601463, 40635.0, 40788.38817417734, 7600.429967752427, 7770.4172187085915, 7771.961140194291, 7798.7660370188705, 7805.141434442206, 7597.962010189941, 7723.073231212263, 7726.768196954073, 7735.4585179037485, 7737.883931741028, 7719.845603087935, 7722.884156737653, 7723.53658780475, 7759.340456061242, 7774.416918731118, 7673.2326767323375, 7733.342665873408, 7743.0, 7746.186650401683, 7752.806179845493, 7614.428917831185, 7673.501222420525, 7684.154742978268, 7684.615769211573, 7696.769096927102, 37099.62900371016, 37113.25773484542, 37278.627213727785, 37329.81335093307, 37410.62589374099, 3558.217192217708, 3588.318219538279, 3590.317839610466, 3595.209054008114, 3597.37046016946, 29792.70207297921, 29796.70203297961, 29835.403291934257, 29931.551026734618, 29951.400971980656, 4992.475790042066, 5129.230615407681, 5149.407818100892, 5170.0, 5175.249588809602, 175908.0, 176692.1165394165, 176775.0, 178100.0, 190009.9999999986, 47366.0, 47403.28895066577, 47590.28614570784, 47692.284615730794, 47766.0, 49084.0, 49110.75444622754, 49166.50833491691, 49177.50822491729, 49225.50774492209, 15196.772048419283, 15321.540353789404, 15487.690246195012, 15501.844981550266, 15511.37954481808, 12555.372231388394, 12561.246325220516, 12568.748625027449, 12569.0, 12577.559785407468, 13387.866121338857, 13454.32728363578, 13556.322183890767, 13558.796618050737, 13634.863651363557, 5064.974675126675, 5127.359245041551, 5184.7407629618365, 5222.3733152022005, 5246.606504512177, 989.7327721515151, 1010.5604062232952, 1011.5296387179997, 1020.8366661334151, 1021.7752094539189, 22447.21434749776, 22599.661005084938, 22683.659745103836, 22823.087076516753, 22975.19586814487, 1071.3839542263229, 1093.748437859281, 1095.457748414524, 1098.0995583621514, 1110.8500352452315, 11945.16383853122, 12042.318950617886, 12090.274583525017, 12098.153129280865, 12270.018398528096, 226876.0, 227722.0, 228118.0, 228579.0, 229509.0, 49605.751971240636, 49628.25557616639, 49724.50275497271, 49730.0, 49746.25380619294, 1413.6253892718437, 1435.6052085676522, 1451.985480145206, 1457.883369330451, 1472.6612879037882, 21507.784922151204, 21778.237761678265, 22214.666779998635, 22259.220927267466, 22396.0, 35648.287034258654, 35810.64189358073, 35840.10399739923, 35898.64101358953, 35979.46030809592, 194688.0, 195311.0, 195551.0, 195749.0, 196405.0, 31676.049718508482, 32536.67463325431, 32629.34741305208, 32742.181445464055, 32826.34347313088, 40255.798721006206, 40433.39349909813, 40445.59554404418, 40513.0, 40635.0, 30184.396312074074, 30281.394372112874, 30517.542236866022, 30676.84661576678, 31079.84460077685, 30065.549016765202, 30286.939957101396, 30379.69620303857, 30386.84806575953, 31188.0, 34233.31533369368, 34336.48495272623, 34496.96509104731, 34587.827060865544, 34671.30657386889, 29699.55450668285, 29757.256068598457, 29986.0, 30092.849535752182, 30403.39193216079, 22114.44713882166, 22552.436189095402, 22609.321720348416, 22767.203147889744, 22816.885915570318], "value": 16666.378665682994, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.9145128230764, 574.9770009199632, 577.7082573300484, 578.3002566894061, 578.7222133375976, 21485.0, 22010.0, 22274.665880011813, 22293.33120006398, 22313.330600081983, 23156.65265021026, 24195.0, 24225.39436514088, 24532.264032079067, 24648.630270545957, 6435.613863168213, 6663.533552651316, 6667.233268174149, 6668.833279168035, 6675.7997260082275, 6200.193974783295, 6522.869542609145, 6592.439642630358, 6607.504437167232, 6620.668966551677, 6402.487800975934, 6411.455026322768, 6423.486121110323, 6425.164728585278, 6426.646534440627, 6432.839179020515, 6439.452646525051, 6442.162518872564, 6442.516811239176, 6444.420002199801, 5863.76544938202, 5939.910901336483, 6083.726232319512, 6106.633601983851, 6106.877862442726, 27343.86328068367, 27850.5822412664, 27868.721312787016, 27873.303167420774, 27941.580876286873, 1951.9219231230734, 1971.5563998100456, 1975.7925417831063, 1979.8515111366705, 1981.4055783264962, 18525.0, 19231.326903558307, 19295.51761205967, 19511.414657560297, 19547.804521954742, 2405.9639105413435, 2457.103157347573, 2487.3781554611346, 2501.9374515637255, 2527.2165628654993, 120864.39567802193, 126050.0, 126392.0, 126468.0, 140414.2979285097, 20047.899760501397, 20241.49396265076, 20545.48636284105, 21373.358799236048, 21440.78559214419, 39948.40077398841, 39962.80018599889, 40150.0, 40200.39699404511, 40301.79849100736, 11124.443777811077, 11133.721656958478, 11213.3832639204, 11276.379799111128, 11410.315381077162, 9357.438553686801, 9358.15776580111, 9499.38254013487, 9531.38046027006, 9584.233261339075, 11249.550017999189, 11392.601258955896, 11411.429428528707, 11453.541858325574, 11514.654560363202, 4006.358982562776, 4206.26390381682, 4207.26372884744, 4252.829886804493, 4284.357346398003, 948.7296120605732, 976.5215044628081, 980.2207245239908, 989.5448093876897, 995.2187532786728, 18732.250709971722, 19117.0, 19155.0, 19159.61680766377, 19599.804001960085, 1034.9016843399866, 1042.6663467690419, 1045.8431235314763, 1047.6647472808781, 1048.5072016152396, 10264.486775661187, 10419.895801042045, 10553.314034587727, 10633.72395312552, 10711.571537138583, 429168.0, 434705.0, 443325.0, 451891.0, 454841.0, 106724.0, 106981.46509267404, 107110.0, 109984.0, 111325.0, 1024.8513965475113, 1083.9403832789271, 1163.4182908545727, 1197.8143387774908, 1200.2678366196612, 19766.20935162635, 19889.801101989375, 20003.09986050602, 20024.59950801005, 20269.0, 54537.72731136319, 54876.0, 55115.17327240014, 55483.445165547826, 56201.156982644476, 65148.67425663031, 65450.0, 65955.0, 66142.0, 66219.0, 19317.710234346214, 19708.21167153298, 19808.0, 19852.801471985094, 19943.800561994194, 22045.559088817812, 22208.777912221318, 22343.888280558494, 22495.212667556556, 22540.32379028632, 17652.293908243526, 17921.462356129337, 18018.639627207645, 18047.097645117956, 18144.45566633003, 15450.9227453862, 16355.0, 16373.09947952874, 16392.0, 16500.17499125063, 16369.836301636831, 16545.338186472887, 16586.917065414596, 16642.916785415997, 17634.91182544079, 17620.29518819233, 17734.556636083686, 17757.200925958623, 17776.55558611045, 17805.0, 16930.153492325582, 16974.660506789547, 17018.234179461706, 17059.573510661838, 17347.219375127897], "value": 12423.368042696802, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1331.2411925202634, 1395.1629022586444, 1396.204163626732, 1403.571910567277, 1414.3918115210456, 14909.254537273133, 15515.146666933315, 15529.92235038826, 15534.533963981085, 15544.84455155448, 14996.775048374284, 15235.542933712006, 15266.923665381686, 15267.694646107071, 15268.38926442941, 2719.157061311, 2730.0308390521377, 2775.528160212769, 2776.430831679501, 2776.5557510798276, 2682.5305571525005, 2705.418335057972, 2722.5507791214427, 2724.182745176449, 2735.7127501612345, 2767.9446411071767, 2806.200232933614, 2806.873690683914, 2807.03157410694, 2810.3255218747454, 2656.9468610627873, 2689.2066840282164, 2694.6227528146073, 2707.4991126641635, 2707.796915231356, 2598.792096632265, 2609.7912167026784, 2610.582306830917, 2613.2160351894545, 2625.12058460416, 14876.851231487763, 15216.695666086727, 15242.085474871543, 15295.388184472607, 15298.847011529853, 7660.578668173248, 7979.760607181794, 7980.800479987989, 7985.5208687478935, 7988.241117093867, 5263.710286025591, 5399.83800485986, 5497.19642982078, 5582.7766889324375, 5598.720063996784, 1878.4176905159309, 1880.4264699266719, 1912.3306842605116, 1920.0687666481745, 1926.4413320137144, 25976.61035084494, 26015.349616259555, 26224.344391390176, 26233.081842135434, 26257.73742262572, 6487.091807147003, 6630.900536491957, 6721.899171512431, 6760.898586521206, 6789.219239787389, 17183.484495464905, 17282.567935801453, 17313.134343283036, 17320.480385588202, 17328.30686772515, 7696.268854458817, 7871.134175240719, 7891.171427000198, 7892.250236227549, 7900.407469439815, 7155.7794955370155, 7250.3112204340505, 7333.303336183054, 7340.0457940467395, 7347.8163045924275, 5129.333186685707, 5230.712310822942, 5264.473552644705, 5269.789208431696, 5270.156774915995, 1305.9412326445142, 1354.6545630864066, 1529.1742459071977, 1529.2888806704714, 1548.6283292009837, 850.4429598612918, 872.5898827551041, 896.2695403246333, 913.4154141349542, 915.7619019055094, 8177.304929080976, 8489.4481858679, 8550.572471376407, 8632.395732298679, 8671.956640216758, 709.7515869445652, 710.4990981358234, 767.4244316762428, 783.9098503672037, 993.6720882108887, 5018.623603229772, 5293.497117773805, 5307.681539107666, 5400.432954539795, 5562.610617256753, 20809.58380832375, 21637.78362216389, 21737.891310543346, 21813.23653672114, 21949.0, 21179.576408471745, 21685.783142168693, 21744.456388590414, 21748.673769893463, 21818.672719909213, 11174.944125279322, 11340.6030788922, 11409.714757131138, 11468.827967580326, 11485.885141148648, 8368.079511253878, 8385.161483851565, 8415.032271288881, 8437.831243374976, 8556.486610803371, 18070.367537136663, 18351.541211469284, 18493.53766155803, 18721.344752933583, 19143.0, 19124.904375478032, 19159.425217243504, 19202.0, 19275.8072419274, 19287.710684339465, 10439.634612788515, 10598.470076496298, 10609.522571484456, 10618.787624247627, 10623.628173014216, 13676.247806370347, 13863.861361386256, 13907.51323703706, 14033.087849289763, 14044.087134336236, 10243.282970192015, 10543.578256869947, 11058.060064894575, 11115.0, 11305.491252893804, 10673.146148308271, 10756.085732712494, 10819.188560858125, 10852.131829453783, 10939.124870010539, 9775.462349570842, 9903.059209375098, 9928.702138935843, 9939.105480506789, 9943.353682010646, 7436.96281518589, 7473.327400533978, 7483.780816448791, 7513.2111128330735, 7561.357284630868, 7460.7015719372785, 7488.9625551871895, 7511.32398084175, 7571.129320128035, 7669.7315593953945], "value": 6636.076737502605, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [501.3875950466026, 520.1080147546957, 522.7334059629587, 531.8085489223881, 535.8231783511441, 6317.399847014538, 6399.144248168037, 6404.935950640498, 6440.484761219103, 6450.258220304667, 6203.689815509229, 6219.129321894939, 6222.968885155579, 6238.937610623892, 6243.968780156093, 5131.846044618667, 5190.792368305263, 5216.02686468713, 5221.112410890139, 5226.111561034633, 5075.766662668414, 5153.948460515403, 5163.070647283487, 5207.557357624606, 5217.50433708797, 5096.904165604395, 5135.0, 5156.8710782230555, 5223.399309079447, 5249.790008399659, 5144.922826157611, 5163.483651634844, 5224.8693782655355, 5227.242049902781, 5250.897311564576, 4767.952320476786, 4806.591439727627, 4836.854894353175, 4841.298011788271, 4841.951580484185, 6113.694315284218, 6162.4453799157845, 6163.291221509539, 6177.351378105324, 6311.589746666498, 5903.085021821582, 5999.520038396918, 6006.579539432241, 6019.578629495937, 6071.969640151815, 6592.703328350236, 6668.366505182, 6682.532222744409, 6708.631025293607, 6753.45972322213, 5231.869203269911, 5258.947410525884, 5284.392294886099, 5285.233641122054, 5289.471052894718, 6570.269406027653, 6803.625800580966, 6853.520253582251, 6907.654617269167, 6973.79078627642, 5398.973005134949, 5432.103702888979, 5450.700211488327, 5470.261514695545, 5481.163810123573, 5461.678786515715, 5496.203050557727, 5544.500994910397, 5562.694051827108, 5564.888702225933, 5946.524278057745, 5952.583319167703, 5991.221141251696, 5993.760249589967, 6031.457168854824, 6644.83387915306, 6663.633500157441, 6684.83287917806, 6724.865502690017, 6750.594964302158, 1889.1404410992966, 1893.1859300500641, 1900.8689829551395, 1952.1215453046186, 1953.9706904396446, 1340.8602687715559, 1399.6780740429758, 1423.5658124272197, 1426.3937826423728, 1441.4594527052354, 5641.351244606841, 5678.3186017678145, 5701.666733282652, 5744.942550574524, 5786.264120763838, 6615.966920165369, 6620.834479137964, 6648.700808463631, 6665.266820649725, 6719.770018566261, 5665.405132461115, 5677.545796336283, 5678.14827775837, 5754.769809207669, 5769.807473160172, 3489.5114683944266, 3585.964140358563, 3587.551556055493, 3597.082743900341, 3604.6034936157525, 6354.4281014708895, 6367.204099487564, 6426.132472116298, 6448.709808058648, 6537.0, 6800.387965083068, 6836.794896153124, 6880.69036893331, 6942.93057069433, 6952.617606031616, 6403.519736019724, 6426.389492998158, 6483.7730679425995, 6520.18497687789, 6539.5422320438065, 6706.698198580978, 6715.3620406061345, 6752.8649427010205, 6774.187097548326, 6776.966115169393, 6605.273419923708, 6633.3035031321015, 6642.6014439133805, 6655.134832471747, 6748.628825414453, 6434.163558737334, 6486.805395838132, 6491.0, 6505.837354066186, 6518.445932095825, 5438.782448702008, 5438.972805135949, 5448.972755136199, 5452.781888724407, 5458.536024437808, 6331.2085989251345, 6609.405153536205, 6736.7642132525125, 6807.813194885209, 6816.318368163343, 6424.935750642434, 6444.9033264502, 6451.3226111257645, 6527.5757075789925, 6585.0, 6469.77355792545, 6475.111290975472, 6524.771632992823, 6545.705443254969, 6592.80221593353, 6408.839779005562, 6424.518161138027, 6496.317886622026, 6537.0, 6553.541252112497, 6539.70571324282, 6572.868542629216, 6600.372964568358, 6616.66916654175, 6651.26836048044, 6330.335314791881, 6342.016987366966, 6368.395002474757, 6396.936030639634, 6439.7424103035355], "value": 5193.11584885953, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [891.0599317719807, 908.055622152961, 912.411494585992, 913.3697748553498, 944.0323668240053, 19013.904930475346, 19632.803671963276, 19642.803571964276, 19651.5087122822, 19713.901430492846, 16564.585885352873, 16633.33466661335, 16665.33338666452, 16755.83244167558, 16766.245518951648, 948.8292107420662, 949.1931857920747, 949.9240060795154, 949.9952500237489, 952.3143336797494, 957.760559860035, 965.2374624046995, 968.6754937096081, 969.8981606931277, 970.5195928015606, 1001.5843424978625, 1005.7334806276342, 1015.1523477895965, 1033.57106800678, 1045.4041196517987, 1026.0304012707993, 1026.0765311219886, 1026.0765311219925, 1026.928115031948, 1040.032769524342, 721.6644260418931, 734.7685479074128, 745.3403737692128, 748.3377211168101, 756.2701992577189, 19851.0, 20051.498712532157, 20052.1979120835, 20058.097385617682, 20059.1976320947, 20745.8962705187, 20827.479313017146, 21952.670709939364, 22110.88944555283, 22176.667349989762, 15591.22043897812, 15599.844001559952, 15715.607109822231, 15754.606134846721, 15867.52397428079, 3819.4079917612817, 3830.636089571486, 3830.9233815323537, 3835.5972622874474, 3843.8654647087496, 104823.47588262086, 135332.32333838366, 137884.0, 141168.0, 143332.0, 17060.914695426443, 17565.560860978323, 17662.205200765995, 17681.7347739784, 17730.734038989427, 31919.840400797846, 32765.0, 33026.504602430985, 33060.0, 33075.173120671694, 9129.224015958718, 9192.126747959066, 9239.953800230956, 9244.630214791467, 9248.167664910055, 4225.471816022997, 4293.463317085364, 4310.245707001262, 4318.632916202095, 4318.913621727548, 4881.658283920163, 4935.481774413706, 4960.851174464772, 4961.305417241589, 4964.35463389757, 1015.939043657383, 1055.9894401056044, 1058.0794708603564, 1064.4039337970762, 1064.9414282214552, 561.9550435965112, 564.8136115082013, 566.1875209074908, 571.0577547047405, 585.1953563849706, 11864.406779661154, 11968.940155299342, 12302.200356976768, 13547.0, 13557.864421355858, 589.6992533807789, 591.7839988404202, 592.8517870532366, 604.5375287904757, 614.717230074162, 5493.890122197614, 5555.138953462219, 5640.407757185519, 5653.038983372837, 5718.656880587178, 122069.0, 124748.0, 125260.37369813092, 127634.0, 128357.0, 109034.0, 110299.0, 110330.0, 111437.44281278542, 112527.87472125338, 92207.0, 94276.0, 95381.52309238548, 95717.52141239388, 97750.0, 10132.290739648153, 10280.177585793268, 10305.124064454605, 10452.007059329351, 10623.097036751962, 42392.788036059625, 44140.33789493224, 44868.55131448644, 44938.0, 45892.54107459016, 56326.155107672595, 56436.435635643116, 56607.15089273747, 58042.709786450796, 59023.704881475314, 15285.0, 15586.610334741723, 15703.371865125268, 15733.213339333217, 15825.287862046465, 16782.580435488722, 16927.661446771242, 16989.49031529056, 17087.145642718064, 17193.14034298305, 16282.10448425348, 16475.093869837274, 16518.917405412896, 16618.086005269826, 16705.415310464075, 15999.600009999844, 16322.347106116098, 16331.510054698378, 16466.341346346013, 16484.83515164833, 15251.694966100395, 15262.618434539225, 15314.923425382802, 15392.692146157238, 15431.768523471932, 10465.790684186122, 10466.00572945569, 10559.472026398804, 10658.62694805678, 10734.248602597743, 10815.513301901276, 10930.234883558393, 10949.582431178358, 11050.944745276222, 11118.61084862026], "value": 8783.792990447784, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1440.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 109.0, 108.0, 108.0, 107.0, 109.0, 107.0, 110.0, 108.0, 109.0], "value": 108.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 129.0, 119.0, 116.0, 124.0, 121.0, 119.0, 122.0, 115.0, 116.0], "value": 120.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 163.0, 162.0, 161.0, 171.0, 168.0, 163.0, 167.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 74.0, 73.0, 74.0, 72.0, 76.0, 82.0, 76.0], "value": 74.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 79.0, 79.0, 79.0, 80.0, 79.0, 80.0, 81.0, 79.0], "value": 79.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 114.0, 115.0, 114.0, 114.0, 114.0, 113.0, 113.0, 113.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 149.0, 148.0, 148.0, 148.0, 148.0, 151.0, 148.0, 150.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 101.0, 99.0, 100.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 58.0, 53.0, 54.0, 53.0, 54.0, 54.0, 54.0, 55.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 42.0, 37.0, 38.0, 38.0, 38.0, 39.0, 38.0, 38.0, 38.0], "value": 38.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 76.0, 77.0, 79.0, 75.0, 76.0, 74.0, 76.0], "value": 76.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 128.0, 118.0, 125.0, 122.0, 123.0, 124.0, 130.0, 135.0, 125.0], "value": 126.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 178.0, 172.0, 170.0, 167.0, 170.0, 181.0, 177.0, 171.0, 173.0], "value": 172.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 63.0, 64.0, 64.0, 65.0, 62.0, 67.0, 65.0, 71.0, 69.0], "value": 65.7, "unit": "score"}]}]} 02:59:07 INFO - Return code: 0 02:59:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:59:07 INFO - # TBPL SUCCESS # 02:59:07 INFO - Running post-action listener: _package_coverage_data 02:59:07 INFO - Running post-action listener: _resource_record_post_action 02:59:07 INFO - [mozharness: 2017-09-08 09:59:07.611576Z] Finished run-tests step (success) 02:59:07 INFO - Running post-run listener: _resource_record_post_run 02:59:07 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 16384; Write bytes: 396423168; Read time: 88; Write time: 262716 02:59:07 INFO - TinderboxPrint: CPU usage
13.1% 02:59:07 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 88 02:59:07 INFO - TinderboxPrint: I/O write bytes / time
396,423,168 / 262,716 02:59:07 INFO - TinderboxPrint: CPU idle
8,219.9 (86.9%) 02:59:07 INFO - TinderboxPrint: CPU user
1,191.7 (12.6%) 02:59:07 INFO - TinderboxPrint: Swap in / out
0 / 0 02:59:07 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 8192; Write bytes: 112168960; Read time: 56; Write time: 77160 02:59:07 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 02:59:07 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 8192; Write bytes: 284254208; Read time: 32; Write time: 185556 02:59:08 INFO - Running post-run listener: _upload_blobber_files 02:59:08 INFO - Blob upload gear active. 02:59:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:59:08 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:59:08 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:59:08 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:59:08 INFO - (blobuploader) - INFO - Open directory for files ... 02:59:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:59:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:59:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:59:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:59:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:59:09 INFO - (blobuploader) - INFO - Done attempting. 02:59:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:59:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:59:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:59:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:59:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:59:10 INFO - (blobuploader) - INFO - Done attempting. 02:59:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:59:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:59:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:59:11 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:59:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:59:11 INFO - (blobuploader) - INFO - Done attempting. 02:59:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:59:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:59:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:59:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:59:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:59:15 INFO - (blobuploader) - INFO - Done attempting. 02:59:15 INFO - (blobuploader) - INFO - Iteration through files over. 02:59:15 INFO - Return code: 0 02:59:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:59:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:59:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4c80fc91791740d70314fafe13aeb53340994044ff42bbf688d877cdfbebe85db912374efc08ba9b50c12baf8e178dc96602b1df63fde6134be08d7de2ff53a", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f670724dbee7cb91c8680751b97d65a5a4a9a3814a00bf63dcf0b9c8dda9f0bae01bc6ead4dfb8a5952a9b342be0676a85524335c9eb5334e96942b7cffb7fcb", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/429670f90ab73fdb3eb631b76174b3c4c18c6c59f84bd953f4222966b66085f8d648fe25c729deae66f18362814bba5828c02c602a2070e2540a5dd1ea3bcdb3", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e2521c387c2afe9d4858610e378dabc9cc709907c53662fa0e8adaaec7ac9156db92931cf6c796c1573d46975723c9503793530e0bff56c77680ae1847579808"} 02:59:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:59:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:59:15 INFO - Contents: 02:59:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4c80fc91791740d70314fafe13aeb53340994044ff42bbf688d877cdfbebe85db912374efc08ba9b50c12baf8e178dc96602b1df63fde6134be08d7de2ff53a", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f670724dbee7cb91c8680751b97d65a5a4a9a3814a00bf63dcf0b9c8dda9f0bae01bc6ead4dfb8a5952a9b342be0676a85524335c9eb5334e96942b7cffb7fcb", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/429670f90ab73fdb3eb631b76174b3c4c18c6c59f84bd953f4222966b66085f8d648fe25c729deae66f18362814bba5828c02c602a2070e2540a5dd1ea3bcdb3", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e2521c387c2afe9d4858610e378dabc9cc709907c53662fa0e8adaaec7ac9156db92931cf6c796c1573d46975723c9503793530e0bff56c77680ae1847579808"} 02:59:15 INFO - Running post-run listener: copy_logs_to_upload_dir 02:59:15 INFO - Copying logs to upload dir... 02:59:15 INFO - mkdir: /builds/slave/test/build/upload/logs 02:59:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.148514 ========= master_lag: 1.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-09-08 02:59:16.075227) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-08 02:59:16.084077) ========= 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=523ca41ca1e0623de333ad52000001bf-1504861648.512952-963811676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4c80fc91791740d70314fafe13aeb53340994044ff42bbf688d877cdfbebe85db912374efc08ba9b50c12baf8e178dc96602b1df63fde6134be08d7de2ff53a", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f670724dbee7cb91c8680751b97d65a5a4a9a3814a00bf63dcf0b9c8dda9f0bae01bc6ead4dfb8a5952a9b342be0676a85524335c9eb5334e96942b7cffb7fcb", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/429670f90ab73fdb3eb631b76174b3c4c18c6c59f84bd953f4222966b66085f8d648fe25c729deae66f18362814bba5828c02c602a2070e2540a5dd1ea3bcdb3", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e2521c387c2afe9d4858610e378dabc9cc709907c53662fa0e8adaaec7ac9156db92931cf6c796c1573d46975723c9503793530e0bff56c77680ae1847579808"} build_url:https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011314 build_url: 'https://queue.taskcluster.net/v1/task/bhya0MgVT7S5tIHCfYUKiw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4c80fc91791740d70314fafe13aeb53340994044ff42bbf688d877cdfbebe85db912374efc08ba9b50c12baf8e178dc96602b1df63fde6134be08d7de2ff53a", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f670724dbee7cb91c8680751b97d65a5a4a9a3814a00bf63dcf0b9c8dda9f0bae01bc6ead4dfb8a5952a9b342be0676a85524335c9eb5334e96942b7cffb7fcb", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/429670f90ab73fdb3eb631b76174b3c4c18c6c59f84bd953f4222966b66085f8d648fe25c729deae66f18362814bba5828c02c602a2070e2540a5dd1ea3bcdb3", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e2521c387c2afe9d4858610e378dabc9cc709907c53662fa0e8adaaec7ac9156db92931cf6c796c1573d46975723c9503793530e0bff56c77680ae1847579808"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-08 02:59:16.111806) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 02:59:16.112115) ========= 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=523ca41ca1e0623de333ad52000001bf-1504861648.512952-963811676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 02:59:16.165441) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-08 02:59:16.167812) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-08 02:59:16.168181) ========= ========= Total master_lag: 1.27 =========