builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-008 starttime: 1504893777.67 results: success (0) revision: 6d0288c291650ab619dc4ff92cb0b60e3b6e7b3b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-08 11:02:57.672729) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-08 11:02:57.673161) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-08 11:02:57.673429) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-08 11:02:57.700532) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 11:02:57.704243) ========= 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=32c5991c409366f7fec8a718000001d2-1504891769.645379-1045930591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-08 11:02:57-- 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% 109M=0s 2017-09-08 11:02:57 (109 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.095302 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 11:02:57.816521) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 11:02:57.816837) ========= 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=32c5991c409366f7fec8a718000001d2-1504891769.645379-1045930591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020182 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 11:02:57.889136) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-09-08 11:02:57.889424) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6d0288c291650ab619dc4ff92cb0b60e3b6e7b3b --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 6d0288c291650ab619dc4ff92cb0b60e3b6e7b3b --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=32c5991c409366f7fec8a718000001d2-1504891769.645379-1045930591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-08 11:02:57,916 truncating revision to first 12 chars 2017-09-08 11:02:57,916 Setting DEBUG logging. 2017-09-08 11:02:57,916 attempt 1/10 2017-09-08 11:02:57,916 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6d0288c29165?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-08 11:02:59,094 attempt 1/10 2017-09-08 11:02:59,857 current task status: no status available at this point. state: STARTED 2017-09-08 11:02:59,858 sleeping for 9.00s (attempt 1/10) 2017-09-08 11:03:08,867 attempt 2/10 2017-09-08 11:03:09,201 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-09-08 11:03:09,385 unpacking tar archive at: mozilla-central-6d0288c29165/testing/mozharness/ program finished with exit code 0 elapsedTime=11.745158 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-09-08 11:03:09.658025) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-08 11:03:09.658509) ========= script_repo_revision: 6d0288c291650ab619dc4ff92cb0b60e3b6e7b3b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-08 11:03:09.659075) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-08 11:03:09.659449) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-08 11:03:09.677629) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-09-08 11:03:09.678219) ========= /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=32c5991c409366f7fec8a718000001d2-1504891769.645379-1045930591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:03:09 INFO - MultiFileLogger online at 20170908 11:03:09 in /builds/slave/test 11:03:09 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 11:03:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:03:09 INFO - {'append_to_log': False, 11:03:09 INFO - 'base_work_dir': '/builds/slave/test', 11:03:09 INFO - 'blob_upload_branch': 'Firefox', 11:03:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:03:09 INFO - 'branch': 'Firefox', 11:03:09 INFO - 'buildbot_json_path': 'buildprops.json', 11:03:09 INFO - 'code_coverage': False, 11:03:09 INFO - 'config_files': ('talos/linux_config.py',), 11:03:09 INFO - 'default_actions': ('clobber', 11:03:09 INFO - 'read-buildbot-config', 11:03:09 INFO - 'download-and-extract', 11:03:09 INFO - 'populate-webroot', 11:03:09 INFO - 'create-virtualenv', 11:03:09 INFO - 'install', 11:03:09 INFO - 'setup-mitmproxy', 11:03:09 INFO - 'run-tests'), 11:03:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:03:09 INFO - 'disable_ccov_upload': False, 11:03:09 INFO - 'disable_stylo': False, 11:03:09 INFO - 'download_minidump_stackwalk': True, 11:03:09 INFO - 'download_symbols': 'ondemand', 11:03:09 INFO - 'enable_stylo': False, 11:03:09 INFO - 'enable_webrender': False, 11:03:09 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:03:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:03:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:03:09 INFO - 'gecko_profile': False, 11:03:09 INFO - 'gecko_profile_interval': 0, 11:03:09 INFO - 'installer_path': 'installer.exe', 11:03:09 INFO - 'log_level': 'info', 11:03:09 INFO - 'log_name': 'talos', 11:03:09 INFO - 'log_to_console': True, 11:03:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:03:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:03:09 INFO - 'opt_config_files': (), 11:03:09 INFO - 'pip_index': False, 11:03:09 INFO - 'suite': 'dromaeojs-e10s', 11:03:09 INFO - 'system_bits': '32', 11:03:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:03:09 INFO - 'title': 'talos-linux64-ix-008', 11:03:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:03:09 INFO - 'use_talos_json': True, 11:03:09 INFO - 'verify': 'False', 11:03:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:03:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:03:09 INFO - 'work_dir': 'build'} 11:03:09 INFO - [mozharness: 2017-09-08 18:03:09.850937Z] Running clobber step. 11:03:09 INFO - Running pre-action listener: _resource_record_pre_action 11:03:09 INFO - Running main action method: clobber 11:03:09 INFO - rmtree: /builds/slave/test/build 11:03:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:03:11 INFO - Running post-action listener: _resource_record_post_action 11:03:11 INFO - [mozharness: 2017-09-08 18:03:11.381084Z] Finished clobber step (success) 11:03:11 INFO - [mozharness: 2017-09-08 18:03:11.381181Z] Running read-buildbot-config step. 11:03:11 INFO - Running pre-action listener: _resource_record_pre_action 11:03:11 INFO - Running main action method: read_buildbot_config 11:03:11 INFO - Using buildbot properties: 11:03:11 INFO - { 11:03:11 INFO - "project": "", 11:03:11 INFO - "product": "firefox", 11:03:11 INFO - "who": "ffxbld@noreply.mozilla.org", 11:03:11 INFO - "installer_path": "public/build/target.tar.bz2", 11:03:11 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 11:03:11 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:03:11 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 11:03:11 INFO - "stage_platform": "linux64-stylosequential", 11:03:11 INFO - "basedir": "/builds/slave/test", 11:03:11 INFO - "buildnumber": 67, 11:03:11 INFO - "platform": "ubuntu64_hw_styloseq", 11:03:11 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:03:11 INFO - "slavebuilddir": "test", 11:03:11 INFO - "taskId": "GXh0FA62QGOXy4HbCloYuA", 11:03:11 INFO - "branch": "mozilla-central", 11:03:11 INFO - "script_repo_revision": "production", 11:03:11 INFO - "revision": "6d0288c291650ab619dc4ff92cb0b60e3b6e7b3b", 11:03:11 INFO - "slavename": "talos-linux64-ix-008", 11:03:11 INFO - "repo_path": "mozilla-central" 11:03:11 INFO - } 11:03:11 INFO - Finding installer, test and symbols from parent task. 11:03:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GXh0FA62QGOXy4HbCloYuA'}, attempt #1 11:03:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GXh0FA62QGOXy4HbCloYuA'}, attempt #1 11:03:12 INFO - Task dependencies: RlzMfz8tRFW8DsiiCEg_WA 11:03:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA'}, attempt #1 11:03:12 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.tar.bz2 11:03:12 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.test_packages.json 11:03:12 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.crashreporter-symbols.zip 11:03:12 INFO - Running post-action listener: _resource_record_post_action 11:03:12 INFO - [mozharness: 2017-09-08 18:03:12.748791Z] Finished read-buildbot-config step (success) 11:03:12 INFO - [mozharness: 2017-09-08 18:03:12.749009Z] Running download-and-extract step. 11:03:12 INFO - Running pre-action listener: _resource_record_pre_action 11:03:12 INFO - Running main action method: download_and_extract 11:03:12 INFO - mkdir: /builds/slave/test/build/tests 11:03: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')]} 11:03:12 INFO - trying https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.test_packages.json 11:03:12 INFO - Downloading https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:03:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:03:13 INFO - Downloaded 989 bytes. 11:03:13 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:03:13 INFO - Using the following test package requirements: 11:03:13 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:03:13 INFO - u'common': [u'target.common.tests.zip'], 11:03:13 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:03:13 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:03:13 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:03:13 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:03:13 INFO - u'mozbase': [u'target.common.tests.zip'], 11:03:13 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:03:13 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:03:13 INFO - u'web-platform': [u'target.common.tests.zip', 11:03:13 INFO - u'target.web-platform.tests.tar.gz'], 11:03:13 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:03:13 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:03:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.common.tests.zip 11:03:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:03:13 INFO - Fetch https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.common.tests.zip into memory 11:03:14 INFO - Content-Length response header: 55023640 11:03:14 INFO - Bytes received: 55023640 11:03:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.talos.tests.zip 11:03:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:03:25 INFO - Fetch https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.talos.tests.zip into memory 11:03:26 INFO - Content-Length response header: 14496665 11:03:26 INFO - Bytes received: 14496665 11:03: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')]} 11:03:26 INFO - trying https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.tar.bz2 11:03:26 INFO - Downloading https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:03:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:03:27 INFO - Downloaded 62833296 bytes. 11:03:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.tar.bz2 11:03:27 INFO - mkdir: /builds/slave/test/properties 11:03:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:03:27 INFO - Writing to file /builds/slave/test/properties/build_url 11:03:27 INFO - Contents: 11:03:27 INFO - build_url:https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.tar.bz2 11:03:27 INFO - Running post-action listener: _resource_record_post_action 11:03:27 INFO - Running post-action listener: find_tests_for_verification 11:03:27 INFO - Running post-action listener: set_extra_try_arguments 11:03:27 INFO - [mozharness: 2017-09-08 18:03:27.485655Z] Finished download-and-extract step (success) 11:03:27 INFO - [mozharness: 2017-09-08 18:03:27.485767Z] Running populate-webroot step. 11:03:27 INFO - Running pre-action listener: _resource_record_pre_action 11:03:27 INFO - Running main action method: populate_webroot 11:03:27 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:03:27 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:03:27 INFO - 'tests': ['tresize', 11:03:27 INFO - 'tcanvasmark']}, 11:03:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:03:27 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:03:27 INFO - 'tests': ['dromaeo_css', 11:03:27 INFO - 'kraken']}, 11:03:27 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:03:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:03:27 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:03:27 INFO - 'talos_options': ['--disable-stylo'], 11:03:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:03:27 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:03:27 INFO - 'tests': ['damp', 'tps']}, 11:03:27 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:03:27 INFO - 'talos_options': ['--disable-stylo'], 11:03:27 INFO - 'tests': ['damp', 'tps']}, 11:03:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:03:27 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:03:27 INFO - 'tests': ['dromaeo_dom']}, 11:03:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:03:27 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:03:27 INFO - 'tests': ['basic_compositor_video', 11:03:27 INFO - 'glvideo']}, 11:03:27 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:03:27 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:03:27 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:03:27 INFO - 'talos_options': ['--disable-stylo'], 11:03:27 INFO - 'tests': ['ts_paint_webext', 11:03:27 INFO - 'tp5o_webext']}, 11:03:27 INFO - 'other-e10s': {'tests': ['a11yr', 11:03:27 INFO - 'ts_paint', 11:03:27 INFO - 'tpaint', 11:03:27 INFO - 'sessionrestore', 11:03:27 INFO - 'sessionrestore_many_windows', 11:03:27 INFO - 'sessionrestore_no_auto_restore', 11:03:27 INFO - 'tabpaint']}, 11:03:27 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:03:27 INFO - 'tests': ['a11yr', 11:03:27 INFO - 'ts_paint', 11:03:27 INFO - 'tpaint', 11:03:27 INFO - 'sessionrestore', 11:03:27 INFO - 'sessionrestore_many_windows', 11:03:27 INFO - 'sessionrestore_no_auto_restore', 11:03:27 INFO - 'tabpaint']}, 11:03:27 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:03:27 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:03:27 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:03:27 INFO - 'tests': ['bloom_basic_singleton']}, 11:03:27 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:03:27 INFO - 'tests': ['bloom_basic']}, 11:03:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:03:27 INFO - 'tsvgr_opacity', 11:03:27 INFO - 'tart', 11:03:27 INFO - 'tscrollx', 11:03:27 INFO - 'tsvg_static']}, 11:03:27 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:03:27 INFO - 'tests': ['tsvgx', 11:03:27 INFO - 'tsvgr_opacity', 11:03:27 INFO - 'tart', 11:03:27 INFO - 'tscrollx', 11:03:27 INFO - 'tsvg_static']}, 11:03:27 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:03:27 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:03:27 INFO - 'talos_options': ['--disable-stylo'], 11:03:27 INFO - 'tests': ['tp5o']}, 11:03:27 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:03:27 INFO - 'talos_options': ['--mitmproxy', 11:03:27 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:03:27 INFO - '--firstNonBlankPaint'], 11:03:27 INFO - 'tests': ['tp6_google', 11:03:27 INFO - 'tp6_youtube', 11:03:27 INFO - 'tp6_amazon', 11:03:27 INFO - 'tp6_facebook']}, 11:03:27 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:03:27 INFO - 'talos_options': ['--disable-stylo', 11:03:27 INFO - '--mitmproxy', 11:03:27 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:03:27 INFO - '--firstNonBlankPaint'], 11:03:27 INFO - 'tests': ['tp6_google', 11:03:27 INFO - 'tp6_youtube', 11:03:27 INFO - 'tp6_amazon', 11:03:27 INFO - 'tp6_facebook']}, 11:03:27 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:03:27 INFO - 'talos_options': ['--stylo-threads=1', 11:03:27 INFO - '--mitmproxy', 11:03:27 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:03:27 INFO - '--firstNonBlankPaint'], 11:03:27 INFO - 'tests': ['tp6_google', 11:03:27 INFO - 'tp6_youtube', 11:03:27 INFO - 'tp6_amazon', 11:03:27 INFO - 'tp6_facebook']}, 11:03:27 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:03:27 INFO - 'talos_options': ['--xperf_path', 11:03:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:03:27 INFO - 'tests': ['tp5n']}, 11:03:27 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:03:27 INFO - 'talos_options': ['--disable-stylo', 11:03:27 INFO - '--xperf_path', 11:03:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:03:27 INFO - 'tests': ['tp5n']}}} 11:03:27 INFO - Running post-action listener: _resource_record_post_action 11:03:27 INFO - [mozharness: 2017-09-08 18:03:27.502595Z] Finished populate-webroot step (success) 11:03:27 INFO - [mozharness: 2017-09-08 18:03:27.502703Z] Running create-virtualenv step. 11:03:27 INFO - Running pre-action listener: _resource_record_pre_action 11:03:27 INFO - Running main action method: create_virtualenv 11:03:27 INFO - Creating virtualenv /builds/slave/test/build/venv 11:03:27 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:03:27 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:03:27 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:03:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:03:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:03:28 INFO - Installing distribute.............................................................................................................................................................................................done. 11:03:28 INFO - Installing pip...............done. 11:03:28 INFO - Return code: 0 11:03:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:03:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:03:28 INFO - Reading from file tmpfile_stdout 11:03:28 INFO - Output received: 11:03:28 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:03:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:03:28 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')]} 11:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:28 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')]} 11:03:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:28 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 0x20e01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2450090>, '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 0x2450d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244af90>, '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': '32c5991c409366f7fec8a718000001d2-1504891769.645379-1045930591', '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 11:03:28 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 11:03:28 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 11:03:28 INFO - Using env: {'DISPLAY': ':0', 11:03:28 INFO - 'HOME': '/home/cltbld', 11:03:28 INFO - 'LANG': 'en_US.UTF-8', 11:03:28 INFO - 'LANGUAGE': 'en_US:en', 11:03:28 INFO - 'LOGNAME': 'cltbld', 11:03:28 INFO - 'MAIL': '/var/mail/cltbld', 11:03:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:28 INFO - 'MOZ_NO_REMOTE': '1', 11:03:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:28 INFO - 'NO_EM_RESTART': '1', 11:03:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:28 INFO - 'PWD': '/builds/slave/test', 11:03:28 INFO - 'SHELL': '/bin/bash', 11:03:28 INFO - 'SHLVL': '1', 11:03:28 INFO - 'TERM': 'linux', 11:03:28 INFO - 'TMOUT': '86400', 11:03:28 INFO - 'USER': 'cltbld', 11:03:28 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1504891769.645379-1045930591', 11:03:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:28 INFO - '_': '/tools/buildbot/bin/python'} 11:03:29 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:03:29 INFO - Downloading/unpacking pip>=1.5 11:03:29 INFO - Running setup.py egg_info for package pip 11:03:29 INFO - warning: no files found matching 'pip/cacert.pem' 11:03:29 INFO - warning: no files found matching '*.html' under directory 'docs' 11:03:29 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:03:29 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:03:29 INFO - Installing collected packages: pip 11:03:29 INFO - Found existing installation: pip 1.1 11:03:29 INFO - Uninstalling pip: 11:03:29 INFO - Successfully uninstalled pip 11:03:29 INFO - Running setup.py install for pip 11:03:29 INFO - warning: no files found matching 'pip/cacert.pem' 11:03:29 INFO - warning: no files found matching '*.html' under directory 'docs' 11:03:29 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:03:29 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:03:29 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:03:29 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:03:29 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:03:29 INFO - Successfully installed pip 11:03:29 INFO - Cleaning up... 11:03:29 INFO - Return code: 0 11:03:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:03: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')]} 11:03:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03: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')]} 11:03:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:29 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 0x20e01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2450090>, '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 0x2450d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244af90>, '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': '32c5991c409366f7fec8a718000001d2-1504891769.645379-1045930591', '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 11:03:29 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 11:03:29 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 11:03:29 INFO - Using env: {'DISPLAY': ':0', 11:03:29 INFO - 'HOME': '/home/cltbld', 11:03:29 INFO - 'LANG': 'en_US.UTF-8', 11:03:29 INFO - 'LANGUAGE': 'en_US:en', 11:03:29 INFO - 'LOGNAME': 'cltbld', 11:03:29 INFO - 'MAIL': '/var/mail/cltbld', 11:03:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:29 INFO - 'MOZ_NO_REMOTE': '1', 11:03:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:29 INFO - 'NO_EM_RESTART': '1', 11:03:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:29 INFO - 'PWD': '/builds/slave/test', 11:03:29 INFO - 'SHELL': '/bin/bash', 11:03:29 INFO - 'SHLVL': '1', 11:03:29 INFO - 'TERM': 'linux', 11:03:29 INFO - 'TMOUT': '86400', 11:03:29 INFO - 'USER': 'cltbld', 11:03:29 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1504891769.645379-1045930591', 11:03:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:29 INFO - '_': '/tools/buildbot/bin/python'} 11:03:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:29 INFO - Downloading/unpacking psutil>=3.1.1 11:03:29 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 11:03:29 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 11:03:29 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 11:03:29 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 11:03:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:03:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:03:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:03:31 INFO - Installing collected packages: psutil 11:03:31 INFO - Running setup.py install for psutil 11:03:31 INFO - building 'psutil._psutil_linux' extension 11:03:31 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 11:03:31 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 11:03:31 INFO - building 'psutil._psutil_posix' extension 11:03:31 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 11:03:31 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 11:03:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:03:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:03:31 INFO - Successfully installed psutil 11:03:31 INFO - Cleaning up... 11:03:31 INFO - Return code: 0 11:03:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:03:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:31 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 0x20e01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2450090>, '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 0x2450d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244af90>, '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': '32c5991c409366f7fec8a718000001d2-1504891769.645379-1045930591', '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 11:03:31 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 11:03:31 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 11:03:31 INFO - Using env: {'DISPLAY': ':0', 11:03:31 INFO - 'HOME': '/home/cltbld', 11:03:31 INFO - 'LANG': 'en_US.UTF-8', 11:03:31 INFO - 'LANGUAGE': 'en_US:en', 11:03:31 INFO - 'LOGNAME': 'cltbld', 11:03:31 INFO - 'MAIL': '/var/mail/cltbld', 11:03:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:31 INFO - 'MOZ_NO_REMOTE': '1', 11:03:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:31 INFO - 'NO_EM_RESTART': '1', 11:03:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:31 INFO - 'PWD': '/builds/slave/test', 11:03:31 INFO - 'SHELL': '/bin/bash', 11:03:31 INFO - 'SHLVL': '1', 11:03:31 INFO - 'TERM': 'linux', 11:03:31 INFO - 'TMOUT': '86400', 11:03:31 INFO - 'USER': 'cltbld', 11:03:31 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1504891769.645379-1045930591', 11:03:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:31 INFO - '_': '/tools/buildbot/bin/python'} 11:03:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:03:31 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 11:03:31 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 11:03:31 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 11:03:31 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 11:03:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:03:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:03:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:03:33 INFO - Installing collected packages: mozsystemmonitor 11:03:33 INFO - Running setup.py install for mozsystemmonitor 11:03:33 INFO - Successfully installed mozsystemmonitor 11:03:33 INFO - Cleaning up... 11:03:34 INFO - Return code: 0 11:03:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:03:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:34 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 0x20e01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2450090>, '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 0x2450d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244af90>, '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': '32c5991c409366f7fec8a718000001d2-1504891769.645379-1045930591', '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 11:03:34 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 11:03:34 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 11:03:34 INFO - Using env: {'DISPLAY': ':0', 11:03:34 INFO - 'HOME': '/home/cltbld', 11:03:34 INFO - 'LANG': 'en_US.UTF-8', 11:03:34 INFO - 'LANGUAGE': 'en_US:en', 11:03:34 INFO - 'LOGNAME': 'cltbld', 11:03:34 INFO - 'MAIL': '/var/mail/cltbld', 11:03:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:34 INFO - 'MOZ_NO_REMOTE': '1', 11:03:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:34 INFO - 'NO_EM_RESTART': '1', 11:03:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:34 INFO - 'PWD': '/builds/slave/test', 11:03:34 INFO - 'SHELL': '/bin/bash', 11:03:34 INFO - 'SHLVL': '1', 11:03:34 INFO - 'TERM': 'linux', 11:03:34 INFO - 'TMOUT': '86400', 11:03:34 INFO - 'USER': 'cltbld', 11:03:34 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1504891769.645379-1045930591', 11:03:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:34 INFO - '_': '/tools/buildbot/bin/python'} 11:03:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:34 INFO - Downloading/unpacking jsonschema==2.5.1 11:03:34 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 11:03:34 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 11:03:34 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 11:03:34 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 11:03:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:03:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:03:35 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 11:03:35 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 11:03:35 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 11:03:35 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 11:03:35 INFO - Downloading functools32-3.2.3-2.tar.gz 11:03:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:03:35 INFO - warning: no files found matching '*.txt' 11:03:35 INFO - no previously-included directories found matching 'build' 11:03:35 INFO - no previously-included directories found matching 'dist' 11:03:35 INFO - no previously-included directories found matching '.git*' 11:03:35 INFO - Installing collected packages: jsonschema, functools32 11:03:36 INFO - Running setup.py install for functools32 11:03:36 INFO - warning: no files found matching '*.txt' 11:03:36 INFO - no previously-included directories found matching 'build' 11:03:36 INFO - no previously-included directories found matching 'dist' 11:03:36 INFO - no previously-included directories found matching '.git*' 11:03:36 INFO - Successfully installed jsonschema functools32 11:03:36 INFO - Cleaning up... 11:03:36 INFO - Return code: 0 11:03:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:03:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:36 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 0x20e01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2450090>, '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 0x2450d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244af90>, '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': '32c5991c409366f7fec8a718000001d2-1504891769.645379-1045930591', '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 11:03:36 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 11:03:36 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 11:03:36 INFO - Using env: {'DISPLAY': ':0', 11:03:36 INFO - 'HOME': '/home/cltbld', 11:03:36 INFO - 'LANG': 'en_US.UTF-8', 11:03:36 INFO - 'LANGUAGE': 'en_US:en', 11:03:36 INFO - 'LOGNAME': 'cltbld', 11:03:36 INFO - 'MAIL': '/var/mail/cltbld', 11:03:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:36 INFO - 'MOZ_NO_REMOTE': '1', 11:03:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:36 INFO - 'NO_EM_RESTART': '1', 11:03:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:36 INFO - 'PWD': '/builds/slave/test', 11:03:36 INFO - 'SHELL': '/bin/bash', 11:03:36 INFO - 'SHLVL': '1', 11:03:36 INFO - 'TERM': 'linux', 11:03:36 INFO - 'TMOUT': '86400', 11:03:36 INFO - 'USER': 'cltbld', 11:03:36 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1504891769.645379-1045930591', 11:03:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:36 INFO - '_': '/tools/buildbot/bin/python'} 11:03:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:03:37 INFO - Cleaning up... 11:03:37 INFO - Return code: 0 11:03:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:03:37 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')]} 11:03:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:37 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')]} 11:03:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:37 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 0x20e01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2450090>, '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 0x2450d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244af90>, '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': '32c5991c409366f7fec8a718000001d2-1504891769.645379-1045930591', '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 11:03:37 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 11:03:37 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 11:03:37 INFO - Using env: {'DISPLAY': ':0', 11:03:37 INFO - 'HOME': '/home/cltbld', 11:03:37 INFO - 'LANG': 'en_US.UTF-8', 11:03:37 INFO - 'LANGUAGE': 'en_US:en', 11:03:37 INFO - 'LOGNAME': 'cltbld', 11:03:37 INFO - 'MAIL': '/var/mail/cltbld', 11:03:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:37 INFO - 'MOZ_NO_REMOTE': '1', 11:03:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:37 INFO - 'NO_EM_RESTART': '1', 11:03:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:37 INFO - 'PWD': '/builds/slave/test', 11:03:37 INFO - 'SHELL': '/bin/bash', 11:03:37 INFO - 'SHLVL': '1', 11:03:37 INFO - 'TERM': 'linux', 11:03:37 INFO - 'TMOUT': '86400', 11:03:37 INFO - 'USER': 'cltbld', 11:03:37 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1504891769.645379-1045930591', 11:03:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:37 INFO - '_': '/tools/buildbot/bin/python'} 11:03:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:37 INFO - Downloading/unpacking blobuploader==1.2.4 11:03:37 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 11:03:37 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 11:03:37 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 11:03:37 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 11:03:38 INFO - Downloading blobuploader-1.2.4.tar.gz 11:03:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:03:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:03:38 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 11:03:38 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 11:03:38 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 11:03:38 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 11:03:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:03:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:03:38 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 11:03:38 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 11:03:38 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 11:03:38 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 11:03:38 INFO - Downloading docopt-0.6.1.tar.gz 11:03:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:03:39 INFO - Installing collected packages: blobuploader, requests, docopt 11:03:39 INFO - Running setup.py install for blobuploader 11:03:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:03:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:03:39 INFO - Running setup.py install for requests 11:03:39 INFO - Running setup.py install for docopt 11:03:39 INFO - Successfully installed blobuploader requests docopt 11:03:39 INFO - Cleaning up... 11:03:39 INFO - Return code: 0 11:03:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:03:39 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')]} 11:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:39 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')]} 11:03:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:39 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 0x20e01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2450090>, '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 0x2450d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244af90>, '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': '32c5991c409366f7fec8a718000001d2-1504891769.645379-1045930591', '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 11:03:39 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 11:03:39 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 11:03:39 INFO - Using env: {'DISPLAY': ':0', 11:03:39 INFO - 'HOME': '/home/cltbld', 11:03:39 INFO - 'LANG': 'en_US.UTF-8', 11:03:39 INFO - 'LANGUAGE': 'en_US:en', 11:03:39 INFO - 'LOGNAME': 'cltbld', 11:03:39 INFO - 'MAIL': '/var/mail/cltbld', 11:03:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:39 INFO - 'MOZ_NO_REMOTE': '1', 11:03:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:39 INFO - 'NO_EM_RESTART': '1', 11:03:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:39 INFO - 'PWD': '/builds/slave/test', 11:03:39 INFO - 'SHELL': '/bin/bash', 11:03:39 INFO - 'SHLVL': '1', 11:03:39 INFO - 'TERM': 'linux', 11:03:39 INFO - 'TMOUT': '86400', 11:03:39 INFO - 'USER': 'cltbld', 11:03:39 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1504891769.645379-1045930591', 11:03:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:39 INFO - '_': '/tools/buildbot/bin/python'} 11:03:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:03:39 INFO - Running setup.py (path:/tmp/pip-daflri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:03:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:03:39 INFO - Running setup.py (path:/tmp/pip-skcU8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:03:40 INFO - Running setup.py (path:/tmp/pip-SU1TAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:03:40 INFO - Running setup.py (path:/tmp/pip-e8E60R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:03:40 INFO - Running setup.py (path:/tmp/pip-T3H2h3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:03:40 INFO - Running setup.py (path:/tmp/pip-bYS2a6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:03:40 INFO - Running setup.py (path:/tmp/pip-Ir4BDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:03:40 INFO - Running setup.py (path:/tmp/pip-9tayaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:03:40 INFO - Running setup.py (path:/tmp/pip-PrJPuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:03:40 INFO - Running setup.py (path:/tmp/pip-0DxfbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:03:40 INFO - Running setup.py (path:/tmp/pip-NeaRMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:03:40 INFO - Running setup.py (path:/tmp/pip-E0tq74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:03:40 INFO - Running setup.py (path:/tmp/pip-WgHSZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:03:40 INFO - Running setup.py (path:/tmp/pip-odZ_Zk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:40 INFO - Running setup.py (path:/tmp/pip-2LCNy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:03:40 INFO - Running setup.py (path:/tmp/pip-55TRHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:03:40 INFO - Running setup.py (path:/tmp/pip-BiS4Kk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:03:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:03:41 INFO - Running setup.py install for manifestparser 11:03:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:03:41 INFO - Running setup.py install for mozcrash 11:03:41 INFO - Running setup.py install for mozdebug 11:03:41 INFO - Running setup.py install for mozdevice 11:03:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:03:41 INFO - Running setup.py install for mozfile 11:03:41 INFO - Running setup.py install for mozhttpd 11:03:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:03:41 INFO - Running setup.py install for mozinfo 11:03:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:03:41 INFO - Running setup.py install for mozInstall 11:03:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:03:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:03:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:03:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:03:41 INFO - Running setup.py install for mozleak 11:03:41 INFO - Running setup.py install for mozlog 11:03:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:03:42 INFO - Running setup.py install for moznetwork 11:03:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:03:42 INFO - Running setup.py install for mozprocess 11:03:42 INFO - Running setup.py install for mozprofile 11:03:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:03:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:03:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:03:42 INFO - Running setup.py install for mozrunner 11:03:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:03:42 INFO - Running setup.py install for mozscreenshot 11:03:42 INFO - Running setup.py install for moztest 11:03:42 INFO - Running setup.py install for mozversion 11:03:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:03:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:03:42 INFO - Cleaning up... 11:03:42 INFO - Return code: 0 11:03:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:03:42 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')]} 11:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:42 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')]} 11:03:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:42 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 0x20e01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2450090>, '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 0x2450d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244af90>, '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': '32c5991c409366f7fec8a718000001d2-1504891769.645379-1045930591', '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 11:03:42 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 11:03:42 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 11:03:42 INFO - Using env: {'DISPLAY': ':0', 11:03:42 INFO - 'HOME': '/home/cltbld', 11:03:42 INFO - 'LANG': 'en_US.UTF-8', 11:03:42 INFO - 'LANGUAGE': 'en_US:en', 11:03:42 INFO - 'LOGNAME': 'cltbld', 11:03:42 INFO - 'MAIL': '/var/mail/cltbld', 11:03:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:42 INFO - 'MOZ_NO_REMOTE': '1', 11:03:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:42 INFO - 'NO_EM_RESTART': '1', 11:03:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:42 INFO - 'PWD': '/builds/slave/test', 11:03:42 INFO - 'SHELL': '/bin/bash', 11:03:42 INFO - 'SHLVL': '1', 11:03:42 INFO - 'TERM': 'linux', 11:03:42 INFO - 'TMOUT': '86400', 11:03:42 INFO - 'USER': 'cltbld', 11:03:42 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1504891769.645379-1045930591', 11:03:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:42 INFO - '_': '/tools/buildbot/bin/python'} 11:03:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:03:43 INFO - Running setup.py (path:/tmp/pip-tCqLw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:03:43 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)) 11:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:03:43 INFO - Running setup.py (path:/tmp/pip-iQIzKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:03:43 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)) 11:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:03:43 INFO - Running setup.py (path:/tmp/pip-vFo8s5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:03:43 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)) 11:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:03:43 INFO - Running setup.py (path:/tmp/pip-yM541l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:03:43 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)) 11:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:03:43 INFO - Running setup.py (path:/tmp/pip-HyxXOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:03:43 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)) 11:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:03:43 INFO - Running setup.py (path:/tmp/pip-x2w6id-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:03:43 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)) 11:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:03:43 INFO - Running setup.py (path:/tmp/pip-I1y0RN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:03:43 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)) 11:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:03:43 INFO - Running setup.py (path:/tmp/pip-OPMPhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:03:43 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)) 11:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:03:43 INFO - Running setup.py (path:/tmp/pip-agdsx9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:03:43 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)) 11:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:03:43 INFO - Running setup.py (path:/tmp/pip-B6kyj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:03:43 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)) 11:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:03:43 INFO - Running setup.py (path:/tmp/pip-38utrB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:03:43 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)) 11:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:03:43 INFO - Running setup.py (path:/tmp/pip-jfyh4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:03:43 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)) 11:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:03:43 INFO - Running setup.py (path:/tmp/pip-n93MYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:03:43 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)) 11:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:03:43 INFO - Running setup.py (path:/tmp/pip-PPmEP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:03:44 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)) 11:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:44 INFO - Running setup.py (path:/tmp/pip-nApnW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:44 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)) 11:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:03:44 INFO - Running setup.py (path:/tmp/pip-7IjQy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:03:44 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)) 11:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:03:44 INFO - Running setup.py (path:/tmp/pip-L63EbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:03:44 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)) 11:03:44 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)) 11:03:44 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)) 11:03:44 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)) 11:03:44 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)) 11:03:44 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)) 11:03:44 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)) 11:03:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:03:44 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 11:03:44 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 11:03:44 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 11:03:44 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 11:03:45 INFO - Downloading blessings-1.6.tar.gz 11:03:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:03:45 INFO - Installing collected packages: blessings 11:03:45 INFO - Running setup.py install for blessings 11:03:45 INFO - Successfully installed blessings 11:03:45 INFO - Cleaning up... 11:03:45 INFO - Return code: 0 11:03:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:03:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:03:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:03:45 INFO - Reading from file tmpfile_stdout 11:03:45 INFO - Current package versions: 11:03:45 INFO - argparse == 1.2.1 11:03:45 INFO - blessings == 1.6 11:03:45 INFO - blobuploader == 1.2.4 11:03:45 INFO - docopt == 0.6.1 11:03:45 INFO - functools32 == 3.2.3-2 11:03:45 INFO - jsonschema == 2.5.1 11:03:45 INFO - manifestparser == 1.1 11:03:45 INFO - mozInstall == 1.13 11:03:45 INFO - mozcrash == 1.0 11:03:45 INFO - mozdebug == 0.1 11:03:45 INFO - mozdevice == 0.51 11:03:45 INFO - mozfile == 1.2 11:03:45 INFO - mozhttpd == 0.7 11:03:45 INFO - mozinfo == 0.10 11:03:45 INFO - mozleak == 0.1 11:03:45 INFO - mozlog == 3.5 11:03:45 INFO - moznetwork == 0.27 11:03:45 INFO - mozprocess == 0.25 11:03:45 INFO - mozprofile == 0.28 11:03:45 INFO - mozrunner == 6.13 11:03:45 INFO - mozscreenshot == 0.1 11:03:45 INFO - mozsystemmonitor == 0.3 11:03:45 INFO - moztest == 0.8 11:03:45 INFO - mozversion == 1.4 11:03:45 INFO - psutil == 3.1.1 11:03:45 INFO - requests == 1.2.3 11:03:45 INFO - wsgiref == 0.1.2 11:03:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:03:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:45 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 0x20e01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2450090>, '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 0x2450d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244af90>, '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': '32c5991c409366f7fec8a718000001d2-1504891769.645379-1045930591', '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 11:03:45 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 11:03:45 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 11:03:45 INFO - Using env: {'DISPLAY': ':0', 11:03:45 INFO - 'HOME': '/home/cltbld', 11:03:45 INFO - 'LANG': 'en_US.UTF-8', 11:03:45 INFO - 'LANGUAGE': 'en_US:en', 11:03:45 INFO - 'LOGNAME': 'cltbld', 11:03:45 INFO - 'MAIL': '/var/mail/cltbld', 11:03:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:45 INFO - 'MOZ_NO_REMOTE': '1', 11:03:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:45 INFO - 'NO_EM_RESTART': '1', 11:03:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:45 INFO - 'PWD': '/builds/slave/test', 11:03:45 INFO - 'SHELL': '/bin/bash', 11:03:45 INFO - 'SHLVL': '1', 11:03:45 INFO - 'TERM': 'linux', 11:03:45 INFO - 'TMOUT': '86400', 11:03:45 INFO - 'USER': 'cltbld', 11:03:45 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1504891769.645379-1045930591', 11:03:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:45 INFO - '_': '/tools/buildbot/bin/python'} 11:03:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:46 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)) 11:03:46 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)) 11:03:46 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)) 11:03:46 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)) 11:03:46 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)) 11:03:46 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)) 11:03:46 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)) 11:03:46 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)) 11:03:46 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)) 11:03:46 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:03:46 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 11:03:46 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 11:03:46 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 11:03:46 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 11:03:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:03:47 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)) 11:03:47 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)) 11:03:47 INFO - Installing collected packages: simplejson 11:03:47 INFO - Running setup.py install for simplejson 11:03:47 INFO - building 'simplejson._speedups' extension 11:03:47 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 11:03:48 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 11:03:48 INFO - Successfully installed simplejson 11:03:48 INFO - Cleaning up... 11:03:48 INFO - Return code: 0 11:03:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:03:48 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')]} 11:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:48 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')]} 11:03:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:48 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 0x20e01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2450090>, '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 0x2450d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244af90>, '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': '32c5991c409366f7fec8a718000001d2-1504891769.645379-1045930591', '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 11:03:48 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 11:03:48 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 11:03:48 INFO - Using env: {'DISPLAY': ':0', 11:03:48 INFO - 'HOME': '/home/cltbld', 11:03:48 INFO - 'LANG': 'en_US.UTF-8', 11:03:48 INFO - 'LANGUAGE': 'en_US:en', 11:03:48 INFO - 'LOGNAME': 'cltbld', 11:03:48 INFO - 'MAIL': '/var/mail/cltbld', 11:03:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:48 INFO - 'MOZ_NO_REMOTE': '1', 11:03:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:48 INFO - 'NO_EM_RESTART': '1', 11:03:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:48 INFO - 'PWD': '/builds/slave/test', 11:03:48 INFO - 'SHELL': '/bin/bash', 11:03:48 INFO - 'SHLVL': '1', 11:03:48 INFO - 'TERM': 'linux', 11:03:48 INFO - 'TMOUT': '86400', 11:03:48 INFO - 'USER': 'cltbld', 11:03:48 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1504891769.645379-1045930591', 11:03:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:48 INFO - '_': '/tools/buildbot/bin/python'} 11:03:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:03:48 INFO - Cleaning up... 11:03:48 INFO - Return code: 0 11:03:48 INFO - Running post-action listener: _resource_record_post_action 11:03:48 INFO - Running post-action listener: _start_resource_monitoring 11:03:48 INFO - Starting resource monitoring. 11:03:48 INFO - [mozharness: 2017-09-08 18:03:48.498889Z] Finished create-virtualenv step (success) 11:03:48 INFO - [mozharness: 2017-09-08 18:03:48.499407Z] Running install step. 11:03:48 INFO - Running pre-action listener: _resource_record_pre_action 11:03:48 INFO - Running main action method: install 11:03:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:03:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:03:48 INFO - Reading from file tmpfile_stdout 11:03:48 INFO - Detecting whether we're running mozinstall >=1.0... 11:03:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:03:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:03:48 INFO - Reading from file tmpfile_stdout 11:03:48 INFO - Output received: 11:03:48 INFO - Usage: mozinstall [options] installer 11:03:48 INFO - Options: 11:03:48 INFO - -h, --help show this help message and exit 11:03:48 INFO - -d DEST, --destination=DEST 11:03:48 INFO - Directory to install application into. [default: 11:03:48 INFO - "/builds/slave/test"] 11:03:48 INFO - --app=APP Application being installed. [default: firefox] 11:03:48 INFO - mkdir: /builds/slave/test/build/application 11:03:48 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'] 11:03:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:04:05 INFO - Reading from file tmpfile_stdout 11:04:05 INFO - Output received: 11:04:05 INFO - /builds/slave/test/build/application/firefox/firefox 11:04:05 INFO - Running post-action listener: _resource_record_post_action 11:04:05 INFO - [mozharness: 2017-09-08 18:04:05.357942Z] Finished install step (success) 11:04:05 INFO - [mozharness: 2017-09-08 18:04:05.358275Z] Running setup-mitmproxy step. 11:04:05 INFO - Running pre-action listener: _resource_record_pre_action 11:04:05 INFO - Running main action method: setup_mitmproxy 11:04:05 INFO - Skipping: mitmproxy is not required 11:04:05 INFO - Running post-action listener: _resource_record_post_action 11:04:05 INFO - [mozharness: 2017-09-08 18:04:05.359408Z] Finished setup-mitmproxy step (success) 11:04:05 INFO - [mozharness: 2017-09-08 18:04:05.359630Z] Running run-tests step. 11:04:05 INFO - Running pre-action listener: _resource_record_pre_action 11:04:05 INFO - Running pre-action listener: _set_gcov_prefix 11:04:05 INFO - Running main action method: run_tests 11:04:05 WARNING - Try message not found. 11:04:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:04:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:04:05 INFO - Python 2.7.3 11:04:05 INFO - Return code: 0 11:04:05 INFO - grabbing minidump binary from tooltool 11:04:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:05 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 0x2450090>, '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 0x2450d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244af90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:04:05 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 11:04:05 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 11:04:05 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 11:04:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:04:05 INFO - Return code: 0 11:04:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:04:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:04:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:04:05 INFO - ENV: RUST_BACKTRACE is now full 11:04:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:04:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:04:05 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/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 11:04:05 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/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 11:04:05 INFO - Using env: {'DISPLAY': ':0', 11:04:05 INFO - 'HOME': '/home/cltbld', 11:04:05 INFO - 'LANG': 'en_US.UTF-8', 11:04:05 INFO - 'LANGUAGE': 'en_US:en', 11:04:05 INFO - 'LOGNAME': 'cltbld', 11:04:05 INFO - 'MAIL': '/var/mail/cltbld', 11:04:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:04:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:04:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:05 INFO - 'MOZ_NO_REMOTE': '1', 11:04:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:04:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:05 INFO - 'NO_EM_RESTART': '1', 11:04:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:05 INFO - 'PWD': '/builds/slave/test', 11:04:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:04:05 INFO - 'RUST_BACKTRACE': 'full', 11:04:05 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:04:05 INFO - 'SHELL': '/bin/bash', 11:04:05 INFO - 'SHLVL': '1', 11:04:05 INFO - 'STYLO_FORCE_ENABLED': '1', 11:04:05 INFO - 'STYLO_THREADS': '1', 11:04:05 INFO - 'TERM': 'linux', 11:04:05 INFO - 'TMOUT': '86400', 11:04:05 INFO - 'USER': 'cltbld', 11:04:05 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1504891769.645379-1045930591', 11:04:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:05 INFO - '_': '/tools/buildbot/bin/python'} 11:04:05 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/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 11:04:05 INFO - mozversion application_buildid: 20170908171740 11:04:05 INFO - mozversion application_changeset: 6d0288c291650ab619dc4ff92cb0b60e3b6e7b3b 11:04:05 INFO - mozversion application_display_name: Nightly 11:04:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:04:05 INFO - mozversion application_name: Firefox 11:04:05 INFO - mozversion application_remotingname: firefox 11:04:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:04:05 INFO - mozversion application_vendor: Mozilla 11:04:05 INFO - mozversion application_version: 57.0a1 11:04:05 INFO - mozversion platform_buildid: 20170908171740 11:04:05 INFO - mozversion platform_changeset: 6d0288c291650ab619dc4ff92cb0b60e3b6e7b3b 11:04:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:04:05 INFO - mozversion platform_version: 57.0a1 11:04:05 INFO - using testdate: 1504893845 11:04:05 INFO - actual date: 1504893845 11:04:05 INFO - starting webserver on 'localhost:36419' 11:04:05 INFO - SUITE-START | Running 2 tests 11:04:05 INFO - TEST-START | dromaeo_css 11:04:05 INFO - Initialising browser for dromaeo_css test... 11:04:05 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36419/getInfo.html -profile /tmp/tmp3Xlp_A/profile 11:04:05 INFO - TEST-INFO | started process 26788 (/builds/slave/test/build/application/firefox/firefox http://localhost:36419/getInfo.html) 11:04:10 INFO - TEST-INFO | 26788: exit 0 11:04:10 INFO - Browser initialized. 11:04:10 INFO - Running cycle 1/1 for dromaeo_css test... 11:04:10 INFO - Using env: {'DISPLAY': ':0', 11:04:10 INFO - 'HOME': '/home/cltbld', 11:04:10 INFO - 'JSGC_DISABLE_POISONING': '1', 11:04:10 INFO - 'LANG': 'en_US.UTF-8', 11:04:10 INFO - 'LANGUAGE': 'en_US:en', 11:04:10 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:04:10 INFO - 'LOGNAME': 'cltbld', 11:04:10 INFO - 'MAIL': '/var/mail/cltbld', 11:04:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:04:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:04:10 INFO - 'MOZ_CRASHREPORTER': '1', 11:04:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:10 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:04:10 INFO - 'MOZ_NO_REMOTE': '1', 11:04:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:04:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:10 INFO - 'NO_EM_RESTART': '1', 11:04:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:10 INFO - 'PWD': '/builds/slave/test', 11:04:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:04:10 INFO - 'RUST_BACKTRACE': 'full', 11:04:10 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:04:10 INFO - 'SHELL': '/bin/bash', 11:04:10 INFO - 'SHLVL': '1', 11:04:10 INFO - 'STYLO_FORCE_ENABLED': '1', 11:04:10 INFO - 'STYLO_THREADS': '1', 11:04:10 INFO - 'TERM': 'linux', 11:04:10 INFO - 'TMOUT': '86400', 11:04:10 INFO - 'USER': 'cltbld', 11:04:10 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1504891769.645379-1045930591', 11:04:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:10 INFO - '_': '/tools/buildbot/bin/python'} 11:04:10 INFO - TEST-INFO | started process 26973 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3Xlp_A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:04:11 INFO - PID 26973 | 11:04:11 INFO - PID 26973 | (/builds/slave/test/build/application/firefox/firefox:27025): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:04:11 INFO - PID 26973 | 11:04:22 INFO - PID 26973 | RSS: Main: 172736512 11:04:22 INFO - PID 26973 | 11:07:19 INFO - PID 26973 | Cycle 1(1): loaded http://localhost:36419/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36419/tests/dromaeo/cssquery-ext.html) 11:07:20 INFO - PID 26973 | RSS: Main: 174780416 11:07:20 INFO - PID 26973 | 11:10:22 INFO - PID 26973 | Cycle 1(1): loaded http://localhost:36419/tests/dromaeo/cssquery-ext.html (next: http://localhost:36419/tests/dromaeo/cssquery-jquery.html) 11:10:23 INFO - PID 26973 | RSS: Main: 170708992 11:10:23 INFO - PID 26973 | 11:13:24 INFO - PID 26973 | Cycle 1(1): loaded http://localhost:36419/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36419/tests/dromaeo/cssquery-mootools.html) 11:13:25 INFO - PID 26973 | RSS: Main: 173375488 11:13:25 INFO - PID 26973 | 11:16:27 INFO - PID 26973 | Cycle 1(1): loaded http://localhost:36419/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36419/tests/dromaeo/cssquery-prototype.html) 11:16:27 INFO - PID 26973 | RSS: Main: 171675648 11:16:27 INFO - PID 26973 | 11:19:30 INFO - PID 26973 | Cycle 1(1): loaded http://localhost:36419/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36419/tests/dromaeo/cssquery-yui.html) 11:19:31 INFO - PID 26973 | RSS: Main: 173453312 11:19:31 INFO - PID 26973 | 11:22:33 INFO - PID 26973 | Cycle 1(1): loaded http://localhost:36419/tests/dromaeo/cssquery-yui.html (next: http://localhost:36419/tests/dromaeo/cssquery-dojo.html) 11:22:33 INFO - PID 26973 | RSS: Main: 176209920 11:22:33 INFO - PID 26973 | 11:22:33 INFO - PID 26973 | __start_tp_report 11:22:33 INFO - PID 26973 | _x_x_mozilla_page_load 11:22:33 INFO - PID 26973 | _x_x_mozilla_page_load_details 11:22:33 INFO - PID 26973 | |i|pagename|runs| 11:22:33 INFO - PID 26973 | |0;dojo.html;3093.9071827845164;3096.8451577421124;3103.6275646922386;3120.0951724000042;3137.3568418474215;6168.876622467559;6209.813705588828;6210;6246.312905580388;6287.59130656507;6238.968805155968;6310;6379.936200637992;6462.256840463348;6483.578567393116;1335.2077204740056;5892.587518873681;5930.940690593104;5949.613275137102;5979.1629171915965;5779.133130030508;5835.18307436957;5904.439078287556;5912.201852749867;5928.7332070056955;5822.5145835919075;5822.854428639275;5889.882202355929;5901.793437229698;5904.350521442638;5805.216295800055;5828.125781132864;5887.116932460122;5894.557908156906;5906.173135760954;5791.305043394777;5796.565257605655;5848.064309710426;5873.1190321451695;5888.057910734305;6095.695215239265;6226.564140510166;6329.4619957303685;6411.198600174978;6416.615003099782;6630.834229144261;6639.933600664028;6765.932340676629;6770.763023294161;6827.0783444234885;6761.357671021246;6770.1537307836525;6849.383555479981;6863.485238607124;6872.553284036521;6148.723307451175;6241.78153764616;6243.719032643451;6262.96868515659;6338.809835704937;6881.690323935435;6892;6895.75864844728;6900.516963812485;6906.343897329745;6475;6559.901601475982;6569.080328753978;6570.5400621956005;6571.474282057424;6706.798796036127;6739.764108256188;6799.150106236721;6800.829979250559;6800.897986530206;6714.664266786739;6721.831954201184;6791.728330866808;6794.898076528856;6812.761553345609;6627.469802415795;6660.600363978177;6743.393094621508;6755.729770809113;6865.141857267841;5320.042392369333;5324.227986941872;5325.946740532622;5337.6797392156595;5351.384590772111;4594.816207351735;4671.579557839811;4681.906361872743;4690.202665546865;4695.22528782747;5766.913496297559;5771.307443106854;5818.6217895836635;5832.50423713989;5835.649861008353;6644.933550664528;6684.030815531721;6712.39588437043;6724.529282950147;6778.898316525256;5699.914501282484;5709.314882214161;5717.313922329264;5723.427657234327;5755.482006619424;5720;5785.797497087582;5797.9420205797405;5806.82579522615;5822.970885145547;6307.022411526221;6359.046143078575;6391.744330226832;6459.450946669585;6477.935220647827;6647.700853461509;6721.361470660279;6807.3873351398615;6810.046593476818;6811.114555107804;6456.451201647913;6516.543841931019;6519.641419721961;6532.738690452328;6558.278589355072;6519.511036672174;6648.202215734143;6675.732970681119;6692.799216023527;6731.831704207434;6721.731130754715;6776.3079013628785;6791.252962174256;6856.24581296067;6865.794026179223;6558.475321974135;6578.8355291118105;6586.37429444202;6587.044878492496;6590.011498275297;6333.303336633059;6353.555251132561;6449;6599.043138744951;6623.4038936495945;6295.370462953668;6412.166418365583;6415.518836087219;6416.32628573993;6444.420002199637;6573.80278591643;6646.03632473279;6695.363940425652;6703.966480167568;6741.089952856301;6166.414190651881;6254.967930291451;6329.430351268408;6346.333634968262;6446.0975463434215 11:22:33 INFO - PID 26973 | |1;ext.html;738.4793720427099;760.2739383888387;764.2968469008512;771.8649236383632;773.4701729315416;37498.62501374986;40944.181116377695;41057.17885642289;41232.58767412325;41278.38082428758;38142.61857381425;38156;38200.80899595505;38221.235575288476;38293.42559861604;6929.688164032618;7022.403095736869;7022.964885175567;7042.084529011221;7047.295270472963;6946.47901407394;7023.086998690163;7027.613481258529;7035.613041282727;7045.964770176168;7000.859982800341;7028.332308430691;7030.683619237147;7035.12060992376;7700.576468294242;7754.806129846743;7827.373810095179;7834.020747406575;7838.255365740302;7841.137474877759;7625.61871906408;7680.80797980055;7772.883406748903;7782.922170778276;7803.843923121506;37644;37984.43023354652;38013;38013.23973520514;38161.23677526434;3540.964590354089;3593.5508061492314;3595.280943811222;3595.8741444049333;3598.712103031777;31387.215319616964;31451.84274078615;31518.842405788055;31574;31587;5124.0776660201145;5161.045206636784;5181.5077567631015;5195.532402083831;5204.869878253036;188084.0595797026;188241;188640;189660;189708;42044.579554204676;42923;47477.525224748;47578.76210618925;47863.76068119637;50628.240576391385;50777;50860;50894.491055088976;50931.23603145956;15266;15409.84590154084;15411.614709632124;15414.229288535753;15416.152111633968;12508.3745812709;12519.43662535188;12530.373481325898;12532.686682833002;12534.310612916195;14072.648183795282;14076.648083797987;14106.083104598374;14139.293035348397;14182.361793719101;5904.321003084614;5905.153897641304;5956.468500887192;5969.194158788595;6028.246469191351;990.6829814459304;1001.4291853643499;1008.3344992305043;1010.1262408017159;1014.9644762433279;21842.344729658136;21934;21994.780052199272;22061.227857024925;22393;1099.351382684204;1100.4277775556666;1103.4703342395535;1116.0736588631416;1118.4407796101948;11490.310581365145;11565.190436669352;11659.591914282959;11863.16957812962;11880.585397009228;229116;230678;230727;230732;231022;51591.48408515867;51859.48140518622;51936.74031629818;51972;52273.73863130736;1439;1460.5175746617404;1482.1847983608973;1486.724955883165;1489.6648254142947;22092.779072209072;22238.55522889501;22338.664920025887;22439.21462748796;22473.88763056174;36767.44848827216;37018.814905926374;37032.629673703996;37034;37062.44406333853;180819;187645;188253;189413;189580;29714.702852971193;30200.84899575576;30288;32668.34663306673;32851.67148328486;42082.7895860531;42256.788716056224;42320.57679423167;42386.5761342395;42714.35928461013;30907.2273193163;30928.53607195939;30975.535366969965;31134.377312453173;31153.221169470944;30826.229344266572;30849.691503084683;31069.689303107585;31104.533431998992;31545.526817097303;34474.13814654654;34593.65406345904;34718.132046698025;34898.47652285167;34910.301793964485;30316.696833031387;30421.847890760404;30797;31273.37453250968;31419;22036;22233.333000010025;22596.435089122246;22780.772192278528;22849.65725514152 11:22:33 INFO - PID 26973 | |2;jquery.html;574.6925394913721;575.9712014399281;579.3366595248441;587.8941790477718;591.8461200087977;22040.88979555102;22600.773992260074;22744.20395286165;22755.317340479793;22918.65622015667;23104;23804.880975595097;23962.161324353652;24076.759232407672;24091.518169636598;6343.365663433643;6480.416762491375;6519.608823470607;6530.510211734115;6531.640759758211;6409.775657851976;6524.151860258184;6524.836879078037;6525.151730275057;6528.934710652904;6234.438900498954;6477.449416799578;6507.349265073479;6507.479401647857;6528.216614006302;6445.1943507061615;6461.93538064618;6475.093486911836;6480.351964803529;6485.027245913104;5810.854728631776;6000.279966404016;6005.54958378119;6011.759529618854;6020.397960203988;27114.322141946413;27517.724822751716;27564;27571.03501377442;27599.862000690067;1991.4722598511405;2017.6771716525286;2020.3534868841975;2020.8787472751683;2021.8786872787532;18675.252989880388;19154;19352.41942741706;19382.449404047642;19715.80284197154;2411.4212588978694;2444.7188573313942;2457.6313552967017;2459.311392810016;2464.6303054541963;117059;122073;131523.34238328843;136833;137578.31210844082;14678.935747185014;14696.846322541265;14795.926020370045;14876.62664784613;14976.850231497763;22604.886975565016;22617.660735088986;22649.320520384415;22653.886730566242;22717.545649087257;10229.846552301722;10275.434851083262;10279.94860025695;10280.383177009404;10330.328528645614;9475.620975160917;9551.188149007274;9563.474008929576;9596.616135354509;9645;8947.821043579092;9092.727218183465;9120.771980700536;9229.584668689926;9247.167754902091;2639.2741995950882;2688.435428559985;2700.986495067512;2702.891884324605;2816.5915942188267;951.9428834269966;955.7813787421094;956.2397893674546;980.9950950245346;982.6658935961807;18511.81488185128;18630.53423664419;18808.198317397655;18828.811711882707;18862.62274754497;1015.7968406318765;1025.7743296474764;1030.3354336452946;1037.984430233547;1043.268174829779;10417.47912604382;10445.738856528647;10493.895061049292;10578.259521833397;10648.254622176373;450736;454754;456884;462396;471286;109391;109656;111314.44342778235;111704.44147779372;111983;1032.396048311746;1075.499892549968;1122.3490375582144;1157.6989982604416;1172.695099274178;19510.414687559394;19525.12136953869;19621.215151393786;19690.50773730668;19963.401097967086;55373.44626553844;55482;56381;56438.1534276978;58128.4187158123;71001.28998709947;71791.64104179446;71835.64082179556;71876.64061679867;72058.27941720726;13811.792823107862;13972.441102355791;14051.648708781953;14079.788803168165;14106.224157671426;21570.6764398531;21698.457538561663;21831.235906743186;21856;22043.66934495952;17198.624110070916;17316.220770065127;17431;17472.563185920455;17521.299148034446;14239.786403203752;14519.49181778675;14842;15338.76991845101;16227.675446490768;17469.38857139994;17536.210870510604;17573.560660983578;17665.911670441565;17706.645867082843;12847.35763211817;13404.731905361643;13465.057445978688;13507.122037067558;13508.594742157751;16980.83019169842;17009.234584443977;17068.65862682764;17380.913095434444;17397.47807565775 11:22:33 INFO - PID 26973 | |3;mootools.html;1309.103264263979;1353.7427888701145;1361.6323592629983;1363.9974618655292;1372.5401990333237;14673.779893301597;15096.924515377435;15230.695386092271;15265.771013434807;15293.311800968955;14898.851011489882;14983.026103303278;14983.775243371358;15007.399704011854;15032.248387580605;2733.6172935788904;2776.875040623177;2780.8470534120615;2786.45664095502;2819.8590070496393;2725.523033469145;2744.300203448118;2745.807793454459;2749.8625068746483;2763.571646394812;2223.9666405003936;2352.200251914349;2720.469508445854;2804.8317100973904;2805.3547684032683;2753.876075576604;2783.262435454606;2796.9021084262054;2800.2859270885792;2801.607774911504;2732.3715545424466;2739.397332586828;2745.958810617842;2750.5324094903913;2755.1596762987283;15051.021683590532;15205.31576079079;15218.391264349413;15220.391184352613;15231.314590843438;7931;8197.262246397793;8206.753797386029;8211.466254693425;8212.096669366365;5238.083335416287;5315.973420132875;5441.401445840955;5692.743826527816;5716.742746576414;1942.0678074524167;1950.9512262193416;1961.0782932021928;1983.9702404463944;1997.4407165993546;24546.509069818505;24700.876495617587;24704.629430558554;24758.752412475824;24803.751962480324;7133.357997780225;7266.45501587383;7330;7459.70161193557;7473.327400533978;16472.752908706378;17144.571385715455;17181.828181718272;19590.608187836162;19660.606787864162;7919.802004949807;8139.064007639197;8140.837183256302;8144.877826832602;8148.062972758209;7311.341979221789;7407.037085178892;7440.181580026193;7519.924800752032;7591.8861217081785;5267.394249661338;5336.653117547347;5356.384015838228;5413.702246376487;5456.48163424474;1463.9560813175622;1475.7343678138038;1487.2340744516582;1506.2920427399106;1530.257824954896;878.310526236901;903.1916434790957;903.4850135422746;914.6021480655936;916.7249825052457;7547.660355284025;7548.7357942472845;7571;7616.695332186761;7616.8476630467085;701.6702149989496;712.2485777504679;717.5909731453022;718.5652680128447;722.5628494760699;4479.61923236522;4535.773211339486;4674.158651442705;5140;5335.253064570963;21107.78892211089;21324.527097134807;21858.344249672537;22062.779372206394;22169.44576385571;21093.894530527556;21516.139354425646;21558.892205538872;21586.676199857015;21653.67519487209;10943;11458.54165833374;11512.94243528777;11518.136139789549;11521.135914806424;7944.880826787487;7946.847707082557;8008.359331253369;8018.518888866687;8023.157568455228;17971.460856174337;18547.35084272044;18581.070946452895;18718.906405467886;19004.42986710401;18838.52903677419;18867.622647546697;18925.337613183474;19006.23975040983;19068.618627627093;10901.781964360827;10919.836202457129;10996.560137594726;11023.283486573348;11026.669199924016;13541.187528747912;13809.585712428643;13811.654708632364;13813.51652692151;13816.93091534536;10877.945610271898;10947.178961578073;10957.561697532328;11083.445827708743;11269.591301087365;10741.24811263204;11031.779364412827;11083.445827708421;11233.775324493301;11312.321260724382;9960.203183745429;10224.488775561342;10229.488525573543;10230.539625716712;10239.078482936571;7089.326513981164;7101.431885449048;7105.431565474853;7105.680244388912;7172.748953786592;7169.139703235645;7267.672954717156;7279.599622020628;7294.817629559304;7309.744158954411 11:22:33 INFO - PID 26973 | |4;prototype.html;501.00884075911597;520.8411434512474;527.3855957809153;532.9481496239481;535.6063293479293;6377.170967774183;6392.1690180276555;6398.5201109916825;6412.551121421502;6437.485001199904;6224.782132625359;6230.5638605297645;6243.313235544098;6248.250209974809;6263.812085637438;5179.507946745062;5190.896182076356;5214.817481388152;5241.764120614582;5248.291480650101;4870.9269360959615;5017.849464516052;5184.144616138333;5219.817306394277;5226.843194704165;4989.3513843200335;4990.725510096943;5011.098002359574;5015.172496538067;5032.968241510482;4962.776675049631;4984.800607975677;4998;5002.52476014778;5004.649674522767;4384.714993525411;4486.753228572427;4488.822920883369;4500.662450316239;4508.278675411918;6104.382338680209;6124.877502449971;6128.9693551531955;6139.754409823602;6171.444569988677;5718.971405142947;5719.113537401709;5747.568547722404;5762.74067666956;5779;6572.835679108012;6574.572652777602;6576.835579110512;6604.867902641969;6612.603243805387;4647.372604698357;4807.399075115611;4824.7828847701585;4860.902781944376;4874.098291816025;6762.72949082041;6800;6899.62052087135;6946.583205007665;6947.7220911163495;4981.800727970841;5008.774605142778;5009.423916249605;5027.974860125676;5041.747912604355;5053.696778193246;5066.36670416198;5090.898182036339;5101.566366858784;5109.718965456861;5660.575456840754;5673.1490276458035;5698.230738850285;5716.828495145152;5755.136729490526;6593.967030164818;6644.501662375341;6672.633005184664;6676.566023208476;6678.83302917431;1759.5952930825981;1769.4691592522192;1769.7345398190375;1771.929122835098;1778.7370966613591;1170.3153655111855;1214.423149004216;1227.2636418149218;1230.9138360314691;1242.7700875338091;5692.715364231772;5707.828765137053;5734.942650573525;5735.598508104393;5744.339400968942;6608.332375531626;6628.370304821035;6652;6697;6763.458923286125;5576.302962129734;5676.318841739017;5700.258966334433;5757.539396848242;5758.3665796762325;3565.7682250653625;3577.195131095483;3582.570091588974;3582.8208589570418;3603.6936860367164;6337.207849018872;6396.5522413431545;6422.710978006001;6488.578242414323;6503.902441463382;6625.238097618835;6858.931410685929;6888.793336199922;6900.654967251618;6920.792376228721;6445.548811583238;6463.64449955257;6474.6762661866715;6482.060101285288;6487.578307410004;6709.295523969913;6724.327567243236;6743.123393958754;6756.716253883738;6823.28355522663;6720.991851222356;6735.225449073419;6736.720023195578;6737.258901520927;6740.831479212863;6485.643289619116;6496.707648155939;6498.935010650022;6505.316941721051;6509.967450162719;4972.403311602631;4990.700557966534;4992.700437973734;5005.899882002413;5023.09584274834;6542.34576542342;6632.734690612321;6734.9326506734305;6740.494462915203;6786.3892249697765;6506.869862602816;6530.608163510205;6533.41199292066;6534.738610455529;6551.672416379257;6484.919663159962;6551.672416379067;6578.901316480161;6590.373914478117;6599.241087275025;6409.487241020801;6426.293107758236;6433.099366088658;6483.2544257411;6488;6591.802245932629;6620.8344791380605;6636.900446493403;6639.3692599203;6647.518669297589;6304.338044505261;6311.747530098744;6316.336784637547;6319.178506794087;6332.113504109337 11:22:33 INFO - PID 26973 | |5;yui.html;886.8935727712676;916.5921165081537;922.7001224602006;924.8705181274622;957.6313119449012;19720.99999999998;20664.690029649566;20794.480137996557;20802.89598552007;20816.375508734764;18213.453596392097;18284;18357.449276521726;19032.33386831461;19269.518262043457;961.1301771896445;984.0307297312178;987.1115995603942;987.1411871671655;987.4914419074182;971.2036130373097;997.0278977996431;1000.7798284377425;1001.2940876681959;1018.7504061504904;1050.5850189175271;1052.6052730226165;1052.6526246338728;1053.7839742852698;1055.372053628094;981.9705408837747;1016.1972042086743;1021.9693409197736;1029.44924465411;1042.1766804224692;743.9070116235471;748.5994992678945;748.9400847932152;748.9850202995909;749.1459735901077;18879.528011799677;18991.525211869677;19018.61962760751;19065;19075.332363367215;20501.58996820055;22070.558588828295;22225.222117225818;22226.222082227207;22231.555368892532;16933.830661693348;17230.569235769082;17263.65472690539;17293.481195564153;17535;3563.2695297463956;3593.317269718771;3594.730395220369;3594.7663401879054;3596.226811235571;140282.99999999898;141780;142086;142128.2893585536;143858;16315.347386104422;16457.42399016029;16724;16777.91611041937;16829.495115146565;28093.297667558065;29155.708442915722;29366.265843354086;29444.11667649974;29652.40695186084;8253.587320633944;8400.789980250544;8421.242088211968;8435.283000944866;8458.40791144614;4132.793360331972;4236.703430759817;4253.76604286761;4282.63597594208;4289.24938135825;5440.945590544123;5488.25908502355;5527.226188333637;5548.639338442988;5568.7215639217875;989.9803202701229;1002.904724051214;1016.466355163545;1029.2846471702244;1036.233187441303;690.623610132479;699.6257002503636;714.1501613080418;716.2443621978758;717.8097804081923;11599.420028998516;11802.46888890002;11854.407279635983;11980.820287695691;12114.454849531792;675.4731309578439;677.6747161362475;679.5243329669252;691.0118530501431;695.2352412346379;5612.160846666517;5632.183333416713;5634.549236061105;5681.744321505542;5785.768569257267;125066.3746681279;126050.69746512637;127265;129041.3547932273;131924.3403782975;105647.47176264224;106228.46885765521;106949;107949;108980;93593;94781;95076;97596;97729.5340569892;10473.895261047292;10517.631882884063;10720.785584288114;10911.290766100177;10939.617113400993;45362.54637453715;45522.772386137854;46090.07819843652;46461.76769116133;46663;57670.42329576818;58474;59183.408165919514;59676.701616493374;61412.385876142456;15673.608159796097;16040.759388608947;16096.114713690391;16183.75724364159;16207.108609026145;15841;16068.357265709708;16136.354545818036;16350.672986539965;16352.264148113125;15466.14936178521;15471.613209669847;15477.84522154764;15550.688986219986;15593.76609350838;15920.363185472916;16115.516534503984;16130.67738645244;16206.756898646765;16333;15872.682546349239;16316.42892498757;16339;16367;16528.421505247257;10904.672859814218;10960.725981850517;11008.834867476835;11048.447577621248;11071.003609675168;9575.569099390683;9659.227261819178;9660.613575457184;9697.6120955161;9767.706968790948 11:22:33 INFO - PID 26973 | __end_tp_report 11:22:33 INFO - PID 26973 | __start_cc_report 11:22:33 INFO - PID 26973 | _x_x_mozilla_cycle_collect,358 11:22:33 INFO - PID 26973 | __end_cc_report 11:22:33 INFO - PID 26973 | __startTimestamp1504894953403__endTimestamp 11:22:33 INFO - PID 26973 | 11:22:33 INFO - PID 26973 | ------- Summary: start ------- 11:22:33 INFO - PID 26973 | Number of tests: 6 11:22:33 INFO - PID 26973 | 11:22:33 INFO - PID 26973 | [#0] dojo.html Cycles:165 Average:6168.39 Median:6412.17 stddev:829.08 (12.9%) stddev-sans-first:795.77 11:22:33 INFO - PID 26973 | Values: 3093.9 3096.8 3103.6 3120.1 3137.4 6168.9 6209.8 6210.0 6246.3 6287.6 6239.0 6310.0 6379.9 6462.3 6483.6 1335.2 5892.6 5930.9 5949.6 5979.2 5779.1 5835.2 5904.4 5912.2 5928.7 5822.5 5822.9 5889.9 5901.8 5904.4 5805.2 5828.1 5887.1 5894.6 5906.2 5791.3 5796.6 5848.1 5873.1 5888.1 6095.7 6226.6 6329.5 6411.2 6416.6 6630.8 6639.9 6765.9 6770.8 6827.1 6761.4 6770.2 6849.4 6863.5 6872.6 6148.7 6241.8 6243.7 6263.0 6338.8 6881.7 6892.0 6895.8 6900.5 6906.3 6475.0 6559.9 6569.1 6570.5 6571.5 6706.8 6739.8 6799.2 6800.8 6800.9 6714.7 6721.8 6791.7 6794.9 6812.8 6627.5 6660.6 6743.4 6755.7 6865.1 5320.0 5324.2 5325.9 5337.7 5351.4 4594.8 4671.6 4681.9 4690.2 4695.2 5766.9 5771.3 5818.6 5832.5 5835.6 6644.9 6684.0 6712.4 6724.5 6778.9 5699.9 5709.3 5717.3 5723.4 5755.5 5720.0 5785.8 5797.9 5806.8 5823.0 6307.0 6359.0 6391.7 6459.5 6477.9 6647.7 6721.4 6807.4 6810.0 6811.1 6456.5 6516.5 6519.6 6532.7 6558.3 6519.5 6648.2 6675.7 6692.8 6731.8 6721.7 6776.3 6791.3 6856.2 6865.8 6558.5 6578.8 6586.4 6587.0 6590.0 6333.3 6353.6 6449.0 6599.0 6623.4 6295.4 6412.2 6415.5 6416.3 6444.4 6573.8 6646.0 6695.4 6704.0 6741.1 6166.4 6255.0 6329.4 6346.3 6446.1 11:22:33 INFO - PID 26973 | 11:22:33 INFO - PID 26973 | [#1] ext.html Cycles:180 Average:36593.75 Median:34655.89 stddev:52662.50 (152.0%) stddev-sans-first:52741.41 11:22:33 INFO - PID 26973 | Values: 738.5 760.3 764.3 771.9 773.5 37498.6 40944.2 41057.2 41232.6 41278.4 38142.6 38156.0 38200.8 38221.2 38293.4 6929.7 7022.4 7023.0 7042.1 7047.3 6946.5 7023.1 7027.6 7035.6 7046.0 7000.9 7028.3 7030.7 7035.1 7700.6 7754.8 7827.4 7834.0 7838.3 7841.1 7625.6 7680.8 7772.9 7782.9 7803.8 37644.0 37984.4 38013.0 38013.2 38161.2 3541.0 3593.6 3595.3 3595.9 3598.7 31387.2 31451.8 31518.8 31574.0 31587.0 5124.1 5161.0 5181.5 5195.5 5204.9 188084.1 188241.0 188640.0 189660.0 189708.0 42044.6 42923.0 47477.5 47578.8 47863.8 50628.2 50777.0 50860.0 50894.5 50931.2 15266.0 15409.8 15411.6 15414.2 15416.2 12508.4 12519.4 12530.4 12532.7 12534.3 14072.6 14076.6 14106.1 14139.3 14182.4 5904.3 5905.2 5956.5 5969.2 6028.2 990.7 1001.4 1008.3 1010.1 1015.0 21842.3 21934.0 21994.8 22061.2 22393.0 1099.4 1100.4 1103.5 1116.1 1118.4 11490.3 11565.2 11659.6 11863.2 11880.6 229116.0 230678.0 230727.0 230732.0 231022.0 51591.5 51859.5 51936.7 51972.0 52273.7 1439.0 1460.5 1482.2 1486.7 1489.7 22092.8 22238.6 22338.7 22439.2 22473.9 36767.4 37018.8 37032.6 37034.0 37062.4 180819.0 187645.0 188253.0 189413.0 189580.0 29714.7 30200.8 30288.0 32668.3 32851.7 42082.8 42256.8 42320.6 42386.6 42714.4 30907.2 30928.5 30975.5 31134.4 31153.2 30826.2 30849.7 31069.7 31104.5 31545.5 34474.1 34593.7 34718.1 34898.5 34910.3 30316.7 30421.8 30797.0 31273.4 31419.0 22036.0 22233.3 22596.4 22780.8 22849.7 11:22:33 INFO - PID 26973 | 11:22:33 INFO - PID 26973 | [#2] jquery.html Cycles:180 Average:33184.92 Median:22322.22 stddev:77471.17 (347.1%) stddev-sans-first:77649.81 11:22:33 INFO - PID 26973 | Values: 574.7 576.0 579.3 587.9 591.8 22040.9 22600.8 22744.2 22755.3 22918.7 23104.0 23804.9 23962.2 24076.8 24091.5 6343.4 6480.4 6519.6 6530.5 6531.6 6409.8 6524.2 6524.8 6525.2 6528.9 6234.4 6477.4 6507.3 6507.5 6528.2 6445.2 6461.9 6475.1 6480.4 6485.0 5810.9 6000.3 6005.5 6011.8 6020.4 27114.3 27517.7 27564.0 27571.0 27599.9 1991.5 2017.7 2020.4 2020.9 2021.9 18675.3 19154.0 19352.4 19382.4 19715.8 2411.4 2444.7 2457.6 2459.3 2464.6 117059.0 122073.0 131523.3 136833.0 137578.3 14678.9 14696.8 14795.9 14876.6 14976.9 22604.9 22617.7 22649.3 22653.9 22717.5 10229.8 10275.4 10279.9 10280.4 10330.3 9475.6 9551.2 9563.5 9596.6 9645.0 8947.8 9092.7 9120.8 9229.6 9247.2 2639.3 2688.4 2701.0 2702.9 2816.6 951.9 955.8 956.2 981.0 982.7 18511.8 18630.5 18808.2 18828.8 18862.6 1015.8 1025.8 1030.3 1038.0 1043.3 10417.5 10445.7 10493.9 10578.3 10648.3 450736.0 454754.0 456884.0 462396.0 471286.0 109391.0 109656.0 111314.4 111704.4 111983.0 1032.4 1075.5 1122.3 1157.7 1172.7 19510.4 19525.1 19621.2 19690.5 19963.4 55373.4 55482.0 56381.0 56438.2 58128.4 71001.3 71791.6 71835.6 71876.6 72058.3 13811.8 13972.4 14051.6 14079.8 14106.2 21570.7 21698.5 21831.2 21856.0 22043.7 17198.6 17316.2 17431.0 17472.6 17521.3 14239.8 14519.5 14842.0 15338.8 16227.7 17469.4 17536.2 17573.6 17665.9 17706.6 12847.4 13404.7 13465.1 13507.1 13508.6 16980.8 17009.2 17068.7 17380.9 17397.5 11:22:33 INFO - PID 26973 | 11:22:33 INFO - PID 26973 | [#3] mootools.html Cycles:180 Average:9272.89 Median:13762.11 stddev:6565.50 (47.7%) stddev-sans-first:6556.65 11:22:33 INFO - PID 26973 | Values: 1309.1 1353.7 1361.6 1364.0 1372.5 14673.8 15096.9 15230.7 15265.8 15293.3 14898.9 14983.0 14983.8 15007.4 15032.2 2733.6 2776.9 2780.8 2786.5 2819.9 2725.5 2744.3 2745.8 2749.9 2763.6 2224.0 2352.2 2720.5 2804.8 2805.4 2753.9 2783.3 2796.9 2800.3 2801.6 2732.4 2739.4 2746.0 2750.5 2755.2 15051.0 15205.3 15218.4 15220.4 15231.3 7931.0 8197.3 8206.8 8211.5 8212.1 5238.1 5316.0 5441.4 5692.7 5716.7 1942.1 1951.0 1961.1 1984.0 1997.4 24546.5 24700.9 24704.6 24758.8 24803.8 7133.4 7266.5 7330.0 7459.7 7473.3 16472.8 17144.6 17181.8 19590.6 19660.6 7919.8 8139.1 8140.8 8144.9 8148.1 7311.3 7407.0 7440.2 7519.9 7591.9 5267.4 5336.7 5356.4 5413.7 5456.5 1464.0 1475.7 1487.2 1506.3 1530.3 878.3 903.2 903.5 914.6 916.7 7547.7 7548.7 7571.0 7616.7 7616.8 701.7 712.2 717.6 718.6 722.6 4479.6 4535.8 4674.2 5140.0 5335.3 21107.8 21324.5 21858.3 22062.8 22169.4 21093.9 21516.1 21558.9 21586.7 21653.7 10943.0 11458.5 11512.9 11518.1 11521.1 7944.9 7946.8 8008.4 8018.5 8023.2 17971.5 18547.4 18581.1 18718.9 19004.4 18838.5 18867.6 18925.3 19006.2 19068.6 10901.8 10919.8 10996.6 11023.3 11026.7 13541.2 13809.6 13811.7 13813.5 13816.9 10877.9 10947.2 10957.6 11083.4 11269.6 10741.2 11031.8 11083.4 11233.8 11312.3 9960.2 10224.5 10229.5 10230.5 10239.1 7089.3 7101.4 7105.4 7105.7 7172.7 7169.1 7267.7 7279.6 7294.8 7309.7 11:22:33 INFO - PID 26973 | 11:22:33 INFO - PID 26973 | [#4] prototype.html Cycles:180 Average:5530.67 Median:6227.67 stddev:1545.65 (24.8%) stddev-sans-first:1503.18 11:22:33 INFO - PID 26973 | Values: 501.0 520.8 527.4 532.9 535.6 6377.2 6392.2 6398.5 6412.6 6437.5 6224.8 6230.6 6243.3 6248.3 6263.8 5179.5 5190.9 5214.8 5241.8 5248.3 4870.9 5017.8 5184.1 5219.8 5226.8 4989.4 4990.7 5011.1 5015.2 5033.0 4962.8 4984.8 4998.0 5002.5 5004.6 4384.7 4486.8 4488.8 4500.7 4508.3 6104.4 6124.9 6129.0 6139.8 6171.4 5719.0 5719.1 5747.6 5762.7 5779.0 6572.8 6574.6 6576.8 6604.9 6612.6 4647.4 4807.4 4824.8 4860.9 4874.1 6762.7 6800.0 6899.6 6946.6 6947.7 4981.8 5008.8 5009.4 5028.0 5041.7 5053.7 5066.4 5090.9 5101.6 5109.7 5660.6 5673.1 5698.2 5716.8 5755.1 6594.0 6644.5 6672.6 6676.6 6678.8 1759.6 1769.5 1769.7 1771.9 1778.7 1170.3 1214.4 1227.3 1230.9 1242.8 5692.7 5707.8 5734.9 5735.6 5744.3 6608.3 6628.4 6652.0 6697.0 6763.5 5576.3 5676.3 5700.3 5757.5 5758.4 3565.8 3577.2 3582.6 3582.8 3603.7 6337.2 6396.6 6422.7 6488.6 6503.9 6625.2 6858.9 6888.8 6900.7 6920.8 6445.5 6463.6 6474.7 6482.1 6487.6 6709.3 6724.3 6743.1 6756.7 6823.3 6721.0 6735.2 6736.7 6737.3 6740.8 6485.6 6496.7 6498.9 6505.3 6510.0 4972.4 4990.7 4992.7 5005.9 5023.1 6542.3 6632.7 6734.9 6740.5 6786.4 6506.9 6530.6 6533.4 6534.7 6551.7 6484.9 6551.7 6578.9 6590.4 6599.2 6409.5 6426.3 6433.1 6483.3 6488.0 6591.8 6620.8 6636.9 6639.4 6647.5 6304.3 6311.7 6316.3 6319.2 6332.1 11:22:33 INFO - PID 26973 | 11:22:33 INFO - PID 26973 | [#5] yui.html Cycles:180 Average:24446.74 Median:19495.26 stddev:35947.70 (184.4%) stddev-sans-first:36005.02 11:22:33 INFO - PID 26973 | Values: 886.9 916.6 922.7 924.9 957.6 19721.0 20664.7 20794.5 20802.9 20816.4 18213.5 18284.0 18357.4 19032.3 19269.5 961.1 984.0 987.1 987.1 987.5 971.2 997.0 1000.8 1001.3 1018.8 1050.6 1052.6 1052.7 1053.8 1055.4 982.0 1016.2 1022.0 1029.4 1042.2 743.9 748.6 748.9 749.0 749.1 18879.5 18991.5 19018.6 19065.0 19075.3 20501.6 22070.6 22225.2 22226.2 22231.6 16933.8 17230.6 17263.7 17293.5 17535.0 3563.3 3593.3 3594.7 3594.8 3596.2 140283.0 141780.0 142086.0 142128.3 143858.0 16315.3 16457.4 16724.0 16777.9 16829.5 28093.3 29155.7 29366.3 29444.1 29652.4 8253.6 8400.8 8421.2 8435.3 8458.4 4132.8 4236.7 4253.8 4282.6 4289.2 5440.9 5488.3 5527.2 5548.6 5568.7 990.0 1002.9 1016.5 1029.3 1036.2 690.6 699.6 714.2 716.2 717.8 11599.4 11802.5 11854.4 11980.8 12114.5 675.5 677.7 679.5 691.0 695.2 5612.2 5632.2 5634.5 5681.7 5785.8 125066.4 126050.7 127265.0 129041.4 131924.3 105647.5 106228.5 106949.0 107949.0 108980.0 93593.0 94781.0 95076.0 97596.0 97729.5 10473.9 10517.6 10720.8 10911.3 10939.6 45362.5 45522.8 46090.1 46461.8 46663.0 57670.4 58474.0 59183.4 59676.7 61412.4 15673.6 16040.8 16096.1 16183.8 16207.1 15841.0 16068.4 16136.4 16350.7 16352.3 15466.1 15471.6 15477.8 15550.7 15593.8 15920.4 16115.5 16130.7 16206.8 16333.0 15872.7 16316.4 16339.0 16367.0 16528.4 10904.7 10960.7 11008.8 11048.4 11071.0 9575.6 9659.2 9660.6 9697.6 9767.7 11:22:33 INFO - PID 26973 | -------- Summary: end -------- 11:22:33 INFO - PID 26973 | 11:22:34 INFO - TEST-INFO | 26973: exit 0 11:22:34 INFO - TEST-OK | dromaeo_css | took 1108483ms 11:22:34 INFO - TEST-START | kraken 11:22:34 INFO - Initialising browser for kraken test... 11:22:34 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36419/getInfo.html -profile /tmp/tmpvG_m34/profile 11:22:34 INFO - TEST-INFO | started process 27345 (/builds/slave/test/build/application/firefox/firefox http://localhost:36419/getInfo.html) 11:22:39 INFO - TEST-INFO | 27345: exit 0 11:22:39 INFO - Browser initialized. 11:22:39 INFO - Running cycle 1/1 for kraken test... 11:22:39 INFO - Using env: {'DISPLAY': ':0', 11:22:39 INFO - 'HOME': '/home/cltbld', 11:22:39 INFO - 'JSGC_DISABLE_POISONING': '1', 11:22:39 INFO - 'LANG': 'en_US.UTF-8', 11:22:39 INFO - 'LANGUAGE': 'en_US:en', 11:22:39 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:22:39 INFO - 'LOGNAME': 'cltbld', 11:22:39 INFO - 'MAIL': '/var/mail/cltbld', 11:22:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:22:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:22:39 INFO - 'MOZ_CRASHREPORTER': '1', 11:22:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:39 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:22:39 INFO - 'MOZ_NO_REMOTE': '1', 11:22:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:22:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:39 INFO - 'NO_EM_RESTART': '1', 11:22:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:39 INFO - 'PWD': '/builds/slave/test', 11:22:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:22:39 INFO - 'RUST_BACKTRACE': 'full', 11:22:39 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:22:39 INFO - 'SHELL': '/bin/bash', 11:22:39 INFO - 'SHLVL': '1', 11:22:39 INFO - 'STYLO_FORCE_ENABLED': '1', 11:22:39 INFO - 'STYLO_THREADS': '1', 11:22:39 INFO - 'TERM': 'linux', 11:22:39 INFO - 'TMOUT': '86400', 11:22:39 INFO - 'USER': 'cltbld', 11:22:39 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1504891769.645379-1045930591', 11:22:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:39 INFO - '_': '/tools/buildbot/bin/python'} 11:22:39 INFO - TEST-INFO | started process 27530 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvG_m34/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:22:40 INFO - PID 27530 | 11:22:40 INFO - PID 27530 | (/builds/slave/test/build/application/firefox/firefox:27581): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:22:40 INFO - PID 27530 | 11:22:50 INFO - PID 27530 | RSS: Main: 172617728 11:22:50 INFO - PID 27530 | 11:22:53 INFO - PID 27530 | Cycle 1(1): loaded http://localhost:36419/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36419/tests/kraken/driver.html?testName=audio-beat-detection) 11:22:54 INFO - PID 27530 | RSS: Main: 178585600 11:22:54 INFO - PID 27530 | 11:22:56 INFO - PID 27530 | Cycle 1(1): loaded http://localhost:36419/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36419/tests/kraken/driver.html?testName=audio-dft) 11:22:57 INFO - PID 27530 | RSS: Main: 179154944 11:22:57 INFO - PID 27530 | 11:23:00 INFO - PID 27530 | Cycle 1(1): loaded http://localhost:36419/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36419/tests/kraken/driver.html?testName=audio-fft) 11:23:01 INFO - PID 27530 | RSS: Main: 173391872 11:23:01 INFO - PID 27530 | 11:23:03 INFO - PID 27530 | Cycle 1(1): loaded http://localhost:36419/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36419/tests/kraken/driver.html?testName=audio-oscillator) 11:23:03 INFO - PID 27530 | RSS: Main: 174137344 11:23:03 INFO - PID 27530 | 11:23:06 INFO - PID 27530 | Cycle 1(1): loaded http://localhost:36419/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36419/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:23:06 INFO - PID 27530 | RSS: Main: 174301184 11:23:06 INFO - PID 27530 | 11:23:09 INFO - PID 27530 | Cycle 1(1): loaded http://localhost:36419/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36419/tests/kraken/driver.html?testName=imaging-darkroom) 11:23:10 INFO - PID 27530 | RSS: Main: 176881664 11:23:10 INFO - PID 27530 | 11:23:14 INFO - PID 27530 | Cycle 1(1): loaded http://localhost:36419/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36419/tests/kraken/driver.html?testName=imaging-desaturate) 11:23:14 INFO - PID 27530 | RSS: Main: 176513024 11:23:14 INFO - PID 27530 | 11:23:17 INFO - PID 27530 | Cycle 1(1): loaded http://localhost:36419/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36419/tests/kraken/driver.html?testName=json-parse-financial) 11:23:18 INFO - PID 27530 | RSS: Main: 176951296 11:23:18 INFO - PID 27530 | 11:23:19 INFO - PID 27530 | Cycle 1(1): loaded http://localhost:36419/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36419/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:23:20 INFO - PID 27530 | RSS: Main: 176910336 11:23:20 INFO - PID 27530 | 11:23:22 INFO - PID 27530 | Cycle 1(1): loaded http://localhost:36419/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36419/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:23:22 INFO - PID 27530 | RSS: Main: 177147904 11:23:22 INFO - PID 27530 | 11:23:24 INFO - PID 27530 | Cycle 1(1): loaded http://localhost:36419/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36419/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:23:25 INFO - PID 27530 | RSS: Main: 174055424 11:23:25 INFO - PID 27530 | 11:23:28 INFO - PID 27530 | Cycle 1(1): loaded http://localhost:36419/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36419/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:23:28 INFO - PID 27530 | RSS: Main: 174944256 11:23:28 INFO - PID 27530 | 11:23:31 INFO - PID 27530 | Cycle 1(1): loaded http://localhost:36419/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36419/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:23:32 INFO - PID 27530 | RSS: Main: 174891008 11:23:32 INFO - PID 27530 | 11:23:34 INFO - PID 27530 | Cycle 1(1): loaded http://localhost:36419/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36419/tests/kraken/driver.html?testName=ai-astar) 11:23:34 INFO - PID 27530 | RSS: Main: 176730112 11:23:34 INFO - PID 27530 | 11:23:34 INFO - PID 27530 | __start_tp_report 11:23:34 INFO - PID 27530 | _x_x_mozilla_page_load 11:23:34 INFO - PID 27530 | _x_x_mozilla_page_load_details 11:23:34 INFO - PID 27530 | |i|pagename|runs| 11:23:34 INFO - PID 27530 | |0;ai-astar;110;110;107;108;108;109;108;107;107;105 11:23:34 INFO - PID 27530 | |1;audio-beat-detection;117;122;116;116;117;118;142;117;115;119 11:23:34 INFO - PID 27530 | |2;audio-dft;164;165;164;164;164;163;164;170;167;164 11:23:34 INFO - PID 27530 | |3;audio-fft;74;80;73;76;73;75;74;77;74;73 11:23:34 INFO - PID 27530 | |4;audio-oscillator;81;79;79;83;78;79;83;78;80;78 11:23:34 INFO - PID 27530 | |5;imaging-gaussian-blur;111;121;113;113;110;114;115;115;119;120 11:23:34 INFO - PID 27530 | |6;imaging-darkroom;148;147;147;150;151;148;149;149;149;148 11:23:34 INFO - PID 27530 | |7;imaging-desaturate;101;93;94;94;94;94;93;94;94;94 11:23:34 INFO - PID 27530 | |8;json-parse-financial;53;53;53;51;50;51;53;53;53;53 11:23:34 INFO - PID 27530 | |9;json-stringify-tinderbox;37;38;38;37;38;37;38;37;37;37 11:23:34 INFO - PID 27530 | |10;stanford-crypto-aes;77;73;77;74;74;75;77;78;77;77 11:23:34 INFO - PID 27530 | |11;stanford-crypto-ccm;119;116;118;122;123;122;123;135;134;120 11:23:34 INFO - PID 27530 | |12;stanford-crypto-pbkdf2;168;167;167;168;179;181;169;168;180;168 11:23:34 INFO - PID 27530 | |13;stanford-crypto-sha256-iterative;68;62;63;63;69;66;63;62;61;70 11:23:34 INFO - PID 27530 | __end_tp_report 11:23:34 INFO - PID 27530 | __start_cc_report 11:23:34 INFO - PID 27530 | _x_x_mozilla_cycle_collect,916 11:23:34 INFO - PID 27530 | __end_cc_report 11:23:34 INFO - PID 27530 | __startTimestamp1504895014490__endTimestamp 11:23:34 INFO - PID 27530 | 11:23:34 INFO - PID 27530 | ------- Summary: start ------- 11:23:34 INFO - PID 27530 | Number of tests: 14 11:23:34 INFO - PID 27530 | 11:23:34 INFO - PID 27530 | [#0] ai-astar Cycles:10 Average:107.90 Median:108.00 stddev:1.52 (1.4%) stddev-sans-first:1.41 11:23:34 INFO - PID 27530 | Values: 110.0 110.0 107.0 108.0 108.0 109.0 108.0 107.0 107.0 105.0 11:23:34 INFO - PID 27530 | 11:23:34 INFO - PID 27530 | [#1] audio-beat-detection Cycles:10 Average:119.90 Median:117.50 stddev:8.01 (6.8%) stddev-sans-first:8.42 11:23:34 INFO - PID 27530 | Values: 117.0 122.0 116.0 116.0 117.0 118.0 142.0 117.0 115.0 119.0 11:23:34 INFO - PID 27530 | 11:23:34 INFO - PID 27530 | [#2] audio-dft Cycles:10 Average:164.90 Median:164.00 stddev:2.08 (1.3%) stddev-sans-first:2.18 11:23:34 INFO - PID 27530 | Values: 164.0 165.0 164.0 164.0 164.0 163.0 164.0 170.0 167.0 164.0 11:23:34 INFO - PID 27530 | 11:23:34 INFO - PID 27530 | [#3] audio-fft Cycles:10 Average:74.90 Median:74.50 stddev:2.23 (3.0%) stddev-sans-first:2.35 11:23:34 INFO - PID 27530 | Values: 74.0 80.0 73.0 76.0 73.0 75.0 74.0 77.0 74.0 73.0 11:23:34 INFO - PID 27530 | 11:23:34 INFO - PID 27530 | [#4] audio-oscillator Cycles:10 Average:79.80 Median:79.50 stddev:1.93 (2.4%) stddev-sans-first:2.00 11:23:34 INFO - PID 27530 | Values: 81.0 79.0 79.0 83.0 78.0 79.0 83.0 78.0 80.0 78.0 11:23:34 INFO - PID 27530 | 11:23:34 INFO - PID 27530 | [#5] imaging-gaussian-blur Cycles:10 Average:115.10 Median:115.00 stddev:3.75 (3.3%) stddev-sans-first:3.68 11:23:34 INFO - PID 27530 | Values: 111.0 121.0 113.0 113.0 110.0 114.0 115.0 115.0 119.0 120.0 11:23:34 INFO - PID 27530 | 11:23:34 INFO - PID 27530 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:149.00 stddev:1.26 (0.8%) stddev-sans-first:1.32 11:23:34 INFO - PID 27530 | Values: 148.0 147.0 147.0 150.0 151.0 148.0 149.0 149.0 149.0 148.0 11:23:34 INFO - PID 27530 | 11:23:34 INFO - PID 27530 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.00 stddev:2.32 (2.5%) stddev-sans-first:0.44 11:23:34 INFO - PID 27530 | Values: 101.0 93.0 94.0 94.0 94.0 94.0 93.0 94.0 94.0 94.0 11:23:34 INFO - PID 27530 | 11:23:34 INFO - PID 27530 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:53.00 stddev:1.16 (2.2%) stddev-sans-first:1.20 11:23:34 INFO - PID 27530 | Values: 53.0 53.0 53.0 51.0 50.0 51.0 53.0 53.0 53.0 53.0 11:23:34 INFO - PID 27530 | 11:23:34 INFO - PID 27530 | [#9] json-stringify-tinderbox Cycles:10 Average:37.40 Median:37.50 stddev:0.52 (1.4%) stddev-sans-first:0.53 11:23:34 INFO - PID 27530 | Values: 37.0 38.0 38.0 37.0 38.0 37.0 38.0 37.0 37.0 37.0 11:23:34 INFO - PID 27530 | 11:23:34 INFO - PID 27530 | [#10] stanford-crypto-aes Cycles:10 Average:75.90 Median:77.00 stddev:1.73 (2.2%) stddev-sans-first:1.79 11:23:34 INFO - PID 27530 | Values: 77.0 73.0 77.0 74.0 74.0 75.0 77.0 78.0 77.0 77.0 11:23:34 INFO - PID 27530 | 11:23:34 INFO - PID 27530 | [#11] stanford-crypto-ccm Cycles:10 Average:123.20 Median:122.50 stddev:6.37 (5.2%) stddev-sans-first:6.58 11:23:34 INFO - PID 27530 | Values: 119.0 116.0 118.0 122.0 123.0 122.0 123.0 135.0 134.0 120.0 11:23:34 INFO - PID 27530 | 11:23:34 INFO - PID 27530 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.50 Median:168.50 stddev:5.91 (3.5%) stddev-sans-first:6.13 11:23:34 INFO - PID 27530 | Values: 168.0 167.0 167.0 168.0 179.0 181.0 169.0 168.0 180.0 168.0 11:23:34 INFO - PID 27530 | 11:23:34 INFO - PID 27530 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:64.50 stddev:3.27 (5.1%) stddev-sans-first:3.24 11:23:34 INFO - PID 27530 | Values: 68.0 62.0 63.0 63.0 69.0 66.0 63.0 62.0 61.0 70.0 11:23:34 INFO - PID 27530 | -------- Summary: end -------- 11:23:34 INFO - PID 27530 | 11:23:34 INFO - PID 27530 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:23:35 INFO - TEST-INFO | 27530: exit 0 11:23:35 INFO - TEST-OK | kraken | took 60997ms 11:23:35 INFO - SUITE-END | took 1169s 11:23:35 INFO - Completed test suite (00:19:29) 11:23:35 INFO - javascript benchmark 11:23:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8408.992075314953, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3093.9071827845164, 3096.8451577421124, 3103.6275646922386, 3120.0951724000042, 3137.3568418474215, 6168.876622467559, 6209.813705588828, 6210.0, 6246.312905580388, 6287.59130656507, 6238.968805155968, 6310.0, 6379.936200637992, 6462.256840463348, 6483.578567393116, 1335.2077204740056, 5892.587518873681, 5930.940690593104, 5949.613275137102, 5979.1629171915965, 5779.133130030508, 5835.18307436957, 5904.439078287556, 5912.201852749867, 5928.7332070056955, 5822.5145835919075, 5822.854428639275, 5889.882202355929, 5901.793437229698, 5904.350521442638, 5805.216295800055, 5828.125781132864, 5887.116932460122, 5894.557908156906, 5906.173135760954, 5791.305043394777, 5796.565257605655, 5848.064309710426, 5873.1190321451695, 5888.057910734305, 6095.695215239265, 6226.564140510166, 6329.4619957303685, 6411.198600174978, 6416.615003099782, 6630.834229144261, 6639.933600664028, 6765.932340676629, 6770.763023294161, 6827.0783444234885, 6761.357671021246, 6770.1537307836525, 6849.383555479981, 6863.485238607124, 6872.553284036521, 6148.723307451175, 6241.78153764616, 6243.719032643451, 6262.96868515659, 6338.809835704937, 6881.690323935435, 6892.0, 6895.75864844728, 6900.516963812485, 6906.343897329745, 6475.0, 6559.901601475982, 6569.080328753978, 6570.5400621956005, 6571.474282057424, 6706.798796036127, 6739.764108256188, 6799.150106236721, 6800.829979250559, 6800.897986530206, 6714.664266786739, 6721.831954201184, 6791.728330866808, 6794.898076528856, 6812.761553345609, 6627.469802415795, 6660.600363978177, 6743.393094621508, 6755.729770809113, 6865.141857267841, 5320.042392369333, 5324.227986941872, 5325.946740532622, 5337.6797392156595, 5351.384590772111, 4594.816207351735, 4671.579557839811, 4681.906361872743, 4690.202665546865, 4695.22528782747, 5766.913496297559, 5771.307443106854, 5818.6217895836635, 5832.50423713989, 5835.649861008353, 6644.933550664528, 6684.030815531721, 6712.39588437043, 6724.529282950147, 6778.898316525256, 5699.914501282484, 5709.314882214161, 5717.313922329264, 5723.427657234327, 5755.482006619424, 5720.0, 5785.797497087582, 5797.9420205797405, 5806.82579522615, 5822.970885145547, 6307.022411526221, 6359.046143078575, 6391.744330226832, 6459.450946669585, 6477.935220647827, 6647.700853461509, 6721.361470660279, 6807.3873351398615, 6810.046593476818, 6811.114555107804, 6456.451201647913, 6516.543841931019, 6519.641419721961, 6532.738690452328, 6558.278589355072, 6519.511036672174, 6648.202215734143, 6675.732970681119, 6692.799216023527, 6731.831704207434, 6721.731130754715, 6776.3079013628785, 6791.252962174256, 6856.24581296067, 6865.794026179223, 6558.475321974135, 6578.8355291118105, 6586.37429444202, 6587.044878492496, 6590.011498275297, 6333.303336633059, 6353.555251132561, 6449.0, 6599.043138744951, 6623.4038936495945, 6295.370462953668, 6412.166418365583, 6415.518836087219, 6416.32628573993, 6444.420002199637, 6573.80278591643, 6646.03632473279, 6695.363940425652, 6703.966480167568, 6741.089952856301, 6166.414190651881, 6254.967930291451, 6329.430351268408, 6346.333634968262, 6446.0975463434215], "value": 6108.368410659546, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [738.4793720427099, 760.2739383888387, 764.2968469008512, 771.8649236383632, 773.4701729315416, 37498.62501374986, 40944.181116377695, 41057.17885642289, 41232.58767412325, 41278.38082428758, 38142.61857381425, 38156.0, 38200.80899595505, 38221.235575288476, 38293.42559861604, 6929.688164032618, 7022.403095736869, 7022.964885175567, 7042.084529011221, 7047.295270472963, 6946.47901407394, 7023.086998690163, 7027.613481258529, 7035.613041282727, 7045.964770176168, 7000.859982800341, 7028.332308430691, 7030.683619237147, 7035.12060992376, 7700.576468294242, 7754.806129846743, 7827.373810095179, 7834.020747406575, 7838.255365740302, 7841.137474877759, 7625.61871906408, 7680.80797980055, 7772.883406748903, 7782.922170778276, 7803.843923121506, 37644.0, 37984.43023354652, 38013.0, 38013.23973520514, 38161.23677526434, 3540.964590354089, 3593.5508061492314, 3595.280943811222, 3595.8741444049333, 3598.712103031777, 31387.215319616964, 31451.84274078615, 31518.842405788055, 31574.0, 31587.0, 5124.0776660201145, 5161.045206636784, 5181.5077567631015, 5195.532402083831, 5204.869878253036, 188084.0595797026, 188241.0, 188640.0, 189660.0, 189708.0, 42044.579554204676, 42923.0, 47477.525224748, 47578.76210618925, 47863.76068119637, 50628.240576391385, 50777.0, 50860.0, 50894.491055088976, 50931.23603145956, 15266.0, 15409.84590154084, 15411.614709632124, 15414.229288535753, 15416.152111633968, 12508.3745812709, 12519.43662535188, 12530.373481325898, 12532.686682833002, 12534.310612916195, 14072.648183795282, 14076.648083797987, 14106.083104598374, 14139.293035348397, 14182.361793719101, 5904.321003084614, 5905.153897641304, 5956.468500887192, 5969.194158788595, 6028.246469191351, 990.6829814459304, 1001.4291853643499, 1008.3344992305043, 1010.1262408017159, 1014.9644762433279, 21842.344729658136, 21934.0, 21994.780052199272, 22061.227857024925, 22393.0, 1099.351382684204, 1100.4277775556666, 1103.4703342395535, 1116.0736588631416, 1118.4407796101948, 11490.310581365145, 11565.190436669352, 11659.591914282959, 11863.16957812962, 11880.585397009228, 229116.0, 230678.0, 230727.0, 230732.0, 231022.0, 51591.48408515867, 51859.48140518622, 51936.74031629818, 51972.0, 52273.73863130736, 1439.0, 1460.5175746617404, 1482.1847983608973, 1486.724955883165, 1489.6648254142947, 22092.779072209072, 22238.55522889501, 22338.664920025887, 22439.21462748796, 22473.88763056174, 36767.44848827216, 37018.814905926374, 37032.629673703996, 37034.0, 37062.44406333853, 180819.0, 187645.0, 188253.0, 189413.0, 189580.0, 29714.702852971193, 30200.84899575576, 30288.0, 32668.34663306673, 32851.67148328486, 42082.7895860531, 42256.788716056224, 42320.57679423167, 42386.5761342395, 42714.35928461013, 30907.2273193163, 30928.53607195939, 30975.535366969965, 31134.377312453173, 31153.221169470944, 30826.229344266572, 30849.691503084683, 31069.689303107585, 31104.533431998992, 31545.526817097303, 34474.13814654654, 34593.65406345904, 34718.132046698025, 34898.47652285167, 34910.301793964485, 30316.696833031387, 30421.847890760404, 30797.0, 31273.37453250968, 31419.0, 22036.0, 22233.333000010025, 22596.435089122246, 22780.772192278528, 22849.65725514152], "value": 16654.444368217755, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.6925394913721, 575.9712014399281, 579.3366595248441, 587.8941790477718, 591.8461200087977, 22040.88979555102, 22600.773992260074, 22744.20395286165, 22755.317340479793, 22918.65622015667, 23104.0, 23804.880975595097, 23962.161324353652, 24076.759232407672, 24091.518169636598, 6343.365663433643, 6480.416762491375, 6519.608823470607, 6530.510211734115, 6531.640759758211, 6409.775657851976, 6524.151860258184, 6524.836879078037, 6525.151730275057, 6528.934710652904, 6234.438900498954, 6477.449416799578, 6507.349265073479, 6507.479401647857, 6528.216614006302, 6445.1943507061615, 6461.93538064618, 6475.093486911836, 6480.351964803529, 6485.027245913104, 5810.854728631776, 6000.279966404016, 6005.54958378119, 6011.759529618854, 6020.397960203988, 27114.322141946413, 27517.724822751716, 27564.0, 27571.03501377442, 27599.862000690067, 1991.4722598511405, 2017.6771716525286, 2020.3534868841975, 2020.8787472751683, 2021.8786872787532, 18675.252989880388, 19154.0, 19352.41942741706, 19382.449404047642, 19715.80284197154, 2411.4212588978694, 2444.7188573313942, 2457.6313552967017, 2459.311392810016, 2464.6303054541963, 117059.0, 122073.0, 131523.34238328843, 136833.0, 137578.31210844082, 14678.935747185014, 14696.846322541265, 14795.926020370045, 14876.62664784613, 14976.850231497763, 22604.886975565016, 22617.660735088986, 22649.320520384415, 22653.886730566242, 22717.545649087257, 10229.846552301722, 10275.434851083262, 10279.94860025695, 10280.383177009404, 10330.328528645614, 9475.620975160917, 9551.188149007274, 9563.474008929576, 9596.616135354509, 9645.0, 8947.821043579092, 9092.727218183465, 9120.771980700536, 9229.584668689926, 9247.167754902091, 2639.2741995950882, 2688.435428559985, 2700.986495067512, 2702.891884324605, 2816.5915942188267, 951.9428834269966, 955.7813787421094, 956.2397893674546, 980.9950950245346, 982.6658935961807, 18511.81488185128, 18630.53423664419, 18808.198317397655, 18828.811711882707, 18862.62274754497, 1015.7968406318765, 1025.7743296474764, 1030.3354336452946, 1037.984430233547, 1043.268174829779, 10417.47912604382, 10445.738856528647, 10493.895061049292, 10578.259521833397, 10648.254622176373, 450736.0, 454754.0, 456884.0, 462396.0, 471286.0, 109391.0, 109656.0, 111314.44342778235, 111704.44147779372, 111983.0, 1032.396048311746, 1075.499892549968, 1122.3490375582144, 1157.6989982604416, 1172.695099274178, 19510.414687559394, 19525.12136953869, 19621.215151393786, 19690.50773730668, 19963.401097967086, 55373.44626553844, 55482.0, 56381.0, 56438.1534276978, 58128.4187158123, 71001.28998709947, 71791.64104179446, 71835.64082179556, 71876.64061679867, 72058.27941720726, 13811.792823107862, 13972.441102355791, 14051.648708781953, 14079.788803168165, 14106.224157671426, 21570.6764398531, 21698.457538561663, 21831.235906743186, 21856.0, 22043.66934495952, 17198.624110070916, 17316.220770065127, 17431.0, 17472.563185920455, 17521.299148034446, 14239.786403203752, 14519.49181778675, 14842.0, 15338.76991845101, 16227.675446490768, 17469.38857139994, 17536.210870510604, 17573.560660983578, 17665.911670441565, 17706.645867082843, 12847.35763211817, 13404.731905361643, 13465.057445978688, 13507.122037067558, 13508.594742157751, 16980.83019169842, 17009.234584443977, 17068.65862682764, 17380.913095434444, 17397.47807565775], "value": 11666.790877897587, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1309.103264263979, 1353.7427888701145, 1361.6323592629983, 1363.9974618655292, 1372.5401990333237, 14673.779893301597, 15096.924515377435, 15230.695386092271, 15265.771013434807, 15293.311800968955, 14898.851011489882, 14983.026103303278, 14983.775243371358, 15007.399704011854, 15032.248387580605, 2733.6172935788904, 2776.875040623177, 2780.8470534120615, 2786.45664095502, 2819.8590070496393, 2725.523033469145, 2744.300203448118, 2745.807793454459, 2749.8625068746483, 2763.571646394812, 2223.9666405003936, 2352.200251914349, 2720.469508445854, 2804.8317100973904, 2805.3547684032683, 2753.876075576604, 2783.262435454606, 2796.9021084262054, 2800.2859270885792, 2801.607774911504, 2732.3715545424466, 2739.397332586828, 2745.958810617842, 2750.5324094903913, 2755.1596762987283, 15051.021683590532, 15205.31576079079, 15218.391264349413, 15220.391184352613, 15231.314590843438, 7931.0, 8197.262246397793, 8206.753797386029, 8211.466254693425, 8212.096669366365, 5238.083335416287, 5315.973420132875, 5441.401445840955, 5692.743826527816, 5716.742746576414, 1942.0678074524167, 1950.9512262193416, 1961.0782932021928, 1983.9702404463944, 1997.4407165993546, 24546.509069818505, 24700.876495617587, 24704.629430558554, 24758.752412475824, 24803.751962480324, 7133.357997780225, 7266.45501587383, 7330.0, 7459.70161193557, 7473.327400533978, 16472.752908706378, 17144.571385715455, 17181.828181718272, 19590.608187836162, 19660.606787864162, 7919.802004949807, 8139.064007639197, 8140.837183256302, 8144.877826832602, 8148.062972758209, 7311.341979221789, 7407.037085178892, 7440.181580026193, 7519.924800752032, 7591.8861217081785, 5267.394249661338, 5336.653117547347, 5356.384015838228, 5413.702246376487, 5456.48163424474, 1463.9560813175622, 1475.7343678138038, 1487.2340744516582, 1506.2920427399106, 1530.257824954896, 878.310526236901, 903.1916434790957, 903.4850135422746, 914.6021480655936, 916.7249825052457, 7547.660355284025, 7548.7357942472845, 7571.0, 7616.695332186761, 7616.8476630467085, 701.6702149989496, 712.2485777504679, 717.5909731453022, 718.5652680128447, 722.5628494760699, 4479.61923236522, 4535.773211339486, 4674.158651442705, 5140.0, 5335.253064570963, 21107.78892211089, 21324.527097134807, 21858.344249672537, 22062.779372206394, 22169.44576385571, 21093.894530527556, 21516.139354425646, 21558.892205538872, 21586.676199857015, 21653.67519487209, 10943.0, 11458.54165833374, 11512.94243528777, 11518.136139789549, 11521.135914806424, 7944.880826787487, 7946.847707082557, 8008.359331253369, 8018.518888866687, 8023.157568455228, 17971.460856174337, 18547.35084272044, 18581.070946452895, 18718.906405467886, 19004.42986710401, 18838.52903677419, 18867.622647546697, 18925.337613183474, 19006.23975040983, 19068.618627627093, 10901.781964360827, 10919.836202457129, 10996.560137594726, 11023.283486573348, 11026.669199924016, 13541.187528747912, 13809.585712428643, 13811.654708632364, 13813.51652692151, 13816.93091534536, 10877.945610271898, 10947.178961578073, 10957.561697532328, 11083.445827708743, 11269.591301087365, 10741.24811263204, 11031.779364412827, 11083.445827708421, 11233.775324493301, 11312.321260724382, 9960.203183745429, 10224.488775561342, 10229.488525573543, 10230.539625716712, 10239.078482936571, 7089.326513981164, 7101.431885449048, 7105.431565474853, 7105.680244388912, 7172.748953786592, 7169.139703235645, 7267.672954717156, 7279.599622020628, 7294.817629559304, 7309.744158954411], "value": 6608.303957948959, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [501.00884075911597, 520.8411434512474, 527.3855957809153, 532.9481496239481, 535.6063293479293, 6377.170967774183, 6392.1690180276555, 6398.5201109916825, 6412.551121421502, 6437.485001199904, 6224.782132625359, 6230.5638605297645, 6243.313235544098, 6248.250209974809, 6263.812085637438, 5179.507946745062, 5190.896182076356, 5214.817481388152, 5241.764120614582, 5248.291480650101, 4870.9269360959615, 5017.849464516052, 5184.144616138333, 5219.817306394277, 5226.843194704165, 4989.3513843200335, 4990.725510096943, 5011.098002359574, 5015.172496538067, 5032.968241510482, 4962.776675049631, 4984.800607975677, 4998.0, 5002.52476014778, 5004.649674522767, 4384.714993525411, 4486.753228572427, 4488.822920883369, 4500.662450316239, 4508.278675411918, 6104.382338680209, 6124.877502449971, 6128.9693551531955, 6139.754409823602, 6171.444569988677, 5718.971405142947, 5719.113537401709, 5747.568547722404, 5762.74067666956, 5779.0, 6572.835679108012, 6574.572652777602, 6576.835579110512, 6604.867902641969, 6612.603243805387, 4647.372604698357, 4807.399075115611, 4824.7828847701585, 4860.902781944376, 4874.098291816025, 6762.72949082041, 6800.0, 6899.62052087135, 6946.583205007665, 6947.7220911163495, 4981.800727970841, 5008.774605142778, 5009.423916249605, 5027.974860125676, 5041.747912604355, 5053.696778193246, 5066.36670416198, 5090.898182036339, 5101.566366858784, 5109.718965456861, 5660.575456840754, 5673.1490276458035, 5698.230738850285, 5716.828495145152, 5755.136729490526, 6593.967030164818, 6644.501662375341, 6672.633005184664, 6676.566023208476, 6678.83302917431, 1759.5952930825981, 1769.4691592522192, 1769.7345398190375, 1771.929122835098, 1778.7370966613591, 1170.3153655111855, 1214.423149004216, 1227.2636418149218, 1230.9138360314691, 1242.7700875338091, 5692.715364231772, 5707.828765137053, 5734.942650573525, 5735.598508104393, 5744.339400968942, 6608.332375531626, 6628.370304821035, 6652.0, 6697.0, 6763.458923286125, 5576.302962129734, 5676.318841739017, 5700.258966334433, 5757.539396848242, 5758.3665796762325, 3565.7682250653625, 3577.195131095483, 3582.570091588974, 3582.8208589570418, 3603.6936860367164, 6337.207849018872, 6396.5522413431545, 6422.710978006001, 6488.578242414323, 6503.902441463382, 6625.238097618835, 6858.931410685929, 6888.793336199922, 6900.654967251618, 6920.792376228721, 6445.548811583238, 6463.64449955257, 6474.6762661866715, 6482.060101285288, 6487.578307410004, 6709.295523969913, 6724.327567243236, 6743.123393958754, 6756.716253883738, 6823.28355522663, 6720.991851222356, 6735.225449073419, 6736.720023195578, 6737.258901520927, 6740.831479212863, 6485.643289619116, 6496.707648155939, 6498.935010650022, 6505.316941721051, 6509.967450162719, 4972.403311602631, 4990.700557966534, 4992.700437973734, 5005.899882002413, 5023.09584274834, 6542.34576542342, 6632.734690612321, 6734.9326506734305, 6740.494462915203, 6786.3892249697765, 6506.869862602816, 6530.608163510205, 6533.41199292066, 6534.738610455529, 6551.672416379257, 6484.919663159962, 6551.672416379067, 6578.901316480161, 6590.373914478117, 6599.241087275025, 6409.487241020801, 6426.293107758236, 6433.099366088658, 6483.2544257411, 6488.0, 6591.802245932629, 6620.8344791380605, 6636.900446493403, 6639.3692599203, 6647.518669297589, 6304.338044505261, 6311.747530098744, 6316.336784637547, 6319.178506794087, 6332.113504109337], "value": 5076.868566329932, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [886.8935727712676, 916.5921165081537, 922.7001224602006, 924.8705181274622, 957.6313119449012, 19720.99999999998, 20664.690029649566, 20794.480137996557, 20802.89598552007, 20816.375508734764, 18213.453596392097, 18284.0, 18357.449276521726, 19032.33386831461, 19269.518262043457, 961.1301771896445, 984.0307297312178, 987.1115995603942, 987.1411871671655, 987.4914419074182, 971.2036130373097, 997.0278977996431, 1000.7798284377425, 1001.2940876681959, 1018.7504061504904, 1050.5850189175271, 1052.6052730226165, 1052.6526246338728, 1053.7839742852698, 1055.372053628094, 981.9705408837747, 1016.1972042086743, 1021.9693409197736, 1029.44924465411, 1042.1766804224692, 743.9070116235471, 748.5994992678945, 748.9400847932152, 748.9850202995909, 749.1459735901077, 18879.528011799677, 18991.525211869677, 19018.61962760751, 19065.0, 19075.332363367215, 20501.58996820055, 22070.558588828295, 22225.222117225818, 22226.222082227207, 22231.555368892532, 16933.830661693348, 17230.569235769082, 17263.65472690539, 17293.481195564153, 17535.0, 3563.2695297463956, 3593.317269718771, 3594.730395220369, 3594.7663401879054, 3596.226811235571, 140282.99999999898, 141780.0, 142086.0, 142128.2893585536, 143858.0, 16315.347386104422, 16457.42399016029, 16724.0, 16777.91611041937, 16829.495115146565, 28093.297667558065, 29155.708442915722, 29366.265843354086, 29444.11667649974, 29652.40695186084, 8253.587320633944, 8400.789980250544, 8421.242088211968, 8435.283000944866, 8458.40791144614, 4132.793360331972, 4236.703430759817, 4253.76604286761, 4282.63597594208, 4289.24938135825, 5440.945590544123, 5488.25908502355, 5527.226188333637, 5548.639338442988, 5568.7215639217875, 989.9803202701229, 1002.904724051214, 1016.466355163545, 1029.2846471702244, 1036.233187441303, 690.623610132479, 699.6257002503636, 714.1501613080418, 716.2443621978758, 717.8097804081923, 11599.420028998516, 11802.46888890002, 11854.407279635983, 11980.820287695691, 12114.454849531792, 675.4731309578439, 677.6747161362475, 679.5243329669252, 691.0118530501431, 695.2352412346379, 5612.160846666517, 5632.183333416713, 5634.549236061105, 5681.744321505542, 5785.768569257267, 125066.3746681279, 126050.69746512637, 127265.0, 129041.3547932273, 131924.3403782975, 105647.47176264224, 106228.46885765521, 106949.0, 107949.0, 108980.0, 93593.0, 94781.0, 95076.0, 97596.0, 97729.5340569892, 10473.895261047292, 10517.631882884063, 10720.785584288114, 10911.290766100177, 10939.617113400993, 45362.54637453715, 45522.772386137854, 46090.07819843652, 46461.76769116133, 46663.0, 57670.42329576818, 58474.0, 59183.408165919514, 59676.701616493374, 61412.385876142456, 15673.608159796097, 16040.759388608947, 16096.114713690391, 16183.75724364159, 16207.108609026145, 15841.0, 16068.357265709708, 16136.354545818036, 16350.672986539965, 16352.264148113125, 15466.14936178521, 15471.613209669847, 15477.84522154764, 15550.688986219986, 15593.76609350838, 15920.363185472916, 16115.516534503984, 16130.67738645244, 16206.756898646765, 16333.0, 15872.682546349239, 16316.42892498757, 16339.0, 16367.0, 16528.421505247257, 10904.672859814218, 10960.725981850517, 11008.834867476835, 11048.447577621248, 11071.003609675168, 9575.569099390683, 9659.227261819178, 9660.613575457184, 9697.6120955161, 9767.706968790948], "value": 8878.635989110338, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1430.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 107.0, 108.0, 108.0, 109.0, 108.0, 107.0, 107.0, 105.0], "value": 107.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 122.0, 116.0, 116.0, 117.0, 118.0, 142.0, 117.0, 115.0, 119.0], "value": 119.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 164.0, 164.0, 164.0, 163.0, 164.0, 170.0, 167.0, 164.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 80.0, 73.0, 76.0, 73.0, 75.0, 74.0, 77.0, 74.0, 73.0], "value": 74.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 79.0, 83.0, 78.0, 79.0, 83.0, 78.0, 80.0, 78.0], "value": 79.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 121.0, 113.0, 113.0, 110.0, 114.0, 115.0, 115.0, 119.0, 120.0], "value": 115.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 150.0, 151.0, 148.0, 149.0, 149.0, 149.0, 148.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 93.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 51.0, 50.0, 51.0, 53.0, 53.0, 53.0, 53.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 38.0, 38.0, 37.0, 38.0, 37.0, 38.0, 37.0, 37.0, 37.0], "value": 37.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 77.0, 74.0, 74.0, 75.0, 77.0, 78.0, 77.0, 77.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 116.0, 118.0, 122.0, 123.0, 122.0, 123.0, 135.0, 134.0, 120.0], "value": 123.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 167.0, 167.0, 168.0, 179.0, 181.0, 169.0, 168.0, 180.0, 168.0], "value": 171.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 62.0, 63.0, 63.0, 69.0, 66.0, 63.0, 62.0, 61.0, 70.0], "value": 64.7, "unit": "score"}]}]} 11:23:35 INFO - Return code: 0 11:23:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:23:35 INFO - # TBPL SUCCESS # 11:23:35 INFO - Running post-action listener: _package_coverage_data 11:23:35 INFO - Running post-action listener: _resource_record_post_action 11:23:35 INFO - [mozharness: 2017-09-08 18:23:35.757698Z] Finished run-tests step (success) 11:23:35 INFO - Running post-run listener: _resource_record_post_run 11:23:35 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 297652224; Read time: 8; Write time: 204940 11:23:35 INFO - TinderboxPrint: CPU usage
13.1% 11:23:35 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 11:23:35 INFO - TinderboxPrint: I/O write bytes / time
297,652,224 / 204,940 11:23:35 INFO - TinderboxPrint: CPU idle
8,222.4 (86.9%) 11:23:35 INFO - TinderboxPrint: CPU user
1,190.6 (12.6%) 11:23:35 INFO - TinderboxPrint: Swap in / out
0 / 0 11:23:35 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 13148160; Read time: 0; Write time: 1356 11:23:35 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:23:35 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284504064; Read time: 8; Write time: 203584 11:23:36 INFO - Running post-run listener: _upload_blobber_files 11:23:36 INFO - Blob upload gear active. 11:23:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:23:36 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 11:23:36 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'] 11:23:36 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 11:23:36 INFO - (blobuploader) - INFO - Open directory for files ... 11:23:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:23:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:23:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:23:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:23:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:23:43 INFO - (blobuploader) - INFO - Done attempting. 11:23:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:23:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:23:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:23:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:23:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:23:44 INFO - (blobuploader) - INFO - Done attempting. 11:23:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:23:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:23:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:23:45 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:23:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:23:45 INFO - (blobuploader) - INFO - Done attempting. 11:23:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:23:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:23:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:23:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:23:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:23:46 INFO - (blobuploader) - INFO - Done attempting. 11:23:46 INFO - (blobuploader) - INFO - Iteration through files over. 11:23:46 INFO - Return code: 0 11:23:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:23:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:23:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/273cb23df6087ec6d49bb7d3d8917a99662474925766cb8281e6991fef1c943ec24a410a9724c4be52320ee7f305d5c4019cd410755f7f748309585d7971d6e6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/412d2f46d23a952aa57ba2871d6051a824f64b54c0b1dd4da23d2636f4d1dd6e6d71290df83d37d669d014eba24431d7c03d18c01e15c431faeec046b7cba429", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/044f64a87819066fc38214f38e5bb77a2e5e9d87a11428eeb7d1ea8b27932f44f3b9f1d8566894b252221f159cee6a195bc13117d6985a1c007c4da5ba0edcbe", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/331be870633a3c74f0ea2d4a36a549882ee5ee9f216fa3ab54a641931af954f77c68399130c541423546c399e46b5ebe1bea9636f378414450eb51639ecfd530"} 11:23:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:23:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:23:46 INFO - Contents: 11:23:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/273cb23df6087ec6d49bb7d3d8917a99662474925766cb8281e6991fef1c943ec24a410a9724c4be52320ee7f305d5c4019cd410755f7f748309585d7971d6e6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/412d2f46d23a952aa57ba2871d6051a824f64b54c0b1dd4da23d2636f4d1dd6e6d71290df83d37d669d014eba24431d7c03d18c01e15c431faeec046b7cba429", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/044f64a87819066fc38214f38e5bb77a2e5e9d87a11428eeb7d1ea8b27932f44f3b9f1d8566894b252221f159cee6a195bc13117d6985a1c007c4da5ba0edcbe", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/331be870633a3c74f0ea2d4a36a549882ee5ee9f216fa3ab54a641931af954f77c68399130c541423546c399e46b5ebe1bea9636f378414450eb51639ecfd530"} 11:23:46 INFO - Running post-run listener: copy_logs_to_upload_dir 11:23:46 INFO - Copying logs to upload dir... 11:23:46 INFO - mkdir: /builds/slave/test/build/upload/logs 11:23:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.945773 ========= master_lag: -0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-09-08 11:23:46.573546) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-08 11:23:46.581251) ========= 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=32c5991c409366f7fec8a718000001d2-1504891769.645379-1045930591 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/273cb23df6087ec6d49bb7d3d8917a99662474925766cb8281e6991fef1c943ec24a410a9724c4be52320ee7f305d5c4019cd410755f7f748309585d7971d6e6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/412d2f46d23a952aa57ba2871d6051a824f64b54c0b1dd4da23d2636f4d1dd6e6d71290df83d37d669d014eba24431d7c03d18c01e15c431faeec046b7cba429", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/044f64a87819066fc38214f38e5bb77a2e5e9d87a11428eeb7d1ea8b27932f44f3b9f1d8566894b252221f159cee6a195bc13117d6985a1c007c4da5ba0edcbe", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/331be870633a3c74f0ea2d4a36a549882ee5ee9f216fa3ab54a641931af954f77c68399130c541423546c399e46b5ebe1bea9636f378414450eb51639ecfd530"} build_url:https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011477 build_url: 'https://queue.taskcluster.net/v1/task/RlzMfz8tRFW8DsiiCEg_WA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/273cb23df6087ec6d49bb7d3d8917a99662474925766cb8281e6991fef1c943ec24a410a9724c4be52320ee7f305d5c4019cd410755f7f748309585d7971d6e6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/412d2f46d23a952aa57ba2871d6051a824f64b54c0b1dd4da23d2636f4d1dd6e6d71290df83d37d669d014eba24431d7c03d18c01e15c431faeec046b7cba429", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/044f64a87819066fc38214f38e5bb77a2e5e9d87a11428eeb7d1ea8b27932f44f3b9f1d8566894b252221f159cee6a195bc13117d6985a1c007c4da5ba0edcbe", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/331be870633a3c74f0ea2d4a36a549882ee5ee9f216fa3ab54a641931af954f77c68399130c541423546c399e46b5ebe1bea9636f378414450eb51639ecfd530"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-08 11:23:46.612643) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 11:23:46.613026) ========= 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=32c5991c409366f7fec8a718000001d2-1504891769.645379-1045930591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004530 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 11:23:46.697003) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-08 11:23:46.697326) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-08 11:23:46.697672) ========= ========= Total master_lag: 0.14 =========