builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-059 starttime: 1504186282.63 results: success (0) revision: fb22415719a9d971a2646fa2d1b74e134ca00c3d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-31 06:31:22.631105) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-31 06:31:22.631808) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-31 06:31:22.632274) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-31 06:31:22.650360) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 06:31:22.650947) ========= 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=3a3620fb28aea1604ab609ef000001d2-1504186276.579097-526733859 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-31 06:31:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 80.1M=0s 2017-08-31 06:31:22 (80.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.093430 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 06:31:22.760889) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 06:31:22.761205) ========= 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=3a3620fb28aea1604ab609ef000001d2-1504186276.579097-526733859 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023119 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 06:31:22.811530) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 06:31:22.811862) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fb22415719a9d971a2646fa2d1b74e134ca00c3d --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 fb22415719a9d971a2646fa2d1b74e134ca00c3d --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=3a3620fb28aea1604ab609ef000001d2-1504186276.579097-526733859 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-31 06:31:22,865 truncating revision to first 12 chars 2017-08-31 06:31:22,865 Setting DEBUG logging. 2017-08-31 06:31:22,865 attempt 1/10 2017-08-31 06:31:22,865 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fb22415719a9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-31 06:31:23,172 unpacking tar archive at: mozilla-central-fb22415719a9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.639835 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 06:31:23.466269) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-31 06:31:23.466584) ========= script_repo_revision: fb22415719a9d971a2646fa2d1b74e134ca00c3d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-31 06:31:23.466953) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-31 06:31:23.467213) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-31 06:31:23.479122) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-08-31 06:31:23.479502) ========= /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=3a3620fb28aea1604ab609ef000001d2-1504186276.579097-526733859 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:31:23 INFO - MultiFileLogger online at 20170831 06:31:23 in /builds/slave/test 06:31:23 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 06:31:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:31:23 INFO - {'append_to_log': False, 06:31:23 INFO - 'base_work_dir': '/builds/slave/test', 06:31:23 INFO - 'blob_upload_branch': 'Firefox', 06:31:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:31:23 INFO - 'branch': 'Firefox', 06:31:23 INFO - 'buildbot_json_path': 'buildprops.json', 06:31:23 INFO - 'code_coverage': False, 06:31:23 INFO - 'config_files': ('talos/linux_config.py',), 06:31:23 INFO - 'default_actions': ('clobber', 06:31:23 INFO - 'read-buildbot-config', 06:31:23 INFO - 'download-and-extract', 06:31:23 INFO - 'populate-webroot', 06:31:23 INFO - 'create-virtualenv', 06:31:23 INFO - 'install', 06:31:23 INFO - 'setup-mitmproxy', 06:31:23 INFO - 'run-tests'), 06:31:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:31:23 INFO - 'disable_ccov_upload': False, 06:31:23 INFO - 'disable_stylo': False, 06:31:23 INFO - 'download_minidump_stackwalk': True, 06:31:23 INFO - 'download_symbols': 'ondemand', 06:31:23 INFO - 'enable_stylo': False, 06:31:23 INFO - 'enable_webrender': False, 06:31:23 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 06:31:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:31:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:31:23 INFO - 'gecko_profile': False, 06:31:23 INFO - 'gecko_profile_interval': 0, 06:31:23 INFO - 'installer_path': 'installer.exe', 06:31:23 INFO - 'log_level': 'info', 06:31:23 INFO - 'log_name': 'talos', 06:31:23 INFO - 'log_to_console': True, 06:31:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:31:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:31:23 INFO - 'opt_config_files': (), 06:31:23 INFO - 'pip_index': False, 06:31:23 INFO - 'suite': 'dromaeojs-e10s', 06:31:23 INFO - 'system_bits': '32', 06:31:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:31:23 INFO - 'title': 'talos-linux64-ix-059', 06:31:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:31:23 INFO - 'use_talos_json': True, 06:31:23 INFO - 'verify': 'False', 06:31:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:31:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:31:23 INFO - 'work_dir': 'build'} 06:31:23 INFO - [mozharness: 2017-08-31 13:31:23.662639Z] Running clobber step. 06:31:23 INFO - Running pre-action listener: _resource_record_pre_action 06:31:23 INFO - Running main action method: clobber 06:31:23 INFO - rmtree: /builds/slave/test/build 06:31:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:31:24 INFO - Running post-action listener: _resource_record_post_action 06:31:24 INFO - [mozharness: 2017-08-31 13:31:24.671345Z] Finished clobber step (success) 06:31:24 INFO - [mozharness: 2017-08-31 13:31:24.671442Z] Running read-buildbot-config step. 06:31:24 INFO - Running pre-action listener: _resource_record_pre_action 06:31:24 INFO - Running main action method: read_buildbot_config 06:31:24 INFO - Using buildbot properties: 06:31:24 INFO - { 06:31:24 INFO - "project": "", 06:31:24 INFO - "product": "firefox", 06:31:24 INFO - "who": "archaeopteryx@coole-files.de", 06:31:24 INFO - "installer_path": "public/build/target.tar.bz2", 06:31:24 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 06:31:24 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 06:31:24 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 06:31:24 INFO - "stage_platform": "linux64-qr", 06:31:24 INFO - "basedir": "/builds/slave/test", 06:31:24 INFO - "buildnumber": 22, 06:31:24 INFO - "platform": "ubuntu64_hw_qr", 06:31:24 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:31:24 INFO - "slavebuilddir": "test", 06:31:24 INFO - "taskId": "cNKW8d5AQjWUKhm9VOd4AA", 06:31:24 INFO - "branch": "mozilla-central", 06:31:24 INFO - "script_repo_revision": "production", 06:31:24 INFO - "revision": "fb22415719a9d971a2646fa2d1b74e134ca00c3d", 06:31:24 INFO - "slavename": "talos-linux64-ix-059", 06:31:24 INFO - "repo_path": "mozilla-central" 06:31:24 INFO - } 06:31:24 INFO - Finding installer, test and symbols from parent task. 06:31:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cNKW8d5AQjWUKhm9VOd4AA'}, attempt #1 06:31:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cNKW8d5AQjWUKhm9VOd4AA'}, attempt #1 06:31:25 INFO - Task dependencies: RI4nAJyITZ2MQzniRVqbBQ 06:31:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ'}, attempt #1 06:31:26 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.tar.bz2 06:31:26 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.test_packages.json 06:31:26 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.crashreporter-symbols.zip 06:31:26 INFO - Running post-action listener: _resource_record_post_action 06:31:26 INFO - [mozharness: 2017-08-31 13:31:26.125841Z] Finished read-buildbot-config step (success) 06:31:26 INFO - [mozharness: 2017-08-31 13:31:26.126057Z] Running download-and-extract step. 06:31:26 INFO - Running pre-action listener: _resource_record_pre_action 06:31:26 INFO - Running main action method: download_and_extract 06:31:26 INFO - mkdir: /builds/slave/test/build/tests 06:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:31:26 INFO - trying https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.test_packages.json 06:31:26 INFO - Downloading https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:31:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:31:26 INFO - Downloaded 989 bytes. 06:31:26 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:31:26 INFO - Using the following test package requirements: 06:31:26 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 06:31:26 INFO - u'common': [u'target.common.tests.zip'], 06:31:26 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:31:26 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:31:26 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:31:26 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:31:26 INFO - u'mozbase': [u'target.common.tests.zip'], 06:31:26 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:31:26 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:31:26 INFO - u'web-platform': [u'target.common.tests.zip', 06:31:26 INFO - u'target.web-platform.tests.tar.gz'], 06:31:26 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:31:26 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:31:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.common.tests.zip 06:31:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:31:26 INFO - Fetch https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.common.tests.zip into memory 06:31:27 INFO - Content-Length response header: 54932979 06:31:27 INFO - Bytes received: 54932979 06:31:38 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:31:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.common.tests.zip 06:31:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:31:38 INFO - Fetch https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.common.tests.zip into memory 06:31:39 INFO - Content-Length response header: 54932979 06:31:39 INFO - Bytes received: 54932979 06:31:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.talos.tests.zip 06:31:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:31:51 INFO - Fetch https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.talos.tests.zip into memory 06:31:52 INFO - Content-Length response header: 14496650 06:31:52 INFO - Bytes received: 14496650 06:31: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')]} 06:31:52 INFO - trying https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.tar.bz2 06:31:52 INFO - Downloading https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:31:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:31:53 INFO - Downloaded 62671715 bytes. 06:31:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.tar.bz2 06:31:53 INFO - mkdir: /builds/slave/test/properties 06:31:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:31:53 INFO - Writing to file /builds/slave/test/properties/build_url 06:31:53 INFO - Contents: 06:31:53 INFO - build_url:https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.tar.bz2 06:31:53 INFO - Running post-action listener: _resource_record_post_action 06:31:53 INFO - Running post-action listener: find_tests_for_verification 06:31:53 INFO - Running post-action listener: set_extra_try_arguments 06:31:53 INFO - [mozharness: 2017-08-31 13:31:53.786540Z] Finished download-and-extract step (success) 06:31:53 INFO - [mozharness: 2017-08-31 13:31:53.786637Z] Running populate-webroot step. 06:31:53 INFO - Running pre-action listener: _resource_record_pre_action 06:31:53 INFO - Running main action method: populate_webroot 06:31:53 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:31:53 INFO - 'chromez-stylo-e10s': {'talos_options': ['--enable-stylo'], 06:31:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:31:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:31:53 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--enable-stylo'], 06:31:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:31:53 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:31:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:31:53 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 06:31:53 INFO - 'talos_options': ['--enable-stylo'], 06:31:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:31:53 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:31:53 INFO - 'tests': ['damp', 'tps']}, 06:31:53 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 06:31:53 INFO - 'talos_options': ['--enable-stylo'], 06:31:53 INFO - 'tests': ['damp', 'tps']}, 06:31:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:31:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 06:31:53 INFO - 'g4-stylo-e10s': {'talos_options': ['--enable-stylo'], 06:31:53 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 06:31:53 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 06:31:53 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 06:31:53 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 06:31:53 INFO - 'talos_options': ['--enable-stylo'], 06:31:53 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 06:31:53 INFO - 'other-e10s': {'tests': ['a11yr', 06:31:53 INFO - 'ts_paint', 06:31:53 INFO - 'tpaint', 06:31:53 INFO - 'sessionrestore', 06:31:53 INFO - 'sessionrestore_many_windows', 06:31:53 INFO - 'sessionrestore_no_auto_restore', 06:31:53 INFO - 'tabpaint']}, 06:31:53 INFO - 'other-stylo-e10s': {'talos_options': ['--enable-stylo'], 06:31:53 INFO - 'tests': ['a11yr', 06:31:53 INFO - 'ts_paint', 06:31:53 INFO - 'tpaint', 06:31:53 INFO - 'sessionrestore', 06:31:53 INFO - 'sessionrestore_many_windows', 06:31:53 INFO - 'sessionrestore_no_auto_restore', 06:31:53 INFO - 'tabpaint']}, 06:31:53 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 06:31:53 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 06:31:53 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--enable-stylo'], 06:31:53 INFO - 'tests': ['bloom_basic_singleton']}, 06:31:53 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--enable-stylo'], 06:31:53 INFO - 'tests': ['bloom_basic']}, 06:31:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:31:53 INFO - 'tsvgr_opacity', 06:31:53 INFO - 'tart', 06:31:53 INFO - 'tscrollx', 06:31:53 INFO - 'tsvg_static']}, 06:31:53 INFO - 'svgr-stylo-e10s': {'talos_options': ['--enable-stylo'], 06:31:53 INFO - 'tests': ['tsvgx', 06:31:53 INFO - 'tsvgr_opacity', 06:31:53 INFO - 'tart', 06:31:53 INFO - 'tscrollx', 06:31:53 INFO - 'tsvg_static']}, 06:31:53 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:31:53 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 06:31:53 INFO - 'talos_options': ['--enable-stylo'], 06:31:53 INFO - 'tests': ['tp5o']}, 06:31:53 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 06:31:53 INFO - 'talos_options': ['--mitmproxy', 06:31:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 06:31:53 INFO - '--firstNonBlankPaint'], 06:31:53 INFO - 'tests': ['tp6_google', 06:31:53 INFO - 'tp6_youtube', 06:31:53 INFO - 'tp6_amazon', 06:31:53 INFO - 'tp6_facebook']}, 06:31:53 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 06:31:53 INFO - 'talos_options': ['--enable-stylo', 06:31:53 INFO - '--mitmproxy', 06:31:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 06:31:53 INFO - '--firstNonBlankPaint'], 06:31:53 INFO - 'tests': ['tp6_google', 06:31:53 INFO - 'tp6_youtube', 06:31:53 INFO - 'tp6_amazon', 06:31:53 INFO - 'tp6_facebook']}, 06:31:53 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 06:31:53 INFO - 'talos_options': ['--enable-stylo', 06:31:53 INFO - '--stylo-threads=1', 06:31:53 INFO - '--mitmproxy', 06:31:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 06:31:53 INFO - '--firstNonBlankPaint'], 06:31:53 INFO - 'tests': ['tp6_google', 06:31:53 INFO - 'tp6_youtube', 06:31:53 INFO - 'tp6_amazon', 06:31:53 INFO - 'tp6_facebook']}, 06:31:53 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:31:53 INFO - 'talos_options': ['--xperf_path', 06:31:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:31:53 INFO - 'tests': ['tp5n']}, 06:31:53 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 06:31:53 INFO - 'talos_options': ['--enable-stylo', 06:31:53 INFO - '--xperf_path', 06:31:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:31:53 INFO - 'tests': ['tp5n']}}} 06:31:53 INFO - Running post-action listener: _resource_record_post_action 06:31:53 INFO - [mozharness: 2017-08-31 13:31:53.800864Z] Finished populate-webroot step (success) 06:31:53 INFO - [mozharness: 2017-08-31 13:31:53.800953Z] Running create-virtualenv step. 06:31:53 INFO - Running pre-action listener: _resource_record_pre_action 06:31:53 INFO - Running main action method: create_virtualenv 06:31:53 INFO - Creating virtualenv /builds/slave/test/build/venv 06:31:53 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:31:53 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 06:31:53 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 06:31:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:31:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:31:54 INFO - Installing distribute.............................................................................................................................................................................................done. 06:31:54 INFO - Installing pip...............done. 06:31:54 INFO - Return code: 0 06:31:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:31:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:31:54 INFO - Reading from file tmpfile_stdout 06:31:54 INFO - Output received: 06:31:54 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 06:31:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:31: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')]} 06:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31: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')]} 06:31:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcb11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe79a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1020b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d580>, '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 0x101e480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e910>, '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': '3a3620fb28aea1604ab609ef000001d2-1504186276.579097-526733859', '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 06:31: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', 'pip>=1.5'] in /builds/slave/test/build 06:31: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 pip>=1.5 06:31:54 INFO - Using env: {'DISPLAY': ':0', 06:31:54 INFO - 'HOME': '/home/cltbld', 06:31:54 INFO - 'LANG': 'en_US.UTF-8', 06:31:54 INFO - 'LANGUAGE': 'en_US:en', 06:31:54 INFO - 'LOGNAME': 'cltbld', 06:31:54 INFO - 'MAIL': '/var/mail/cltbld', 06:31:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:54 INFO - 'MOZ_NO_REMOTE': '1', 06:31:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:54 INFO - 'NO_EM_RESTART': '1', 06:31:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:54 INFO - 'PWD': '/builds/slave/test', 06:31:54 INFO - 'SHELL': '/bin/bash', 06:31:54 INFO - 'SHLVL': '1', 06:31:54 INFO - 'TERM': 'linux', 06:31:54 INFO - 'TMOUT': '86400', 06:31:54 INFO - 'USER': 'cltbld', 06:31:54 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1504186276.579097-526733859', 06:31:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:54 INFO - '_': '/tools/buildbot/bin/python'} 06:31:55 INFO - Ignoring indexes: http://pypi.python.org/simple/ 06:31:55 INFO - Downloading/unpacking pip>=1.5 06:31:55 INFO - Running setup.py egg_info for package pip 06:31:55 INFO - warning: no files found matching 'pip/cacert.pem' 06:31:55 INFO - warning: no files found matching '*.html' under directory 'docs' 06:31:55 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 06:31:55 INFO - no previously-included directories found matching 'docs/_build/_sources' 06:31:55 INFO - Installing collected packages: pip 06:31:55 INFO - Found existing installation: pip 1.1 06:31:55 INFO - Uninstalling pip: 06:31:55 INFO - Successfully uninstalled pip 06:31:55 INFO - Running setup.py install for pip 06:31:55 INFO - warning: no files found matching 'pip/cacert.pem' 06:31:55 INFO - warning: no files found matching '*.html' under directory 'docs' 06:31:55 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 06:31:55 INFO - no previously-included directories found matching 'docs/_build/_sources' 06:31:55 INFO - Installing pip script to /builds/slave/test/build/venv/bin 06:31:55 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 06:31:55 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 06:31:55 INFO - Successfully installed pip 06:31:55 INFO - Cleaning up... 06:31:55 INFO - Return code: 0 06:31:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:31:55 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')]} 06:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:55 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')]} 06:31:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:55 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 0xcb11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe79a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1020b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d580>, '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 0x101e480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e910>, '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': '3a3620fb28aea1604ab609ef000001d2-1504186276.579097-526733859', '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 06:31:55 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 06:31:55 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 06:31:55 INFO - Using env: {'DISPLAY': ':0', 06:31:55 INFO - 'HOME': '/home/cltbld', 06:31:55 INFO - 'LANG': 'en_US.UTF-8', 06:31:55 INFO - 'LANGUAGE': 'en_US:en', 06:31:55 INFO - 'LOGNAME': 'cltbld', 06:31:55 INFO - 'MAIL': '/var/mail/cltbld', 06:31:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:55 INFO - 'MOZ_NO_REMOTE': '1', 06:31:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:55 INFO - 'NO_EM_RESTART': '1', 06:31:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:55 INFO - 'PWD': '/builds/slave/test', 06:31:55 INFO - 'SHELL': '/bin/bash', 06:31:55 INFO - 'SHLVL': '1', 06:31:55 INFO - 'TERM': 'linux', 06:31:55 INFO - 'TMOUT': '86400', 06:31:55 INFO - 'USER': 'cltbld', 06:31:55 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1504186276.579097-526733859', 06:31:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:55 INFO - '_': '/tools/buildbot/bin/python'} 06:31:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:56 INFO - Downloading/unpacking psutil>=3.1.1 06:31: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 06:31: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 06:31: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 06:31: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 06:31:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:31:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:31:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:31:57 INFO - Installing collected packages: psutil 06:31:57 INFO - Running setup.py install for psutil 06:31:57 INFO - building 'psutil._psutil_linux' extension 06:31:57 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 06:31:57 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 06:31:57 INFO - building 'psutil._psutil_posix' extension 06:31:57 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 06:31:57 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 06:31:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:31:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:31:57 INFO - Successfully installed psutil 06:31:57 INFO - Cleaning up... 06:31:57 INFO - Return code: 0 06:31:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:31:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:31:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcb11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe79a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1020b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d580>, '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 0x101e480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e910>, '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': '3a3620fb28aea1604ab609ef000001d2-1504186276.579097-526733859', '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 06:31:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:31:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:31:57 INFO - Using env: {'DISPLAY': ':0', 06:31:57 INFO - 'HOME': '/home/cltbld', 06:31:57 INFO - 'LANG': 'en_US.UTF-8', 06:31:57 INFO - 'LANGUAGE': 'en_US:en', 06:31:57 INFO - 'LOGNAME': 'cltbld', 06:31:57 INFO - 'MAIL': '/var/mail/cltbld', 06:31:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:57 INFO - 'MOZ_NO_REMOTE': '1', 06:31:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:57 INFO - 'NO_EM_RESTART': '1', 06:31:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:57 INFO - 'PWD': '/builds/slave/test', 06:31:57 INFO - 'SHELL': '/bin/bash', 06:31:57 INFO - 'SHLVL': '1', 06:31:57 INFO - 'TERM': 'linux', 06:31:57 INFO - 'TMOUT': '86400', 06:31:57 INFO - 'USER': 'cltbld', 06:31:57 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1504186276.579097-526733859', 06:31:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:57 INFO - '_': '/tools/buildbot/bin/python'} 06:31:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:31:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:31:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:31:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:31:59 INFO - Installing collected packages: mozsystemmonitor 06:31:59 INFO - Running setup.py install for mozsystemmonitor 06:31:59 INFO - Successfully installed mozsystemmonitor 06:31:59 INFO - Cleaning up... 06:31:59 INFO - Return code: 0 06:31:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:31:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:31:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:59 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 0xcb11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe79a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1020b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d580>, '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 0x101e480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e910>, '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': '3a3620fb28aea1604ab609ef000001d2-1504186276.579097-526733859', '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 06:31:59 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 06:31:59 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 06:31:59 INFO - Using env: {'DISPLAY': ':0', 06:31:59 INFO - 'HOME': '/home/cltbld', 06:31:59 INFO - 'LANG': 'en_US.UTF-8', 06:31:59 INFO - 'LANGUAGE': 'en_US:en', 06:31:59 INFO - 'LOGNAME': 'cltbld', 06:31:59 INFO - 'MAIL': '/var/mail/cltbld', 06:31:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:59 INFO - 'MOZ_NO_REMOTE': '1', 06:31:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:59 INFO - 'NO_EM_RESTART': '1', 06:31:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:59 INFO - 'PWD': '/builds/slave/test', 06:31:59 INFO - 'SHELL': '/bin/bash', 06:31:59 INFO - 'SHLVL': '1', 06:31:59 INFO - 'TERM': 'linux', 06:31:59 INFO - 'TMOUT': '86400', 06:31:59 INFO - 'USER': 'cltbld', 06:31:59 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1504186276.579097-526733859', 06:31:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:59 INFO - '_': '/tools/buildbot/bin/python'} 06:31:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:59 INFO - Downloading/unpacking jsonschema==2.5.1 06:31:59 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 06:31:59 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 06:31:59 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 06:31:59 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 06:32:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:32:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:32:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:32:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:32:00 INFO - Downloading functools32-3.2.3-2.tar.gz 06:32:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:32:00 INFO - warning: no files found matching '*.txt' 06:32:00 INFO - no previously-included directories found matching 'build' 06:32:00 INFO - no previously-included directories found matching 'dist' 06:32:00 INFO - no previously-included directories found matching '.git*' 06:32:00 INFO - Installing collected packages: jsonschema, functools32 06:32:00 INFO - Running setup.py install for functools32 06:32:01 INFO - warning: no files found matching '*.txt' 06:32:01 INFO - no previously-included directories found matching 'build' 06:32:01 INFO - no previously-included directories found matching 'dist' 06:32:01 INFO - no previously-included directories found matching '.git*' 06:32:01 INFO - Successfully installed jsonschema functools32 06:32:01 INFO - Cleaning up... 06:32:01 INFO - Return code: 0 06:32:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:32:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xcb11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe79a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1020b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d580>, '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 0x101e480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e910>, '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': '3a3620fb28aea1604ab609ef000001d2-1504186276.579097-526733859', '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 06:32:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:32:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:32:01 INFO - Using env: {'DISPLAY': ':0', 06:32:01 INFO - 'HOME': '/home/cltbld', 06:32:01 INFO - 'LANG': 'en_US.UTF-8', 06:32:01 INFO - 'LANGUAGE': 'en_US:en', 06:32:01 INFO - 'LOGNAME': 'cltbld', 06:32:01 INFO - 'MAIL': '/var/mail/cltbld', 06:32:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:32:01 INFO - 'MOZ_NO_REMOTE': '1', 06:32:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:32:01 INFO - 'NO_EM_RESTART': '1', 06:32:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:32:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:32:01 INFO - 'PWD': '/builds/slave/test', 06:32:01 INFO - 'SHELL': '/bin/bash', 06:32:01 INFO - 'SHLVL': '1', 06:32:01 INFO - 'TERM': 'linux', 06:32:01 INFO - 'TMOUT': '86400', 06:32:01 INFO - 'USER': 'cltbld', 06:32:01 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1504186276.579097-526733859', 06:32:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:32:01 INFO - '_': '/tools/buildbot/bin/python'} 06:32:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:32:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:32:01 INFO - Cleaning up... 06:32:01 INFO - Return code: 0 06:32:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:32:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xcb11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe79a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1020b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d580>, '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 0x101e480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e910>, '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': '3a3620fb28aea1604ab609ef000001d2-1504186276.579097-526733859', '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 06:32:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:32:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:32:01 INFO - Using env: {'DISPLAY': ':0', 06:32:01 INFO - 'HOME': '/home/cltbld', 06:32:01 INFO - 'LANG': 'en_US.UTF-8', 06:32:01 INFO - 'LANGUAGE': 'en_US:en', 06:32:01 INFO - 'LOGNAME': 'cltbld', 06:32:01 INFO - 'MAIL': '/var/mail/cltbld', 06:32:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:32:01 INFO - 'MOZ_NO_REMOTE': '1', 06:32:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:32:01 INFO - 'NO_EM_RESTART': '1', 06:32:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:32:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:32:01 INFO - 'PWD': '/builds/slave/test', 06:32:01 INFO - 'SHELL': '/bin/bash', 06:32:01 INFO - 'SHLVL': '1', 06:32:01 INFO - 'TERM': 'linux', 06:32:01 INFO - 'TMOUT': '86400', 06:32:01 INFO - 'USER': 'cltbld', 06:32:01 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1504186276.579097-526733859', 06:32:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:32:01 INFO - '_': '/tools/buildbot/bin/python'} 06:32:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:32:01 INFO - Downloading/unpacking blobuploader==1.2.4 06:32: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 06:32: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 06:32: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 06:32: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 06:32:02 INFO - Downloading blobuploader-1.2.4.tar.gz 06:32:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:32:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:32:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:32:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:32:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:32:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:32: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 06:32: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 06:32: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 06:32: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 06:32:03 INFO - Downloading docopt-0.6.1.tar.gz 06:32:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:32:03 INFO - Installing collected packages: blobuploader, requests, docopt 06:32:03 INFO - Running setup.py install for blobuploader 06:32:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:32:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:32:03 INFO - Running setup.py install for requests 06:32:03 INFO - Running setup.py install for docopt 06:32:03 INFO - Successfully installed blobuploader requests docopt 06:32:03 INFO - Cleaning up... 06:32:03 INFO - Return code: 0 06:32:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:32: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')]} 06:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:32: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')]} 06:32:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:32:03 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 0xcb11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe79a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1020b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d580>, '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 0x101e480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e910>, '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': '3a3620fb28aea1604ab609ef000001d2-1504186276.579097-526733859', '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 06:32:03 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 06:32:03 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 06:32:03 INFO - Using env: {'DISPLAY': ':0', 06:32:03 INFO - 'HOME': '/home/cltbld', 06:32:03 INFO - 'LANG': 'en_US.UTF-8', 06:32:03 INFO - 'LANGUAGE': 'en_US:en', 06:32:03 INFO - 'LOGNAME': 'cltbld', 06:32:03 INFO - 'MAIL': '/var/mail/cltbld', 06:32:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:32:03 INFO - 'MOZ_NO_REMOTE': '1', 06:32:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:32:03 INFO - 'NO_EM_RESTART': '1', 06:32:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:32:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:32:03 INFO - 'PWD': '/builds/slave/test', 06:32:03 INFO - 'SHELL': '/bin/bash', 06:32:03 INFO - 'SHLVL': '1', 06:32:03 INFO - 'TERM': 'linux', 06:32:03 INFO - 'TMOUT': '86400', 06:32:03 INFO - 'USER': 'cltbld', 06:32:03 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1504186276.579097-526733859', 06:32:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:32:03 INFO - '_': '/tools/buildbot/bin/python'} 06:32:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:32:04 INFO - Running setup.py (path:/tmp/pip-PBW8rF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:32:04 INFO - Running setup.py (path:/tmp/pip-WsSbJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:32:04 INFO - Running setup.py (path:/tmp/pip-UeZZtj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:32:04 INFO - Running setup.py (path:/tmp/pip-Bd57WD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:32:04 INFO - Running setup.py (path:/tmp/pip-a2HQ0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:32:04 INFO - Running setup.py (path:/tmp/pip-g6oqb5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:32:04 INFO - Running setup.py (path:/tmp/pip-9xMF3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:32:04 INFO - Running setup.py (path:/tmp/pip-HS2Zye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:32:04 INFO - Running setup.py (path:/tmp/pip-Cnzzps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:32:04 INFO - Running setup.py (path:/tmp/pip-z7su1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:32:04 INFO - Running setup.py (path:/tmp/pip-9Z4CtC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:32:04 INFO - Running setup.py (path:/tmp/pip-5uE8gW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:32:04 INFO - Running setup.py (path:/tmp/pip-Ig4PXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:32:04 INFO - Running setup.py (path:/tmp/pip-TbX4oQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:32:05 INFO - Running setup.py (path:/tmp/pip-yX14Al-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:32:05 INFO - Running setup.py (path:/tmp/pip-vUouBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:32:05 INFO - Running setup.py (path:/tmp/pip-BvMuLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:32:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:32:05 INFO - Running setup.py install for manifestparser 06:32:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:32:05 INFO - Running setup.py install for mozcrash 06:32:05 INFO - Running setup.py install for mozdebug 06:32:05 INFO - Running setup.py install for mozdevice 06:32:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:32:05 INFO - Running setup.py install for mozfile 06:32:05 INFO - Running setup.py install for mozhttpd 06:32:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:32:05 INFO - Running setup.py install for mozinfo 06:32:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:32:05 INFO - Running setup.py install for mozInstall 06:32:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:32:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:32:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:32:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:32:06 INFO - Running setup.py install for mozleak 06:32:06 INFO - Running setup.py install for mozlog 06:32:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:32:06 INFO - Running setup.py install for moznetwork 06:32:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:32:06 INFO - Running setup.py install for mozprocess 06:32:06 INFO - Running setup.py install for mozprofile 06:32:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:32:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:32:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:32:06 INFO - Running setup.py install for mozrunner 06:32:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:32:06 INFO - Running setup.py install for mozscreenshot 06:32:06 INFO - Running setup.py install for moztest 06:32:06 INFO - Running setup.py install for mozversion 06:32:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:32:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:32:06 INFO - Cleaning up... 06:32:07 INFO - Return code: 0 06:32:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:32:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:32:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:32:07 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 0xcb11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe79a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1020b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d580>, '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 0x101e480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e910>, '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': '3a3620fb28aea1604ab609ef000001d2-1504186276.579097-526733859', '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 06:32:07 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 06:32:07 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 06:32:07 INFO - Using env: {'DISPLAY': ':0', 06:32:07 INFO - 'HOME': '/home/cltbld', 06:32:07 INFO - 'LANG': 'en_US.UTF-8', 06:32:07 INFO - 'LANGUAGE': 'en_US:en', 06:32:07 INFO - 'LOGNAME': 'cltbld', 06:32:07 INFO - 'MAIL': '/var/mail/cltbld', 06:32:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:32:07 INFO - 'MOZ_NO_REMOTE': '1', 06:32:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:32:07 INFO - 'NO_EM_RESTART': '1', 06:32:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:32:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:32:07 INFO - 'PWD': '/builds/slave/test', 06:32:07 INFO - 'SHELL': '/bin/bash', 06:32:07 INFO - 'SHLVL': '1', 06:32:07 INFO - 'TERM': 'linux', 06:32:07 INFO - 'TMOUT': '86400', 06:32:07 INFO - 'USER': 'cltbld', 06:32:07 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1504186276.579097-526733859', 06:32:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:32:07 INFO - '_': '/tools/buildbot/bin/python'} 06:32:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:32:07 INFO - Running setup.py (path:/tmp/pip-6mKmm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:32:07 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)) 06:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:32:07 INFO - Running setup.py (path:/tmp/pip-5qesmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:32:07 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)) 06:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:32:07 INFO - Running setup.py (path:/tmp/pip-MWGEiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:32:07 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)) 06:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:32:07 INFO - Running setup.py (path:/tmp/pip-z0LlvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:32:07 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)) 06:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:32:07 INFO - Running setup.py (path:/tmp/pip-SwJJ0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:32:07 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)) 06:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:32:07 INFO - Running setup.py (path:/tmp/pip-WwuNcG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:32:07 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)) 06:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:32:07 INFO - Running setup.py (path:/tmp/pip-bXjqSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:32:07 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)) 06:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:32:07 INFO - Running setup.py (path:/tmp/pip-7ayo5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:32:07 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)) 06:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:32:07 INFO - Running setup.py (path:/tmp/pip-bkIcDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:32:07 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)) 06:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:32:07 INFO - Running setup.py (path:/tmp/pip-iLf5wB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:32:07 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)) 06:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:32:07 INFO - Running setup.py (path:/tmp/pip-peiEAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:32:08 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)) 06:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:32:08 INFO - Running setup.py (path:/tmp/pip-J0VtTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:32:08 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)) 06:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:32:08 INFO - Running setup.py (path:/tmp/pip-iq1i3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:32:08 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)) 06:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:32:08 INFO - Running setup.py (path:/tmp/pip-CSRwzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:32:08 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)) 06:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:32:08 INFO - Running setup.py (path:/tmp/pip-41X_WQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:32:08 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)) 06:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:32:08 INFO - Running setup.py (path:/tmp/pip-AdYion-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:32:08 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)) 06:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:32:08 INFO - Running setup.py (path:/tmp/pip-_Ml8c_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:32:08 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)) 06:32:08 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)) 06:32:08 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)) 06:32:08 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)) 06:32:08 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)) 06:32:08 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)) 06:32:08 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)) 06:32:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:32:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:32:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:32:09 INFO - Downloading blessings-1.6.tar.gz 06:32:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:32:09 INFO - Installing collected packages: blessings 06:32:09 INFO - Running setup.py install for blessings 06:32:09 INFO - Successfully installed blessings 06:32:09 INFO - Cleaning up... 06:32:09 INFO - Return code: 0 06:32:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:32:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:32:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:32:09 INFO - Reading from file tmpfile_stdout 06:32:09 INFO - Current package versions: 06:32:09 INFO - argparse == 1.2.1 06:32:09 INFO - blessings == 1.6 06:32:09 INFO - blobuploader == 1.2.4 06:32:09 INFO - docopt == 0.6.1 06:32:09 INFO - functools32 == 3.2.3-2 06:32:09 INFO - jsonschema == 2.5.1 06:32:09 INFO - manifestparser == 1.1 06:32:09 INFO - mozInstall == 1.13 06:32:09 INFO - mozcrash == 1.0 06:32:09 INFO - mozdebug == 0.1 06:32:09 INFO - mozdevice == 0.51 06:32:09 INFO - mozfile == 1.2 06:32:09 INFO - mozhttpd == 0.7 06:32:09 INFO - mozinfo == 0.10 06:32:09 INFO - mozleak == 0.1 06:32:09 INFO - mozlog == 3.5 06:32:09 INFO - moznetwork == 0.27 06:32:09 INFO - mozprocess == 0.25 06:32:09 INFO - mozprofile == 0.28 06:32:09 INFO - mozrunner == 6.13 06:32:09 INFO - mozscreenshot == 0.1 06:32:09 INFO - mozsystemmonitor == 0.3 06:32:09 INFO - moztest == 0.8 06:32:09 INFO - mozversion == 1.4 06:32:09 INFO - psutil == 3.1.1 06:32:09 INFO - requests == 1.2.3 06:32:09 INFO - wsgiref == 0.1.2 06:32:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:32:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:32:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:32:10 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 0xcb11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe79a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1020b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d580>, '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 0x101e480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e910>, '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': '3a3620fb28aea1604ab609ef000001d2-1504186276.579097-526733859', '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 06:32:10 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 06:32:10 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 06:32:10 INFO - Using env: {'DISPLAY': ':0', 06:32:10 INFO - 'HOME': '/home/cltbld', 06:32:10 INFO - 'LANG': 'en_US.UTF-8', 06:32:10 INFO - 'LANGUAGE': 'en_US:en', 06:32:10 INFO - 'LOGNAME': 'cltbld', 06:32:10 INFO - 'MAIL': '/var/mail/cltbld', 06:32:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:32:10 INFO - 'MOZ_NO_REMOTE': '1', 06:32:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:32:10 INFO - 'NO_EM_RESTART': '1', 06:32:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:32:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:32:10 INFO - 'PWD': '/builds/slave/test', 06:32:10 INFO - 'SHELL': '/bin/bash', 06:32:10 INFO - 'SHLVL': '1', 06:32:10 INFO - 'TERM': 'linux', 06:32:10 INFO - 'TMOUT': '86400', 06:32:10 INFO - 'USER': 'cltbld', 06:32:10 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1504186276.579097-526733859', 06:32:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:32:10 INFO - '_': '/tools/buildbot/bin/python'} 06:32:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:32:10 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)) 06:32:10 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)) 06:32:10 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)) 06:32:10 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)) 06:32:10 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)) 06:32:10 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)) 06:32:10 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)) 06:32:10 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)) 06:32:10 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)) 06:32:10 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 06:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:32:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 06:32:11 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)) 06:32:11 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)) 06:32:11 INFO - Installing collected packages: simplejson 06:32:11 INFO - Running setup.py install for simplejson 06:32:11 INFO - building 'simplejson._speedups' extension 06:32:11 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 06:32:12 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 06:32:12 INFO - Successfully installed simplejson 06:32:12 INFO - Cleaning up... 06:32:12 INFO - Return code: 0 06:32:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:32:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:32:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:32:12 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 0xcb11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe79a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1020b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d580>, '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 0x101e480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e910>, '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': '3a3620fb28aea1604ab609ef000001d2-1504186276.579097-526733859', '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 06:32:12 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 06:32:12 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 06:32:12 INFO - Using env: {'DISPLAY': ':0', 06:32:12 INFO - 'HOME': '/home/cltbld', 06:32:12 INFO - 'LANG': 'en_US.UTF-8', 06:32:12 INFO - 'LANGUAGE': 'en_US:en', 06:32:12 INFO - 'LOGNAME': 'cltbld', 06:32:12 INFO - 'MAIL': '/var/mail/cltbld', 06:32:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:32:12 INFO - 'MOZ_NO_REMOTE': '1', 06:32:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:32:12 INFO - 'NO_EM_RESTART': '1', 06:32:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:32:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:32:12 INFO - 'PWD': '/builds/slave/test', 06:32:12 INFO - 'SHELL': '/bin/bash', 06:32:12 INFO - 'SHLVL': '1', 06:32:12 INFO - 'TERM': 'linux', 06:32:12 INFO - 'TMOUT': '86400', 06:32:12 INFO - 'USER': 'cltbld', 06:32:12 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1504186276.579097-526733859', 06:32:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:32:12 INFO - '_': '/tools/buildbot/bin/python'} 06:32:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:32:12 INFO - Cleaning up... 06:32:12 INFO - Return code: 0 06:32:12 INFO - Running post-action listener: _resource_record_post_action 06:32:12 INFO - Running post-action listener: _start_resource_monitoring 06:32:12 INFO - Starting resource monitoring. 06:32:12 INFO - [mozharness: 2017-08-31 13:32:12.707566Z] Finished create-virtualenv step (success) 06:32:12 INFO - [mozharness: 2017-08-31 13:32:12.708106Z] Running install step. 06:32:12 INFO - Running pre-action listener: _resource_record_pre_action 06:32:12 INFO - Running main action method: install 06:32:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:32:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:32:12 INFO - Reading from file tmpfile_stdout 06:32:12 INFO - Detecting whether we're running mozinstall >=1.0... 06:32:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:32:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:32:13 INFO - Reading from file tmpfile_stdout 06:32:13 INFO - Output received: 06:32:13 INFO - Usage: mozinstall [options] installer 06:32:13 INFO - Options: 06:32:13 INFO - -h, --help show this help message and exit 06:32:13 INFO - -d DEST, --destination=DEST 06:32:13 INFO - Directory to install application into. [default: 06:32:13 INFO - "/builds/slave/test"] 06:32:13 INFO - --app=APP Application being installed. [default: firefox] 06:32:13 INFO - mkdir: /builds/slave/test/build/application 06:32:13 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'] 06:32:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:32:29 INFO - Reading from file tmpfile_stdout 06:32:29 INFO - Output received: 06:32:29 INFO - /builds/slave/test/build/application/firefox/firefox 06:32:29 INFO - Running post-action listener: _resource_record_post_action 06:32:29 INFO - [mozharness: 2017-08-31 13:32:29.538883Z] Finished install step (success) 06:32:29 INFO - [mozharness: 2017-08-31 13:32:29.539109Z] Running setup-mitmproxy step. 06:32:29 INFO - Running pre-action listener: _resource_record_pre_action 06:32:29 INFO - Running main action method: setup_mitmproxy 06:32:29 INFO - Skipping: mitmproxy is not required 06:32:29 INFO - Running post-action listener: _resource_record_post_action 06:32:29 INFO - [mozharness: 2017-08-31 13:32:29.539632Z] Finished setup-mitmproxy step (success) 06:32:29 INFO - [mozharness: 2017-08-31 13:32:29.539733Z] Running run-tests step. 06:32:29 INFO - Running pre-action listener: _resource_record_pre_action 06:32:29 INFO - Running pre-action listener: _set_gcov_prefix 06:32:29 INFO - Running main action method: run_tests 06:32:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:32:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:32:29 INFO - Python 2.7.3 06:32:29 INFO - Return code: 0 06:32:29 INFO - grabbing minidump binary from tooltool 06:32: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')]} 06:32:29 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 0x101d580>, '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 0x101e480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e910>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:32:29 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 06:32:29 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 06:32:29 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 06:32:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:32:29 INFO - Return code: 0 06:32:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:32:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:32:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:32:29 INFO - ENV: RUST_BACKTRACE is now full 06:32:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:32:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:32:29 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/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 06:32:29 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/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 06:32:29 INFO - Using env: {'DISPLAY': ':0', 06:32:29 INFO - 'HOME': '/home/cltbld', 06:32:29 INFO - 'LANG': 'en_US.UTF-8', 06:32:29 INFO - 'LANGUAGE': 'en_US:en', 06:32:29 INFO - 'LOGNAME': 'cltbld', 06:32:29 INFO - 'MAIL': '/var/mail/cltbld', 06:32:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:32:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:32:29 INFO - 'MOZ_ACCELERATED': '1', 06:32:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:32:29 INFO - 'MOZ_NO_REMOTE': '1', 06:32:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:32:29 INFO - 'MOZ_WEBRENDER': '1', 06:32:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:32:29 INFO - 'NO_EM_RESTART': '1', 06:32:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:32:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:32:29 INFO - 'PWD': '/builds/slave/test', 06:32:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:32:29 INFO - 'RUST_BACKTRACE': 'full', 06:32:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 06:32:29 INFO - 'SHELL': '/bin/bash', 06:32:29 INFO - 'SHLVL': '1', 06:32:29 INFO - 'TERM': 'linux', 06:32:29 INFO - 'TMOUT': '86400', 06:32:29 INFO - 'USER': 'cltbld', 06:32:29 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1504186276.579097-526733859', 06:32:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:32:29 INFO - '_': '/tools/buildbot/bin/python'} 06:32:29 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/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 06:32:29 INFO - mozversion application_buildid: 20170831123711 06:32:29 INFO - mozversion application_changeset: fb22415719a9d971a2646fa2d1b74e134ca00c3d 06:32:29 INFO - mozversion application_display_name: Nightly 06:32:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:32:29 INFO - mozversion application_name: Firefox 06:32:29 INFO - mozversion application_remotingname: firefox 06:32:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:32:29 INFO - mozversion application_vendor: Mozilla 06:32:29 INFO - mozversion application_version: 57.0a1 06:32:29 INFO - mozversion platform_buildid: 20170831123711 06:32:29 INFO - mozversion platform_changeset: fb22415719a9d971a2646fa2d1b74e134ca00c3d 06:32:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:32:29 INFO - mozversion platform_version: 57.0a1 06:32:29 INFO - using testdate: 1504186349 06:32:29 INFO - actual date: 1504186349 06:32:29 INFO - starting webserver on 'localhost:33661' 06:32:29 INFO - SUITE-START | Running 2 tests 06:32:29 INFO - TEST-START | dromaeo_css 06:32:29 INFO - Initialising browser for dromaeo_css test... 06:32:29 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33661/getInfo.html -profile /tmp/tmpZFenfw/profile 06:32:29 INFO - TEST-INFO | started process 12586 (/builds/slave/test/build/application/firefox/firefox http://localhost:33661/getInfo.html) 06:32:36 INFO - TEST-INFO | 12586: exit 0 06:32:36 INFO - Browser initialized. 06:32:36 INFO - Running cycle 1/1 for dromaeo_css test... 06:32:36 INFO - Using env: {'DISPLAY': ':0', 06:32:36 INFO - 'HOME': '/home/cltbld', 06:32:36 INFO - 'JSGC_DISABLE_POISONING': '1', 06:32:36 INFO - 'LANG': 'en_US.UTF-8', 06:32:36 INFO - 'LANGUAGE': 'en_US:en', 06:32:36 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 06:32:36 INFO - 'LOGNAME': 'cltbld', 06:32:36 INFO - 'MAIL': '/var/mail/cltbld', 06:32:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:32:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:32:36 INFO - 'MOZ_ACCELERATED': '1', 06:32:36 INFO - 'MOZ_CRASHREPORTER': '1', 06:32:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:32:36 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 06:32:36 INFO - 'MOZ_NO_REMOTE': '1', 06:32:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:32:36 INFO - 'MOZ_WEBRENDER': '1', 06:32:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:32:36 INFO - 'NO_EM_RESTART': '1', 06:32:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:32:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:32:36 INFO - 'PWD': '/builds/slave/test', 06:32:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:32:36 INFO - 'RUST_BACKTRACE': 'full', 06:32:36 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 06:32:36 INFO - 'SHELL': '/bin/bash', 06:32:36 INFO - 'SHLVL': '1', 06:32:36 INFO - 'TERM': 'linux', 06:32:36 INFO - 'TMOUT': '86400', 06:32:36 INFO - 'USER': 'cltbld', 06:32:36 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1504186276.579097-526733859', 06:32:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:32:36 INFO - '_': '/tools/buildbot/bin/python'} 06:32:36 INFO - TEST-INFO | started process 12778 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZFenfw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 06:32:37 INFO - PID 12778 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 06:32:37 INFO - PID 12778 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 06:32:37 INFO - PID 12778 | 06:32:37 INFO - PID 12778 | (/builds/slave/test/build/application/firefox/firefox:12839): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 06:32:37 INFO - PID 12778 | 06:32:48 INFO - PID 12778 | RSS: Main: 198213632 06:32:48 INFO - PID 12778 | 06:32:52 INFO - PID 12778 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 06:35:46 INFO - PID 12778 | Cycle 1(1): loaded http://localhost:33661/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33661/tests/dromaeo/cssquery-ext.html) 06:35:48 INFO - PID 12778 | RSS: Main: 211869696 06:35:48 INFO - PID 12778 | 06:38:50 INFO - PID 12778 | Cycle 1(1): loaded http://localhost:33661/tests/dromaeo/cssquery-ext.html (next: http://localhost:33661/tests/dromaeo/cssquery-jquery.html) 06:38:51 INFO - PID 12778 | RSS: Main: 212402176 06:38:51 INFO - PID 12778 | 06:41:53 INFO - PID 12778 | Cycle 1(1): loaded http://localhost:33661/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33661/tests/dromaeo/cssquery-mootools.html) 06:41:53 INFO - PID 12778 | RSS: Main: 212279296 06:41:53 INFO - PID 12778 | 06:44:55 INFO - PID 12778 | Cycle 1(1): loaded http://localhost:33661/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33661/tests/dromaeo/cssquery-prototype.html) 06:44:56 INFO - PID 12778 | RSS: Main: 209514496 06:44:56 INFO - PID 12778 | 06:48:00 INFO - PID 12778 | Cycle 1(1): loaded http://localhost:33661/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33661/tests/dromaeo/cssquery-yui.html) 06:48:01 INFO - PID 12778 | RSS: Main: 210984960 06:48:01 INFO - PID 12778 | 06:51:03 INFO - PID 12778 | Cycle 1(1): loaded http://localhost:33661/tests/dromaeo/cssquery-yui.html (next: http://localhost:33661/tests/dromaeo/cssquery-dojo.html) 06:51:03 INFO - PID 12778 | RSS: Main: 214028288 06:51:03 INFO - PID 12778 | 06:51:03 INFO - PID 12778 | __start_tp_report 06:51:03 INFO - PID 12778 | _x_x_mozilla_page_load 06:51:03 INFO - PID 12778 | _x_x_mozilla_page_load_details 06:51:03 INFO - PID 12778 | |i|pagename|runs| 06:51:03 INFO - PID 12778 | |0;dojo.html;3247.1557395077302;3253.3330667213218;3255.462848629975;3294.456414691576;3338.315645292715;6252.718627661755;6259.561830671849;6274.529410294234;6318.778842740505;6351.079093531435;6096.298925623554;6164.321924588303;6211.565190436671;6235.501159907208;6322.715477803498;5814.302283725959;5860.824175274749;5878.353381128072;5882.6764527950945;5890.469857712805;618.6780208396807;5687.146927960797;5713.114467257582;5864.530837533009;5867.677277749722;5716.799912003102;5734.455226753452;5796.3334216565;5801.216835727165;5878.441548052928;5699.287589051369;5783.450572195677;5813.418658134195;5813.767449302023;5852.326982397036;5685.204071430003;5717.656940583578;5762.3373312069225;5817.360090390053;5824.767009319622;6204.565680402374;6219.68901554925;6227.034809604518;6326.2092238470195;6341.270753863272;6528.673566321712;6656.56732312403;6663.4669226461765;6754.324567543255;6755.560888542278;6648.867022659568;6718.966405167943;6832.59004459734;6852.28051054642;6854.074699915497;6319.74721011159;6325.399087086719;6386.936130638681;6397.936020639827;6400.839979000516;6737.09049278351;6741.685371352637;6786.117804685359;6791.864162716718;6803.115594972622;6457.192850893638;6577.112089867806;6588.53880228389;6589.308122647149;6602.60384376939;6683.6658167091455;6684.2647308795995;6689.5986240825705;6705.597664140168;6710.731570737214;6583.539152259296;6593.274739778621;6596.406323430819;6629.502787290972;6745.224299205556;6528.445082168069;6775.661216939232;6837.2820853809635;6840.281770414134;6857.691403886837;5104.183330667075;5193.272941788153;5244.239585260192;5296.761645725952;5296.867578310496;4526.660500462479;4562.543745625411;4565.680402371869;4578.130155270488;4635.7450340230935;5823.94176058234;5851.9707401463575;5871.4715675589405;5884;5885.087811389241;6752.763653272112;6758.695858686273;6791.762288319984;6819.659017049128;6824.317568243236;5793.536517078624;5809.2738407699035;5877.4122587740885;5901.0558310670085;5926.851828704317;5718.656880587178;5757.625754326039;5806.216160818235;5832.50423713989;5841.620294680833;6349.49204063683;6441.3880681335195;6488.67556622167;6494.9350506495275;6573.112629795012;6735.292794256533;6739.93260067393;6796.082528858639;6835.487338449736;6836.145481814773;6615.470762338905;6629.569078009914;6648.268690444144;6653.301403352772;6663.46692264608;6677.833054173684;6685.39831415175;6686.197656281277;6780.457563395015;6788.1175447191545;6575.145231119924;6748.966255168889;6781.42357899584;6880.105586273752;6898.586084834926;6458.838529036811;6500.772472963424;6515.576487528296;6530.8040758777315;6539.738410463528;6482.124913136666;6492.0261960706275;6514.5765525242605;6515.641639709862;6539.4768418525455;5998.082232705113;6349.777757778455;6423.807285781434;6447.806565803034;6478.384553467413;6325.841853953688;6365.490760739037;6394.968025159845;6485.708143133665;6497.317781632861;6336.429721325103;6352.428281454691;6353.237611486466;6370.044493326038;6371.044343348535 06:51:03 INFO - PID 12778 | |1;ext.html;777.4169372970272;807.3258828877887;844.5270648436875;866.6446756829702;873.6549063120068;39833.601663983354;40273.597264027354;40337.19325613486;40597.594024059785;40646.7967660162;37777.24445511088;37782.622173778254;37942;37964.050898727546;38013.23973520528;6860;6926.064981227521;6934.375906168444;6941.652917354138;6942.271061538541;6870.244273129952;6971.7211311547735;6980.232174460805;6986.301369863024;6992.160940687125;6907.481938854581;6919.273476284993;6966.338197871194;7360.1903790583265;7674.462787604842;7581.052368453943;7632.7787553991375;7644.388448924073;7646.120696119906;7650.770476885702;7504.024476817979;7589.316961473494;7592.81017974555;7593.316601505836;7599.734009309647;37212;37600.811995940116;37780;37850.242995139946;38057;3463.826808659582;3516.7889926604485;3519.982400087983;3522.18989632386;3523.541939547868;30544;30615.69384306151;30803.691963080306;30846.53730194049;30950.380992380025;5114.28400023997;5135.12702840518;5146.871328216787;5160.767765450564;5244.449332820037;183414;187241;187555;188551;189022.99999999863;45632;45757.31364029542;45807.770961145645;45828.541714583094;45894.541054589026;46984.295235571495;47686.523134768904;47741.761291193325;47814.521854781706;47892.76053619779;14540.27298635064;14681.706365872622;14796.48212312564;14796.852031479762;14801.925990370195;11879.703007424883;11967.760644787055;12042.09684273683;12062.819057714141;12092.214006089576;12987.935060324828;13058.738825223632;13207.537736179187;13225.140365876186;13371.598852034454;5415.783368665288;5438.809641662523;5469.781208751685;5479.767052413175;5502.724863756796;970.5195928015678;981.4258658684606;992.2012779712256;1000.9199264058858;1008.0977525115128;22509.774902251094;22553.323400298017;22834.31497055091;22992.770072299398;23074.65388019181;1072.5495291977388;1089.5805115030612;1097.0729733375285;1104.6465131158113;1107.9778404432027;11786.410679465993;11834.112441566916;11964.940175299242;12055.517779288906;12081.939590301992;222937;222970;223582;223815;224464;41682.583174168474;43056;49945.50054499409;50169.24746128811;50197.74901125544;1391.2070120031485;1399.2583930516842;1411.1321537254514;1414.5826981040618;1415.9185996585004;27256.72743272542;27306.45387092287;27346.726532735214;27350.863245683646;27395.726042739316;35965.28069438649;36065.81967090148;36220.81889590535;36589.26821463609;36593;200759;201128;202165;202560;202766;32776.672233277364;33154.834225828716;33313.00121992688;33449.83275083609;36064.09839754027;44444;44836.551634484546;45436.77281613571;45488.77255613701;45797.08405831931;33019.504707429885;33161;33254.66745332516;33532;33595.83202083974;32415.51376729398;32922.34155316928;32926.17684557905;33171.50242746312;33536.16159596029;37284.44073338848;37634;37666.811665941495;37735.49058037648;37805.62194378021;31343.84328078345;31454;31962.20094497656;33191;33212.50181247235;24049.278521644377;24463.755362446147;24498.530088194766;24988.250352489453;25141.37146571277 06:51:03 INFO - PID 12778 | |2;jquery.html;550.9421510741372;557.2838902010915;559.1305519916533;561.7556362982103;572.997135014325;21894.89052554737;22700.318990430293;22707;22740.204092856733;22745.54508909825;23927.16254931078;26208.082717104906;26419;26482.337941551472;26544;6522.119513865627;6677.66611669417;6688.431483323923;6692.364225398579;6703.731850725965;6443.806685799434;6511.12099866519;6513.57661751987;6560.475161987029;6563.803085907431;5804.187413762055;6468.288488266287;6471.255805582371;6483.546151769378;6510.348965103499;6478.2873883872735;6501.4798816094835;6552.868942621169;6553.541252112354;6556.409923106896;6063.514918806485;6074.665893375863;6079.118527813486;6085.482733967574;6086.513078953717;28117.297067573476;29037.41925161506;29341.413171736447;29784.851075744482;29848.40303193924;2054.6609809381434;2087.8642888212216;2092.163134746114;2106.104905415192;2106.6418708819538;18833.529161771065;19551.120199591052;19587.608247835105;19615.01924903749;19627.60744785096;2394.640803879432;2424.8787560622077;2497.1509686706427;2497.675302210719;2502.299356180254;127295;131339.34330328382;131499;131663.34168329096;132795;13967.022308438312;14339.78490322646;14390.352434140488;14489.20309382973;14927.701445971019;22342.776572234394;22377.55244895093;22523.662145067836;22559.774402256095;22587.209447669582;9734.464604446823;10011.549480273405;10074.093331600045;10090.293679442515;10150.49247537635;9230.307726920508;9246.214071803837;9289.442633442015;9332.860007099898;9361.719148425558;8641.611127499153;8879.312930543176;9013.414128081653;9111.498867562348;9147.399205139074;2613.4773045391;2645.4312322850296;2694.811363204596;2764.6958834528186;2820.3795165063652;942.783159873233;971.523953262896;973.4970397743144;976.9902300977042;981.1415011864618;19885.60228795416;23661;24949;25328.11351602685;25592.23223303304;1005.2109094360892;1036.5439206749006;1046.2676126711333;1048.8059708953867;1052.5211028981948;11271.661850144508;11433.885661143282;11438.542458301576;11473.139514536444;11497.71255718597;507811;509401;516344;520033;521347;115818;116876;117613;119056;119177;1203.1036877526299;1215.6292330839178;1238.6531771104105;1246.4141853328922;1252.0922331309728;18309;18474.16866241049;18597.163127659016;18620;18968.715469267696;55083.44916550783;57141.42858571361;57383.42616573781;57667.84664306606;57919;67231.32768672446;68139.65930170317;70445.6477717608;70639.64680176566;70712.19297939244;14593.854061459675;14785.038972466755;14785.778213327023;14826.332815023134;14829.258537072887;17714.911425443304;22256.888715556317;23309.951052202352;23380.415489612897;23864.164754234214;18354.449366519028;18366.26534938641;18654.253829846653;18722.625547489246;18734;16068.43760468378;16375.918120409322;16910.408135715683;16944.661106778043;17564.2096105673;18719.625607487502;19524.414267571996;19586.412407627795;19975.101120449322;20017.29939452112;14672.779908301598;14686;14695.706085878437;14914.403423862925;14955.102693838404;18773.812261877207;18780.624387512446;19079.618407632046;19100.71348929795;19123 06:51:03 INFO - PID 12778 | |3;mootools.html;1334.5796074236614;1397.692507648317;1399.7480453518363;1404.431205361829;1408.3662351941623;15016.47442339517;15589.142597157152;15615.375384984602;15696.843031569695;15724.606884827885;14956;16057.116858572774;16074.83925160748;16086.678266434665;16090.919545402287;2773.2234974207254;2843.218115018366;2843.2749648839517;2844.886204551826;2846.4022555263314;2682.678078630557;2685.597160425932;2756.104266113511;2757.310672331917;2761.0888406825798;2725.4140359822636;2763.226296636935;2764.5023895698764;2765.4745598336253;2774.902878399256;2727.986360068207;2735.7401046900513;2758.517259479603;2761.9447611047867;2770.3351195713085;2634.288742039658;2648.099646120309;2648.6689163854517;2651.6287719719253;2658.5081759874483;14904.329305181293;15140.924295378452;15250.161241131733;15267.541973740805;15273.083614983136;8094.797630059236;8389.832203355898;8433.95783021081;8435.367347448904;8454.957725211396;5416.837494875121;5432.809851655173;5523.613347065707;5630.634008789457;5792.275965504312;1857.5634725839418;1873.7564116664882;1877.1740434208905;1909.8185672361242;1932.2753967262277;26382.868085659447;26444.86777566119;26471.47057058848;26518.602220966703;26609.46781064368;6610.405063544208;6870.690818913161;6876.040328506352;6948.44412447003;7119.359257666835;17151.142442877805;17168.742468862976;17203.483895483154;17245.56886077858;17270.568235794206;7828.647710853025;8019.318357939641;8109.878351824727;8119.4722343047515;8125.553094579855;7310.195878453366;7470.551766893895;7499.512531685423;7651.770446886602;7657.234276572298;5071.41678706946;5268.604854635918;5287.735613219324;5299.5760339172775;5405.648632838853;1378.5795332423506;1426.7645838436542;1452.3972551391266;1518.627936155649;1522;835.4694768821842;841.2344766262794;859.6174702257435;863.119617989647;873.7378786364065;8433.536155511383;8547.529885856338;8553.828923421497;8708.95645521781;8791.69229076992;953.423178976723;976.6044751875502;991.4398364923795;999.6501224571342;1011.6358111080006;4716.891530490332;5240.292560504359;5307.548858347007;5463.9566720627245;5631.63394379364;21052.57894842125;21660.675089873665;21888.343349699535;22200.666989995163;22331.218407355664;21136;21412.357629271148;22087;22118.88940555287;22152.556948860933;10876.347419154717;11063.668089957153;11247.100231981258;11284.097272218203;11336.659900203007;8622.008469025892;8777.297816174818;8824.602892869709;8859.468431894107;8927.866082008904;17899;18021.81978180254;18109.185086671394;18186.27254909789;18868.52828679294;18798.906005469886;18836.434906952814;18873;19170;19305.90347048312;11247.493862776031;11501.597444089417;11538.94230528842;11556.479958401724;11567.826482602935;13813.171209727047;13967.231802250973;14154.646133846736;14202.360893759598;14212.786808198092;11321.792250511071;11615;11759.76480470403;11816.172867899164;11934.820977685167;10707;11006.504707288032;11042.613508527164;11111.833322500008;11204.047655949336;9009.729708108767;9349.57926893305;9442.575084121094;9444.102810233016;9450.480223587769;6979.302069793183;7157.463190260647;7198.6040767756185;7238.52949558277;7292.817679557841;7015.193252775996;7088.574685518885;7145.285471453021;7164.462665300228;7402.407807375289 06:51:03 INFO - PID 12778 | |4;prototype.html;499.96008302730326;502.6278260349245;524.9212618107283;529.3806246691371;530.7744208711299;6250.781222657208;6309.148264984232;6337.493000559955;6339.587926784761;6377.808665740035;5924.644521328723;6118.663473508956;6130.356312587181;6146.508279337653;6230.781922632709;5015.498450154973;5018.34761481007;5055.5702765265;5060.393897142956;5075.7715902784275;4974.353334066566;4983.177775667011;5021.59827213822;5033.464793238061;5068.1890897456415;4709.458412282597;4948.208286674133;4953.133201689708;4958.206686930092;5010.473900240477;4946.505349465043;5003.224500202438;5003.323886498028;5020.7740651670765;5023.8492845214705;4376.927652725103;4399.6040356368085;4426.959664478845;4488.259437192859;4512.593866551993;6034.3448882492;6055.27336719592;6069.57512974092;6090.421409966046;6139.693015349215;5655.717214139277;5664.291963504562;5690.772369105272;5697.173909783059;5725.885482290372;6574.397921454953;6585.637789921552;6590.670466476657;6628.4697224221945;6682.131322927989;4870.853874383774;4881.8535443936735;4890.462049174588;4897.4857639948;4897.755112244409;6841.144856892888;6844.8973265401055;6912.861742765217;6964.199117101548;7011.298870112999;5056.873578160576;5074.23886417033;5078.13671675816;5101.489851014869;5111.948880511221;5038.622103342264;5067.265246539231;5085.516875896784;5118.769655365518;5160.716160611202;5617.241672374177;5632.451075954145;5640.8871822563315;5695.686737229409;5724.112762521816;6563.540552161398;6608.570442921291;6669.366410191024;6682.064510968468;6746;1758.9120543973006;1769.6106856491551;1771.636814453034;1776.413783451458;1777.626698393352;1150.930944143354;1159.5186301315193;1162.8953394194393;1191.3149938785234;1215.4199540597365;5710;5783.4794868461195;5793.826185214451;5803.680797556175;5835.620684655484;6483.578567393104;6654.074096283216;6763.357481039294;6768.593884366954;6778.593284402951;5669.177969194444;5698.743556539883;5741.19623252745;5754.251947246831;5782.397920935596;3501.474778783203;3552.632236588932;3587.94618080729;3596.7841929484316;3605.2068544920076;6425.58233714807;6521.967390163114;6531.902021469682;6558.639274839929;6651.636414535009;6861.279565645636;6895.586264824126;6921.792346229621;6950.652467376712;6956.2000369958105;6426.333071775348;6534.738610455529;6591.604503729792;6601.174853143357;6639.9496307251575;6710.396064354231;6726.39462448382;6732.293109223657;6761.763338283333;6793.5244532882225;6601.53789234749;6602.877510823268;6664.333566643297;6711.261761206361;6734.494912881455;6419.582727122722;6447;6461.935380646321;6482;6528.151340325728;4911.778969946289;4970.65205435616;4975.676581022222;4991.5258050485145;5026;6678.766243181465;6748.19021717397;6756.594604323756;6791.694373753094;6819.659017049227;6447.516436267205;6490.221173459215;6516.51126165549;6525.445337146396;6541.757066157415;6463.0270075765675;6518.348165183444;6519.185101862267;6528.857449946336;6569.343065693392;5782.826515204551;6442.226932768098;6491.837704057436;6517.315681853337;6550.7707230246715;6510.7721229756735;6537.967310163419;6549.967250163719;6560.343965603402;6714.160729908762;6372.872542549216;6400.45596124316;6404.263509696445;6434.453071488976;6439.549231553746 06:51:03 INFO - PID 12778 | |5;yui.html;881.5944665453891;901.4411065139615;902.2962089570134;902.7246689759621;911.5761171055462;19187.808121918795;19969.201231950705;20129.396118116463;20159.596808063867;20213.59572808543;19379.224831006777;21306.147754089856;21351.039203235854;21366;21409.892950535224;944.4805357053627;967.6468089147446;971.9222462203043;976.5507866381438;977.2328721953268;973.6835528453281;975.4586204656448;976.0434773921561;976.24828881761;976.4043933200742;772.8647486689835;774.1871035412822;825.7605294464598;998.3660375661435;1041.843723441486;989.65362123257;991.504247876062;994.3536701144242;994.5773046455228;996.2627655534889;733.1605311917878;734.4785202506174;734.5629350536423;734.7391675955066;734.8162959260185;17644.558886027953;18988.24047038117;20027.899860500605;20265.493362665904;20372.796272037238;21109.050092745863;21161.25935592247;21637.891810541005;21755.456113597127;21888.562228755334;16322.102284374354;16709.164541772985;16738.581535461588;16874.493765187064;16915.83084169155;3690.151265209017;3709.888703338904;3718.6467285607823;3731.3843215869347;3733.607971163043;127683;130737.34631326878;133323;134148.32925835406;134902;16161.595960100856;16457.753133703005;16562.254698538596;16565.503034908972;16847.15764211809;29146.708532914825;30194.84902575473;30198.245043873638;30259.69740302569;30279.545806812916;8980.68567600144;9255.537223138816;9293.953530232306;9297.209737172416;9322.906770932339;4256.851010214627;4316.568343165658;4351.216780979454;4397.802098905557;4457.398251236042;4591.104734576792;4809.9038019239415;5280.551153152025;5404.648697834628;5472.452754724575;1098.0776148035688;1107.3466654673782;1114.6990312615549;1121.556984990924;1121.9775604487866;639.2520750721667;648.1056142523288;662.1954325494547;663.8373598468406;665.7037618259925;11757.823632645517;11963.46164422603;12126.211796233392;12163.878361216275;13015.349232538336;683.9760608378782;697.6128248821952;703.7290643102442;705.0763499815258;709.5848928376854;5488.25908502355;5624.831255062355;5791.276090488689;6133.785317513865;6163.907541386883;107272.46363768131;108696.4565177169;111234.44382778034;113045.43477282561;113668.43165784118;101910;102422.48788756008;103923;105693;106757.46621266844;89338.55330723304;90586.54706726424;90865.54567227121;91996;94035;12770.936145319214;13062.54281100157;13073.934630327169;13145.079844411182;13195.20828750278;38994.4150837732;39412.60587394089;39540.60459395369;40311.59688403078;41700.58299416967;52349.7382513085;52627.21059184192;52992.99909552801;53000;54845;15695.372185112925;16154.919225403797;16316.42892498757;16425.917870410573;16559;20520.38438846837;21507.46231344229;21854.125834966424;21863.890680546494;22099.33701988943;17648.55878602994;18106.637867242844;18143.092845357944;18355.724664129782;18704;17281.827181728022;17642.38251661237;18243.817561824213;18306.90846545759;18693.906530467262;17830.37593684215;18388.448346549623;18414.079296035412;18529.351472698392;18827.05864706732;11205.327680339205;11564.190506664452;11987.820182697093;12025.278483291031;12771.297578632893;13596.66008349799;13724.245166515937;13732.725345492834;13806.922950074319;13828.170309781446 06:51:03 INFO - PID 12778 | __end_tp_report 06:51:03 INFO - PID 12778 | __start_cc_report 06:51:03 INFO - PID 12778 | _x_x_mozilla_cycle_collect,381 06:51:03 INFO - PID 12778 | __end_cc_report 06:51:03 INFO - PID 12778 | __startTimestamp1504187463662__endTimestamp 06:51:03 INFO - PID 12778 | 06:51:03 INFO - PID 12778 | ------- Summary: start ------- 06:51:03 INFO - PID 12778 | Number of tests: 6 06:51:03 INFO - PID 12778 | 06:51:03 INFO - PID 12778 | [#0] dojo.html Cycles:165 Average:6147.74 Median:6386.94 stddev:841.84 (13.2%) stddev-sans-first:813.09 06:51:03 INFO - PID 12778 | Values: 3247.2 3253.3 3255.5 3294.5 3338.3 6252.7 6259.6 6274.5 6318.8 6351.1 6096.3 6164.3 6211.6 6235.5 6322.7 5814.3 5860.8 5878.4 5882.7 5890.5 618.7 5687.1 5713.1 5864.5 5867.7 5716.8 5734.5 5796.3 5801.2 5878.4 5699.3 5783.5 5813.4 5813.8 5852.3 5685.2 5717.7 5762.3 5817.4 5824.8 6204.6 6219.7 6227.0 6326.2 6341.3 6528.7 6656.6 6663.5 6754.3 6755.6 6648.9 6719.0 6832.6 6852.3 6854.1 6319.7 6325.4 6386.9 6397.9 6400.8 6737.1 6741.7 6786.1 6791.9 6803.1 6457.2 6577.1 6588.5 6589.3 6602.6 6683.7 6684.3 6689.6 6705.6 6710.7 6583.5 6593.3 6596.4 6629.5 6745.2 6528.4 6775.7 6837.3 6840.3 6857.7 5104.2 5193.3 5244.2 5296.8 5296.9 4526.7 4562.5 4565.7 4578.1 4635.7 5823.9 5852.0 5871.5 5884.0 5885.1 6752.8 6758.7 6791.8 6819.7 6824.3 5793.5 5809.3 5877.4 5901.1 5926.9 5718.7 5757.6 5806.2 5832.5 5841.6 6349.5 6441.4 6488.7 6494.9 6573.1 6735.3 6739.9 6796.1 6835.5 6836.1 6615.5 6629.6 6648.3 6653.3 6663.5 6677.8 6685.4 6686.2 6780.5 6788.1 6575.1 6749.0 6781.4 6880.1 6898.6 6458.8 6500.8 6515.6 6530.8 6539.7 6482.1 6492.0 6514.6 6515.6 6539.5 5998.1 6349.8 6423.8 6447.8 6478.4 6325.8 6365.5 6395.0 6485.7 6497.3 6336.4 6352.4 6353.2 6370.0 6371.0 06:51:03 INFO - PID 12778 | 06:51:03 INFO - PID 12778 | [#1] ext.html Cycles:180 Average:37011.20 Median:19744.41 stddev:52986.23 (268.4%) stddev-sans-first:53065.02 06:51:03 INFO - PID 12778 | Values: 777.4 807.3 844.5 866.6 873.7 39833.6 40273.6 40337.2 40597.6 40646.8 37777.2 37782.6 37942.0 37964.1 38013.2 6860.0 6926.1 6934.4 6941.7 6942.3 6870.2 6971.7 6980.2 6986.3 6992.2 6907.5 6919.3 6966.3 7360.2 7674.5 7581.1 7632.8 7644.4 7646.1 7650.8 7504.0 7589.3 7592.8 7593.3 7599.7 37212.0 37600.8 37780.0 37850.2 38057.0 3463.8 3516.8 3520.0 3522.2 3523.5 30544.0 30615.7 30803.7 30846.5 30950.4 5114.3 5135.1 5146.9 5160.8 5244.4 183414.0 187241.0 187555.0 188551.0 189023.0 45632.0 45757.3 45807.8 45828.5 45894.5 46984.3 47686.5 47741.8 47814.5 47892.8 14540.3 14681.7 14796.5 14796.9 14801.9 11879.7 11967.8 12042.1 12062.8 12092.2 12987.9 13058.7 13207.5 13225.1 13371.6 5415.8 5438.8 5469.8 5479.8 5502.7 970.5 981.4 992.2 1000.9 1008.1 22509.8 22553.3 22834.3 22992.8 23074.7 1072.5 1089.6 1097.1 1104.6 1108.0 11786.4 11834.1 11964.9 12055.5 12081.9 222937.0 222970.0 223582.0 223815.0 224464.0 41682.6 43056.0 49945.5 50169.2 50197.7 1391.2 1399.3 1411.1 1414.6 1415.9 27256.7 27306.5 27346.7 27350.9 27395.7 35965.3 36065.8 36220.8 36589.3 36593.0 200759.0 201128.0 202165.0 202560.0 202766.0 32776.7 33154.8 33313.0 33449.8 36064.1 44444.0 44836.6 45436.8 45488.8 45797.1 33019.5 33161.0 33254.7 33532.0 33595.8 32415.5 32922.3 32926.2 33171.5 33536.2 37284.4 37634.0 37666.8 37735.5 37805.6 31343.8 31454.0 31962.2 33191.0 33212.5 24049.3 24463.8 24498.5 24988.3 25141.4 06:51:03 INFO - PID 12778 | 06:51:03 INFO - PID 12778 | [#2] jquery.html Cycles:180 Average:35416.96 Median:22742.87 stddev:86220.48 (379.1%) stddev-sans-first:86422.61 06:51:03 INFO - PID 12778 | Values: 550.9 557.3 559.1 561.8 573.0 21894.9 22700.3 22707.0 22740.2 22745.5 23927.2 26208.1 26419.0 26482.3 26544.0 6522.1 6677.7 6688.4 6692.4 6703.7 6443.8 6511.1 6513.6 6560.5 6563.8 5804.2 6468.3 6471.3 6483.5 6510.3 6478.3 6501.5 6552.9 6553.5 6556.4 6063.5 6074.7 6079.1 6085.5 6086.5 28117.3 29037.4 29341.4 29784.9 29848.4 2054.7 2087.9 2092.2 2106.1 2106.6 18833.5 19551.1 19587.6 19615.0 19627.6 2394.6 2424.9 2497.2 2497.7 2502.3 127295.0 131339.3 131499.0 131663.3 132795.0 13967.0 14339.8 14390.4 14489.2 14927.7 22342.8 22377.6 22523.7 22559.8 22587.2 9734.5 10011.5 10074.1 10090.3 10150.5 9230.3 9246.2 9289.4 9332.9 9361.7 8641.6 8879.3 9013.4 9111.5 9147.4 2613.5 2645.4 2694.8 2764.7 2820.4 942.8 971.5 973.5 977.0 981.1 19885.6 23661.0 24949.0 25328.1 25592.2 1005.2 1036.5 1046.3 1048.8 1052.5 11271.7 11433.9 11438.5 11473.1 11497.7 507811.0 509401.0 516344.0 520033.0 521347.0 115818.0 116876.0 117613.0 119056.0 119177.0 1203.1 1215.6 1238.7 1246.4 1252.1 18309.0 18474.2 18597.2 18620.0 18968.7 55083.4 57141.4 57383.4 57667.8 57919.0 67231.3 68139.7 70445.6 70639.6 70712.2 14593.9 14785.0 14785.8 14826.3 14829.3 17714.9 22256.9 23310.0 23380.4 23864.2 18354.4 18366.3 18654.3 18722.6 18734.0 16068.4 16375.9 16910.4 16944.7 17564.2 18719.6 19524.4 19586.4 19975.1 20017.3 14672.8 14686.0 14695.7 14914.4 14955.1 18773.8 18780.6 19079.6 19100.7 19123.0 06:51:03 INFO - PID 12778 | 06:51:03 INFO - PID 12778 | [#3] mootools.html Cycles:180 Average:9410.19 Median:14646.07 stddev:6691.30 (45.7%) stddev-sans-first:6682.56 06:51:03 INFO - PID 12778 | Values: 1334.6 1397.7 1399.7 1404.4 1408.4 15016.5 15589.1 15615.4 15696.8 15724.6 14956.0 16057.1 16074.8 16086.7 16090.9 2773.2 2843.2 2843.3 2844.9 2846.4 2682.7 2685.6 2756.1 2757.3 2761.1 2725.4 2763.2 2764.5 2765.5 2774.9 2728.0 2735.7 2758.5 2761.9 2770.3 2634.3 2648.1 2648.7 2651.6 2658.5 14904.3 15140.9 15250.2 15267.5 15273.1 8094.8 8389.8 8434.0 8435.4 8455.0 5416.8 5432.8 5523.6 5630.6 5792.3 1857.6 1873.8 1877.2 1909.8 1932.3 26382.9 26444.9 26471.5 26518.6 26609.5 6610.4 6870.7 6876.0 6948.4 7119.4 17151.1 17168.7 17203.5 17245.6 17270.6 7828.6 8019.3 8109.9 8119.5 8125.6 7310.2 7470.6 7499.5 7651.8 7657.2 5071.4 5268.6 5287.7 5299.6 5405.6 1378.6 1426.8 1452.4 1518.6 1522.0 835.5 841.2 859.6 863.1 873.7 8433.5 8547.5 8553.8 8709.0 8791.7 953.4 976.6 991.4 999.7 1011.6 4716.9 5240.3 5307.5 5464.0 5631.6 21052.6 21660.7 21888.3 22200.7 22331.2 21136.0 21412.4 22087.0 22118.9 22152.6 10876.3 11063.7 11247.1 11284.1 11336.7 8622.0 8777.3 8824.6 8859.5 8927.9 17899.0 18021.8 18109.2 18186.3 18868.5 18798.9 18836.4 18873.0 19170.0 19305.9 11247.5 11501.6 11538.9 11556.5 11567.8 13813.2 13967.2 14154.6 14202.4 14212.8 11321.8 11615.0 11759.8 11816.2 11934.8 10707.0 11006.5 11042.6 11111.8 11204.0 9009.7 9349.6 9442.6 9444.1 9450.5 6979.3 7157.5 7198.6 7238.5 7292.8 7015.2 7088.6 7145.3 7164.5 7402.4 06:51:03 INFO - PID 12778 | 06:51:03 INFO - PID 12778 | [#4] prototype.html Cycles:180 Average:5520.88 Median:6104.54 stddev:1553.70 (25.5%) stddev-sans-first:1511.66 06:51:03 INFO - PID 12778 | Values: 500.0 502.6 524.9 529.4 530.8 6250.8 6309.1 6337.5 6339.6 6377.8 5924.6 6118.7 6130.4 6146.5 6230.8 5015.5 5018.3 5055.6 5060.4 5075.8 4974.4 4983.2 5021.6 5033.5 5068.2 4709.5 4948.2 4953.1 4958.2 5010.5 4946.5 5003.2 5003.3 5020.8 5023.8 4376.9 4399.6 4427.0 4488.3 4512.6 6034.3 6055.3 6069.6 6090.4 6139.7 5655.7 5664.3 5690.8 5697.2 5725.9 6574.4 6585.6 6590.7 6628.5 6682.1 4870.9 4881.9 4890.5 4897.5 4897.8 6841.1 6844.9 6912.9 6964.2 7011.3 5056.9 5074.2 5078.1 5101.5 5111.9 5038.6 5067.3 5085.5 5118.8 5160.7 5617.2 5632.5 5640.9 5695.7 5724.1 6563.5 6608.6 6669.4 6682.1 6746.0 1758.9 1769.6 1771.6 1776.4 1777.6 1150.9 1159.5 1162.9 1191.3 1215.4 5710.0 5783.5 5793.8 5803.7 5835.6 6483.6 6654.1 6763.4 6768.6 6778.6 5669.2 5698.7 5741.2 5754.3 5782.4 3501.5 3552.6 3587.9 3596.8 3605.2 6425.6 6522.0 6531.9 6558.6 6651.6 6861.3 6895.6 6921.8 6950.7 6956.2 6426.3 6534.7 6591.6 6601.2 6639.9 6710.4 6726.4 6732.3 6761.8 6793.5 6601.5 6602.9 6664.3 6711.3 6734.5 6419.6 6447.0 6461.9 6482.0 6528.2 4911.8 4970.7 4975.7 4991.5 5026.0 6678.8 6748.2 6756.6 6791.7 6819.7 6447.5 6490.2 6516.5 6525.4 6541.8 6463.0 6518.3 6519.2 6528.9 6569.3 5782.8 6442.2 6491.8 6517.3 6550.8 6510.8 6538.0 6550.0 6560.3 6714.2 6372.9 6400.5 6404.3 6434.5 6439.5 06:51:03 INFO - PID 12778 | 06:51:03 INFO - PID 12778 | [#5] yui.html Cycles:180 Average:23783.80 Median:21696.67 stddev:32881.84 (151.6%) stddev-sans-first:32929.11 06:51:03 INFO - PID 12778 | Values: 881.6 901.4 902.3 902.7 911.6 19187.8 19969.2 20129.4 20159.6 20213.6 19379.2 21306.1 21351.0 21366.0 21409.9 944.5 967.6 971.9 976.6 977.2 973.7 975.5 976.0 976.2 976.4 772.9 774.2 825.8 998.4 1041.8 989.7 991.5 994.4 994.6 996.3 733.2 734.5 734.6 734.7 734.8 17644.6 18988.2 20027.9 20265.5 20372.8 21109.1 21161.3 21637.9 21755.5 21888.6 16322.1 16709.2 16738.6 16874.5 16915.8 3690.2 3709.9 3718.6 3731.4 3733.6 127683.0 130737.3 133323.0 134148.3 134902.0 16161.6 16457.8 16562.3 16565.5 16847.2 29146.7 30194.8 30198.2 30259.7 30279.5 8980.7 9255.5 9294.0 9297.2 9322.9 4256.9 4316.6 4351.2 4397.8 4457.4 4591.1 4809.9 5280.6 5404.6 5472.5 1098.1 1107.3 1114.7 1121.6 1122.0 639.3 648.1 662.2 663.8 665.7 11757.8 11963.5 12126.2 12163.9 13015.3 684.0 697.6 703.7 705.1 709.6 5488.3 5624.8 5791.3 6133.8 6163.9 107272.5 108696.5 111234.4 113045.4 113668.4 101910.0 102422.5 103923.0 105693.0 106757.5 89338.6 90586.5 90865.5 91996.0 94035.0 12770.9 13062.5 13073.9 13145.1 13195.2 38994.4 39412.6 39540.6 40311.6 41700.6 52349.7 52627.2 52993.0 53000.0 54845.0 15695.4 16154.9 16316.4 16425.9 16559.0 20520.4 21507.5 21854.1 21863.9 22099.3 17648.6 18106.6 18143.1 18355.7 18704.0 17281.8 17642.4 18243.8 18306.9 18693.9 17830.4 18388.4 18414.1 18529.4 18827.1 11205.3 11564.2 11987.8 12025.3 12771.3 13596.7 13724.2 13732.7 13806.9 13828.2 06:51:03 INFO - PID 12778 | -------- Summary: end -------- 06:51:03 INFO - PID 12778 | 06:51:04 INFO - TEST-INFO | 12778: exit 0 06:51:04 INFO - TEST-OK | dromaeo_css | took 1114715ms 06:51:04 INFO - TEST-START | kraken 06:51:04 INFO - Initialising browser for kraken test... 06:51:04 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33661/getInfo.html -profile /tmp/tmpgwgLde/profile 06:51:04 INFO - TEST-INFO | started process 13164 (/builds/slave/test/build/application/firefox/firefox http://localhost:33661/getInfo.html) 06:51:10 INFO - TEST-INFO | 13164: exit 0 06:51:10 INFO - Browser initialized. 06:51:10 INFO - Running cycle 1/1 for kraken test... 06:51:10 INFO - Using env: {'DISPLAY': ':0', 06:51:10 INFO - 'HOME': '/home/cltbld', 06:51:10 INFO - 'JSGC_DISABLE_POISONING': '1', 06:51:10 INFO - 'LANG': 'en_US.UTF-8', 06:51:10 INFO - 'LANGUAGE': 'en_US:en', 06:51:10 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 06:51:10 INFO - 'LOGNAME': 'cltbld', 06:51:10 INFO - 'MAIL': '/var/mail/cltbld', 06:51:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:51:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:51:10 INFO - 'MOZ_ACCELERATED': '1', 06:51:10 INFO - 'MOZ_CRASHREPORTER': '1', 06:51:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:10 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 06:51:10 INFO - 'MOZ_NO_REMOTE': '1', 06:51:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:51:10 INFO - 'MOZ_WEBRENDER': '1', 06:51:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:10 INFO - 'NO_EM_RESTART': '1', 06:51:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:10 INFO - 'PWD': '/builds/slave/test', 06:51:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:51:10 INFO - 'RUST_BACKTRACE': 'full', 06:51:10 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 06:51:10 INFO - 'SHELL': '/bin/bash', 06:51:10 INFO - 'SHLVL': '1', 06:51:10 INFO - 'TERM': 'linux', 06:51:10 INFO - 'TMOUT': '86400', 06:51:10 INFO - 'USER': 'cltbld', 06:51:10 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1504186276.579097-526733859', 06:51:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:10 INFO - '_': '/tools/buildbot/bin/python'} 06:51:10 INFO - TEST-INFO | started process 13358 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgwgLde/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 06:51:11 INFO - PID 13358 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 06:51:11 INFO - PID 13358 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 06:51:11 INFO - PID 13358 | 06:51:11 INFO - PID 13358 | (/builds/slave/test/build/application/firefox/firefox:13420): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 06:51:11 INFO - PID 13358 | 06:51:22 INFO - PID 13358 | RSS: Main: 204460032 06:51:22 INFO - PID 13358 | 06:51:24 INFO - PID 13358 | Cycle 1(1): loaded http://localhost:33661/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33661/tests/kraken/driver.html?testName=audio-beat-detection) 06:51:25 INFO - PID 13358 | RSS: Main: 205221888 06:51:25 INFO - PID 13358 | 06:51:28 INFO - PID 13358 | Cycle 1(1): loaded http://localhost:33661/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33661/tests/kraken/driver.html?testName=audio-dft) 06:51:29 INFO - PID 13358 | RSS: Main: 204480512 06:51:29 INFO - PID 13358 | 06:51:32 INFO - PID 13358 | Cycle 1(1): loaded http://localhost:33661/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33661/tests/kraken/driver.html?testName=audio-fft) 06:51:32 INFO - PID 13358 | RSS: Main: 200372224 06:51:32 INFO - PID 13358 | 06:51:34 INFO - PID 13358 | Cycle 1(1): loaded http://localhost:33661/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33661/tests/kraken/driver.html?testName=audio-oscillator) 06:51:35 INFO - PID 13358 | RSS: Main: 199913472 06:51:35 INFO - PID 13358 | 06:51:37 INFO - PID 13358 | Cycle 1(1): loaded http://localhost:33661/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33661/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:51:38 INFO - PID 13358 | RSS: Main: 200404992 06:51:38 INFO - PID 13358 | 06:51:41 INFO - PID 13358 | Cycle 1(1): loaded http://localhost:33661/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33661/tests/kraken/driver.html?testName=imaging-darkroom) 06:51:42 INFO - PID 13358 | RSS: Main: 203644928 06:51:42 INFO - PID 13358 | 06:51:45 INFO - PID 13358 | Cycle 1(1): loaded http://localhost:33661/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33661/tests/kraken/driver.html?testName=imaging-desaturate) 06:51:46 INFO - PID 13358 | RSS: Main: 201314304 06:51:46 INFO - PID 13358 | 06:51:49 INFO - PID 13358 | Cycle 1(1): loaded http://localhost:33661/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33661/tests/kraken/driver.html?testName=json-parse-financial) 06:51:50 INFO - PID 13358 | RSS: Main: 203907072 06:51:50 INFO - PID 13358 | 06:51:51 INFO - PID 13358 | Cycle 1(1): loaded http://localhost:33661/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33661/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:51:52 INFO - PID 13358 | RSS: Main: 202997760 06:51:52 INFO - PID 13358 | 06:51:53 INFO - PID 13358 | Cycle 1(1): loaded http://localhost:33661/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33661/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:51:54 INFO - PID 13358 | RSS: Main: 202555392 06:51:54 INFO - PID 13358 | 06:51:56 INFO - PID 13358 | Cycle 1(1): loaded http://localhost:33661/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33661/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:51:57 INFO - PID 13358 | RSS: Main: 202715136 06:51:57 INFO - PID 13358 | 06:52:00 INFO - PID 13358 | Cycle 1(1): loaded http://localhost:33661/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33661/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:52:00 INFO - PID 13358 | RSS: Main: 203005952 06:52:00 INFO - PID 13358 | 06:52:03 INFO - PID 13358 | Cycle 1(1): loaded http://localhost:33661/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33661/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:52:04 INFO - PID 13358 | RSS: Main: 203649024 06:52:04 INFO - PID 13358 | 06:52:06 INFO - PID 13358 | Cycle 1(1): loaded http://localhost:33661/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33661/tests/kraken/driver.html?testName=ai-astar) 06:52:06 INFO - PID 13358 | RSS: Main: 205250560 06:52:06 INFO - PID 13358 | 06:52:06 INFO - PID 13358 | __start_tp_report 06:52:06 INFO - PID 13358 | _x_x_mozilla_page_load 06:52:06 INFO - PID 13358 | _x_x_mozilla_page_load_details 06:52:06 INFO - PID 13358 | |i|pagename|runs| 06:52:06 INFO - PID 13358 | |0;ai-astar;101;117;101;116;113;111;108;108;109;118 06:52:06 INFO - PID 13358 | |1;audio-beat-detection;146;125;151;175;124;146;155;124;177;118 06:52:06 INFO - PID 13358 | |2;audio-dft;169;163;163;163;160;169;167;166;161;172 06:52:06 INFO - PID 13358 | |3;audio-fft;79;83;84;153;76;75;75;86;96;83 06:52:06 INFO - PID 13358 | |4;audio-oscillator;90;79;142;82;90;80;123;88;79;136 06:52:06 INFO - PID 13358 | |5;imaging-gaussian-blur;125;117;114;127;122;115;123;118;121;121 06:52:06 INFO - PID 13358 | |6;imaging-darkroom;152;152;150;157;150;148;155;152;151;149 06:52:06 INFO - PID 13358 | |7;imaging-desaturate;105;96;105;95;102;96;99;102;95;102 06:52:06 INFO - PID 13358 | |8;json-parse-financial;53;54;51;52;54;54;52;64;52;54 06:52:06 INFO - PID 13358 | |9;json-stringify-tinderbox;42;38;37;38;38;45;38;37;40;49 06:52:06 INFO - PID 13358 | |10;stanford-crypto-aes;76;77;79;74;77;83;80;75;76;81 06:52:06 INFO - PID 13358 | |11;stanford-crypto-ccm;127;124;123;130;122;129;121;131;122;161 06:52:06 INFO - PID 13358 | |12;stanford-crypto-pbkdf2;172;171;169;176;174;171;170;168;170;168 06:52:06 INFO - PID 13358 | |13;stanford-crypto-sha256-iterative;64;68;66;67;71;64;66;69;66;65 06:52:06 INFO - PID 13358 | __end_tp_report 06:52:06 INFO - PID 13358 | __start_cc_report 06:52:06 INFO - PID 13358 | _x_x_mozilla_cycle_collect,924 06:52:06 INFO - PID 13358 | __end_cc_report 06:52:06 INFO - PID 13358 | __startTimestamp1504187526481__endTimestamp 06:52:06 INFO - PID 13358 | 06:52:06 INFO - PID 13358 | ------- Summary: start ------- 06:52:06 INFO - PID 13358 | Number of tests: 14 06:52:06 INFO - PID 13358 | 06:52:06 INFO - PID 13358 | [#0] ai-astar Cycles:10 Average:110.20 Median:112.00 stddev:6.05 (5.4%) stddev-sans-first:5.43 06:52:06 INFO - PID 13358 | Values: 101.0 117.0 101.0 116.0 113.0 111.0 108.0 108.0 109.0 118.0 06:52:06 INFO - PID 13358 | 06:52:06 INFO - PID 13358 | [#1] audio-beat-detection Cycles:10 Average:144.10 Median:148.50 stddev:21.25 (14.3%) stddev-sans-first:22.53 06:52:06 INFO - PID 13358 | Values: 146.0 125.0 151.0 175.0 124.0 146.0 155.0 124.0 177.0 118.0 06:52:06 INFO - PID 13358 | 06:52:06 INFO - PID 13358 | [#2] audio-dft Cycles:10 Average:165.30 Median:166.50 stddev:3.92 (2.4%) stddev-sans-first:3.92 06:52:06 INFO - PID 13358 | Values: 169.0 163.0 163.0 163.0 160.0 169.0 167.0 166.0 161.0 172.0 06:52:06 INFO - PID 13358 | 06:52:06 INFO - PID 13358 | [#3] audio-fft Cycles:10 Average:89.00 Median:83.00 stddev:23.36 (28.1%) stddev-sans-first:24.50 06:52:06 INFO - PID 13358 | Values: 79.0 83.0 84.0 153.0 76.0 75.0 75.0 86.0 96.0 83.0 06:52:06 INFO - PID 13358 | 06:52:06 INFO - PID 13358 | [#4] audio-oscillator Cycles:10 Average:98.90 Median:81.00 stddev:24.78 (30.6%) stddev-sans-first:26.07 06:52:06 INFO - PID 13358 | Values: 90.0 79.0 142.0 82.0 90.0 80.0 123.0 88.0 79.0 136.0 06:52:06 INFO - PID 13358 | 06:52:06 INFO - PID 13358 | [#5] imaging-gaussian-blur Cycles:10 Average:120.30 Median:121.50 stddev:4.24 (3.5%) stddev-sans-first:4.15 06:52:06 INFO - PID 13358 | Values: 125.0 117.0 114.0 127.0 122.0 115.0 123.0 118.0 121.0 121.0 06:52:06 INFO - PID 13358 | 06:52:06 INFO - PID 13358 | [#6] imaging-darkroom Cycles:10 Average:151.60 Median:152.00 stddev:2.72 (1.8%) stddev-sans-first:2.88 06:52:06 INFO - PID 13358 | Values: 152.0 152.0 150.0 157.0 150.0 148.0 155.0 152.0 151.0 149.0 06:52:06 INFO - PID 13358 | 06:52:06 INFO - PID 13358 | [#7] imaging-desaturate Cycles:10 Average:99.70 Median:95.00 stddev:4.00 (4.2%) stddev-sans-first:3.76 06:52:06 INFO - PID 13358 | Values: 105.0 96.0 105.0 95.0 102.0 96.0 99.0 102.0 95.0 102.0 06:52:06 INFO - PID 13358 | 06:52:06 INFO - PID 13358 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:3.68 (6.8%) stddev-sans-first:3.89 06:52:06 INFO - PID 13358 | Values: 53.0 54.0 51.0 52.0 54.0 54.0 52.0 64.0 52.0 54.0 06:52:06 INFO - PID 13358 | 06:52:06 INFO - PID 13358 | [#9] json-stringify-tinderbox Cycles:10 Average:40.20 Median:39.00 stddev:3.99 (10.2%) stddev-sans-first:4.18 06:52:06 INFO - PID 13358 | Values: 42.0 38.0 37.0 38.0 38.0 45.0 38.0 37.0 40.0 49.0 06:52:06 INFO - PID 13358 | 06:52:06 INFO - PID 13358 | [#10] stanford-crypto-aes Cycles:10 Average:77.80 Median:78.00 stddev:2.86 (3.7%) stddev-sans-first:2.96 06:52:06 INFO - PID 13358 | Values: 76.0 77.0 79.0 74.0 77.0 83.0 80.0 75.0 76.0 81.0 06:52:06 INFO - PID 13358 | 06:52:06 INFO - PID 13358 | [#11] stanford-crypto-ccm Cycles:10 Average:129.00 Median:128.00 stddev:11.81 (9.2%) stddev-sans-first:12.51 06:52:06 INFO - PID 13358 | Values: 127.0 124.0 123.0 130.0 122.0 129.0 121.0 131.0 122.0 161.0 06:52:06 INFO - PID 13358 | 06:52:06 INFO - PID 13358 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.90 Median:171.00 stddev:2.56 (1.5%) stddev-sans-first:2.68 06:52:06 INFO - PID 13358 | Values: 172.0 171.0 169.0 176.0 174.0 171.0 170.0 168.0 170.0 168.0 06:52:06 INFO - PID 13358 | 06:52:06 INFO - PID 13358 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:66.50 stddev:2.22 (3.3%) stddev-sans-first:2.15 06:52:06 INFO - PID 13358 | Values: 64.0 68.0 66.0 67.0 71.0 64.0 66.0 69.0 66.0 65.0 06:52:06 INFO - PID 13358 | -------- Summary: end -------- 06:52:06 INFO - PID 13358 | 06:52:06 INFO - PID 13358 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 06:52:07 INFO - TEST-INFO | 13358: exit 0 06:52:07 INFO - TEST-OK | kraken | took 62768ms 06:52:07 INFO - SUITE-END | took 1177s 06:52:07 INFO - Completed test suite (00:19:37) 06:52:07 INFO - javascript benchmark 06:52:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8512.59560159769, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3247.1557395077302, 3253.3330667213218, 3255.462848629975, 3294.456414691576, 3338.315645292715, 6252.718627661755, 6259.561830671849, 6274.529410294234, 6318.778842740505, 6351.079093531435, 6096.298925623554, 6164.321924588303, 6211.565190436671, 6235.501159907208, 6322.715477803498, 5814.302283725959, 5860.824175274749, 5878.353381128072, 5882.6764527950945, 5890.469857712805, 618.6780208396807, 5687.146927960797, 5713.114467257582, 5864.530837533009, 5867.677277749722, 5716.799912003102, 5734.455226753452, 5796.3334216565, 5801.216835727165, 5878.441548052928, 5699.287589051369, 5783.450572195677, 5813.418658134195, 5813.767449302023, 5852.326982397036, 5685.204071430003, 5717.656940583578, 5762.3373312069225, 5817.360090390053, 5824.767009319622, 6204.565680402374, 6219.68901554925, 6227.034809604518, 6326.2092238470195, 6341.270753863272, 6528.673566321712, 6656.56732312403, 6663.4669226461765, 6754.324567543255, 6755.560888542278, 6648.867022659568, 6718.966405167943, 6832.59004459734, 6852.28051054642, 6854.074699915497, 6319.74721011159, 6325.399087086719, 6386.936130638681, 6397.936020639827, 6400.839979000516, 6737.09049278351, 6741.685371352637, 6786.117804685359, 6791.864162716718, 6803.115594972622, 6457.192850893638, 6577.112089867806, 6588.53880228389, 6589.308122647149, 6602.60384376939, 6683.6658167091455, 6684.2647308795995, 6689.5986240825705, 6705.597664140168, 6710.731570737214, 6583.539152259296, 6593.274739778621, 6596.406323430819, 6629.502787290972, 6745.224299205556, 6528.445082168069, 6775.661216939232, 6837.2820853809635, 6840.281770414134, 6857.691403886837, 5104.183330667075, 5193.272941788153, 5244.239585260192, 5296.761645725952, 5296.867578310496, 4526.660500462479, 4562.543745625411, 4565.680402371869, 4578.130155270488, 4635.7450340230935, 5823.94176058234, 5851.9707401463575, 5871.4715675589405, 5884.0, 5885.087811389241, 6752.763653272112, 6758.695858686273, 6791.762288319984, 6819.659017049128, 6824.317568243236, 5793.536517078624, 5809.2738407699035, 5877.4122587740885, 5901.0558310670085, 5926.851828704317, 5718.656880587178, 5757.625754326039, 5806.216160818235, 5832.50423713989, 5841.620294680833, 6349.49204063683, 6441.3880681335195, 6488.67556622167, 6494.9350506495275, 6573.112629795012, 6735.292794256533, 6739.93260067393, 6796.082528858639, 6835.487338449736, 6836.145481814773, 6615.470762338905, 6629.569078009914, 6648.268690444144, 6653.301403352772, 6663.46692264608, 6677.833054173684, 6685.39831415175, 6686.197656281277, 6780.457563395015, 6788.1175447191545, 6575.145231119924, 6748.966255168889, 6781.42357899584, 6880.105586273752, 6898.586084834926, 6458.838529036811, 6500.772472963424, 6515.576487528296, 6530.8040758777315, 6539.738410463528, 6482.124913136666, 6492.0261960706275, 6514.5765525242605, 6515.641639709862, 6539.4768418525455, 5998.082232705113, 6349.777757778455, 6423.807285781434, 6447.806565803034, 6478.384553467413, 6325.841853953688, 6365.490760739037, 6394.968025159845, 6485.708143133665, 6497.317781632861, 6336.429721325103, 6352.428281454691, 6353.237611486466, 6370.044493326038, 6371.044343348535], "value": 6089.830869419652, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [777.4169372970272, 807.3258828877887, 844.5270648436875, 866.6446756829702, 873.6549063120068, 39833.601663983354, 40273.597264027354, 40337.19325613486, 40597.594024059785, 40646.7967660162, 37777.24445511088, 37782.622173778254, 37942.0, 37964.050898727546, 38013.23973520528, 6860.0, 6926.064981227521, 6934.375906168444, 6941.652917354138, 6942.271061538541, 6870.244273129952, 6971.7211311547735, 6980.232174460805, 6986.301369863024, 6992.160940687125, 6907.481938854581, 6919.273476284993, 6966.338197871194, 7360.1903790583265, 7674.462787604842, 7581.052368453943, 7632.7787553991375, 7644.388448924073, 7646.120696119906, 7650.770476885702, 7504.024476817979, 7589.316961473494, 7592.81017974555, 7593.316601505836, 7599.734009309647, 37212.0, 37600.811995940116, 37780.0, 37850.242995139946, 38057.0, 3463.826808659582, 3516.7889926604485, 3519.982400087983, 3522.18989632386, 3523.541939547868, 30544.0, 30615.69384306151, 30803.691963080306, 30846.53730194049, 30950.380992380025, 5114.28400023997, 5135.12702840518, 5146.871328216787, 5160.767765450564, 5244.449332820037, 183414.0, 187241.0, 187555.0, 188551.0, 189022.99999999863, 45632.0, 45757.31364029542, 45807.770961145645, 45828.541714583094, 45894.541054589026, 46984.295235571495, 47686.523134768904, 47741.761291193325, 47814.521854781706, 47892.76053619779, 14540.27298635064, 14681.706365872622, 14796.48212312564, 14796.852031479762, 14801.925990370195, 11879.703007424883, 11967.760644787055, 12042.09684273683, 12062.819057714141, 12092.214006089576, 12987.935060324828, 13058.738825223632, 13207.537736179187, 13225.140365876186, 13371.598852034454, 5415.783368665288, 5438.809641662523, 5469.781208751685, 5479.767052413175, 5502.724863756796, 970.5195928015678, 981.4258658684606, 992.2012779712256, 1000.9199264058858, 1008.0977525115128, 22509.774902251094, 22553.323400298017, 22834.31497055091, 22992.770072299398, 23074.65388019181, 1072.5495291977388, 1089.5805115030612, 1097.0729733375285, 1104.6465131158113, 1107.9778404432027, 11786.410679465993, 11834.112441566916, 11964.940175299242, 12055.517779288906, 12081.939590301992, 222937.0, 222970.0, 223582.0, 223815.0, 224464.0, 41682.583174168474, 43056.0, 49945.50054499409, 50169.24746128811, 50197.74901125544, 1391.2070120031485, 1399.2583930516842, 1411.1321537254514, 1414.5826981040618, 1415.9185996585004, 27256.72743272542, 27306.45387092287, 27346.726532735214, 27350.863245683646, 27395.726042739316, 35965.28069438649, 36065.81967090148, 36220.81889590535, 36589.26821463609, 36593.0, 200759.0, 201128.0, 202165.0, 202560.0, 202766.0, 32776.672233277364, 33154.834225828716, 33313.00121992688, 33449.83275083609, 36064.09839754027, 44444.0, 44836.551634484546, 45436.77281613571, 45488.77255613701, 45797.08405831931, 33019.504707429885, 33161.0, 33254.66745332516, 33532.0, 33595.83202083974, 32415.51376729398, 32922.34155316928, 32926.17684557905, 33171.50242746312, 33536.16159596029, 37284.44073338848, 37634.0, 37666.811665941495, 37735.49058037648, 37805.62194378021, 31343.84328078345, 31454.0, 31962.20094497656, 33191.0, 33212.50181247235, 24049.278521644377, 24463.755362446147, 24498.530088194766, 24988.250352489453, 25141.37146571277], "value": 16772.291927512695, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.9421510741372, 557.2838902010915, 559.1305519916533, 561.7556362982103, 572.997135014325, 21894.89052554737, 22700.318990430293, 22707.0, 22740.204092856733, 22745.54508909825, 23927.16254931078, 26208.082717104906, 26419.0, 26482.337941551472, 26544.0, 6522.119513865627, 6677.66611669417, 6688.431483323923, 6692.364225398579, 6703.731850725965, 6443.806685799434, 6511.12099866519, 6513.57661751987, 6560.475161987029, 6563.803085907431, 5804.187413762055, 6468.288488266287, 6471.255805582371, 6483.546151769378, 6510.348965103499, 6478.2873883872735, 6501.4798816094835, 6552.868942621169, 6553.541252112354, 6556.409923106896, 6063.514918806485, 6074.665893375863, 6079.118527813486, 6085.482733967574, 6086.513078953717, 28117.297067573476, 29037.41925161506, 29341.413171736447, 29784.851075744482, 29848.40303193924, 2054.6609809381434, 2087.8642888212216, 2092.163134746114, 2106.104905415192, 2106.6418708819538, 18833.529161771065, 19551.120199591052, 19587.608247835105, 19615.01924903749, 19627.60744785096, 2394.640803879432, 2424.8787560622077, 2497.1509686706427, 2497.675302210719, 2502.299356180254, 127295.0, 131339.34330328382, 131499.0, 131663.34168329096, 132795.0, 13967.022308438312, 14339.78490322646, 14390.352434140488, 14489.20309382973, 14927.701445971019, 22342.776572234394, 22377.55244895093, 22523.662145067836, 22559.774402256095, 22587.209447669582, 9734.464604446823, 10011.549480273405, 10074.093331600045, 10090.293679442515, 10150.49247537635, 9230.307726920508, 9246.214071803837, 9289.442633442015, 9332.860007099898, 9361.719148425558, 8641.611127499153, 8879.312930543176, 9013.414128081653, 9111.498867562348, 9147.399205139074, 2613.4773045391, 2645.4312322850296, 2694.811363204596, 2764.6958834528186, 2820.3795165063652, 942.783159873233, 971.523953262896, 973.4970397743144, 976.9902300977042, 981.1415011864618, 19885.60228795416, 23661.0, 24949.0, 25328.11351602685, 25592.23223303304, 1005.2109094360892, 1036.5439206749006, 1046.2676126711333, 1048.8059708953867, 1052.5211028981948, 11271.661850144508, 11433.885661143282, 11438.542458301576, 11473.139514536444, 11497.71255718597, 507811.0, 509401.0, 516344.0, 520033.0, 521347.0, 115818.0, 116876.0, 117613.0, 119056.0, 119177.0, 1203.1036877526299, 1215.6292330839178, 1238.6531771104105, 1246.4141853328922, 1252.0922331309728, 18309.0, 18474.16866241049, 18597.163127659016, 18620.0, 18968.715469267696, 55083.44916550783, 57141.42858571361, 57383.42616573781, 57667.84664306606, 57919.0, 67231.32768672446, 68139.65930170317, 70445.6477717608, 70639.64680176566, 70712.19297939244, 14593.854061459675, 14785.038972466755, 14785.778213327023, 14826.332815023134, 14829.258537072887, 17714.911425443304, 22256.888715556317, 23309.951052202352, 23380.415489612897, 23864.164754234214, 18354.449366519028, 18366.26534938641, 18654.253829846653, 18722.625547489246, 18734.0, 16068.43760468378, 16375.918120409322, 16910.408135715683, 16944.661106778043, 17564.2096105673, 18719.625607487502, 19524.414267571996, 19586.412407627795, 19975.101120449322, 20017.29939452112, 14672.779908301598, 14686.0, 14695.706085878437, 14914.403423862925, 14955.102693838404, 18773.812261877207, 18780.624387512446, 19079.618407632046, 19100.71348929795, 19123.0], "value": 12059.888793736294, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1334.5796074236614, 1397.692507648317, 1399.7480453518363, 1404.431205361829, 1408.3662351941623, 15016.47442339517, 15589.142597157152, 15615.375384984602, 15696.843031569695, 15724.606884827885, 14956.0, 16057.116858572774, 16074.83925160748, 16086.678266434665, 16090.919545402287, 2773.2234974207254, 2843.218115018366, 2843.2749648839517, 2844.886204551826, 2846.4022555263314, 2682.678078630557, 2685.597160425932, 2756.104266113511, 2757.310672331917, 2761.0888406825798, 2725.4140359822636, 2763.226296636935, 2764.5023895698764, 2765.4745598336253, 2774.902878399256, 2727.986360068207, 2735.7401046900513, 2758.517259479603, 2761.9447611047867, 2770.3351195713085, 2634.288742039658, 2648.099646120309, 2648.6689163854517, 2651.6287719719253, 2658.5081759874483, 14904.329305181293, 15140.924295378452, 15250.161241131733, 15267.541973740805, 15273.083614983136, 8094.797630059236, 8389.832203355898, 8433.95783021081, 8435.367347448904, 8454.957725211396, 5416.837494875121, 5432.809851655173, 5523.613347065707, 5630.634008789457, 5792.275965504312, 1857.5634725839418, 1873.7564116664882, 1877.1740434208905, 1909.8185672361242, 1932.2753967262277, 26382.868085659447, 26444.86777566119, 26471.47057058848, 26518.602220966703, 26609.46781064368, 6610.405063544208, 6870.690818913161, 6876.040328506352, 6948.44412447003, 7119.359257666835, 17151.142442877805, 17168.742468862976, 17203.483895483154, 17245.56886077858, 17270.568235794206, 7828.647710853025, 8019.318357939641, 8109.878351824727, 8119.4722343047515, 8125.553094579855, 7310.195878453366, 7470.551766893895, 7499.512531685423, 7651.770446886602, 7657.234276572298, 5071.41678706946, 5268.604854635918, 5287.735613219324, 5299.5760339172775, 5405.648632838853, 1378.5795332423506, 1426.7645838436542, 1452.3972551391266, 1518.627936155649, 1522.0, 835.4694768821842, 841.2344766262794, 859.6174702257435, 863.119617989647, 873.7378786364065, 8433.536155511383, 8547.529885856338, 8553.828923421497, 8708.95645521781, 8791.69229076992, 953.423178976723, 976.6044751875502, 991.4398364923795, 999.6501224571342, 1011.6358111080006, 4716.891530490332, 5240.292560504359, 5307.548858347007, 5463.9566720627245, 5631.63394379364, 21052.57894842125, 21660.675089873665, 21888.343349699535, 22200.666989995163, 22331.218407355664, 21136.0, 21412.357629271148, 22087.0, 22118.88940555287, 22152.556948860933, 10876.347419154717, 11063.668089957153, 11247.100231981258, 11284.097272218203, 11336.659900203007, 8622.008469025892, 8777.297816174818, 8824.602892869709, 8859.468431894107, 8927.866082008904, 17899.0, 18021.81978180254, 18109.185086671394, 18186.27254909789, 18868.52828679294, 18798.906005469886, 18836.434906952814, 18873.0, 19170.0, 19305.90347048312, 11247.493862776031, 11501.597444089417, 11538.94230528842, 11556.479958401724, 11567.826482602935, 13813.171209727047, 13967.231802250973, 14154.646133846736, 14202.360893759598, 14212.786808198092, 11321.792250511071, 11615.0, 11759.76480470403, 11816.172867899164, 11934.820977685167, 10707.0, 11006.504707288032, 11042.613508527164, 11111.833322500008, 11204.047655949336, 9009.729708108767, 9349.57926893305, 9442.575084121094, 9444.102810233016, 9450.480223587769, 6979.302069793183, 7157.463190260647, 7198.6040767756185, 7238.52949558277, 7292.817679557841, 7015.193252775996, 7088.574685518885, 7145.285471453021, 7164.462665300228, 7402.407807375289], "value": 6728.579960362813, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.96008302730326, 502.6278260349245, 524.9212618107283, 529.3806246691371, 530.7744208711299, 6250.781222657208, 6309.148264984232, 6337.493000559955, 6339.587926784761, 6377.808665740035, 5924.644521328723, 6118.663473508956, 6130.356312587181, 6146.508279337653, 6230.781922632709, 5015.498450154973, 5018.34761481007, 5055.5702765265, 5060.393897142956, 5075.7715902784275, 4974.353334066566, 4983.177775667011, 5021.59827213822, 5033.464793238061, 5068.1890897456415, 4709.458412282597, 4948.208286674133, 4953.133201689708, 4958.206686930092, 5010.473900240477, 4946.505349465043, 5003.224500202438, 5003.323886498028, 5020.7740651670765, 5023.8492845214705, 4376.927652725103, 4399.6040356368085, 4426.959664478845, 4488.259437192859, 4512.593866551993, 6034.3448882492, 6055.27336719592, 6069.57512974092, 6090.421409966046, 6139.693015349215, 5655.717214139277, 5664.291963504562, 5690.772369105272, 5697.173909783059, 5725.885482290372, 6574.397921454953, 6585.637789921552, 6590.670466476657, 6628.4697224221945, 6682.131322927989, 4870.853874383774, 4881.8535443936735, 4890.462049174588, 4897.4857639948, 4897.755112244409, 6841.144856892888, 6844.8973265401055, 6912.861742765217, 6964.199117101548, 7011.298870112999, 5056.873578160576, 5074.23886417033, 5078.13671675816, 5101.489851014869, 5111.948880511221, 5038.622103342264, 5067.265246539231, 5085.516875896784, 5118.769655365518, 5160.716160611202, 5617.241672374177, 5632.451075954145, 5640.8871822563315, 5695.686737229409, 5724.112762521816, 6563.540552161398, 6608.570442921291, 6669.366410191024, 6682.064510968468, 6746.0, 1758.9120543973006, 1769.6106856491551, 1771.636814453034, 1776.413783451458, 1777.626698393352, 1150.930944143354, 1159.5186301315193, 1162.8953394194393, 1191.3149938785234, 1215.4199540597365, 5710.0, 5783.4794868461195, 5793.826185214451, 5803.680797556175, 5835.620684655484, 6483.578567393104, 6654.074096283216, 6763.357481039294, 6768.593884366954, 6778.593284402951, 5669.177969194444, 5698.743556539883, 5741.19623252745, 5754.251947246831, 5782.397920935596, 3501.474778783203, 3552.632236588932, 3587.94618080729, 3596.7841929484316, 3605.2068544920076, 6425.58233714807, 6521.967390163114, 6531.902021469682, 6558.639274839929, 6651.636414535009, 6861.279565645636, 6895.586264824126, 6921.792346229621, 6950.652467376712, 6956.2000369958105, 6426.333071775348, 6534.738610455529, 6591.604503729792, 6601.174853143357, 6639.9496307251575, 6710.396064354231, 6726.39462448382, 6732.293109223657, 6761.763338283333, 6793.5244532882225, 6601.53789234749, 6602.877510823268, 6664.333566643297, 6711.261761206361, 6734.494912881455, 6419.582727122722, 6447.0, 6461.935380646321, 6482.0, 6528.151340325728, 4911.778969946289, 4970.65205435616, 4975.676581022222, 4991.5258050485145, 5026.0, 6678.766243181465, 6748.19021717397, 6756.594604323756, 6791.694373753094, 6819.659017049227, 6447.516436267205, 6490.221173459215, 6516.51126165549, 6525.445337146396, 6541.757066157415, 6463.0270075765675, 6518.348165183444, 6519.185101862267, 6528.857449946336, 6569.343065693392, 5782.826515204551, 6442.226932768098, 6491.837704057436, 6517.315681853337, 6550.7707230246715, 6510.7721229756735, 6537.967310163419, 6549.967250163719, 6560.343965603402, 6714.160729908762, 6372.872542549216, 6400.45596124316, 6404.263509696445, 6434.453071488976, 6439.549231553746], "value": 5061.763001385057, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [881.5944665453891, 901.4411065139615, 902.2962089570134, 902.7246689759621, 911.5761171055462, 19187.808121918795, 19969.201231950705, 20129.396118116463, 20159.596808063867, 20213.59572808543, 19379.224831006777, 21306.147754089856, 21351.039203235854, 21366.0, 21409.892950535224, 944.4805357053627, 967.6468089147446, 971.9222462203043, 976.5507866381438, 977.2328721953268, 973.6835528453281, 975.4586204656448, 976.0434773921561, 976.24828881761, 976.4043933200742, 772.8647486689835, 774.1871035412822, 825.7605294464598, 998.3660375661435, 1041.843723441486, 989.65362123257, 991.504247876062, 994.3536701144242, 994.5773046455228, 996.2627655534889, 733.1605311917878, 734.4785202506174, 734.5629350536423, 734.7391675955066, 734.8162959260185, 17644.558886027953, 18988.24047038117, 20027.899860500605, 20265.493362665904, 20372.796272037238, 21109.050092745863, 21161.25935592247, 21637.891810541005, 21755.456113597127, 21888.562228755334, 16322.102284374354, 16709.164541772985, 16738.581535461588, 16874.493765187064, 16915.83084169155, 3690.151265209017, 3709.888703338904, 3718.6467285607823, 3731.3843215869347, 3733.607971163043, 127683.0, 130737.34631326878, 133323.0, 134148.32925835406, 134902.0, 16161.595960100856, 16457.753133703005, 16562.254698538596, 16565.503034908972, 16847.15764211809, 29146.708532914825, 30194.84902575473, 30198.245043873638, 30259.69740302569, 30279.545806812916, 8980.68567600144, 9255.537223138816, 9293.953530232306, 9297.209737172416, 9322.906770932339, 4256.851010214627, 4316.568343165658, 4351.216780979454, 4397.802098905557, 4457.398251236042, 4591.104734576792, 4809.9038019239415, 5280.551153152025, 5404.648697834628, 5472.452754724575, 1098.0776148035688, 1107.3466654673782, 1114.6990312615549, 1121.556984990924, 1121.9775604487866, 639.2520750721667, 648.1056142523288, 662.1954325494547, 663.8373598468406, 665.7037618259925, 11757.823632645517, 11963.46164422603, 12126.211796233392, 12163.878361216275, 13015.349232538336, 683.9760608378782, 697.6128248821952, 703.7290643102442, 705.0763499815258, 709.5848928376854, 5488.25908502355, 5624.831255062355, 5791.276090488689, 6133.785317513865, 6163.907541386883, 107272.46363768131, 108696.4565177169, 111234.44382778034, 113045.43477282561, 113668.43165784118, 101910.0, 102422.48788756008, 103923.0, 105693.0, 106757.46621266844, 89338.55330723304, 90586.54706726424, 90865.54567227121, 91996.0, 94035.0, 12770.936145319214, 13062.54281100157, 13073.934630327169, 13145.079844411182, 13195.20828750278, 38994.4150837732, 39412.60587394089, 39540.60459395369, 40311.59688403078, 41700.58299416967, 52349.7382513085, 52627.21059184192, 52992.99909552801, 53000.0, 54845.0, 15695.372185112925, 16154.919225403797, 16316.42892498757, 16425.917870410573, 16559.0, 20520.38438846837, 21507.46231344229, 21854.125834966424, 21863.890680546494, 22099.33701988943, 17648.55878602994, 18106.637867242844, 18143.092845357944, 18355.724664129782, 18704.0, 17281.827181728022, 17642.38251661237, 18243.817561824213, 18306.90846545759, 18693.906530467262, 17830.37593684215, 18388.448346549623, 18414.079296035412, 18529.351472698392, 18827.05864706732, 11205.327680339205, 11564.190506664452, 11987.820182697093, 12025.278483291031, 12771.297578632893, 13596.66008349799, 13724.245166515937, 13732.725345492834, 13806.922950074319, 13828.170309781446], "value": 9069.440712841286, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1517.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 117.0, 101.0, 116.0, 113.0, 111.0, 108.0, 108.0, 109.0, 118.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 125.0, 151.0, 175.0, 124.0, 146.0, 155.0, 124.0, 177.0, 118.0], "value": 144.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 163.0, 163.0, 163.0, 160.0, 169.0, 167.0, 166.0, 161.0, 172.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 83.0, 84.0, 153.0, 76.0, 75.0, 75.0, 86.0, 96.0, 83.0], "value": 89.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 79.0, 142.0, 82.0, 90.0, 80.0, 123.0, 88.0, 79.0, 136.0], "value": 98.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 117.0, 114.0, 127.0, 122.0, 115.0, 123.0, 118.0, 121.0, 121.0], "value": 120.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 152.0, 150.0, 157.0, 150.0, 148.0, 155.0, 152.0, 151.0, 149.0], "value": 151.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 96.0, 105.0, 95.0, 102.0, 96.0, 99.0, 102.0, 95.0, 102.0], "value": 99.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 51.0, 52.0, 54.0, 54.0, 52.0, 64.0, 52.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [42.0, 38.0, 37.0, 38.0, 38.0, 45.0, 38.0, 37.0, 40.0, 49.0], "value": 40.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 79.0, 74.0, 77.0, 83.0, 80.0, 75.0, 76.0, 81.0], "value": 77.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 124.0, 123.0, 130.0, 122.0, 129.0, 121.0, 131.0, 122.0, 161.0], "value": 129.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 171.0, 169.0, 176.0, 174.0, 171.0, 170.0, 168.0, 170.0, 168.0], "value": 170.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 68.0, 66.0, 67.0, 71.0, 64.0, 66.0, 69.0, 66.0, 65.0], "value": 66.6, "unit": "score"}]}]} 06:52:07 INFO - Return code: 0 06:52:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:52:07 INFO - # TBPL SUCCESS # 06:52:07 INFO - Running post-action listener: _package_coverage_data 06:52:07 INFO - Running post-action listener: _resource_record_post_action 06:52:07 INFO - [mozharness: 2017-08-31 13:52:07.775014Z] Finished run-tests step (success) 06:52:07 INFO - Running post-run listener: _resource_record_post_run 06:52:07 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 9281536; Write bytes: 404979712; Read time: 3300; Write time: 230216 06:52:07 INFO - TinderboxPrint: CPU usage
13.3% 06:52:07 INFO - TinderboxPrint: I/O read bytes / time
9,281,536 / 3,300 06:52:07 INFO - TinderboxPrint: I/O write bytes / time
404,979,712 / 230,216 06:52:07 INFO - TinderboxPrint: CPU idle
8,257.2 (86.7%) 06:52:07 INFO - TinderboxPrint: CPU user
1,202.7 (12.6%) 06:52:07 INFO - TinderboxPrint: Swap in / out
0 / 0 06:52:07 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 121106432; Read time: 0; Write time: 75620 06:52:07 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 06:52:07 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 9281536; Write bytes: 283873280; Read time: 3300; Write time: 154596 06:52:08 INFO - Running post-run listener: _upload_blobber_files 06:52:08 INFO - Blob upload gear active. 06:52:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:52:08 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:52:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:52:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:52:08 INFO - (blobuploader) - INFO - Open directory for files ... 06:52:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:52:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:52:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:52:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:52:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:52:09 INFO - (blobuploader) - INFO - Done attempting. 06:52:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:52:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:52:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:52:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:52:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:52:14 INFO - (blobuploader) - INFO - Done attempting. 06:52:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:52:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:52:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:52:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:52:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:52:15 INFO - (blobuploader) - INFO - Done attempting. 06:52:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:52:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:52:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:52:16 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:52:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:52:16 INFO - (blobuploader) - INFO - Done attempting. 06:52:16 INFO - (blobuploader) - INFO - Iteration through files over. 06:52:16 INFO - Return code: 0 06:52:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:52:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:52:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/789e8fcac4d498ff3338893aba89e014b2c95109a2fcad0e6de12b3c346b0cb7412fdb2702adfecfaf561acc1665501255285f46d7d23ccd22d624b5aab2baa4", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2581f39144b321c290cd5fd12a6a257f7ce1ff6899d057c559de48bd56fde3893a22d6171131409940bb348e4a5d98aef5b0308584f82b4de0670defcc3ae6da", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/67db3eb957903fc99710a7d780e21b665f779d1447fa0af45500be93c37da16599c254371f8e38e4d3a758b2adf076686341e2cf4af1ef47b1ba72e0f8e09f39", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0ce60a035708a1804018eeef201ffc394031696c3e8a5e2ef029b705fa27bf2e73d0384f0b330597aa644cc1af9c55c58b6c6b66aeac4e5441829b96ebb2d19"} 06:52:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:52:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:52:16 INFO - Contents: 06:52:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/789e8fcac4d498ff3338893aba89e014b2c95109a2fcad0e6de12b3c346b0cb7412fdb2702adfecfaf561acc1665501255285f46d7d23ccd22d624b5aab2baa4", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2581f39144b321c290cd5fd12a6a257f7ce1ff6899d057c559de48bd56fde3893a22d6171131409940bb348e4a5d98aef5b0308584f82b4de0670defcc3ae6da", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/67db3eb957903fc99710a7d780e21b665f779d1447fa0af45500be93c37da16599c254371f8e38e4d3a758b2adf076686341e2cf4af1ef47b1ba72e0f8e09f39", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0ce60a035708a1804018eeef201ffc394031696c3e8a5e2ef029b705fa27bf2e73d0384f0b330597aa644cc1af9c55c58b6c6b66aeac4e5441829b96ebb2d19"} 06:52:16 INFO - Running post-run listener: copy_logs_to_upload_dir 06:52:16 INFO - Copying logs to upload dir... 06:52:16 INFO - mkdir: /builds/slave/test/build/upload/logs 06:52:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.999742 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-08-31 06:52:16.513189) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-31 06:52:16.519170) ========= 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=3a3620fb28aea1604ab609ef000001d2-1504186276.579097-526733859 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/789e8fcac4d498ff3338893aba89e014b2c95109a2fcad0e6de12b3c346b0cb7412fdb2702adfecfaf561acc1665501255285f46d7d23ccd22d624b5aab2baa4", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2581f39144b321c290cd5fd12a6a257f7ce1ff6899d057c559de48bd56fde3893a22d6171131409940bb348e4a5d98aef5b0308584f82b4de0670defcc3ae6da", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/67db3eb957903fc99710a7d780e21b665f779d1447fa0af45500be93c37da16599c254371f8e38e4d3a758b2adf076686341e2cf4af1ef47b1ba72e0f8e09f39", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0ce60a035708a1804018eeef201ffc394031696c3e8a5e2ef029b705fa27bf2e73d0384f0b330597aa644cc1af9c55c58b6c6b66aeac4e5441829b96ebb2d19"} build_url:https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011465 build_url: 'https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/789e8fcac4d498ff3338893aba89e014b2c95109a2fcad0e6de12b3c346b0cb7412fdb2702adfecfaf561acc1665501255285f46d7d23ccd22d624b5aab2baa4", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2581f39144b321c290cd5fd12a6a257f7ce1ff6899d057c559de48bd56fde3893a22d6171131409940bb348e4a5d98aef5b0308584f82b4de0670defcc3ae6da", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/67db3eb957903fc99710a7d780e21b665f779d1447fa0af45500be93c37da16599c254371f8e38e4d3a758b2adf076686341e2cf4af1ef47b1ba72e0f8e09f39", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0ce60a035708a1804018eeef201ffc394031696c3e8a5e2ef029b705fa27bf2e73d0384f0b330597aa644cc1af9c55c58b6c6b66aeac4e5441829b96ebb2d19"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-31 06:52:16.550091) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 06:52:16.550489) ========= 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=3a3620fb28aea1604ab609ef000001d2-1504186276.579097-526733859 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004426 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 06:52:16.632573) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-31 06:52:16.632883) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-31 06:52:16.633186) ========= ========= Total master_lag: 0.19 =========