builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-076 starttime: 1505945125.0 results: success (0) revision: 319a34bea9e4f3459886b5b9e835bd338320f1fd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-20 15:05:24.998050) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-20 15:05:24.998477) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-20 15:05:24.998761) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-20 15:05:25.120211) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 15:05:25.120490) ========= 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=9bfb7e13875ed353a705960e000001c0-1505936161.49982-244763078 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-20 15:05:25-- 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% 99.2M=0s 2017-09-20 15:05:25 (99.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125694 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 15:05:25.299516) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 15:05:25.299832) ========= 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=9bfb7e13875ed353a705960e000001c0-1505936161.49982-244763078 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020081 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 15:05:25.368347) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-20 15:05:25.368675) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 319a34bea9e4f3459886b5b9e835bd338320f1fd --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 319a34bea9e4f3459886b5b9e835bd338320f1fd --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=9bfb7e13875ed353a705960e000001c0-1505936161.49982-244763078 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-20 15:05:25,699 truncating revision to first 12 chars 2017-09-20 15:05:25,699 Setting DEBUG logging. 2017-09-20 15:05:25,699 attempt 1/10 2017-09-20 15:05:25,699 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/319a34bea9e4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-20 15:05:26,355 unpacking tar archive at: mozilla-central-319a34bea9e4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.008528 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-20 15:05:26.415580) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-20 15:05:26.415861) ========= script_repo_revision: 319a34bea9e4f3459886b5b9e835bd338320f1fd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-20 15:05:26.416199) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-20 15:05:26.416459) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-20 15:05:26.437277) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-09-20 15:05:26.437594) ========= /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=9bfb7e13875ed353a705960e000001c0-1505936161.49982-244763078 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:05:26 INFO - MultiFileLogger online at 20170920 15:05:26 in /builds/slave/test 15:05:26 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 15:05:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:05:26 INFO - {'append_to_log': False, 15:05:26 INFO - 'base_work_dir': '/builds/slave/test', 15:05:26 INFO - 'blob_upload_branch': 'Firefox', 15:05:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:05:26 INFO - 'branch': 'Firefox', 15:05:26 INFO - 'buildbot_json_path': 'buildprops.json', 15:05:26 INFO - 'code_coverage': False, 15:05:26 INFO - 'config_files': ('talos/linux_config.py',), 15:05:26 INFO - 'default_actions': ('clobber', 15:05:26 INFO - 'read-buildbot-config', 15:05:26 INFO - 'download-and-extract', 15:05:26 INFO - 'populate-webroot', 15:05:26 INFO - 'create-virtualenv', 15:05:26 INFO - 'install', 15:05:26 INFO - 'setup-mitmproxy', 15:05:26 INFO - 'run-tests'), 15:05:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:05:26 INFO - 'disable_ccov_upload': False, 15:05:26 INFO - 'disable_stylo': False, 15:05:26 INFO - 'download_minidump_stackwalk': True, 15:05:26 INFO - 'download_symbols': 'ondemand', 15:05:26 INFO - 'enable_stylo': False, 15:05:26 INFO - 'enable_webrender': False, 15:05:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:05:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:05:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:05:26 INFO - 'gecko_profile': False, 15:05:26 INFO - 'gecko_profile_interval': 0, 15:05:26 INFO - 'installer_path': 'installer.exe', 15:05:26 INFO - 'log_level': 'info', 15:05:26 INFO - 'log_name': 'talos', 15:05:26 INFO - 'log_to_console': True, 15:05:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:05:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:05:26 INFO - 'opt_config_files': (), 15:05:26 INFO - 'pip_index': False, 15:05:26 INFO - 'suite': 'dromaeojs-e10s', 15:05:26 INFO - 'system_bits': '32', 15:05:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:05:26 INFO - 'title': 'talos-linux64-ix-076', 15:05:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:05:26 INFO - 'use_talos_json': True, 15:05:26 INFO - 'verify': 'False', 15:05:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:05:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:05:26 INFO - 'work_dir': 'build'} 15:05:26 INFO - [mozharness: 2017-09-20 22:05:26.895115Z] Running clobber step. 15:05:26 INFO - Running pre-action listener: _resource_record_pre_action 15:05:26 INFO - Running main action method: clobber 15:05:26 INFO - rmtree: /builds/slave/test/build 15:05:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:05:27 INFO - Running post-action listener: _resource_record_post_action 15:05:27 INFO - [mozharness: 2017-09-20 22:05:27.876081Z] Finished clobber step (success) 15:05:27 INFO - [mozharness: 2017-09-20 22:05:27.876178Z] Running read-buildbot-config step. 15:05:27 INFO - Running pre-action listener: _resource_record_pre_action 15:05:27 INFO - Running main action method: read_buildbot_config 15:05:27 INFO - Using buildbot properties: 15:05:27 INFO - { 15:05:27 INFO - "project": "", 15:05:27 INFO - "product": "firefox", 15:05:27 INFO - "who": "kwierso@gmail.com", 15:05:27 INFO - "installer_path": "public/build/target.tar.bz2", 15:05:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 15:05:27 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:05:27 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 15:05:27 INFO - "stage_platform": "linux64-qr", 15:05:27 INFO - "basedir": "/builds/slave/test", 15:05:27 INFO - "buildnumber": 83, 15:05:27 INFO - "platform": "ubuntu64_hw_qr", 15:05:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:05:27 INFO - "slavebuilddir": "test", 15:05:27 INFO - "taskId": "KGMpahSeT9ml8d8wf6nPvQ", 15:05:27 INFO - "branch": "mozilla-central", 15:05:27 INFO - "script_repo_revision": "production", 15:05:27 INFO - "revision": "319a34bea9e4f3459886b5b9e835bd338320f1fd", 15:05:27 INFO - "slavename": "talos-linux64-ix-076", 15:05:27 INFO - "repo_path": "mozilla-central" 15:05:27 INFO - } 15:05:27 INFO - Finding installer, test and symbols from parent task. 15:05:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KGMpahSeT9ml8d8wf6nPvQ'}, attempt #1 15:05:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KGMpahSeT9ml8d8wf6nPvQ'}, attempt #1 15:05:28 INFO - Task dependencies: So2N-P5gRV2VMrCgAQvl_g 15:05:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/So2N-P5gRV2VMrCgAQvl_g'}, attempt #1 15:05:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/So2N-P5gRV2VMrCgAQvl_g/artifacts/public/build/target.tar.bz2 15:05:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/So2N-P5gRV2VMrCgAQvl_g/artifacts/public/build/target.test_packages.json 15:05:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/So2N-P5gRV2VMrCgAQvl_g/artifacts/public/build/target.crashreporter-symbols.zip 15:05:29 INFO - Running post-action listener: _resource_record_post_action 15:05:29 INFO - [mozharness: 2017-09-20 22:05:29.254051Z] Finished read-buildbot-config step (success) 15:05:29 INFO - [mozharness: 2017-09-20 22:05:29.254269Z] Running download-and-extract step. 15:05:29 INFO - Running pre-action listener: _resource_record_pre_action 15:05:29 INFO - Running main action method: download_and_extract 15:05:29 INFO - mkdir: /builds/slave/test/build/tests 15:05:29 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')]} 15:05:29 INFO - trying https://queue.taskcluster.net/v1/task/So2N-P5gRV2VMrCgAQvl_g/artifacts/public/build/target.test_packages.json 15:05:29 INFO - Downloading https://queue.taskcluster.net/v1/task/So2N-P5gRV2VMrCgAQvl_g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:05:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/So2N-P5gRV2VMrCgAQvl_g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:05:29 INFO - Downloaded 989 bytes. 15:05:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:05:29 INFO - Using the following test package requirements: 15:05:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:05:29 INFO - u'common': [u'target.common.tests.zip'], 15:05:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:05:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:05:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:05:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:05:29 INFO - u'mozbase': [u'target.common.tests.zip'], 15:05:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:05:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:05:29 INFO - u'web-platform': [u'target.common.tests.zip', 15:05:29 INFO - u'target.web-platform.tests.tar.gz'], 15:05:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:05:29 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 15:05:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/So2N-P5gRV2VMrCgAQvl_g/artifacts/public/build/target.common.tests.zip 15:05:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/So2N-P5gRV2VMrCgAQvl_g/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:05:29 INFO - Fetch https://queue.taskcluster.net/v1/task/So2N-P5gRV2VMrCgAQvl_g/artifacts/public/build/target.common.tests.zip into memory 15:05:31 INFO - Content-Length response header: 54732410 15:05:31 INFO - Bytes received: 54732410 15:05:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/So2N-P5gRV2VMrCgAQvl_g/artifacts/public/build/target.talos.tests.zip 15:05:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/So2N-P5gRV2VMrCgAQvl_g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:05:42 INFO - Fetch https://queue.taskcluster.net/v1/task/So2N-P5gRV2VMrCgAQvl_g/artifacts/public/build/target.talos.tests.zip into memory 15:05:42 INFO - Content-Length response header: 14512509 15:05:42 INFO - Bytes received: 14512509 15:05:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:43 INFO - trying https://queue.taskcluster.net/v1/task/So2N-P5gRV2VMrCgAQvl_g/artifacts/public/build/target.tar.bz2 15:05:43 INFO - Downloading https://queue.taskcluster.net/v1/task/So2N-P5gRV2VMrCgAQvl_g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:05:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/So2N-P5gRV2VMrCgAQvl_g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:05:44 INFO - Downloaded 61645932 bytes. 15:05:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/So2N-P5gRV2VMrCgAQvl_g/artifacts/public/build/target.tar.bz2 15:05:44 INFO - mkdir: /builds/slave/test/properties 15:05:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:05:44 INFO - Writing to file /builds/slave/test/properties/build_url 15:05:44 INFO - Contents: 15:05:44 INFO - build_url:https://queue.taskcluster.net/v1/task/So2N-P5gRV2VMrCgAQvl_g/artifacts/public/build/target.tar.bz2 15:05:44 INFO - Running post-action listener: _resource_record_post_action 15:05:44 INFO - Running post-action listener: find_tests_for_verification 15:05:44 INFO - Running post-action listener: set_extra_try_arguments 15:05:44 INFO - [mozharness: 2017-09-20 22:05:44.342115Z] Finished download-and-extract step (success) 15:05:44 INFO - [mozharness: 2017-09-20 22:05:44.342225Z] Running populate-webroot step. 15:05:44 INFO - Running pre-action listener: _resource_record_pre_action 15:05:44 INFO - Running main action method: populate_webroot 15:05:44 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:05:44 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:05:44 INFO - 'tests': ['tresize', 15:05:44 INFO - 'tcanvasmark']}, 15:05:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:05:44 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:05:44 INFO - 'tests': ['dromaeo_css', 15:05:44 INFO - 'kraken']}, 15:05:44 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:05:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:05:44 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:05:44 INFO - 'talos_options': ['--disable-stylo'], 15:05:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:05:44 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:05:44 INFO - 'tests': ['damp', 'tps']}, 15:05:44 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:05:44 INFO - 'talos_options': ['--disable-stylo'], 15:05:44 INFO - 'tests': ['damp', 'tps']}, 15:05:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:05:44 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:05:44 INFO - 'tests': ['dromaeo_dom']}, 15:05:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:05:44 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:05:44 INFO - 'tests': ['basic_compositor_video', 15:05:44 INFO - 'glvideo']}, 15:05:44 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:05:44 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:05:44 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:05:44 INFO - 'talos_options': ['--disable-stylo'], 15:05:44 INFO - 'tests': ['ts_paint_webext', 15:05:44 INFO - 'tp5o_webext']}, 15:05:44 INFO - 'other-e10s': {'tests': ['a11yr', 15:05:44 INFO - 'ts_paint', 15:05:44 INFO - 'tpaint', 15:05:44 INFO - 'sessionrestore', 15:05:44 INFO - 'sessionrestore_many_windows', 15:05:44 INFO - 'sessionrestore_no_auto_restore', 15:05:44 INFO - 'tabpaint']}, 15:05:44 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:05:44 INFO - 'tests': ['a11yr', 15:05:44 INFO - 'ts_paint', 15:05:44 INFO - 'tpaint', 15:05:44 INFO - 'sessionrestore', 15:05:44 INFO - 'sessionrestore_many_windows', 15:05:44 INFO - 'sessionrestore_no_auto_restore', 15:05:44 INFO - 'tabpaint']}, 15:05:44 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 15:05:44 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 15:05:44 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:05:44 INFO - 'tests': ['perf_reftest_singletons']}, 15:05:44 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:05:44 INFO - 'tests': ['bloom_basic']}, 15:05:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:05:44 INFO - 'tsvgr_opacity', 15:05:44 INFO - 'tart', 15:05:44 INFO - 'tscrollx', 15:05:44 INFO - 'tsvg_static']}, 15:05:44 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:05:44 INFO - 'tests': ['tsvgx', 15:05:44 INFO - 'tsvgr_opacity', 15:05:44 INFO - 'tart', 15:05:44 INFO - 'tscrollx', 15:05:44 INFO - 'tsvg_static']}, 15:05:44 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:05:44 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:05:44 INFO - 'talos_options': ['--disable-stylo'], 15:05:44 INFO - 'tests': ['tp5o']}, 15:05:44 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:05:44 INFO - 'talos_options': ['--mitmproxy', 15:05:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:05:44 INFO - '--firstNonBlankPaint'], 15:05:44 INFO - 'tests': ['tp6_google', 15:05:44 INFO - 'tp6_youtube', 15:05:44 INFO - 'tp6_amazon', 15:05:44 INFO - 'tp6_facebook']}, 15:05:44 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:05:44 INFO - 'talos_options': ['--disable-stylo', 15:05:44 INFO - '--mitmproxy', 15:05:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:05:44 INFO - '--firstNonBlankPaint'], 15:05:44 INFO - 'tests': ['tp6_google', 15:05:44 INFO - 'tp6_youtube', 15:05:44 INFO - 'tp6_amazon', 15:05:44 INFO - 'tp6_facebook']}, 15:05:44 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:05:44 INFO - 'talos_options': ['--stylo-threads=1', 15:05:44 INFO - '--mitmproxy', 15:05:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:05:44 INFO - '--firstNonBlankPaint'], 15:05:44 INFO - 'tests': ['tp6_google', 15:05:44 INFO - 'tp6_youtube', 15:05:44 INFO - 'tp6_amazon', 15:05:44 INFO - 'tp6_facebook']}, 15:05:44 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:05:44 INFO - 'talos_options': ['--xperf_path', 15:05:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:05:44 INFO - 'tests': ['tp5n']}, 15:05:44 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:05:44 INFO - 'talos_options': ['--disable-stylo', 15:05:44 INFO - '--xperf_path', 15:05:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:05:44 INFO - 'tests': ['tp5n']}}} 15:05:44 INFO - Running post-action listener: _resource_record_post_action 15:05:44 INFO - [mozharness: 2017-09-20 22:05:44.359818Z] Finished populate-webroot step (success) 15:05:44 INFO - [mozharness: 2017-09-20 22:05:44.359922Z] Running create-virtualenv step. 15:05:44 INFO - Running pre-action listener: _resource_record_pre_action 15:05:44 INFO - Running main action method: create_virtualenv 15:05:44 INFO - Creating virtualenv /builds/slave/test/build/venv 15:05:44 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:05:44 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:05:44 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:05:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:05:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:05:45 INFO - Installing distribute.............................................................................................................................................................................................done. 15:05:45 INFO - Installing pip...............done. 15:05:45 INFO - Return code: 0 15:05:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:05:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:05:45 INFO - Reading from file tmpfile_stdout 15:05:45 INFO - Output received: 15:05:45 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 15:05:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:05:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22781f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2441a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e8090>, '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 0x25e8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e2f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505936161.49982-244763078', '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 15:05:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:05:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:05:45 INFO - Using env: {'DISPLAY': ':0', 15:05:45 INFO - 'HOME': '/home/cltbld', 15:05:45 INFO - 'LANG': 'en_US.UTF-8', 15:05:45 INFO - 'LANGUAGE': 'en_US:en', 15:05:45 INFO - 'LOGNAME': 'cltbld', 15:05:45 INFO - 'MAIL': '/var/mail/cltbld', 15:05:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:45 INFO - 'MOZ_NO_REMOTE': '1', 15:05:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:45 INFO - 'NO_EM_RESTART': '1', 15:05:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:45 INFO - 'PWD': '/builds/slave/test', 15:05:45 INFO - 'SHELL': '/bin/bash', 15:05:45 INFO - 'SHLVL': '1', 15:05:45 INFO - 'TERM': 'linux', 15:05:45 INFO - 'TMOUT': '86400', 15:05:45 INFO - 'USER': 'cltbld', 15:05:45 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505936161.49982-244763078', 15:05:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:45 INFO - '_': '/tools/buildbot/bin/python'} 15:05:47 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:05:47 INFO - Downloading/unpacking pip>=1.5 15:05:47 INFO - Running setup.py egg_info for package pip 15:05:47 INFO - warning: no files found matching 'pip/cacert.pem' 15:05:47 INFO - warning: no files found matching '*.html' under directory 'docs' 15:05:47 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:05:47 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:05:47 INFO - Installing collected packages: pip 15:05:47 INFO - Found existing installation: pip 1.1 15:05:47 INFO - Uninstalling pip: 15:05:47 INFO - Successfully uninstalled pip 15:05:47 INFO - Running setup.py install for pip 15:05:47 INFO - warning: no files found matching 'pip/cacert.pem' 15:05:47 INFO - warning: no files found matching '*.html' under directory 'docs' 15:05:47 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:05:47 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:05:47 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:05:47 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:05:47 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:05:47 INFO - Successfully installed pip 15:05:47 INFO - Cleaning up... 15:05:47 INFO - Return code: 0 15:05:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:05:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:47 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 0x22781f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2441a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e8090>, '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 0x25e8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e2f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505936161.49982-244763078', '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 15:05:47 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 15:05:47 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 15:05:47 INFO - Using env: {'DISPLAY': ':0', 15:05:47 INFO - 'HOME': '/home/cltbld', 15:05:47 INFO - 'LANG': 'en_US.UTF-8', 15:05:47 INFO - 'LANGUAGE': 'en_US:en', 15:05:47 INFO - 'LOGNAME': 'cltbld', 15:05:47 INFO - 'MAIL': '/var/mail/cltbld', 15:05:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:47 INFO - 'MOZ_NO_REMOTE': '1', 15:05:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:47 INFO - 'NO_EM_RESTART': '1', 15:05:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:47 INFO - 'PWD': '/builds/slave/test', 15:05:47 INFO - 'SHELL': '/bin/bash', 15:05:47 INFO - 'SHLVL': '1', 15:05:47 INFO - 'TERM': 'linux', 15:05:47 INFO - 'TMOUT': '86400', 15:05:47 INFO - 'USER': 'cltbld', 15:05:47 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505936161.49982-244763078', 15:05:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:47 INFO - '_': '/tools/buildbot/bin/python'} 15:05:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:47 INFO - Downloading/unpacking psutil>=3.1.1 15:05:47 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 15:05:47 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 15:05:47 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 15:05:47 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 15:05:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:05:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:05:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:05:48 INFO - Installing collected packages: psutil 15:05:48 INFO - Running setup.py install for psutil 15:05:48 INFO - building 'psutil._psutil_linux' extension 15:05:48 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 15:05:48 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 15:05:48 INFO - building 'psutil._psutil_posix' extension 15:05:48 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 15:05:48 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 15:05:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:05:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:05:49 INFO - Successfully installed psutil 15:05:49 INFO - Cleaning up... 15:05:49 INFO - Return code: 0 15:05:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:05:49 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')]} 15:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:49 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')]} 15:05:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:49 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 0x22781f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2441a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e8090>, '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 0x25e8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e2f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505936161.49982-244763078', '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 15:05:49 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 15:05:49 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 15:05:49 INFO - Using env: {'DISPLAY': ':0', 15:05:49 INFO - 'HOME': '/home/cltbld', 15:05:49 INFO - 'LANG': 'en_US.UTF-8', 15:05:49 INFO - 'LANGUAGE': 'en_US:en', 15:05:49 INFO - 'LOGNAME': 'cltbld', 15:05:49 INFO - 'MAIL': '/var/mail/cltbld', 15:05:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:49 INFO - 'MOZ_NO_REMOTE': '1', 15:05:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:49 INFO - 'NO_EM_RESTART': '1', 15:05:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:49 INFO - 'PWD': '/builds/slave/test', 15:05:49 INFO - 'SHELL': '/bin/bash', 15:05:49 INFO - 'SHLVL': '1', 15:05:49 INFO - 'TERM': 'linux', 15:05:49 INFO - 'TMOUT': '86400', 15:05:49 INFO - 'USER': 'cltbld', 15:05:49 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505936161.49982-244763078', 15:05:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:49 INFO - '_': '/tools/buildbot/bin/python'} 15:05:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:05:49 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 15:05:49 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 15:05:49 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 15:05:49 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 15:05:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:05:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:05:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:05:50 INFO - Installing collected packages: mozsystemmonitor 15:05:50 INFO - Running setup.py install for mozsystemmonitor 15:05:50 INFO - Successfully installed mozsystemmonitor 15:05:50 INFO - Cleaning up... 15:05:52 INFO - Return code: 0 15:05:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22781f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2441a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e8090>, '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 0x25e8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e2f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505936161.49982-244763078', '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 15:05:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:05:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:05:52 INFO - Using env: {'DISPLAY': ':0', 15:05:52 INFO - 'HOME': '/home/cltbld', 15:05:52 INFO - 'LANG': 'en_US.UTF-8', 15:05:52 INFO - 'LANGUAGE': 'en_US:en', 15:05:52 INFO - 'LOGNAME': 'cltbld', 15:05:52 INFO - 'MAIL': '/var/mail/cltbld', 15:05:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:52 INFO - 'MOZ_NO_REMOTE': '1', 15:05:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:52 INFO - 'NO_EM_RESTART': '1', 15:05:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:52 INFO - 'PWD': '/builds/slave/test', 15:05:52 INFO - 'SHELL': '/bin/bash', 15:05:52 INFO - 'SHLVL': '1', 15:05:52 INFO - 'TERM': 'linux', 15:05:52 INFO - 'TMOUT': '86400', 15:05:52 INFO - 'USER': 'cltbld', 15:05:52 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505936161.49982-244763078', 15:05:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:52 INFO - '_': '/tools/buildbot/bin/python'} 15:05:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:52 INFO - Downloading/unpacking jsonschema==2.5.1 15:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:05:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:53 INFO - Downloading functools32-3.2.3-2.tar.gz 15:05:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:05:53 INFO - warning: no files found matching '*.txt' 15:05:53 INFO - no previously-included directories found matching 'build' 15:05:53 INFO - no previously-included directories found matching 'dist' 15:05:53 INFO - no previously-included directories found matching '.git*' 15:05:53 INFO - Installing collected packages: jsonschema, functools32 15:05:54 INFO - Running setup.py install for functools32 15:05:54 INFO - warning: no files found matching '*.txt' 15:05:54 INFO - no previously-included directories found matching 'build' 15:05:54 INFO - no previously-included directories found matching 'dist' 15:05:54 INFO - no previously-included directories found matching '.git*' 15:05:54 INFO - Successfully installed jsonschema functools32 15:05:54 INFO - Cleaning up... 15:05:54 INFO - Return code: 0 15:05:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:05:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x22781f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2441a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e8090>, '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 0x25e8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e2f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505936161.49982-244763078', '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 15:05:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:05:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:05:54 INFO - Using env: {'DISPLAY': ':0', 15:05:54 INFO - 'HOME': '/home/cltbld', 15:05:54 INFO - 'LANG': 'en_US.UTF-8', 15:05:54 INFO - 'LANGUAGE': 'en_US:en', 15:05:54 INFO - 'LOGNAME': 'cltbld', 15:05:54 INFO - 'MAIL': '/var/mail/cltbld', 15:05:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:54 INFO - 'MOZ_NO_REMOTE': '1', 15:05:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:54 INFO - 'NO_EM_RESTART': '1', 15:05:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:54 INFO - 'PWD': '/builds/slave/test', 15:05:54 INFO - 'SHELL': '/bin/bash', 15:05:54 INFO - 'SHLVL': '1', 15:05:54 INFO - 'TERM': 'linux', 15:05:54 INFO - 'TMOUT': '86400', 15:05:54 INFO - 'USER': 'cltbld', 15:05:54 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505936161.49982-244763078', 15:05:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:54 INFO - '_': '/tools/buildbot/bin/python'} 15:05:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:05:54 INFO - Cleaning up... 15:05:54 INFO - Return code: 0 15:05:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:05:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22781f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2441a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e8090>, '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 0x25e8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e2f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505936161.49982-244763078', '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 15:05:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:05:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:05:54 INFO - Using env: {'DISPLAY': ':0', 15:05:54 INFO - 'HOME': '/home/cltbld', 15:05:54 INFO - 'LANG': 'en_US.UTF-8', 15:05:54 INFO - 'LANGUAGE': 'en_US:en', 15:05:54 INFO - 'LOGNAME': 'cltbld', 15:05:54 INFO - 'MAIL': '/var/mail/cltbld', 15:05:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:54 INFO - 'MOZ_NO_REMOTE': '1', 15:05:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:54 INFO - 'NO_EM_RESTART': '1', 15:05:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:54 INFO - 'PWD': '/builds/slave/test', 15:05:54 INFO - 'SHELL': '/bin/bash', 15:05:54 INFO - 'SHLVL': '1', 15:05:54 INFO - 'TERM': 'linux', 15:05:54 INFO - 'TMOUT': '86400', 15:05:54 INFO - 'USER': 'cltbld', 15:05:54 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505936161.49982-244763078', 15:05:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:54 INFO - '_': '/tools/buildbot/bin/python'} 15:05:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:54 INFO - Downloading/unpacking blobuploader==1.2.4 15:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:55 INFO - Downloading blobuploader-1.2.4.tar.gz 15:05:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:05:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:05:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:05:56 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 15:05:56 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 15:05:56 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 15:05:56 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 15:05:56 INFO - Downloading docopt-0.6.1.tar.gz 15:05:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:05:56 INFO - Installing collected packages: blobuploader, requests, docopt 15:05:56 INFO - Running setup.py install for blobuploader 15:05:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:05:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:05:56 INFO - Running setup.py install for requests 15:05:56 INFO - Running setup.py install for docopt 15:05:56 INFO - Successfully installed blobuploader requests docopt 15:05:56 INFO - Cleaning up... 15:05:56 INFO - Return code: 0 15:05:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:05:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22781f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2441a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e8090>, '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 0x25e8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e2f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505936161.49982-244763078', '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 15:05:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:05:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:05:56 INFO - Using env: {'DISPLAY': ':0', 15:05:56 INFO - 'HOME': '/home/cltbld', 15:05:56 INFO - 'LANG': 'en_US.UTF-8', 15:05:56 INFO - 'LANGUAGE': 'en_US:en', 15:05:56 INFO - 'LOGNAME': 'cltbld', 15:05:56 INFO - 'MAIL': '/var/mail/cltbld', 15:05:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:56 INFO - 'MOZ_NO_REMOTE': '1', 15:05:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:56 INFO - 'NO_EM_RESTART': '1', 15:05:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:56 INFO - 'PWD': '/builds/slave/test', 15:05:56 INFO - 'SHELL': '/bin/bash', 15:05:56 INFO - 'SHLVL': '1', 15:05:56 INFO - 'TERM': 'linux', 15:05:56 INFO - 'TMOUT': '86400', 15:05:56 INFO - 'USER': 'cltbld', 15:05:56 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505936161.49982-244763078', 15:05:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:56 INFO - '_': '/tools/buildbot/bin/python'} 15:05:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:05:57 INFO - Running setup.py (path:/tmp/pip-liS0DA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:05:57 INFO - Running setup.py (path:/tmp/pip-ub5pJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:05:57 INFO - Running setup.py (path:/tmp/pip-LVVKHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:05:57 INFO - Running setup.py (path:/tmp/pip-9PmjsV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:05:57 INFO - Running setup.py (path:/tmp/pip-PHp7dp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:05:57 INFO - Running setup.py (path:/tmp/pip-i1oAos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:05:57 INFO - Running setup.py (path:/tmp/pip-CoEWBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:05:57 INFO - Running setup.py (path:/tmp/pip-DaoGWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:05:57 INFO - Running setup.py (path:/tmp/pip-88NvQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:05:57 INFO - Running setup.py (path:/tmp/pip-boiUIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:05:57 INFO - Running setup.py (path:/tmp/pip-yMi1nI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:05:57 INFO - Running setup.py (path:/tmp/pip-nmuELZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:05:57 INFO - Running setup.py (path:/tmp/pip-vXdk3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:05:57 INFO - Running setup.py (path:/tmp/pip-85M8W6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:05:58 INFO - Running setup.py (path:/tmp/pip-aDlfHt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:05:58 INFO - Running setup.py (path:/tmp/pip-9WzH7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:05:58 INFO - Running setup.py (path:/tmp/pip-3nVQ9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:05:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:05:58 INFO - Running setup.py install for manifestparser 15:05:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:05:58 INFO - Running setup.py install for mozcrash 15:05:58 INFO - Running setup.py install for mozdebug 15:05:58 INFO - Running setup.py install for mozdevice 15:05:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:05:58 INFO - Running setup.py install for mozfile 15:05:58 INFO - Running setup.py install for mozhttpd 15:05:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:05:58 INFO - Running setup.py install for mozinfo 15:05:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:05:58 INFO - Running setup.py install for mozInstall 15:05:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:05:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:05:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:05:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:05:59 INFO - Running setup.py install for mozleak 15:05:59 INFO - Running setup.py install for mozlog 15:05:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:05:59 INFO - Running setup.py install for moznetwork 15:05:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:05:59 INFO - Running setup.py install for mozprocess 15:05:59 INFO - Running setup.py install for mozprofile 15:05:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:05:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:05:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:05:59 INFO - Running setup.py install for mozrunner 15:05:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:05:59 INFO - Running setup.py install for mozscreenshot 15:05:59 INFO - Running setup.py install for moztest 15:05:59 INFO - Running setup.py install for mozversion 15:06:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:06:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:06:00 INFO - Cleaning up... 15:06:00 INFO - Return code: 0 15:06:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:00 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 0x22781f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2441a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e8090>, '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 0x25e8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e2f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505936161.49982-244763078', '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 15:06:00 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 15:06:00 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 15:06:00 INFO - Using env: {'DISPLAY': ':0', 15:06:00 INFO - 'HOME': '/home/cltbld', 15:06:00 INFO - 'LANG': 'en_US.UTF-8', 15:06:00 INFO - 'LANGUAGE': 'en_US:en', 15:06:00 INFO - 'LOGNAME': 'cltbld', 15:06:00 INFO - 'MAIL': '/var/mail/cltbld', 15:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:00 INFO - 'MOZ_NO_REMOTE': '1', 15:06:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:00 INFO - 'NO_EM_RESTART': '1', 15:06:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:00 INFO - 'PWD': '/builds/slave/test', 15:06:00 INFO - 'SHELL': '/bin/bash', 15:06:00 INFO - 'SHLVL': '1', 15:06:00 INFO - 'TERM': 'linux', 15:06:00 INFO - 'TMOUT': '86400', 15:06:00 INFO - 'USER': 'cltbld', 15:06:00 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505936161.49982-244763078', 15:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:00 INFO - '_': '/tools/buildbot/bin/python'} 15:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:06:00 INFO - Running setup.py (path:/tmp/pip-QFoVxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:06:00 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)) 15:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:06:00 INFO - Running setup.py (path:/tmp/pip-uaCGCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:06:00 INFO - Running setup.py (path:/tmp/pip-p0w5PB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:06:00 INFO - Running setup.py (path:/tmp/pip-q16VVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:06:00 INFO - Running setup.py (path:/tmp/pip-i9Z4A4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:06:00 INFO - Running setup.py (path:/tmp/pip-xeXm65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:06:00 INFO - Running setup.py (path:/tmp/pip-WpcS76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:06:00 INFO - Running setup.py (path:/tmp/pip-0FBjwj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:06:00 INFO - Running setup.py (path:/tmp/pip-Kc9MJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:06:00 INFO - Running setup.py (path:/tmp/pip-Ic40qH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:06:00 INFO - Running setup.py (path:/tmp/pip-6s7EH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:06:01 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)) 15:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:06:01 INFO - Running setup.py (path:/tmp/pip-kP9HQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:06:01 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)) 15:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:06:01 INFO - Running setup.py (path:/tmp/pip-_tecXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:06:01 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)) 15:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:06:01 INFO - Running setup.py (path:/tmp/pip-bpvPji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:06:01 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)) 15:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:06:01 INFO - Running setup.py (path:/tmp/pip-rFzW9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:06:01 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)) 15:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:06:01 INFO - Running setup.py (path:/tmp/pip-PqYVtU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:06:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:06:01 INFO - Running setup.py (path:/tmp/pip-R9OaDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:06:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:06:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:06:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:06:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:06:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:06:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:06:01 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:06:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:02 INFO - Downloading blessings-1.6.tar.gz 15:06:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:06:02 INFO - Installing collected packages: blessings 15:06:02 INFO - Running setup.py install for blessings 15:06:02 INFO - Successfully installed blessings 15:06:02 INFO - Cleaning up... 15:06:02 INFO - Return code: 0 15:06:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:06:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:06:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:06:03 INFO - Reading from file tmpfile_stdout 15:06:03 INFO - Current package versions: 15:06:03 INFO - argparse == 1.2.1 15:06:03 INFO - blessings == 1.6 15:06:03 INFO - blobuploader == 1.2.4 15:06:03 INFO - docopt == 0.6.1 15:06:03 INFO - functools32 == 3.2.3-2 15:06:03 INFO - jsonschema == 2.5.1 15:06:03 INFO - manifestparser == 1.1 15:06:03 INFO - mozInstall == 1.13 15:06:03 INFO - mozcrash == 1.0 15:06:03 INFO - mozdebug == 0.1 15:06:03 INFO - mozdevice == 0.51 15:06:03 INFO - mozfile == 1.2 15:06:03 INFO - mozhttpd == 0.7 15:06:03 INFO - mozinfo == 0.10 15:06:03 INFO - mozleak == 0.1 15:06:03 INFO - mozlog == 3.5 15:06:03 INFO - moznetwork == 0.27 15:06:03 INFO - mozprocess == 0.25 15:06:03 INFO - mozprofile == 0.28 15:06:03 INFO - mozrunner == 6.13 15:06:03 INFO - mozscreenshot == 0.1 15:06:03 INFO - mozsystemmonitor == 0.3 15:06:03 INFO - moztest == 0.8 15:06:03 INFO - mozversion == 1.4 15:06:03 INFO - psutil == 3.1.1 15:06:03 INFO - requests == 1.2.3 15:06:03 INFO - wsgiref == 0.1.2 15:06:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:06: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')]} 15:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06: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')]} 15:06:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:03 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 0x22781f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2441a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e8090>, '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 0x25e8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e2f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505936161.49982-244763078', '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 15:06:03 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 15:06:03 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 15:06:03 INFO - Using env: {'DISPLAY': ':0', 15:06:03 INFO - 'HOME': '/home/cltbld', 15:06:03 INFO - 'LANG': 'en_US.UTF-8', 15:06:03 INFO - 'LANGUAGE': 'en_US:en', 15:06:03 INFO - 'LOGNAME': 'cltbld', 15:06:03 INFO - 'MAIL': '/var/mail/cltbld', 15:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:03 INFO - 'MOZ_NO_REMOTE': '1', 15:06:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:03 INFO - 'NO_EM_RESTART': '1', 15:06:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:03 INFO - 'PWD': '/builds/slave/test', 15:06:03 INFO - 'SHELL': '/bin/bash', 15:06:03 INFO - 'SHLVL': '1', 15:06:03 INFO - 'TERM': 'linux', 15:06:03 INFO - 'TMOUT': '86400', 15:06:03 INFO - 'USER': 'cltbld', 15:06:03 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505936161.49982-244763078', 15:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:03 INFO - '_': '/tools/buildbot/bin/python'} 15:06:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:03 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)) 15:06:03 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)) 15:06:03 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)) 15:06:03 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)) 15:06:03 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)) 15:06:03 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)) 15:06:03 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)) 15:06:03 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)) 15:06:03 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)) 15:06:03 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:06: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 15:06: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 15:06: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 15:06: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 15:06:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:06:04 INFO - Installing collected packages: simplejson 15:06:04 INFO - Running setup.py install for simplejson 15:06:04 INFO - building 'simplejson._speedups' extension 15:06:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 15:06:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 15:06:05 INFO - Successfully installed simplejson 15:06:05 INFO - Cleaning up... 15:06:05 INFO - Return code: 0 15:06:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:06: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')]} 15:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06: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')]} 15:06:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22781f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2441a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e8090>, '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 0x25e8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e2f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505936161.49982-244763078', '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 15:06:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:06:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:06:05 INFO - Using env: {'DISPLAY': ':0', 15:06:05 INFO - 'HOME': '/home/cltbld', 15:06:05 INFO - 'LANG': 'en_US.UTF-8', 15:06:05 INFO - 'LANGUAGE': 'en_US:en', 15:06:05 INFO - 'LOGNAME': 'cltbld', 15:06:05 INFO - 'MAIL': '/var/mail/cltbld', 15:06:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:05 INFO - 'MOZ_NO_REMOTE': '1', 15:06:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:05 INFO - 'NO_EM_RESTART': '1', 15:06:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:05 INFO - 'PWD': '/builds/slave/test', 15:06:05 INFO - 'SHELL': '/bin/bash', 15:06:05 INFO - 'SHLVL': '1', 15:06:05 INFO - 'TERM': 'linux', 15:06:05 INFO - 'TMOUT': '86400', 15:06:05 INFO - 'USER': 'cltbld', 15:06:05 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505936161.49982-244763078', 15:06:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:05 INFO - '_': '/tools/buildbot/bin/python'} 15:06:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:06:05 INFO - Cleaning up... 15:06:05 INFO - Return code: 0 15:06:05 INFO - Running post-action listener: _resource_record_post_action 15:06:05 INFO - Running post-action listener: _start_resource_monitoring 15:06:05 INFO - Starting resource monitoring. 15:06:05 INFO - [mozharness: 2017-09-20 22:06:05.852593Z] Finished create-virtualenv step (success) 15:06:05 INFO - [mozharness: 2017-09-20 22:06:05.853080Z] Running install step. 15:06:05 INFO - Running pre-action listener: _resource_record_pre_action 15:06:05 INFO - Running main action method: install 15:06:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:06:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:06:06 INFO - Reading from file tmpfile_stdout 15:06:06 INFO - Detecting whether we're running mozinstall >=1.0... 15:06:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:06:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:06:06 INFO - Reading from file tmpfile_stdout 15:06:06 INFO - Output received: 15:06:06 INFO - Usage: mozinstall [options] installer 15:06:06 INFO - Options: 15:06:06 INFO - -h, --help show this help message and exit 15:06:06 INFO - -d DEST, --destination=DEST 15:06:06 INFO - Directory to install application into. [default: 15:06:06 INFO - "/builds/slave/test"] 15:06:06 INFO - --app=APP Application being installed. [default: firefox] 15:06:06 INFO - mkdir: /builds/slave/test/build/application 15:06:06 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'] 15:06:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:06:24 INFO - Reading from file tmpfile_stdout 15:06:24 INFO - Output received: 15:06:24 INFO - /builds/slave/test/build/application/firefox/firefox 15:06:24 INFO - Running post-action listener: _resource_record_post_action 15:06:24 INFO - [mozharness: 2017-09-20 22:06:24.216320Z] Finished install step (success) 15:06:24 INFO - [mozharness: 2017-09-20 22:06:24.216465Z] Running setup-mitmproxy step. 15:06:24 INFO - Running pre-action listener: _resource_record_pre_action 15:06:24 INFO - Running main action method: setup_mitmproxy 15:06:24 INFO - Skipping: mitmproxy is not required 15:06:24 INFO - Running post-action listener: _resource_record_post_action 15:06:24 INFO - [mozharness: 2017-09-20 22:06:24.217016Z] Finished setup-mitmproxy step (success) 15:06:24 INFO - [mozharness: 2017-09-20 22:06:24.217145Z] Running run-tests step. 15:06:24 INFO - Running pre-action listener: _resource_record_pre_action 15:06:24 INFO - Running pre-action listener: _set_gcov_prefix 15:06:24 INFO - Running main action method: run_tests 15:06:24 WARNING - Try message not found. 15:06:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:06:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:06:24 INFO - Python 2.7.3 15:06:24 INFO - Return code: 0 15:06:24 INFO - grabbing minidump binary from tooltool 15:06:24 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')]} 15:06:24 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 0x25e8090>, '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 0x25e8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e2f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:06:24 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 15:06:24 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 15:06:24 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 15:06:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:06:24 INFO - Return code: 0 15:06:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:06:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:06:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:06:24 INFO - ENV: RUST_BACKTRACE is now full 15:06:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:06:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:06:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/So2N-P5gRV2VMrCgAQvl_g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--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 15:06:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/So2N-P5gRV2VMrCgAQvl_g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-076 --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 15:06:24 INFO - Using env: {'DISPLAY': ':0', 15:06:24 INFO - 'HOME': '/home/cltbld', 15:06:24 INFO - 'LANG': 'en_US.UTF-8', 15:06:24 INFO - 'LANGUAGE': 'en_US:en', 15:06:24 INFO - 'LOGNAME': 'cltbld', 15:06:24 INFO - 'MAIL': '/var/mail/cltbld', 15:06:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:06:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:06:24 INFO - 'MOZ_ACCELERATED': '1', 15:06:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:24 INFO - 'MOZ_NO_REMOTE': '1', 15:06:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:06:24 INFO - 'MOZ_WEBRENDER': '1', 15:06:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:24 INFO - 'NO_EM_RESTART': '1', 15:06:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:24 INFO - 'PWD': '/builds/slave/test', 15:06:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:06:24 INFO - 'RUST_BACKTRACE': 'full', 15:06:24 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:06:24 INFO - 'SHELL': '/bin/bash', 15:06:24 INFO - 'SHLVL': '1', 15:06:24 INFO - 'TERM': 'linux', 15:06:24 INFO - 'TMOUT': '86400', 15:06:24 INFO - 'USER': 'cltbld', 15:06:24 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505936161.49982-244763078', 15:06:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:24 INFO - '_': '/tools/buildbot/bin/python'} 15:06:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/So2N-P5gRV2VMrCgAQvl_g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--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 15:06:24 INFO - mozversion application_buildid: 20170920210755 15:06:24 INFO - mozversion application_changeset: 319a34bea9e4f3459886b5b9e835bd338320f1fd 15:06:24 INFO - mozversion application_display_name: Nightly 15:06:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:06:24 INFO - mozversion application_name: Firefox 15:06:24 INFO - mozversion application_remotingname: firefox 15:06:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:06:24 INFO - mozversion application_vendor: Mozilla 15:06:24 INFO - mozversion application_version: 57.0a1 15:06:24 INFO - mozversion platform_buildid: 20170920210755 15:06:24 INFO - mozversion platform_changeset: 319a34bea9e4f3459886b5b9e835bd338320f1fd 15:06:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:06:24 INFO - mozversion platform_version: 57.0a1 15:06:24 INFO - using testdate: 1505945184 15:06:24 INFO - actual date: 1505945184 15:06:24 INFO - starting webserver on 'localhost:38383' 15:06:24 INFO - SUITE-START | Running 2 tests 15:06:24 INFO - TEST-START | dromaeo_css 15:06:24 INFO - Initialising browser for dromaeo_css test... 15:06:24 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38383/getInfo.html -profile /tmp/tmpwfylHZ/profile 15:06:24 INFO - TEST-INFO | started process 13282 (/builds/slave/test/build/application/firefox/firefox http://localhost:38383/getInfo.html) 15:06:32 INFO - TEST-INFO | 13282: exit 0 15:06:32 INFO - Browser initialized. 15:06:32 INFO - Running cycle 1/1 for dromaeo_css test... 15:06:32 INFO - Using env: {'DISPLAY': ':0', 15:06:32 INFO - 'HOME': '/home/cltbld', 15:06:32 INFO - 'JSGC_DISABLE_POISONING': '1', 15:06:32 INFO - 'LANG': 'en_US.UTF-8', 15:06:32 INFO - 'LANGUAGE': 'en_US:en', 15:06:32 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:06:32 INFO - 'LOGNAME': 'cltbld', 15:06:32 INFO - 'MAIL': '/var/mail/cltbld', 15:06:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:06:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:06:32 INFO - 'MOZ_ACCELERATED': '1', 15:06:32 INFO - 'MOZ_CRASHREPORTER': '1', 15:06:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:32 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:06:32 INFO - 'MOZ_NO_REMOTE': '1', 15:06:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:06:32 INFO - 'MOZ_WEBRENDER': '1', 15:06:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:32 INFO - 'NO_EM_RESTART': '1', 15:06:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:32 INFO - 'PWD': '/builds/slave/test', 15:06:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:06:32 INFO - 'RUST_BACKTRACE': 'full', 15:06:32 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:06:32 INFO - 'SHELL': '/bin/bash', 15:06:32 INFO - 'SHLVL': '1', 15:06:32 INFO - 'TERM': 'linux', 15:06:32 INFO - 'TMOUT': '86400', 15:06:32 INFO - 'USER': 'cltbld', 15:06:32 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505936161.49982-244763078', 15:06:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:32 INFO - '_': '/tools/buildbot/bin/python'} 15:06:32 INFO - TEST-INFO | started process 13527 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwfylHZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:06:33 INFO - PID 13527 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 15:06:33 INFO - PID 13527 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 15:06:33 INFO - PID 13527 | 15:06:33 INFO - PID 13527 | (/builds/slave/test/build/application/firefox/firefox:13589): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:06:33 INFO - PID 13527 | 15:06:43 INFO - PID 13527 | RSS: Main: 183447552 15:06:43 INFO - PID 13527 | 15:09:40 INFO - PID 13527 | Cycle 1(1): loaded http://localhost:38383/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38383/tests/dromaeo/cssquery-ext.html) 15:09:42 INFO - PID 13527 | RSS: Main: 191356928 15:09:42 INFO - PID 13527 | 15:12:44 INFO - PID 13527 | Cycle 1(1): loaded http://localhost:38383/tests/dromaeo/cssquery-ext.html (next: http://localhost:38383/tests/dromaeo/cssquery-jquery.html) 15:12:45 INFO - PID 13527 | RSS: Main: 191430656 15:12:45 INFO - PID 13527 | 15:15:47 INFO - PID 13527 | Cycle 1(1): loaded http://localhost:38383/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38383/tests/dromaeo/cssquery-mootools.html) 15:15:48 INFO - PID 13527 | RSS: Main: 190652416 15:15:48 INFO - PID 13527 | 15:18:50 INFO - PID 13527 | Cycle 1(1): loaded http://localhost:38383/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38383/tests/dromaeo/cssquery-prototype.html) 15:18:50 INFO - PID 13527 | RSS: Main: 190414848 15:18:50 INFO - PID 13527 | 15:21:54 INFO - PID 13527 | Cycle 1(1): loaded http://localhost:38383/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38383/tests/dromaeo/cssquery-yui.html) 15:21:55 INFO - PID 13527 | RSS: Main: 188301312 15:21:55 INFO - PID 13527 | 15:24:56 INFO - PID 13527 | Cycle 1(1): loaded http://localhost:38383/tests/dromaeo/cssquery-yui.html (next: http://localhost:38383/tests/dromaeo/cssquery-dojo.html) 15:24:57 INFO - PID 13527 | RSS: Main: 193855488 15:24:57 INFO - PID 13527 | 15:24:57 INFO - PID 13527 | __start_tp_report 15:24:57 INFO - PID 13527 | _x_x_mozilla_page_load 15:24:57 INFO - PID 13527 | _x_x_mozilla_page_load_details 15:24:57 INFO - PID 13527 | |i|pagename|runs| 15:24:57 INFO - PID 13527 | |0;dojo.html;3085.5063189889593;3120.2355422921387;3146.2134466383404;3160.2415420299135;3170.4134735074012;6172.074188871671;6246.593971391862;6301.621902685831;6323.905141422877;6337.144485494457;6214.7203375848085;6215.875682486348;6273.153124328214;6276.623402595847;6308.053791931201;5765.394633563478;5794.913076303858;5811.970940145315;5853.765849366042;5906.291245050578;5873.148393482942;5902.586818922677;5920.378360272152;5938.61399009063;5943.970280148593;5727.198192253088;5742.4831765141125;5781.330044115964;5829.213056237396;5940.6435613863305;5442.12925931851;5811.883762324772;5855.736491857834;5943.108533719955;5955;5695.7152142392715;5710.857228569277;5739.053056245714;5752.856178595527;5761.769529218826;6199.597026193283;6273.686315684243;6294.99280115184;6336.239651241881;6357.777477788301;6765.661716914135;6766.391024807791;6836.863262734718;6864.141982252218;6867.381935625767;6673.833154171136;6744.865102697919;6818.181818181801;6846.691898864513;6897.931020689829;6179.752809887599;6199.721012554446;6217.160683307741;6220.502359811204;6230.657313847737;6769.356911093439;6791.660416979132;6862.279460656659;6872.725090996404;6885.896711549331;6641.501887358468;6699.9665001674675;6718.731250750013;6735.797926062226;6753.831154221184;6680.699368528428;6789.6605169741315;6870.587764734132;6872.10662613857;6881.208661004049;6748.426383757337;6752.527323087336;6759.425448836806;6805.353491418307;6823.078884350549;6725.495587830932;6733.427658648971;6749.291324410866;6773.356531129535;6800.65996700163;5222.582193424517;5287.576993840484;5297.708626025606;5306.018386598492;5306.257124002643;4581.266997280486;4591.44902611682;4644.373009643722;4648.907021859612;4651.790669419885;5637.633553818989;5765.971170144123;5794.710264486759;5797.855053623609;5812;6840.863182736317;6858.211305699909;6875.346842049998;6880.621565813928;6881.036654868322;5859.589828711949;5859.589828712034;5860.941390586039;5891.293044834647;5895.970520147372;5710.114932185518;5793.391693872167;5874.970625146847;5878.706064696748;5919.67441790697;6529.608223506605;6535.183102112236;6559.737610495622;6603.966980165068;6637.900431493532;6659.733610655519;6749.932500675127;6828.146481689789;6907.585544867324;6907.965460172667;6469.967650161907;6551.475881929339;6557.049227862029;6561.540692151503;6591.868162636816;6719;6751.966240168964;6784.6946887389195;6793.864122717617;6800.659967001531;6832.077669514552;6838.760643377458;6841.350071743176;6929.995150703221;6957.582545047313;6452.419282264619;6487.740490380332;6518.152640156749;6575.375339342755;6675.065490831191;6459.4832413405875;6463.709133088928;6520.673966301761;6526.184226971629;6540.803775886731;6501;6501.8699626008165;6521.087047813215;6549.836254093686;6587.242467116343;6614.074029635951;6687.565308254948;6690.933090669031;6696.933030669826;6717.193936727624;6329.841753956188;6342.8731425370315;6371.171747672958;6415.647139407378;6430.903536446864 15:24:57 INFO - PID 13527 | |1;ext.html;881.4755220643717;887.9245264152547;898.0077014898537;902.2150728865888;908.9909100908993;39016.41475377868;42801.78599107004;42834.78582607082;42863.99999999996;42939.14121717564;38148;38213.23573528535;38452.615473845326;38541.614583854156;38546.22907541847;7181.4254859611365;7247.20280769115;7258.600776957265;7323.670434830418;7851.21487851216;7926.762197134095;8031.477953932976;8032.437729358947;8036.07585127709;8049;7960.960195199045;7968.561729104897;8004.63979120941;8027.197280271956;8043.316318112968;7886.960565197194;7935.523868567904;7999.480033797843;8004.279614834663;8033.517988920654;7796.181400952875;7940.285374316281;7943.602819858984;8006.759797206093;8018.959905200437;38008.80995595032;38199.236015279814;38235;38330.80834595809;38358.23283534341;3502.7548071634997;3533.876314329012;3557.2351944331836;3582.731295152874;3587.4798154267487;30980.380392392028;31180.220494487592;31193.37613247745;31322.686773132205;31398.529022064686;5201.271821944931;5237.266782650432;5279.234510995922;5297.549708274802;5387.057264978613;191392;191623;192724;193456.9999999986;193709;42057.158856823306;48627.756861215465;48722;49155.75422122938;49388.259176112384;45215;45492.772536137105;52960.735196323774;53184.468155317954;53719.731401342746;15767.7385809135;15891.364345426286;15899.125548094966;15932.761008584881;15957.122358270175;12843.678908027186;12859.678508037186;12932.288724120264;12944.417501212469;12974.80537791934;14502.637434064021;14527.418903243752;14699.412023519153;14718.541396831766;14727.852721472862;5697.686627235542;5703.800366987136;5785.566082543826;5855.648661080349;5943.286805583358;995.7659949911765;999.9650012249537;1034.715453250362;1036.18659352408;1050.4275170032352;23104.4223894404;23112.768872311062;23117.768822311562;23299.650505242436;23614.527709446058;1127.3405058041137;1128.5598616539555;1132.445101900063;1142.331735934471;1144;12071;12546.309952952675;12573.87426125727;12643.747125057631;12700.110992230455;224164;225284;225758;225865;225993;52759;53147.468525315024;53244.46755532473;53453.732731336095;53543.46456535385;1431.806706094664;1467.9045862018934;1476.1615819995643;1486.472302332678;1488.1889370293216;22772.544549109258;22789.88605056964;23174.768252317263;23229.186978455673;23350.416239594146;37388.252234954605;37510.43734343933;37638.059048524;37851.432228517144;37869.43195852119;192028;193435;193458;194198;195283;30571.847140765043;31425.371492570477;34012.48981265233;34541.65458345384;34552;43615;43746.34380484359;43954;44066.779666102746;44787.104257915315;31766.682333176374;32179.839100804347;32372.190695232806;32449.351012979136;32697.836510817295;31144.532832007084;31237.425802876744;31726.841365793025;31815;31984.68015319817;35619.46570801492;35854.28291434104;35893.28213435665;36014.09964750902;36047.81976090208;30990.22524436817;31345.059648209677;31405.528917065807;31503.369932600763;31539.21151971219;23361.299161025196;23445.413864652837;23587.29238122859;23603.40991475227;23877.880610596836 15:24:57 INFO - PID 13527 | |2;jquery.html;567.9602427830054;570.9771609135635;574.7844558290641;581.1457157977774;595.1429940885125;21792.89103554482;22516.662250066263;22621.321360359216;22773.772262277373;22851.085956561717;23593.292201233948;24114.51770964584;24453.633195502083;24868.50262994739;25085.49829003419;6561.967190164054;6735.057092007123;6738.326167383247;6739.730410783563;6765.627890466022;6558.442532384729;6678.432333251655;6706.1952565691945;6714.328567143295;6726.192856857184;6138.386161383871;6446.226452825667;6465.612063276195;6482.448991835699;6495.155629768124;6450.967745161268;6486.383793539653;6494.383033611799;6528.902066469007;6573.901391479131;6061.878552467808;6071.1803906472505;6071.301800292978;6087.178230938811;6114.082887566856;27249.45501089967;27510.17469475919;27960;27987.44025119486;28300.433991320264;2003.1286390420214;2046.723692301535;2048.702938073971;2053.5276886316233;2065.855390122692;18324.816751832444;18938.52653683669;18947.43157705257;18969.43091707251;19003.714944275845;2402;2418.310781427285;2465.5438743832447;2477.19491165372;2481.565725997943;121355.39322303332;128455;135138;144412.99999999895;144440;14623.976321657594;14703.411863525553;14725.631859203606;14947.70104597902;14958.626034349229;22825.657615135788;22922.885385572965;22956.081756729876;22974;22998.770012299996;9925.156361709336;9993;10017.749556261151;10026.498675066363;10114.949425252973;9096.226820720312;9321;9362.485063321446;9412.576434060484;9446.244300455946;8790.736277911545;8847.380683352103;8965.910340896638;9049.547522623843;9055.68305109318;2607.1657069737503;2670.919872403831;2675.2375572961614;2691.757741803247;2691.792729961413;945.933784635069;947.9383840050375;954.1651055326589;988.4711679251566;994.4580203788952;18798;18873.811261887204;18955.526111847314;19165;19327.323543675902;999.7403271877487;1033.338663255517;1045.6706137566641;1045.7398834404523;1048.9318194317498;10182.592696292213;10198.235132364955;10508.422036787897;10549.789004219872;10739.979701928305;439712;460500;465213;466893;484324;110917.44541277403;111420.44289778662;113128;115246.42376788062;115456.42271788587;1046.9267151299337;1119.1270808769173;1148.1044785067493;1188.3285943441754;1197.592818441734;19196.808031919503;19698.31055913036;19716.21135154578;19852.305169319003;19876.10557524886;53869.461305386445;54012;54650.72674636601;54813.725931370085;56059.43940560542;72023.63988180025;72166;72612.63693681498;73574.26425735674;73979;13536.661583460098;13897.16617002983;13928;14028.719425611635;14059.156450612996;19898.70151947751;21535.2462663806;21611.98430247592;21752.12991480323;21918.89040554787;16677.49967500977;16827.831721682625;16906.154692265092;17662.293508259525;17859.821401785815;15391.84608153904;15611.687766244384;15771.44799931997;16116.435924742578;16312.755308670143;17836.91081544584;18122.637547249244;18289.725654115464;18296.72554911651;18322.725159122358;13933.512327068504;13934.651633709238;13951.093178943742;13969.441222350992;13981.580552583031;16464.917675411547;17368.56578585495;17373;17374.73937890958;17627.294908203527 15:24:57 INFO - PID 13527 | |3;mootools.html;1306.6276111308275;1346.2864681718693;1363.0390574644875;1375.1770079179878;1379.3103448275863;12701.809472857904;13284.667883302922;13337.7332453351;13351.666208344795;15480.845191548082;15595.922020389882;15627.531174064796;15712.921435392836;15766.921165394186;15842.603934901634;2754.1049159023296;2804.4110736745306;2821.8165819221786;2823.477656633519;2823.731745484186;2696.245051385605;2701.75684188423;2771.88912443503;2783.6520434945633;2826.7455928966388;2749.8625068746583;2754.4628797384516;2766.585012248159;2775.3339198592294;2783;2684.7986401019903;2726.9318267043286;2727.386338073937;2743.3553115017953;2750.3261700883213;2662.2412612405565;2690.9730902690917;2715.3618899558587;2717.6331195288776;2719.0891051497774;15059.17174555399;15319.080855148726;15322.15728134952;15340.769888451681;15382.769258461132;8012;8264.462809917337;8350.373721970876;8352.8329433411;8366.163383661646;5250.606204534637;5499.560035197174;5561.721913904288;5643.5203007743985;5659.60382773206;1793.2737241417246;1809.9276028958825;1868.0472958790979;1888.5750706091158;2012.094557449139;26216.86891565549;27047.323816904536;27055.86472067647;27075.45849083027;27116;6695.129633147757;6910.965445172843;6966.303369663095;7061.152661680529;7123.572585644878;17064.2321095551;17069.57326066858;17072.57318567046;17122.914385427994;17138.457538821567;7678.57767822764;7768.184340644264;7782.727604533814;7827.099883513469;7853.842923141505;7093.113360829896;7250.16623088341;7313.451491138186;7338.082739657543;7413.777586672409;5093.643444958817;5252.579793616502;5285.286486324374;5341.305630268041;5355.161764264946;1498.7077519883735;1507.4573153664671;1517.248961763934;1545.5054382597461;1550.4805890026967;903.1239697493421;903.2773780975193;915.5422288855572;924.3021518753433;927.0590350793949;7670.693172273158;7741.690332386642;7816.179301173295;7830.960845195737;7839.25527074927;711.6833009310807;716.8924661300742;717.5766297884273;722.4148439763808;739.0429393934867;4608.5852273294895;4627.467841198238;4642.558956899089;4669.743164125938;5037.420696619935;21358.572828543343;22020.33938981833;22125.66811497829;22519.662205066936;22592.66111008336;21019.264325748525;21727.891360543097;21817.23639672604;22014.119435222412;22171.55656886853;11003.22977391575;11165.888341116648;11221.831672524919;11368.602098926498;11399.601013964637;8611.13888611134;8621.741347759576;8621.87067194005;8628.956855215683;8643.351748618754;18720.344787932358;18856.622867542847;19249.51876203106;19255.8074419254;19726;19721.506962326057;19848;20134.89932550328;20311.187552497733;20565.691514626993;11147.163962702667;11179.88820111821;11229.831552526883;11353.886461135284;11366.033887119356;14000.43998240059;14178;14186.787198191829;14196.645083872985;14198.361073751912;11591.88408115908;11604.245724027911;11653.417329133339;11803.468843902217;11931.642050738492;11223.775524489627;11258.437078145897;11404.315741055563;11551.075913926697;11734.589289374831;9451.338406311766;9485.288603354638;9488.478133702713;9515.714528564155;9560.426374417557;7055.61194134307;7088.645567721696;7209.783706488814;7289.4168466523615;7299.233580473974;7152.6781294842895;7249;7258.0927384076995;7263.709451622088;7278.818029549304 15:24:57 INFO - PID 13527 | |4;prototype.html;483.91289567877766;513.3813754425917;516.6486788983491;519.4000928927088;523.4163907243425;6237.349126621185;6313.337099604544;6385.712642931067;6386;6428.228612566487;6162.168107305512;6205.379462053804;6211.192544969159;6260.499160067195;6292.842678933018;5101.897962040766;5127.230915362707;5145.845624631267;5181.792728290864;5206.609504287175;5118.820841270556;5178.1197196476505;5181.740912954356;5198.584113270948;5199.2461093141665;5102.69383836971;5121.206213036985;5146.716930568818;5151.484851514837;5164.380274367062;4771.809127634908;5003.5997120230295;5027.416363845377;5029.705542869427;5062.848114556569;4444.911101777979;4505.301678239878;4509;4530.75080870552;4534.88662783433;5938.495227905633;6060.2424696912885;6076.149339092531;6155.692215389213;6160.353162917874;5553.611247212697;5650.943490565124;5677.034904066319;5731.971340143273;5756.366799652035;6556.672166391709;6612.504062195355;6623.933760662379;6638.73445062197;6683.598984060924;4854.902901941941;4865.683730557503;4886.218205087204;4920.188168952154;4926.866820631239;6640.236372817139;6740.191177058784;6796.25241223465;6851.725930962805;6859.9314006860295;4967.801287948441;4987.850364489072;5026.944341688213;5029.723365214948;5076.949230507647;5006.3992320921;5068.315777370008;5101.795928162906;5102.617303702237;5115.335006449212;5567.4432556744005;5613.270274864241;5644.887102258014;5694.515966142924;5721.313442386941;6503.447206987365;6628.33716628343;6637.269900311058;6684.565503242274;6689.832754181184;1730.195459111519;1777.4667599720033;1778.084286592406;1779.9555011124826;1784.9464516064538;1163.0753550927034;1212.4483360071147;1236.208826351136;1238.2756087688622;1240.4418011894504;5663.971680141655;5714.399988001283;5719.227904232958;5726.656400615976;5740.913886291709;6637.46900247979;6654.767083152066;6680.766173183915;6708.746258064834;6782.287859774751;5638.774449022075;5690.146478028329;5691.743871525791;5695.373508914016;5759.568032397587;3558.484019817112;3571.5714114306447;3576.801771406556;3602.45963105531;3606.8998955318357;6468.482521398277;6480.287168411471;6486.935130648633;6533.281339052701;6535.8692826143215;6883.552569083094;6887.724491020404;6957.60847830436;6989.580625162506;7005.824854378681;6070.7875224366935;6307.432331090224;6413.45485633717;6430.421262086435;6434.903476447951;6504.7315773423725;6681.69932353055;6683.460285091634;6742.157230346207;6761.628110453972;6656.667166641745;6697.497687673346;6761.22245941723;6783;6824.146981627297;6359.141515895295;6414.871702566016;6465.870682586228;6519.706613202323;6591.274959754519;5026.899462010666;5036.093503169464;5063.898722025612;5064.518870707277;5065;6387.840303992437;6681.832954176184;6727.192736871607;6841.657917104026;6857.485688573277;6358.650274234961;6469.644169570531;6505.642189679613;6524.217093948757;6589.80230593083;6486.2216534016225;6520.478361730955;6555.4427873631275;6560.901586476302;6574.27682954865;6361.363863613602;6471.579347342407;6491.545591808717;6503.479721622353;6512;6390.827118779637;6529.779874842387;6601.240857301472;6641.546395874022;6684.43182329488;6380.138681278154;6424.325445828121;6473.643949582818;6476.773312934025;6481.805545833632 15:24:57 INFO - PID 13527 | |5;yui.html;875.6628697951287;894.883665123534;911.1890417528397;918.6049998500646;935.9953200233998;19218.61562768744;20195;20267.290644827433;20280.89859550702;20341.084651190697;18077.63844723105;18536.90731546344;18603.534911627215;18650;18913.527161820963;957.3155194036262;972.8589354543587;974.5030034682292;974.6783561424749;974.8878878928907;963.6868017894212;966.3911735606558;975.34651783305;977.1157102821923;979.9755006124833;994.2344394815988;1026.4508487958944;1028.8662473878423;1029.9124574411185;1049.1659130990881;1005.557554675944;1013.1995723378523;1013.3919648211088;1017.4302390661217;1018.1956254558927;726.7456390263366;739.8668239716849;747.4618274842105;750.8761054426013;752.2139364364252;20026.499337516678;20369.4907627309;20584.79415205844;20587.691184632244;20653.27713530034;18848.246070157176;19169.616607667907;19196.328128515575;19409.80590194094;19575.80424195754;15830.76253856193;16182.75725864113;16275.267612957445;16299.348026078942;16430.096344701036;3720.4233343831747;3728.198437335986;3756.5679946806194;3765.265773174232;3773.3773927301963;135482;137543.31228343793;140583.29708351495;140660;142146.57853421438;15685.215739212994;15757.842421575637;15911.602209944613;16180.190990450667;16227.269772860249;29968.100956971324;29982.70017299799;31336.37327253442;31420.214494637818;31499.37001259962;9011.594478248495;9047.095290470901;9098.727038188865;9115.635374584943;9118.86321705175;4467.955320446819;4572.268437050123;4576.725396476222;4579.473360563511;4583.679142460062;5447.509724124848;5449.4005659377435;5484.177373393943;5511.3937466878615;5565.860853478614;939.5959737313021;958.8274110660009;975.4391225045628;977.237754551451;986.413084214891;682.2529330383222;707.6214225389494;711.1040089487283;714.7677004973405;719.1406269507888;11733.647990560297;11894.226875253255;12009.09931755122;12426.486333056278;12505.499780008699;695.9130108736408;696.1646024770296;700.0479348086598;702.9543079699803;714.3071220915704;5452.91820622691;5561.138023606348;5576.163575463713;5636.070048441961;5649.491545760901;126110.36944815217;127304.36347818201;127744.36127819301;128442;128519.35740321239;108475.45762271139;111340.44329778299;111525;112343.99999999837;114610;95828;95987;97049.5147524272;97212.51393743127;98529.50735246278;9922.553485093043;10182.389056656624;10187.847182292124;10216.335938163995;10268.794624107626;44011.01950412175;44147.77926110349;44251.557484424746;45345.319820202065;46548.30177547272;58207.70896145492;58839.41160588339;59025;59113.70443147929;60790.696046519486;15312;15369.615759606098;15471.922640387176;15547.455839045579;15550.377984880479;16423.67152656964;16563.751543727096;16643.91678041602;16688.582785430463;16795.244214010156;13687.178769273876;13718;13769.931150344584;14003.22982235946;14022.439102435788;13442.596722098353;13447.529336473177;13542.458301667823;13563.254021028939;13681.315934203449;13395.598132056053;13402.798958015443;13447.327633618475;13560.59318220455;13580.728385432434;11317.943410282896;11334.546618135182;11537.826932596186;11677.76644467123;11718.589849355232;11707.707307317385;11911.3448760319;12088.576899808464;12118.575849845212;12154 15:24:57 INFO - PID 13527 | __end_tp_report 15:24:57 INFO - PID 13527 | __start_cc_report 15:24:57 INFO - PID 13527 | _x_x_mozilla_cycle_collect,281 15:24:57 INFO - PID 13527 | __end_cc_report 15:24:57 INFO - PID 13527 | __startTimestamp1505946297198__endTimestamp 15:24:57 INFO - PID 13527 | 15:24:57 INFO - PID 13527 | ------- Summary: start ------- 15:24:57 INFO - PID 13527 | Number of tests: 6 15:24:57 INFO - PID 13527 | 15:24:57 INFO - PID 13527 | [#0] dojo.html Cycles:165 Average:6219.07 Median:6463.71 stddev:758.94 (11.7%) stddev-sans-first:720.36 15:24:57 INFO - PID 13527 | Values: 3085.5 3120.2 3146.2 3160.2 3170.4 6172.1 6246.6 6301.6 6323.9 6337.1 6214.7 6215.9 6273.2 6276.6 6308.1 5765.4 5794.9 5812.0 5853.8 5906.3 5873.1 5902.6 5920.4 5938.6 5944.0 5727.2 5742.5 5781.3 5829.2 5940.6 5442.1 5811.9 5855.7 5943.1 5955.0 5695.7 5710.9 5739.1 5752.9 5761.8 6199.6 6273.7 6295.0 6336.2 6357.8 6765.7 6766.4 6836.9 6864.1 6867.4 6673.8 6744.9 6818.2 6846.7 6897.9 6179.8 6199.7 6217.2 6220.5 6230.7 6769.4 6791.7 6862.3 6872.7 6885.9 6641.5 6700.0 6718.7 6735.8 6753.8 6680.7 6789.7 6870.6 6872.1 6881.2 6748.4 6752.5 6759.4 6805.4 6823.1 6725.5 6733.4 6749.3 6773.4 6800.7 5222.6 5287.6 5297.7 5306.0 5306.3 4581.3 4591.4 4644.4 4648.9 4651.8 5637.6 5766.0 5794.7 5797.9 5812.0 6840.9 6858.2 6875.3 6880.6 6881.0 5859.6 5859.6 5860.9 5891.3 5896.0 5710.1 5793.4 5875.0 5878.7 5919.7 6529.6 6535.2 6559.7 6604.0 6637.9 6659.7 6749.9 6828.1 6907.6 6908.0 6470.0 6551.5 6557.0 6561.5 6591.9 6719.0 6752.0 6784.7 6793.9 6800.7 6832.1 6838.8 6841.4 6930.0 6957.6 6452.4 6487.7 6518.2 6575.4 6675.1 6459.5 6463.7 6520.7 6526.2 6540.8 6501.0 6501.9 6521.1 6549.8 6587.2 6614.1 6687.6 6690.9 6696.9 6717.2 6329.8 6342.9 6371.2 6415.6 6430.9 15:24:57 INFO - PID 13527 | 15:24:57 INFO - PID 13527 | [#1] ext.html Cycles:180 Average:37295.34 Median:19588.35 stddev:52910.54 (270.1%) stddev-sans-first:52988.32 15:24:57 INFO - PID 13527 | Values: 881.5 887.9 898.0 902.2 909.0 39016.4 42801.8 42834.8 42864.0 42939.1 38148.0 38213.2 38452.6 38541.6 38546.2 7181.4 7247.2 7258.6 7323.7 7851.2 7926.8 8031.5 8032.4 8036.1 8049.0 7961.0 7968.6 8004.6 8027.2 8043.3 7887.0 7935.5 7999.5 8004.3 8033.5 7796.2 7940.3 7943.6 8006.8 8019.0 38008.8 38199.2 38235.0 38330.8 38358.2 3502.8 3533.9 3557.2 3582.7 3587.5 30980.4 31180.2 31193.4 31322.7 31398.5 5201.3 5237.3 5279.2 5297.5 5387.1 191392.0 191623.0 192724.0 193457.0 193709.0 42057.2 48627.8 48722.0 49155.8 49388.3 45215.0 45492.8 52960.7 53184.5 53719.7 15767.7 15891.4 15899.1 15932.8 15957.1 12843.7 12859.7 12932.3 12944.4 12974.8 14502.6 14527.4 14699.4 14718.5 14727.9 5697.7 5703.8 5785.6 5855.6 5943.3 995.8 1000.0 1034.7 1036.2 1050.4 23104.4 23112.8 23117.8 23299.7 23614.5 1127.3 1128.6 1132.4 1142.3 1144.0 12071.0 12546.3 12573.9 12643.7 12700.1 224164.0 225284.0 225758.0 225865.0 225993.0 52759.0 53147.5 53244.5 53453.7 53543.5 1431.8 1467.9 1476.2 1486.5 1488.2 22772.5 22789.9 23174.8 23229.2 23350.4 37388.3 37510.4 37638.1 37851.4 37869.4 192028.0 193435.0 193458.0 194198.0 195283.0 30571.8 31425.4 34012.5 34541.7 34552.0 43615.0 43746.3 43954.0 44066.8 44787.1 31766.7 32179.8 32372.2 32449.4 32697.8 31144.5 31237.4 31726.8 31815.0 31984.7 35619.5 35854.3 35893.3 36014.1 36047.8 30990.2 31345.1 31405.5 31503.4 31539.2 23361.3 23445.4 23587.3 23603.4 23877.9 15:24:57 INFO - PID 13527 | 15:24:57 INFO - PID 13527 | [#2] jquery.html Cycles:180 Average:33568.74 Median:22799.71 stddev:78396.98 (343.9%) stddev-sans-first:78577.75 15:24:57 INFO - PID 13527 | Values: 568.0 571.0 574.8 581.1 595.1 21792.9 22516.7 22621.3 22773.8 22851.1 23593.3 24114.5 24453.6 24868.5 25085.5 6562.0 6735.1 6738.3 6739.7 6765.6 6558.4 6678.4 6706.2 6714.3 6726.2 6138.4 6446.2 6465.6 6482.4 6495.2 6451.0 6486.4 6494.4 6528.9 6573.9 6061.9 6071.2 6071.3 6087.2 6114.1 27249.5 27510.2 27960.0 27987.4 28300.4 2003.1 2046.7 2048.7 2053.5 2065.9 18324.8 18938.5 18947.4 18969.4 19003.7 2402.0 2418.3 2465.5 2477.2 2481.6 121355.4 128455.0 135138.0 144413.0 144440.0 14624.0 14703.4 14725.6 14947.7 14958.6 22825.7 22922.9 22956.1 22974.0 22998.8 9925.2 9993.0 10017.7 10026.5 10114.9 9096.2 9321.0 9362.5 9412.6 9446.2 8790.7 8847.4 8965.9 9049.5 9055.7 2607.2 2670.9 2675.2 2691.8 2691.8 945.9 947.9 954.2 988.5 994.5 18798.0 18873.8 18955.5 19165.0 19327.3 999.7 1033.3 1045.7 1045.7 1048.9 10182.6 10198.2 10508.4 10549.8 10740.0 439712.0 460500.0 465213.0 466893.0 484324.0 110917.4 111420.4 113128.0 115246.4 115456.4 1046.9 1119.1 1148.1 1188.3 1197.6 19196.8 19698.3 19716.2 19852.3 19876.1 53869.5 54012.0 54650.7 54813.7 56059.4 72023.6 72166.0 72612.6 73574.3 73979.0 13536.7 13897.2 13928.0 14028.7 14059.2 19898.7 21535.2 21612.0 21752.1 21918.9 16677.5 16827.8 16906.2 17662.3 17859.8 15391.8 15611.7 15771.4 16116.4 16312.8 17836.9 18122.6 18289.7 18296.7 18322.7 13933.5 13934.7 13951.1 13969.4 13981.6 16464.9 17368.6 17373.0 17374.7 17627.3 15:24:57 INFO - PID 13527 | 15:24:57 INFO - PID 13527 | [#3] mootools.html Cycles:180 Average:9384.20 Median:2716.50 stddev:6801.50 (250.4%) stddev-sans-first:6793.51 15:24:57 INFO - PID 13527 | Values: 1306.6 1346.3 1363.0 1375.2 1379.3 12701.8 13284.7 13337.7 13351.7 15480.8 15595.9 15627.5 15712.9 15766.9 15842.6 2754.1 2804.4 2821.8 2823.5 2823.7 2696.2 2701.8 2771.9 2783.7 2826.7 2749.9 2754.5 2766.6 2775.3 2783.0 2684.8 2726.9 2727.4 2743.4 2750.3 2662.2 2691.0 2715.4 2717.6 2719.1 15059.2 15319.1 15322.2 15340.8 15382.8 8012.0 8264.5 8350.4 8352.8 8366.2 5250.6 5499.6 5561.7 5643.5 5659.6 1793.3 1809.9 1868.0 1888.6 2012.1 26216.9 27047.3 27055.9 27075.5 27116.0 6695.1 6911.0 6966.3 7061.2 7123.6 17064.2 17069.6 17072.6 17122.9 17138.5 7678.6 7768.2 7782.7 7827.1 7853.8 7093.1 7250.2 7313.5 7338.1 7413.8 5093.6 5252.6 5285.3 5341.3 5355.2 1498.7 1507.5 1517.2 1545.5 1550.5 903.1 903.3 915.5 924.3 927.1 7670.7 7741.7 7816.2 7831.0 7839.3 711.7 716.9 717.6 722.4 739.0 4608.6 4627.5 4642.6 4669.7 5037.4 21358.6 22020.3 22125.7 22519.7 22592.7 21019.3 21727.9 21817.2 22014.1 22171.6 11003.2 11165.9 11221.8 11368.6 11399.6 8611.1 8621.7 8621.9 8629.0 8643.4 18720.3 18856.6 19249.5 19255.8 19726.0 19721.5 19848.0 20134.9 20311.2 20565.7 11147.2 11179.9 11229.8 11353.9 11366.0 14000.4 14178.0 14186.8 14196.6 14198.4 11591.9 11604.2 11653.4 11803.5 11931.6 11223.8 11258.4 11404.3 11551.1 11734.6 9451.3 9485.3 9488.5 9515.7 9560.4 7055.6 7088.6 7209.8 7289.4 7299.2 7152.7 7249.0 7258.1 7263.7 7278.8 15:24:57 INFO - PID 13527 | 15:24:57 INFO - PID 13527 | [#4] prototype.html Cycles:180 Average:5529.39 Median:6161.26 stddev:1540.57 (25.0%) stddev-sans-first:1497.63 15:24:57 INFO - PID 13527 | Values: 483.9 513.4 516.6 519.4 523.4 6237.3 6313.3 6385.7 6386.0 6428.2 6162.2 6205.4 6211.2 6260.5 6292.8 5101.9 5127.2 5145.8 5181.8 5206.6 5118.8 5178.1 5181.7 5198.6 5199.2 5102.7 5121.2 5146.7 5151.5 5164.4 4771.8 5003.6 5027.4 5029.7 5062.8 4444.9 4505.3 4509.0 4530.8 4534.9 5938.5 6060.2 6076.1 6155.7 6160.4 5553.6 5650.9 5677.0 5732.0 5756.4 6556.7 6612.5 6623.9 6638.7 6683.6 4854.9 4865.7 4886.2 4920.2 4926.9 6640.2 6740.2 6796.3 6851.7 6859.9 4967.8 4987.9 5026.9 5029.7 5076.9 5006.4 5068.3 5101.8 5102.6 5115.3 5567.4 5613.3 5644.9 5694.5 5721.3 6503.4 6628.3 6637.3 6684.6 6689.8 1730.2 1777.5 1778.1 1780.0 1784.9 1163.1 1212.4 1236.2 1238.3 1240.4 5664.0 5714.4 5719.2 5726.7 5740.9 6637.5 6654.8 6680.8 6708.7 6782.3 5638.8 5690.1 5691.7 5695.4 5759.6 3558.5 3571.6 3576.8 3602.5 3606.9 6468.5 6480.3 6486.9 6533.3 6535.9 6883.6 6887.7 6957.6 6989.6 7005.8 6070.8 6307.4 6413.5 6430.4 6434.9 6504.7 6681.7 6683.5 6742.2 6761.6 6656.7 6697.5 6761.2 6783.0 6824.1 6359.1 6414.9 6465.9 6519.7 6591.3 5026.9 5036.1 5063.9 5064.5 5065.0 6387.8 6681.8 6727.2 6841.7 6857.5 6358.7 6469.6 6505.6 6524.2 6589.8 6486.2 6520.5 6555.4 6560.9 6574.3 6361.4 6471.6 6491.5 6503.5 6512.0 6390.8 6529.8 6601.2 6641.5 6684.4 6380.1 6424.3 6473.6 6476.8 6481.8 15:24:57 INFO - PID 13527 | 15:24:57 INFO - PID 13527 | [#5] yui.html Cycles:180 Average:24333.64 Median:20231.15 stddev:36059.49 (178.2%) stddev-sans-first:36117.63 15:24:57 INFO - PID 13527 | Values: 875.7 894.9 911.2 918.6 936.0 19218.6 20195.0 20267.3 20280.9 20341.1 18077.6 18536.9 18603.5 18650.0 18913.5 957.3 972.9 974.5 974.7 974.9 963.7 966.4 975.3 977.1 980.0 994.2 1026.5 1028.9 1029.9 1049.2 1005.6 1013.2 1013.4 1017.4 1018.2 726.7 739.9 747.5 750.9 752.2 20026.5 20369.5 20584.8 20587.7 20653.3 18848.2 19169.6 19196.3 19409.8 19575.8 15830.8 16182.8 16275.3 16299.3 16430.1 3720.4 3728.2 3756.6 3765.3 3773.4 135482.0 137543.3 140583.3 140660.0 142146.6 15685.2 15757.8 15911.6 16180.2 16227.3 29968.1 29982.7 31336.4 31420.2 31499.4 9011.6 9047.1 9098.7 9115.6 9118.9 4468.0 4572.3 4576.7 4579.5 4583.7 5447.5 5449.4 5484.2 5511.4 5565.9 939.6 958.8 975.4 977.2 986.4 682.3 707.6 711.1 714.8 719.1 11733.6 11894.2 12009.1 12426.5 12505.5 695.9 696.2 700.0 703.0 714.3 5452.9 5561.1 5576.2 5636.1 5649.5 126110.4 127304.4 127744.4 128442.0 128519.4 108475.5 111340.4 111525.0 112344.0 114610.0 95828.0 95987.0 97049.5 97212.5 98529.5 9922.6 10182.4 10187.8 10216.3 10268.8 44011.0 44147.8 44251.6 45345.3 46548.3 58207.7 58839.4 59025.0 59113.7 60790.7 15312.0 15369.6 15471.9 15547.5 15550.4 16423.7 16563.8 16643.9 16688.6 16795.2 13687.2 13718.0 13769.9 14003.2 14022.4 13442.6 13447.5 13542.5 13563.3 13681.3 13395.6 13402.8 13447.3 13560.6 13580.7 11317.9 11334.5 11537.8 11677.8 11718.6 11707.7 11911.3 12088.6 12118.6 12154.0 15:24:57 INFO - PID 13527 | -------- Summary: end -------- 15:24:57 INFO - PID 13527 | 15:24:58 INFO - TEST-INFO | 13527: exit 0 15:24:58 INFO - TEST-OK | dromaeo_css | took 1113513ms 15:24:58 INFO - TEST-START | kraken 15:24:58 INFO - Initialising browser for kraken test... 15:24:58 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38383/getInfo.html -profile /tmp/tmpUwQIDX/profile 15:24:58 INFO - TEST-INFO | started process 13911 (/builds/slave/test/build/application/firefox/firefox http://localhost:38383/getInfo.html) 15:25:04 INFO - TEST-INFO | 13911: exit 0 15:25:04 INFO - Browser initialized. 15:25:04 INFO - Running cycle 1/1 for kraken test... 15:25:04 INFO - Using env: {'DISPLAY': ':0', 15:25:04 INFO - 'HOME': '/home/cltbld', 15:25:04 INFO - 'JSGC_DISABLE_POISONING': '1', 15:25:04 INFO - 'LANG': 'en_US.UTF-8', 15:25:04 INFO - 'LANGUAGE': 'en_US:en', 15:25:04 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:25:04 INFO - 'LOGNAME': 'cltbld', 15:25:04 INFO - 'MAIL': '/var/mail/cltbld', 15:25:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:25:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:25:04 INFO - 'MOZ_ACCELERATED': '1', 15:25:04 INFO - 'MOZ_CRASHREPORTER': '1', 15:25:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:04 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:25:04 INFO - 'MOZ_NO_REMOTE': '1', 15:25:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:25:04 INFO - 'MOZ_WEBRENDER': '1', 15:25:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:04 INFO - 'NO_EM_RESTART': '1', 15:25:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:04 INFO - 'PWD': '/builds/slave/test', 15:25:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:25:04 INFO - 'RUST_BACKTRACE': 'full', 15:25:04 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:25:04 INFO - 'SHELL': '/bin/bash', 15:25:04 INFO - 'SHLVL': '1', 15:25:04 INFO - 'TERM': 'linux', 15:25:04 INFO - 'TMOUT': '86400', 15:25:04 INFO - 'USER': 'cltbld', 15:25:04 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505936161.49982-244763078', 15:25:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:04 INFO - '_': '/tools/buildbot/bin/python'} 15:25:04 INFO - TEST-INFO | started process 14154 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUwQIDX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:25:05 INFO - PID 14154 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 15:25:05 INFO - PID 14154 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 15:25:05 INFO - PID 14154 | 15:25:05 INFO - PID 14154 | (/builds/slave/test/build/application/firefox/firefox:14214): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:25:05 INFO - PID 14154 | 15:25:15 INFO - PID 14154 | RSS: Main: 190353408 15:25:15 INFO - PID 14154 | 15:25:18 INFO - PID 14154 | Cycle 1(1): loaded http://localhost:38383/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38383/tests/kraken/driver.html?testName=audio-beat-detection) 15:25:19 INFO - PID 14154 | RSS: Main: 188768256 15:25:19 INFO - PID 14154 | 15:25:22 INFO - PID 14154 | Cycle 1(1): loaded http://localhost:38383/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38383/tests/kraken/driver.html?testName=audio-dft) 15:25:22 INFO - PID 14154 | RSS: Main: 188968960 15:25:22 INFO - PID 14154 | 15:25:25 INFO - PID 14154 | Cycle 1(1): loaded http://localhost:38383/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38383/tests/kraken/driver.html?testName=audio-fft) 15:25:26 INFO - PID 14154 | RSS: Main: 186617856 15:25:26 INFO - PID 14154 | 15:25:28 INFO - PID 14154 | Cycle 1(1): loaded http://localhost:38383/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38383/tests/kraken/driver.html?testName=audio-oscillator) 15:25:29 INFO - PID 14154 | RSS: Main: 186933248 15:25:29 INFO - PID 14154 | 15:25:31 INFO - PID 14154 | Cycle 1(1): loaded http://localhost:38383/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38383/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:25:31 INFO - PID 14154 | RSS: Main: 186355712 15:25:31 INFO - PID 14154 | 15:25:35 INFO - PID 14154 | Cycle 1(1): loaded http://localhost:38383/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38383/tests/kraken/driver.html?testName=imaging-darkroom) 15:25:35 INFO - PID 14154 | RSS: Main: 189362176 15:25:35 INFO - PID 14154 | 15:25:39 INFO - PID 14154 | Cycle 1(1): loaded http://localhost:38383/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38383/tests/kraken/driver.html?testName=imaging-desaturate) 15:25:40 INFO - PID 14154 | RSS: Main: 187764736 15:25:40 INFO - PID 14154 | 15:25:43 INFO - PID 14154 | Cycle 1(1): loaded http://localhost:38383/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38383/tests/kraken/driver.html?testName=json-parse-financial) 15:25:43 INFO - PID 14154 | RSS: Main: 188911616 15:25:43 INFO - PID 14154 | 15:25:45 INFO - PID 14154 | Cycle 1(1): loaded http://localhost:38383/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38383/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:25:46 INFO - PID 14154 | RSS: Main: 189435904 15:25:46 INFO - PID 14154 | 15:25:47 INFO - PID 14154 | Cycle 1(1): loaded http://localhost:38383/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38383/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:25:48 INFO - PID 14154 | RSS: Main: 186544128 15:25:48 INFO - PID 14154 | 15:25:50 INFO - PID 14154 | Cycle 1(1): loaded http://localhost:38383/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38383/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:25:51 INFO - PID 14154 | RSS: Main: 185999360 15:25:51 INFO - PID 14154 | 15:25:53 INFO - PID 14154 | Cycle 1(1): loaded http://localhost:38383/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38383/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:25:54 INFO - PID 14154 | RSS: Main: 187002880 15:25:54 INFO - PID 14154 | 15:25:57 INFO - PID 14154 | Cycle 1(1): loaded http://localhost:38383/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38383/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:25:58 INFO - PID 14154 | RSS: Main: 186728448 15:25:58 INFO - PID 14154 | 15:25:59 INFO - PID 14154 | Cycle 1(1): loaded http://localhost:38383/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38383/tests/kraken/driver.html?testName=ai-astar) 15:26:00 INFO - PID 14154 | RSS: Main: 188256256 15:26:00 INFO - PID 14154 | 15:26:00 INFO - PID 14154 | __start_tp_report 15:26:00 INFO - PID 14154 | _x_x_mozilla_page_load 15:26:00 INFO - PID 14154 | _x_x_mozilla_page_load_details 15:26:00 INFO - PID 14154 | |i|pagename|runs| 15:26:00 INFO - PID 14154 | |0;ai-astar;120;113;107;112;94;116;113;111;107;113 15:26:00 INFO - PID 14154 | |1;audio-beat-detection;121;118;115;117;124;152;124;153;122;122 15:26:00 INFO - PID 14154 | |2;audio-dft;165;168;173;171;162;183;168;164;166;163 15:26:00 INFO - PID 14154 | |3;audio-fft;81;80;74;82;75;74;77;78;83;76 15:26:00 INFO - PID 14154 | |4;audio-oscillator;79;82;82;78;79;91;79;80;85;79 15:26:00 INFO - PID 14154 | |5;imaging-gaussian-blur;114;110;122;119;124;114;115;114;114;115 15:26:00 INFO - PID 14154 | |6;imaging-darkroom;150;151;150;147;157;150;149;149;150;150 15:26:00 INFO - PID 14154 | |7;imaging-desaturate;99;100;103;94;95;98;101;95;102;97 15:26:00 INFO - PID 14154 | |8;json-parse-financial;55;58;54;54;58;54;56;51;53;58 15:26:00 INFO - PID 14154 | |9;json-stringify-tinderbox;42;45;49;41;49;41;39;39;38;39 15:26:00 INFO - PID 14154 | |10;stanford-crypto-aes;86;91;76;76;78;78;84;72;78;75 15:26:00 INFO - PID 14154 | |11;stanford-crypto-ccm;117;115;118;116;117;112;115;119;110;119 15:26:00 INFO - PID 14154 | |12;stanford-crypto-pbkdf2;176;177;174;174;171;176;180;172;169;168 15:26:00 INFO - PID 14154 | |13;stanford-crypto-sha256-iterative;66;65;63;65;69;68;64;68;64;66 15:26:00 INFO - PID 14154 | __end_tp_report 15:26:00 INFO - PID 14154 | __start_cc_report 15:26:00 INFO - PID 14154 | _x_x_mozilla_cycle_collect,744 15:26:00 INFO - PID 14154 | __end_cc_report 15:26:00 INFO - PID 14154 | __startTimestamp1505946360120__endTimestamp 15:26:00 INFO - PID 14154 | 15:26:00 INFO - PID 14154 | ------- Summary: start ------- 15:26:00 INFO - PID 14154 | Number of tests: 14 15:26:00 INFO - PID 14154 | 15:26:00 INFO - PID 14154 | [#0] ai-astar Cycles:10 Average:110.60 Median:113.00 stddev:6.98 (6.2%) stddev-sans-first:6.52 15:26:00 INFO - PID 14154 | Values: 120.0 113.0 107.0 112.0 94.0 116.0 113.0 111.0 107.0 113.0 15:26:00 INFO - PID 14154 | 15:26:00 INFO - PID 14154 | [#1] audio-beat-detection Cycles:10 Average:126.80 Median:123.00 stddev:13.86 (11.3%) stddev-sans-first:14.54 15:26:00 INFO - PID 14154 | Values: 121.0 118.0 115.0 117.0 124.0 152.0 124.0 153.0 122.0 122.0 15:26:00 INFO - PID 14154 | 15:26:00 INFO - PID 14154 | [#2] audio-dft Cycles:10 Average:168.30 Median:168.00 stddev:6.22 (3.7%) stddev-sans-first:6.48 15:26:00 INFO - PID 14154 | Values: 165.0 168.0 173.0 171.0 162.0 183.0 168.0 164.0 166.0 163.0 15:26:00 INFO - PID 14154 | 15:26:00 INFO - PID 14154 | [#3] audio-fft Cycles:10 Average:78.00 Median:79.00 stddev:3.33 (4.2%) stddev-sans-first:3.35 15:26:00 INFO - PID 14154 | Values: 81.0 80.0 74.0 82.0 75.0 74.0 77.0 78.0 83.0 76.0 15:26:00 INFO - PID 14154 | 15:26:00 INFO - PID 14154 | [#4] audio-oscillator Cycles:10 Average:81.40 Median:81.00 stddev:3.98 (4.9%) stddev-sans-first:4.12 15:26:00 INFO - PID 14154 | Values: 79.0 82.0 82.0 78.0 79.0 91.0 79.0 80.0 85.0 79.0 15:26:00 INFO - PID 14154 | 15:26:00 INFO - PID 14154 | [#5] imaging-gaussian-blur Cycles:10 Average:116.10 Median:115.00 stddev:4.25 (3.7%) stddev-sans-first:4.44 15:26:00 INFO - PID 14154 | Values: 114.0 110.0 122.0 119.0 124.0 114.0 115.0 114.0 114.0 115.0 15:26:00 INFO - PID 14154 | 15:26:00 INFO - PID 14154 | [#6] imaging-darkroom Cycles:10 Average:150.30 Median:150.00 stddev:2.58 (1.7%) stddev-sans-first:2.74 15:26:00 INFO - PID 14154 | Values: 150.0 151.0 150.0 147.0 157.0 150.0 149.0 149.0 150.0 150.0 15:26:00 INFO - PID 14154 | 15:26:00 INFO - PID 14154 | [#7] imaging-desaturate Cycles:10 Average:98.40 Median:95.00 stddev:3.13 (3.3%) stddev-sans-first:3.32 15:26:00 INFO - PID 14154 | Values: 99.0 100.0 103.0 94.0 95.0 98.0 101.0 95.0 102.0 97.0 15:26:00 INFO - PID 14154 | 15:26:00 INFO - PID 14154 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.50 stddev:2.38 (4.3%) stddev-sans-first:2.52 15:26:00 INFO - PID 14154 | Values: 55.0 58.0 54.0 54.0 58.0 54.0 56.0 51.0 53.0 58.0 15:26:00 INFO - PID 14154 | 15:26:00 INFO - PID 14154 | [#9] json-stringify-tinderbox Cycles:10 Average:42.20 Median:41.50 stddev:4.10 (9.9%) stddev-sans-first:4.35 15:26:00 INFO - PID 14154 | Values: 42.0 45.0 49.0 41.0 49.0 41.0 39.0 39.0 38.0 39.0 15:26:00 INFO - PID 14154 | 15:26:00 INFO - PID 14154 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:78.00 stddev:5.80 (7.4%) stddev-sans-first:5.63 15:26:00 INFO - PID 14154 | Values: 86.0 91.0 76.0 76.0 78.0 78.0 84.0 72.0 78.0 75.0 15:26:00 INFO - PID 14154 | 15:26:00 INFO - PID 14154 | [#11] stanford-crypto-ccm Cycles:10 Average:115.80 Median:117.00 stddev:2.94 (2.5%) stddev-sans-first:3.08 15:26:00 INFO - PID 14154 | Values: 117.0 115.0 118.0 116.0 117.0 112.0 115.0 119.0 110.0 119.0 15:26:00 INFO - PID 14154 | 15:26:00 INFO - PID 14154 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.70 Median:175.00 stddev:3.74 (2.1%) stddev-sans-first:3.88 15:26:00 INFO - PID 14154 | Values: 176.0 177.0 174.0 174.0 171.0 176.0 180.0 172.0 169.0 168.0 15:26:00 INFO - PID 14154 | 15:26:00 INFO - PID 14154 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:1.99 (3.0%) stddev-sans-first:2.11 15:26:00 INFO - PID 14154 | Values: 66.0 65.0 63.0 65.0 69.0 68.0 64.0 68.0 64.0 66.0 15:26:00 INFO - PID 14154 | -------- Summary: end -------- 15:26:00 INFO - PID 14154 | 15:26:00 INFO - PID 14154 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 15:26:01 INFO - TEST-INFO | 14154: exit 0 15:26:01 INFO - TEST-OK | kraken | took 62985ms 15:26:01 INFO - SUITE-END | took 1176s 15:26:01 INFO - Completed test suite (00:19:36) 15:26:01 INFO - javascript benchmark 15:26:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8468.956836176332, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3085.5063189889593, 3120.2355422921387, 3146.2134466383404, 3160.2415420299135, 3170.4134735074012, 6172.074188871671, 6246.593971391862, 6301.621902685831, 6323.905141422877, 6337.144485494457, 6214.7203375848085, 6215.875682486348, 6273.153124328214, 6276.623402595847, 6308.053791931201, 5765.394633563478, 5794.913076303858, 5811.970940145315, 5853.765849366042, 5906.291245050578, 5873.148393482942, 5902.586818922677, 5920.378360272152, 5938.61399009063, 5943.970280148593, 5727.198192253088, 5742.4831765141125, 5781.330044115964, 5829.213056237396, 5940.6435613863305, 5442.12925931851, 5811.883762324772, 5855.736491857834, 5943.108533719955, 5955.0, 5695.7152142392715, 5710.857228569277, 5739.053056245714, 5752.856178595527, 5761.769529218826, 6199.597026193283, 6273.686315684243, 6294.99280115184, 6336.239651241881, 6357.777477788301, 6765.661716914135, 6766.391024807791, 6836.863262734718, 6864.141982252218, 6867.381935625767, 6673.833154171136, 6744.865102697919, 6818.181818181801, 6846.691898864513, 6897.931020689829, 6179.752809887599, 6199.721012554446, 6217.160683307741, 6220.502359811204, 6230.657313847737, 6769.356911093439, 6791.660416979132, 6862.279460656659, 6872.725090996404, 6885.896711549331, 6641.501887358468, 6699.9665001674675, 6718.731250750013, 6735.797926062226, 6753.831154221184, 6680.699368528428, 6789.6605169741315, 6870.587764734132, 6872.10662613857, 6881.208661004049, 6748.426383757337, 6752.527323087336, 6759.425448836806, 6805.353491418307, 6823.078884350549, 6725.495587830932, 6733.427658648971, 6749.291324410866, 6773.356531129535, 6800.65996700163, 5222.582193424517, 5287.576993840484, 5297.708626025606, 5306.018386598492, 5306.257124002643, 4581.266997280486, 4591.44902611682, 4644.373009643722, 4648.907021859612, 4651.790669419885, 5637.633553818989, 5765.971170144123, 5794.710264486759, 5797.855053623609, 5812.0, 6840.863182736317, 6858.211305699909, 6875.346842049998, 6880.621565813928, 6881.036654868322, 5859.589828711949, 5859.589828712034, 5860.941390586039, 5891.293044834647, 5895.970520147372, 5710.114932185518, 5793.391693872167, 5874.970625146847, 5878.706064696748, 5919.67441790697, 6529.608223506605, 6535.183102112236, 6559.737610495622, 6603.966980165068, 6637.900431493532, 6659.733610655519, 6749.932500675127, 6828.146481689789, 6907.585544867324, 6907.965460172667, 6469.967650161907, 6551.475881929339, 6557.049227862029, 6561.540692151503, 6591.868162636816, 6719.0, 6751.966240168964, 6784.6946887389195, 6793.864122717617, 6800.659967001531, 6832.077669514552, 6838.760643377458, 6841.350071743176, 6929.995150703221, 6957.582545047313, 6452.419282264619, 6487.740490380332, 6518.152640156749, 6575.375339342755, 6675.065490831191, 6459.4832413405875, 6463.709133088928, 6520.673966301761, 6526.184226971629, 6540.803775886731, 6501.0, 6501.8699626008165, 6521.087047813215, 6549.836254093686, 6587.242467116343, 6614.074029635951, 6687.565308254948, 6690.933090669031, 6696.933030669826, 6717.193936727624, 6329.841753956188, 6342.8731425370315, 6371.171747672958, 6415.647139407378, 6430.903536446864], "value": 6160.083648700428, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [881.4755220643717, 887.9245264152547, 898.0077014898537, 902.2150728865888, 908.9909100908993, 39016.41475377868, 42801.78599107004, 42834.78582607082, 42863.99999999996, 42939.14121717564, 38148.0, 38213.23573528535, 38452.615473845326, 38541.614583854156, 38546.22907541847, 7181.4254859611365, 7247.20280769115, 7258.600776957265, 7323.670434830418, 7851.21487851216, 7926.762197134095, 8031.477953932976, 8032.437729358947, 8036.07585127709, 8049.0, 7960.960195199045, 7968.561729104897, 8004.63979120941, 8027.197280271956, 8043.316318112968, 7886.960565197194, 7935.523868567904, 7999.480033797843, 8004.279614834663, 8033.517988920654, 7796.181400952875, 7940.285374316281, 7943.602819858984, 8006.759797206093, 8018.959905200437, 38008.80995595032, 38199.236015279814, 38235.0, 38330.80834595809, 38358.23283534341, 3502.7548071634997, 3533.876314329012, 3557.2351944331836, 3582.731295152874, 3587.4798154267487, 30980.380392392028, 31180.220494487592, 31193.37613247745, 31322.686773132205, 31398.529022064686, 5201.271821944931, 5237.266782650432, 5279.234510995922, 5297.549708274802, 5387.057264978613, 191392.0, 191623.0, 192724.0, 193456.9999999986, 193709.0, 42057.158856823306, 48627.756861215465, 48722.0, 49155.75422122938, 49388.259176112384, 45215.0, 45492.772536137105, 52960.735196323774, 53184.468155317954, 53719.731401342746, 15767.7385809135, 15891.364345426286, 15899.125548094966, 15932.761008584881, 15957.122358270175, 12843.678908027186, 12859.678508037186, 12932.288724120264, 12944.417501212469, 12974.80537791934, 14502.637434064021, 14527.418903243752, 14699.412023519153, 14718.541396831766, 14727.852721472862, 5697.686627235542, 5703.800366987136, 5785.566082543826, 5855.648661080349, 5943.286805583358, 995.7659949911765, 999.9650012249537, 1034.715453250362, 1036.18659352408, 1050.4275170032352, 23104.4223894404, 23112.768872311062, 23117.768822311562, 23299.650505242436, 23614.527709446058, 1127.3405058041137, 1128.5598616539555, 1132.445101900063, 1142.331735934471, 1144.0, 12071.0, 12546.309952952675, 12573.87426125727, 12643.747125057631, 12700.110992230455, 224164.0, 225284.0, 225758.0, 225865.0, 225993.0, 52759.0, 53147.468525315024, 53244.46755532473, 53453.732731336095, 53543.46456535385, 1431.806706094664, 1467.9045862018934, 1476.1615819995643, 1486.472302332678, 1488.1889370293216, 22772.544549109258, 22789.88605056964, 23174.768252317263, 23229.186978455673, 23350.416239594146, 37388.252234954605, 37510.43734343933, 37638.059048524, 37851.432228517144, 37869.43195852119, 192028.0, 193435.0, 193458.0, 194198.0, 195283.0, 30571.847140765043, 31425.371492570477, 34012.48981265233, 34541.65458345384, 34552.0, 43615.0, 43746.34380484359, 43954.0, 44066.779666102746, 44787.104257915315, 31766.682333176374, 32179.839100804347, 32372.190695232806, 32449.351012979136, 32697.836510817295, 31144.532832007084, 31237.425802876744, 31726.841365793025, 31815.0, 31984.68015319817, 35619.46570801492, 35854.28291434104, 35893.28213435665, 36014.09964750902, 36047.81976090208, 30990.22524436817, 31345.059648209677, 31405.528917065807, 31503.369932600763, 31539.21151971219, 23361.299161025196, 23445.413864652837, 23587.29238122859, 23603.40991475227, 23877.880610596836], "value": 17208.352361474273, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.9602427830054, 570.9771609135635, 574.7844558290641, 581.1457157977774, 595.1429940885125, 21792.89103554482, 22516.662250066263, 22621.321360359216, 22773.772262277373, 22851.085956561717, 23593.292201233948, 24114.51770964584, 24453.633195502083, 24868.50262994739, 25085.49829003419, 6561.967190164054, 6735.057092007123, 6738.326167383247, 6739.730410783563, 6765.627890466022, 6558.442532384729, 6678.432333251655, 6706.1952565691945, 6714.328567143295, 6726.192856857184, 6138.386161383871, 6446.226452825667, 6465.612063276195, 6482.448991835699, 6495.155629768124, 6450.967745161268, 6486.383793539653, 6494.383033611799, 6528.902066469007, 6573.901391479131, 6061.878552467808, 6071.1803906472505, 6071.301800292978, 6087.178230938811, 6114.082887566856, 27249.45501089967, 27510.17469475919, 27960.0, 27987.44025119486, 28300.433991320264, 2003.1286390420214, 2046.723692301535, 2048.702938073971, 2053.5276886316233, 2065.855390122692, 18324.816751832444, 18938.52653683669, 18947.43157705257, 18969.43091707251, 19003.714944275845, 2402.0, 2418.310781427285, 2465.5438743832447, 2477.19491165372, 2481.565725997943, 121355.39322303332, 128455.0, 135138.0, 144412.99999999895, 144440.0, 14623.976321657594, 14703.411863525553, 14725.631859203606, 14947.70104597902, 14958.626034349229, 22825.657615135788, 22922.885385572965, 22956.081756729876, 22974.0, 22998.770012299996, 9925.156361709336, 9993.0, 10017.749556261151, 10026.498675066363, 10114.949425252973, 9096.226820720312, 9321.0, 9362.485063321446, 9412.576434060484, 9446.244300455946, 8790.736277911545, 8847.380683352103, 8965.910340896638, 9049.547522623843, 9055.68305109318, 2607.1657069737503, 2670.919872403831, 2675.2375572961614, 2691.757741803247, 2691.792729961413, 945.933784635069, 947.9383840050375, 954.1651055326589, 988.4711679251566, 994.4580203788952, 18798.0, 18873.811261887204, 18955.526111847314, 19165.0, 19327.323543675902, 999.7403271877487, 1033.338663255517, 1045.6706137566641, 1045.7398834404523, 1048.9318194317498, 10182.592696292213, 10198.235132364955, 10508.422036787897, 10549.789004219872, 10739.979701928305, 439712.0, 460500.0, 465213.0, 466893.0, 484324.0, 110917.44541277403, 111420.44289778662, 113128.0, 115246.42376788062, 115456.42271788587, 1046.9267151299337, 1119.1270808769173, 1148.1044785067493, 1188.3285943441754, 1197.592818441734, 19196.808031919503, 19698.31055913036, 19716.21135154578, 19852.305169319003, 19876.10557524886, 53869.461305386445, 54012.0, 54650.72674636601, 54813.725931370085, 56059.43940560542, 72023.63988180025, 72166.0, 72612.63693681498, 73574.26425735674, 73979.0, 13536.661583460098, 13897.16617002983, 13928.0, 14028.719425611635, 14059.156450612996, 19898.70151947751, 21535.2462663806, 21611.98430247592, 21752.12991480323, 21918.89040554787, 16677.49967500977, 16827.831721682625, 16906.154692265092, 17662.293508259525, 17859.821401785815, 15391.84608153904, 15611.687766244384, 15771.44799931997, 16116.435924742578, 16312.755308670143, 17836.91081544584, 18122.637547249244, 18289.725654115464, 18296.72554911651, 18322.725159122358, 13933.512327068504, 13934.651633709238, 13951.093178943742, 13969.441222350992, 13981.580552583031, 16464.917675411547, 17368.56578585495, 17373.0, 17374.73937890958, 17627.294908203527], "value": 11735.531772187529, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1306.6276111308275, 1346.2864681718693, 1363.0390574644875, 1375.1770079179878, 1379.3103448275863, 12701.809472857904, 13284.667883302922, 13337.7332453351, 13351.666208344795, 15480.845191548082, 15595.922020389882, 15627.531174064796, 15712.921435392836, 15766.921165394186, 15842.603934901634, 2754.1049159023296, 2804.4110736745306, 2821.8165819221786, 2823.477656633519, 2823.731745484186, 2696.245051385605, 2701.75684188423, 2771.88912443503, 2783.6520434945633, 2826.7455928966388, 2749.8625068746583, 2754.4628797384516, 2766.585012248159, 2775.3339198592294, 2783.0, 2684.7986401019903, 2726.9318267043286, 2727.386338073937, 2743.3553115017953, 2750.3261700883213, 2662.2412612405565, 2690.9730902690917, 2715.3618899558587, 2717.6331195288776, 2719.0891051497774, 15059.17174555399, 15319.080855148726, 15322.15728134952, 15340.769888451681, 15382.769258461132, 8012.0, 8264.462809917337, 8350.373721970876, 8352.8329433411, 8366.163383661646, 5250.606204534637, 5499.560035197174, 5561.721913904288, 5643.5203007743985, 5659.60382773206, 1793.2737241417246, 1809.9276028958825, 1868.0472958790979, 1888.5750706091158, 2012.094557449139, 26216.86891565549, 27047.323816904536, 27055.86472067647, 27075.45849083027, 27116.0, 6695.129633147757, 6910.965445172843, 6966.303369663095, 7061.152661680529, 7123.572585644878, 17064.2321095551, 17069.57326066858, 17072.57318567046, 17122.914385427994, 17138.457538821567, 7678.57767822764, 7768.184340644264, 7782.727604533814, 7827.099883513469, 7853.842923141505, 7093.113360829896, 7250.16623088341, 7313.451491138186, 7338.082739657543, 7413.777586672409, 5093.643444958817, 5252.579793616502, 5285.286486324374, 5341.305630268041, 5355.161764264946, 1498.7077519883735, 1507.4573153664671, 1517.248961763934, 1545.5054382597461, 1550.4805890026967, 903.1239697493421, 903.2773780975193, 915.5422288855572, 924.3021518753433, 927.0590350793949, 7670.693172273158, 7741.690332386642, 7816.179301173295, 7830.960845195737, 7839.25527074927, 711.6833009310807, 716.8924661300742, 717.5766297884273, 722.4148439763808, 739.0429393934867, 4608.5852273294895, 4627.467841198238, 4642.558956899089, 4669.743164125938, 5037.420696619935, 21358.572828543343, 22020.33938981833, 22125.66811497829, 22519.662205066936, 22592.66111008336, 21019.264325748525, 21727.891360543097, 21817.23639672604, 22014.119435222412, 22171.55656886853, 11003.22977391575, 11165.888341116648, 11221.831672524919, 11368.602098926498, 11399.601013964637, 8611.13888611134, 8621.741347759576, 8621.87067194005, 8628.956855215683, 8643.351748618754, 18720.344787932358, 18856.622867542847, 19249.51876203106, 19255.8074419254, 19726.0, 19721.506962326057, 19848.0, 20134.89932550328, 20311.187552497733, 20565.691514626993, 11147.163962702667, 11179.88820111821, 11229.831552526883, 11353.886461135284, 11366.033887119356, 14000.43998240059, 14178.0, 14186.787198191829, 14196.645083872985, 14198.361073751912, 11591.88408115908, 11604.245724027911, 11653.417329133339, 11803.468843902217, 11931.642050738492, 11223.775524489627, 11258.437078145897, 11404.315741055563, 11551.075913926697, 11734.589289374831, 9451.338406311766, 9485.288603354638, 9488.478133702713, 9515.714528564155, 9560.426374417557, 7055.61194134307, 7088.645567721696, 7209.783706488814, 7289.4168466523615, 7299.233580473974, 7152.6781294842895, 7249.0, 7258.0927384076995, 7263.709451622088, 7278.818029549304], "value": 6641.814583787492, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [483.91289567877766, 513.3813754425917, 516.6486788983491, 519.4000928927088, 523.4163907243425, 6237.349126621185, 6313.337099604544, 6385.712642931067, 6386.0, 6428.228612566487, 6162.168107305512, 6205.379462053804, 6211.192544969159, 6260.499160067195, 6292.842678933018, 5101.897962040766, 5127.230915362707, 5145.845624631267, 5181.792728290864, 5206.609504287175, 5118.820841270556, 5178.1197196476505, 5181.740912954356, 5198.584113270948, 5199.2461093141665, 5102.69383836971, 5121.206213036985, 5146.716930568818, 5151.484851514837, 5164.380274367062, 4771.809127634908, 5003.5997120230295, 5027.416363845377, 5029.705542869427, 5062.848114556569, 4444.911101777979, 4505.301678239878, 4509.0, 4530.75080870552, 4534.88662783433, 5938.495227905633, 6060.2424696912885, 6076.149339092531, 6155.692215389213, 6160.353162917874, 5553.611247212697, 5650.943490565124, 5677.034904066319, 5731.971340143273, 5756.366799652035, 6556.672166391709, 6612.504062195355, 6623.933760662379, 6638.73445062197, 6683.598984060924, 4854.902901941941, 4865.683730557503, 4886.218205087204, 4920.188168952154, 4926.866820631239, 6640.236372817139, 6740.191177058784, 6796.25241223465, 6851.725930962805, 6859.9314006860295, 4967.801287948441, 4987.850364489072, 5026.944341688213, 5029.723365214948, 5076.949230507647, 5006.3992320921, 5068.315777370008, 5101.795928162906, 5102.617303702237, 5115.335006449212, 5567.4432556744005, 5613.270274864241, 5644.887102258014, 5694.515966142924, 5721.313442386941, 6503.447206987365, 6628.33716628343, 6637.269900311058, 6684.565503242274, 6689.832754181184, 1730.195459111519, 1777.4667599720033, 1778.084286592406, 1779.9555011124826, 1784.9464516064538, 1163.0753550927034, 1212.4483360071147, 1236.208826351136, 1238.2756087688622, 1240.4418011894504, 5663.971680141655, 5714.399988001283, 5719.227904232958, 5726.656400615976, 5740.913886291709, 6637.46900247979, 6654.767083152066, 6680.766173183915, 6708.746258064834, 6782.287859774751, 5638.774449022075, 5690.146478028329, 5691.743871525791, 5695.373508914016, 5759.568032397587, 3558.484019817112, 3571.5714114306447, 3576.801771406556, 3602.45963105531, 3606.8998955318357, 6468.482521398277, 6480.287168411471, 6486.935130648633, 6533.281339052701, 6535.8692826143215, 6883.552569083094, 6887.724491020404, 6957.60847830436, 6989.580625162506, 7005.824854378681, 6070.7875224366935, 6307.432331090224, 6413.45485633717, 6430.421262086435, 6434.903476447951, 6504.7315773423725, 6681.69932353055, 6683.460285091634, 6742.157230346207, 6761.628110453972, 6656.667166641745, 6697.497687673346, 6761.22245941723, 6783.0, 6824.146981627297, 6359.141515895295, 6414.871702566016, 6465.870682586228, 6519.706613202323, 6591.274959754519, 5026.899462010666, 5036.093503169464, 5063.898722025612, 5064.518870707277, 5065.0, 6387.840303992437, 6681.832954176184, 6727.192736871607, 6841.657917104026, 6857.485688573277, 6358.650274234961, 6469.644169570531, 6505.642189679613, 6524.217093948757, 6589.80230593083, 6486.2216534016225, 6520.478361730955, 6555.4427873631275, 6560.901586476302, 6574.27682954865, 6361.363863613602, 6471.579347342407, 6491.545591808717, 6503.479721622353, 6512.0, 6390.827118779637, 6529.779874842387, 6601.240857301472, 6641.546395874022, 6684.43182329488, 6380.138681278154, 6424.325445828121, 6473.643949582818, 6476.773312934025, 6481.805545833632], "value": 5074.510470309111, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [875.6628697951287, 894.883665123534, 911.1890417528397, 918.6049998500646, 935.9953200233998, 19218.61562768744, 20195.0, 20267.290644827433, 20280.89859550702, 20341.084651190697, 18077.63844723105, 18536.90731546344, 18603.534911627215, 18650.0, 18913.527161820963, 957.3155194036262, 972.8589354543587, 974.5030034682292, 974.6783561424749, 974.8878878928907, 963.6868017894212, 966.3911735606558, 975.34651783305, 977.1157102821923, 979.9755006124833, 994.2344394815988, 1026.4508487958944, 1028.8662473878423, 1029.9124574411185, 1049.1659130990881, 1005.557554675944, 1013.1995723378523, 1013.3919648211088, 1017.4302390661217, 1018.1956254558927, 726.7456390263366, 739.8668239716849, 747.4618274842105, 750.8761054426013, 752.2139364364252, 20026.499337516678, 20369.4907627309, 20584.79415205844, 20587.691184632244, 20653.27713530034, 18848.246070157176, 19169.616607667907, 19196.328128515575, 19409.80590194094, 19575.80424195754, 15830.76253856193, 16182.75725864113, 16275.267612957445, 16299.348026078942, 16430.096344701036, 3720.4233343831747, 3728.198437335986, 3756.5679946806194, 3765.265773174232, 3773.3773927301963, 135482.0, 137543.31228343793, 140583.29708351495, 140660.0, 142146.57853421438, 15685.215739212994, 15757.842421575637, 15911.602209944613, 16180.190990450667, 16227.269772860249, 29968.100956971324, 29982.70017299799, 31336.37327253442, 31420.214494637818, 31499.37001259962, 9011.594478248495, 9047.095290470901, 9098.727038188865, 9115.635374584943, 9118.86321705175, 4467.955320446819, 4572.268437050123, 4576.725396476222, 4579.473360563511, 4583.679142460062, 5447.509724124848, 5449.4005659377435, 5484.177373393943, 5511.3937466878615, 5565.860853478614, 939.5959737313021, 958.8274110660009, 975.4391225045628, 977.237754551451, 986.413084214891, 682.2529330383222, 707.6214225389494, 711.1040089487283, 714.7677004973405, 719.1406269507888, 11733.647990560297, 11894.226875253255, 12009.09931755122, 12426.486333056278, 12505.499780008699, 695.9130108736408, 696.1646024770296, 700.0479348086598, 702.9543079699803, 714.3071220915704, 5452.91820622691, 5561.138023606348, 5576.163575463713, 5636.070048441961, 5649.491545760901, 126110.36944815217, 127304.36347818201, 127744.36127819301, 128442.0, 128519.35740321239, 108475.45762271139, 111340.44329778299, 111525.0, 112343.99999999837, 114610.0, 95828.0, 95987.0, 97049.5147524272, 97212.51393743127, 98529.50735246278, 9922.553485093043, 10182.389056656624, 10187.847182292124, 10216.335938163995, 10268.794624107626, 44011.01950412175, 44147.77926110349, 44251.557484424746, 45345.319820202065, 46548.30177547272, 58207.70896145492, 58839.41160588339, 59025.0, 59113.70443147929, 60790.696046519486, 15312.0, 15369.615759606098, 15471.922640387176, 15547.455839045579, 15550.377984880479, 16423.67152656964, 16563.751543727096, 16643.91678041602, 16688.582785430463, 16795.244214010156, 13687.178769273876, 13718.0, 13769.931150344584, 14003.22982235946, 14022.439102435788, 13442.596722098353, 13447.529336473177, 13542.458301667823, 13563.254021028939, 13681.315934203449, 13395.598132056053, 13402.798958015443, 13447.327633618475, 13560.59318220455, 13580.728385432434, 11317.943410282896, 11334.546618135182, 11537.826932596186, 11677.76644467123, 11718.589849355232, 11707.707307317385, 11911.3448760319, 12088.576899808464, 12118.575849845212, 12154.0], "value": 8799.227781477115, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1461.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 113.0, 107.0, 112.0, 94.0, 116.0, 113.0, 111.0, 107.0, 113.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 118.0, 115.0, 117.0, 124.0, 152.0, 124.0, 153.0, 122.0, 122.0], "value": 126.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 168.0, 173.0, 171.0, 162.0, 183.0, 168.0, 164.0, 166.0, 163.0], "value": 168.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 74.0, 82.0, 75.0, 74.0, 77.0, 78.0, 83.0, 76.0], "value": 78.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 82.0, 82.0, 78.0, 79.0, 91.0, 79.0, 80.0, 85.0, 79.0], "value": 81.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 110.0, 122.0, 119.0, 124.0, 114.0, 115.0, 114.0, 114.0, 115.0], "value": 116.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 150.0, 147.0, 157.0, 150.0, 149.0, 149.0, 150.0, 150.0], "value": 150.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 100.0, 103.0, 94.0, 95.0, 98.0, 101.0, 95.0, 102.0, 97.0], "value": 98.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 58.0, 54.0, 54.0, 58.0, 54.0, 56.0, 51.0, 53.0, 58.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [42.0, 45.0, 49.0, 41.0, 49.0, 41.0, 39.0, 39.0, 38.0, 39.0], "value": 42.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 91.0, 76.0, 76.0, 78.0, 78.0, 84.0, 72.0, 78.0, 75.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 115.0, 118.0, 116.0, 117.0, 112.0, 115.0, 119.0, 110.0, 119.0], "value": 115.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 177.0, 174.0, 174.0, 171.0, 176.0, 180.0, 172.0, 169.0, 168.0], "value": 173.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 63.0, 65.0, 69.0, 68.0, 64.0, 68.0, 64.0, 66.0], "value": 65.8, "unit": "score"}]}]} 15:26:01 INFO - Return code: 0 15:26:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:26:01 INFO - # TBPL SUCCESS # 15:26:01 INFO - Running post-action listener: _package_coverage_data 15:26:01 INFO - Running post-action listener: _resource_record_post_action 15:26:01 INFO - [mozharness: 2017-09-20 22:26:01.408963Z] Finished run-tests step (success) 15:26:01 INFO - Running post-run listener: _resource_record_post_run 15:26:01 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4476928; Write bytes: 336191488; Read time: 2532; Write time: 329636 15:26:01 INFO - TinderboxPrint: CPU usage
13.3% 15:26:01 INFO - TinderboxPrint: I/O read bytes / time
4,476,928 / 2,532 15:26:01 INFO - TinderboxPrint: I/O write bytes / time
336,191,488 / 329,636 15:26:01 INFO - TinderboxPrint: CPU idle
8,255.1 (86.7%) 15:26:01 INFO - TinderboxPrint: CPU user
1,201.2 (12.6%) 15:26:01 INFO - TinderboxPrint: Swap in / out
0 / 0 15:26:01 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 9932800; Read time: 0; Write time: 1232 15:26:01 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 15:26:01 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4472832; Write bytes: 325828608; Read time: 2516; Write time: 328376 15:26:02 INFO - Running post-run listener: _upload_blobber_files 15:26:02 INFO - Blob upload gear active. 15:26:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:26:02 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 15:26:02 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'] 15:26:02 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 15:26:02 INFO - (blobuploader) - INFO - Open directory for files ... 15:26:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:26:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:26:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:26:03 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:26:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:26:03 INFO - (blobuploader) - INFO - Done attempting. 15:26:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:26:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:26:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:26:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:26:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:26:10 INFO - (blobuploader) - INFO - Done attempting. 15:26:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:26:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:26:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:26:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:26:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:26:11 INFO - (blobuploader) - INFO - Done attempting. 15:26:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:26:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:26:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:26:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:26:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:26:12 INFO - (blobuploader) - INFO - Done attempting. 15:26:12 INFO - (blobuploader) - INFO - Iteration through files over. 15:26:12 INFO - Return code: 0 15:26:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:26:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:26:12 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3156a37cada0718e6790cad27464ab635526efd6b3e9e5ecdf6327956f711472d9ebab1b08b0be1fb00ce7d1891ca438e713447e7806b7b3cbc3b39dca0c227", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/addbb7040bee5bd94aec840df0f7eb84d5b3c84f4bbd63344ae128a6251dc7c54b32a896241534f8f6ab3cdaebe5bc77b7d02b4731443dd1b1bd192bbe3cf8c3", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fc320cffeb69cde16f932ca1e82300aae5a2fd2417079e63a8e74e5f2e7ab4d83814cb5591f700c857e89c5ddf57280370d6d4aced893f6e779022edba5ac1e", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c1da2b2f196401dabca273962870c0975088a1297abdae6b5cb4ce16add15bc6fe90b2e181ea336580b4633db5be6cdf55beda51d607e7658da4933b5721756"} 15:26:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:26:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:26:12 INFO - Contents: 15:26:12 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3156a37cada0718e6790cad27464ab635526efd6b3e9e5ecdf6327956f711472d9ebab1b08b0be1fb00ce7d1891ca438e713447e7806b7b3cbc3b39dca0c227", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/addbb7040bee5bd94aec840df0f7eb84d5b3c84f4bbd63344ae128a6251dc7c54b32a896241534f8f6ab3cdaebe5bc77b7d02b4731443dd1b1bd192bbe3cf8c3", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fc320cffeb69cde16f932ca1e82300aae5a2fd2417079e63a8e74e5f2e7ab4d83814cb5591f700c857e89c5ddf57280370d6d4aced893f6e779022edba5ac1e", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c1da2b2f196401dabca273962870c0975088a1297abdae6b5cb4ce16add15bc6fe90b2e181ea336580b4633db5be6cdf55beda51d607e7658da4933b5721756"} 15:26:12 INFO - Running post-run listener: copy_logs_to_upload_dir 15:26:12 INFO - Copying logs to upload dir... 15:26:12 INFO - mkdir: /builds/slave/test/build/upload/logs 15:26:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.072862 ========= master_lag: 0.14 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-09-20 15:26:12.651163) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-20 15:26:12.658007) ========= 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=9bfb7e13875ed353a705960e000001c0-1505936161.49982-244763078 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3156a37cada0718e6790cad27464ab635526efd6b3e9e5ecdf6327956f711472d9ebab1b08b0be1fb00ce7d1891ca438e713447e7806b7b3cbc3b39dca0c227", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/addbb7040bee5bd94aec840df0f7eb84d5b3c84f4bbd63344ae128a6251dc7c54b32a896241534f8f6ab3cdaebe5bc77b7d02b4731443dd1b1bd192bbe3cf8c3", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fc320cffeb69cde16f932ca1e82300aae5a2fd2417079e63a8e74e5f2e7ab4d83814cb5591f700c857e89c5ddf57280370d6d4aced893f6e779022edba5ac1e", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c1da2b2f196401dabca273962870c0975088a1297abdae6b5cb4ce16add15bc6fe90b2e181ea336580b4633db5be6cdf55beda51d607e7658da4933b5721756"} build_url:https://queue.taskcluster.net/v1/task/So2N-P5gRV2VMrCgAQvl_g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011266 build_url: 'https://queue.taskcluster.net/v1/task/So2N-P5gRV2VMrCgAQvl_g/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3156a37cada0718e6790cad27464ab635526efd6b3e9e5ecdf6327956f711472d9ebab1b08b0be1fb00ce7d1891ca438e713447e7806b7b3cbc3b39dca0c227", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/addbb7040bee5bd94aec840df0f7eb84d5b3c84f4bbd63344ae128a6251dc7c54b32a896241534f8f6ab3cdaebe5bc77b7d02b4731443dd1b1bd192bbe3cf8c3", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fc320cffeb69cde16f932ca1e82300aae5a2fd2417079e63a8e74e5f2e7ab4d83814cb5591f700c857e89c5ddf57280370d6d4aced893f6e779022edba5ac1e", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c1da2b2f196401dabca273962870c0975088a1297abdae6b5cb4ce16add15bc6fe90b2e181ea336580b4633db5be6cdf55beda51d607e7658da4933b5721756"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-20 15:26:12.685968) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 15:26:12.688701) ========= 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=9bfb7e13875ed353a705960e000001c0-1505936161.49982-244763078 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004437 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 15:26:12.771410) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-20 15:26:12.773729) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-20 15:26:12.774028) ========= ========= Total master_lag: 0.38 =========