builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-048 starttime: 1506947783.71 results: success (0) revision: d248045d3695ae01b8caafb3dde608c2c6ed80ef ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-02 05:36:23.715277) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-02 05:36:23.715685) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-02 05:36:23.715952) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-02 05:36:23.733936) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 05:36:23.734219) ========= 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=fa44defc139c4ba8574fe040000001db-1506947580.571284-1832286885 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-02 05:36:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 217M=0s 2017-10-02 05:36:23 (217 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125135 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 05:36:23.879371) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 05:36:23.879674) ========= 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=fa44defc139c4ba8574fe040000001db-1506947580.571284-1832286885 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021153 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 05:36:23.929002) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-02 05:36:23.931345) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev d248045d3695ae01b8caafb3dde608c2c6ed80ef --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev d248045d3695ae01b8caafb3dde608c2c6ed80ef --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=fa44defc139c4ba8574fe040000001db-1506947580.571284-1832286885 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-02 05:36:23,962 truncating revision to first 12 chars 2017-10-02 05:36:23,962 Setting DEBUG logging. 2017-10-02 05:36:23,962 attempt 1/10 2017-10-02 05:36:23,962 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/d248045d3695?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-02 05:36:24,931 unpacking tar archive at: mozilla-beta-d248045d3695/testing/mozharness/ program finished with exit code 0 elapsedTime=1.280804 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-02 05:36:25.228879) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-02 05:36:25.232231) ========= script_repo_revision: d248045d3695ae01b8caafb3dde608c2c6ed80ef ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-02 05:36:25.232669) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-02 05:36:25.232933) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-02 05:36:25.248231) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2017-10-02 05:36:25.248590) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 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', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-Non-PGO'] 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=fa44defc139c4ba8574fe040000001db-1506947580.571284-1832286885 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:36:25 INFO - MultiFileLogger online at 20171002 05:36:25 in /builds/slave/test 05:36:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 05:36:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:36:25 INFO - {'append_to_log': False, 05:36:25 INFO - 'base_work_dir': '/builds/slave/test', 05:36:25 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 05:36:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:36:25 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 05:36:25 INFO - 'buildbot_json_path': 'buildprops.json', 05:36:25 INFO - 'code_coverage': False, 05:36:25 INFO - 'config_files': ('talos/linux_config.py',), 05:36:25 INFO - 'default_actions': ('clobber', 05:36:25 INFO - 'read-buildbot-config', 05:36:25 INFO - 'download-and-extract', 05:36:25 INFO - 'populate-webroot', 05:36:25 INFO - 'create-virtualenv', 05:36:25 INFO - 'install', 05:36:25 INFO - 'setup-mitmproxy', 05:36:25 INFO - 'run-tests'), 05:36:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:36:25 INFO - 'disable_ccov_upload': False, 05:36:25 INFO - 'disable_stylo': False, 05:36:25 INFO - 'download_minidump_stackwalk': True, 05:36:25 INFO - 'download_symbols': 'ondemand', 05:36:25 INFO - 'enable_stylo': False, 05:36:25 INFO - 'enable_webrender': False, 05:36:25 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 05:36:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:36:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:36:25 INFO - 'gecko_profile': False, 05:36:25 INFO - 'gecko_profile_interval': 0, 05:36:25 INFO - 'installer_path': 'installer.exe', 05:36:25 INFO - 'log_level': 'info', 05:36:25 INFO - 'log_name': 'talos', 05:36:25 INFO - 'log_to_console': True, 05:36:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:36:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:36:25 INFO - 'opt_config_files': (), 05:36:25 INFO - 'pip_index': False, 05:36:25 INFO - 'suite': 'dromaeojs-e10s', 05:36:25 INFO - 'system_bits': '32', 05:36:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:36:25 INFO - 'title': 'talos-linux64-ix-048', 05:36:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:36:25 INFO - 'use_talos_json': True, 05:36:25 INFO - 'verify': 'False', 05:36:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:36:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:36:25 INFO - 'work_dir': 'build'} 05:36:25 INFO - [mozharness: 2017-10-02 12:36:25.422230Z] Running clobber step. 05:36:25 INFO - Running pre-action listener: _resource_record_pre_action 05:36:25 INFO - Running main action method: clobber 05:36:25 INFO - rmtree: /builds/slave/test/build 05:36:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:36:26 INFO - Running post-action listener: _resource_record_post_action 05:36:26 INFO - [mozharness: 2017-10-02 12:36:26.418328Z] Finished clobber step (success) 05:36:26 INFO - [mozharness: 2017-10-02 12:36:26.418423Z] Running read-buildbot-config step. 05:36:26 INFO - Running pre-action listener: _resource_record_pre_action 05:36:26 INFO - Running main action method: read_buildbot_config 05:36:26 INFO - Using buildbot properties: 05:36:26 INFO - { 05:36:26 INFO - "project": "", 05:36:26 INFO - "product": "firefox", 05:36:26 INFO - "who": "ntim.bugs@gmail.com", 05:36:26 INFO - "installer_path": "public/build/target.tar.bz2", 05:36:26 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 05:36:26 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 05:36:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 05:36:26 INFO - "stage_platform": "linux64", 05:36:26 INFO - "basedir": "/builds/slave/test", 05:36:26 INFO - "buildnumber": 143, 05:36:26 INFO - "platform": "ubuntu64_hw", 05:36:26 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:36:26 INFO - "slavebuilddir": "test", 05:36:26 INFO - "taskId": "QDTjqlnTRmOOE8bj-R3jAA", 05:36:26 INFO - "branch": "mozilla-beta", 05:36:26 INFO - "script_repo_revision": "production", 05:36:26 INFO - "revision": "d248045d3695ae01b8caafb3dde608c2c6ed80ef", 05:36:26 INFO - "slavename": "talos-linux64-ix-048", 05:36:26 INFO - "repo_path": "releases/mozilla-beta" 05:36:26 INFO - } 05:36:26 INFO - Finding installer, test and symbols from parent task. 05:36:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QDTjqlnTRmOOE8bj-R3jAA'}, attempt #1 05:36:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QDTjqlnTRmOOE8bj-R3jAA'}, attempt #1 05:36:27 INFO - Task dependencies: XFLjpHIBQ1-E65lN9Pg_1g 05:36:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XFLjpHIBQ1-E65lN9Pg_1g'}, attempt #1 05:36:27 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/XFLjpHIBQ1-E65lN9Pg_1g/artifacts/public/build/target.tar.bz2 05:36:27 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/XFLjpHIBQ1-E65lN9Pg_1g/artifacts/public/build/target.test_packages.json 05:36:27 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/XFLjpHIBQ1-E65lN9Pg_1g/artifacts/public/build/target.crashreporter-symbols.zip 05:36:27 INFO - Running post-action listener: _resource_record_post_action 05:36:27 INFO - [mozharness: 2017-10-02 12:36:27.740784Z] Finished read-buildbot-config step (success) 05:36:27 INFO - [mozharness: 2017-10-02 12:36:27.741000Z] Running download-and-extract step. 05:36:27 INFO - Running pre-action listener: _resource_record_pre_action 05:36:27 INFO - Running main action method: download_and_extract 05:36:27 INFO - mkdir: /builds/slave/test/build/tests 05:36:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:27 INFO - trying https://queue.taskcluster.net/v1/task/XFLjpHIBQ1-E65lN9Pg_1g/artifacts/public/build/target.test_packages.json 05:36:27 INFO - Downloading https://queue.taskcluster.net/v1/task/XFLjpHIBQ1-E65lN9Pg_1g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:36:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XFLjpHIBQ1-E65lN9Pg_1g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:36:28 INFO - Downloaded 989 bytes. 05:36:28 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:36:28 INFO - Using the following test package requirements: 05:36:28 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:36:28 INFO - u'common': [u'target.common.tests.zip'], 05:36:28 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:36:28 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:36:28 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:36:28 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:36:28 INFO - u'mozbase': [u'target.common.tests.zip'], 05:36:28 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:36:28 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:36:28 INFO - u'web-platform': [u'target.common.tests.zip', 05:36:28 INFO - u'target.web-platform.tests.tar.gz'], 05:36:28 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:36:28 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 05:36:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XFLjpHIBQ1-E65lN9Pg_1g/artifacts/public/build/target.common.tests.zip 05:36:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XFLjpHIBQ1-E65lN9Pg_1g/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:36:28 INFO - Fetch https://queue.taskcluster.net/v1/task/XFLjpHIBQ1-E65lN9Pg_1g/artifacts/public/build/target.common.tests.zip into memory 05:36:29 INFO - Content-Length response header: 55176995 05:36:29 INFO - Bytes received: 55176995 05:36:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XFLjpHIBQ1-E65lN9Pg_1g/artifacts/public/build/target.talos.tests.zip 05:36:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XFLjpHIBQ1-E65lN9Pg_1g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:36:40 INFO - Fetch https://queue.taskcluster.net/v1/task/XFLjpHIBQ1-E65lN9Pg_1g/artifacts/public/build/target.talos.tests.zip into memory 05:36:41 INFO - Content-Length response header: 14509184 05:36:41 INFO - Bytes received: 14509184 05:36:41 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')]} 05:36:41 INFO - trying https://queue.taskcluster.net/v1/task/XFLjpHIBQ1-E65lN9Pg_1g/artifacts/public/build/target.tar.bz2 05:36:41 INFO - Downloading https://queue.taskcluster.net/v1/task/XFLjpHIBQ1-E65lN9Pg_1g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:36:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XFLjpHIBQ1-E65lN9Pg_1g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:36:43 INFO - Downloaded 53514912 bytes. 05:36:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XFLjpHIBQ1-E65lN9Pg_1g/artifacts/public/build/target.tar.bz2 05:36:43 INFO - mkdir: /builds/slave/test/properties 05:36:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:36:43 INFO - Writing to file /builds/slave/test/properties/build_url 05:36:43 INFO - Contents: 05:36:43 INFO - build_url:https://queue.taskcluster.net/v1/task/XFLjpHIBQ1-E65lN9Pg_1g/artifacts/public/build/target.tar.bz2 05:36:43 INFO - Running post-action listener: _resource_record_post_action 05:36:43 INFO - Running post-action listener: find_tests_for_verification 05:36:43 INFO - Running post-action listener: set_extra_try_arguments 05:36:43 INFO - [mozharness: 2017-10-02 12:36:43.972227Z] Finished download-and-extract step (success) 05:36:43 INFO - [mozharness: 2017-10-02 12:36:43.972324Z] Running populate-webroot step. 05:36:43 INFO - Running pre-action listener: _resource_record_pre_action 05:36:43 INFO - Running main action method: populate_webroot 05:36:43 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:36:43 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:36:43 INFO - 'tests': ['tresize', 05:36:43 INFO - 'tcanvasmark']}, 05:36:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:36:43 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:36:43 INFO - 'tests': ['dromaeo_css', 05:36:43 INFO - 'kraken']}, 05:36:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:36:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:36:43 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:36:43 INFO - 'talos_options': ['--disable-stylo'], 05:36:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:36:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:36:43 INFO - 'tests': ['damp', 'tps']}, 05:36:43 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:36:43 INFO - 'talos_options': ['--disable-stylo'], 05:36:43 INFO - 'tests': ['damp', 'tps']}, 05:36:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:36:43 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:36:43 INFO - 'tests': ['dromaeo_dom']}, 05:36:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:36:43 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:36:43 INFO - 'tests': ['basic_compositor_video', 05:36:43 INFO - 'glvideo']}, 05:36:43 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:36:43 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:36:43 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:36:43 INFO - 'talos_options': ['--disable-stylo'], 05:36:43 INFO - 'tests': ['ts_paint_webext', 05:36:43 INFO - 'tp5o_webext']}, 05:36:43 INFO - 'other-e10s': {'tests': ['a11yr', 05:36:43 INFO - 'ts_paint', 05:36:43 INFO - 'tpaint', 05:36:43 INFO - 'sessionrestore', 05:36:43 INFO - 'sessionrestore_many_windows', 05:36:43 INFO - 'sessionrestore_no_auto_restore', 05:36:43 INFO - 'tabpaint']}, 05:36:43 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:36:43 INFO - 'tests': ['a11yr', 05:36:43 INFO - 'ts_paint', 05:36:43 INFO - 'tpaint', 05:36:43 INFO - 'sessionrestore', 05:36:43 INFO - 'sessionrestore_many_windows', 05:36:43 INFO - 'sessionrestore_no_auto_restore', 05:36:43 INFO - 'tabpaint']}, 05:36:43 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 05:36:43 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 05:36:43 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:36:43 INFO - 'tests': ['perf_reftest_singletons']}, 05:36:43 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:36:43 INFO - 'tests': ['bloom_basic']}, 05:36:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:36:43 INFO - 'tsvgr_opacity', 05:36:43 INFO - 'tart', 05:36:43 INFO - 'tscrollx', 05:36:43 INFO - 'tsvg_static']}, 05:36:43 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:36:43 INFO - 'tests': ['tsvgx', 05:36:43 INFO - 'tsvgr_opacity', 05:36:43 INFO - 'tart', 05:36:43 INFO - 'tscrollx', 05:36:43 INFO - 'tsvg_static']}, 05:36:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:36:43 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:36:43 INFO - 'talos_options': ['--disable-stylo'], 05:36:43 INFO - 'tests': ['tp5o']}, 05:36:43 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:36:43 INFO - 'talos_options': ['--mitmproxy', 05:36:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:36:43 INFO - '--firstNonBlankPaint'], 05:36:43 INFO - 'tests': ['tp6_google', 05:36:43 INFO - 'tp6_youtube', 05:36:43 INFO - 'tp6_amazon', 05:36:43 INFO - 'tp6_facebook']}, 05:36:43 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:36:43 INFO - 'talos_options': ['--disable-stylo', 05:36:43 INFO - '--mitmproxy', 05:36:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:36:43 INFO - '--firstNonBlankPaint'], 05:36:43 INFO - 'tests': ['tp6_google', 05:36:43 INFO - 'tp6_youtube', 05:36:43 INFO - 'tp6_amazon', 05:36:43 INFO - 'tp6_facebook']}, 05:36:43 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:36:43 INFO - 'talos_options': ['--stylo-threads=1', 05:36:43 INFO - '--mitmproxy', 05:36:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:36:43 INFO - '--firstNonBlankPaint'], 05:36:43 INFO - 'tests': ['tp6_google', 05:36:43 INFO - 'tp6_youtube', 05:36:43 INFO - 'tp6_amazon', 05:36:43 INFO - 'tp6_facebook']}, 05:36:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:36:43 INFO - 'talos_options': ['--xperf_path', 05:36:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:36:43 INFO - 'tests': ['tp5n']}, 05:36:43 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:36:43 INFO - 'talos_options': ['--disable-stylo', 05:36:43 INFO - '--xperf_path', 05:36:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:36:43 INFO - 'tests': ['tp5n']}}} 05:36:43 INFO - Running post-action listener: _resource_record_post_action 05:36:43 INFO - [mozharness: 2017-10-02 12:36:43.987207Z] Finished populate-webroot step (success) 05:36:43 INFO - [mozharness: 2017-10-02 12:36:43.987308Z] Running create-virtualenv step. 05:36:43 INFO - Running pre-action listener: _resource_record_pre_action 05:36:43 INFO - Running main action method: create_virtualenv 05:36:43 INFO - Creating virtualenv /builds/slave/test/build/venv 05:36:43 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:36:43 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 05:36:43 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:36:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:36:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:36:44 INFO - Installing distribute.............................................................................................................................................................................................done. 05:36:45 INFO - Installing pip...............done. 05:36:45 INFO - Return code: 0 05:36:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:36:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:36:45 INFO - Reading from file tmpfile_stdout 05:36:45 INFO - Output received: 05:36:45 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 05:36:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:36: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')]} 05:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36: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')]} 05:36:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1143090>, '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 0x1143d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x113df90>, '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': 'fa44defc139c4ba8574fe040000001db-1506947580.571284-1832286885', '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 05:36:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:36:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:36:45 INFO - Using env: {'DISPLAY': ':0', 05:36:45 INFO - 'HOME': '/home/cltbld', 05:36:45 INFO - 'LANG': 'en_US.UTF-8', 05:36:45 INFO - 'LANGUAGE': 'en_US:en', 05:36:45 INFO - 'LOGNAME': 'cltbld', 05:36:45 INFO - 'MAIL': '/var/mail/cltbld', 05:36:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:45 INFO - 'MOZ_NO_REMOTE': '1', 05:36:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:45 INFO - 'NO_EM_RESTART': '1', 05:36:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:45 INFO - 'PWD': '/builds/slave/test', 05:36:45 INFO - 'SHELL': '/bin/bash', 05:36:45 INFO - 'SHLVL': '1', 05:36:45 INFO - 'TERM': 'linux', 05:36:45 INFO - 'TMOUT': '86400', 05:36:45 INFO - 'USER': 'cltbld', 05:36:45 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506947580.571284-1832286885', 05:36:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:45 INFO - '_': '/tools/buildbot/bin/python'} 05:36:46 INFO - Ignoring indexes: http://pypi.python.org/simple/ 05:36:46 INFO - Downloading/unpacking pip>=1.5 05:36:46 INFO - Running setup.py egg_info for package pip 05:36:46 INFO - warning: no files found matching 'pip/cacert.pem' 05:36:46 INFO - warning: no files found matching '*.html' under directory 'docs' 05:36:46 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 05:36:46 INFO - no previously-included directories found matching 'docs/_build/_sources' 05:36:46 INFO - Installing collected packages: pip 05:36:46 INFO - Found existing installation: pip 1.1 05:36:46 INFO - Uninstalling pip: 05:36:46 INFO - Successfully uninstalled pip 05:36:46 INFO - Running setup.py install for pip 05:36:46 INFO - warning: no files found matching 'pip/cacert.pem' 05:36:46 INFO - warning: no files found matching '*.html' under directory 'docs' 05:36:46 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 05:36:46 INFO - no previously-included directories found matching 'docs/_build/_sources' 05:36:46 INFO - Installing pip script to /builds/slave/test/build/venv/bin 05:36:46 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 05:36:46 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 05:36:46 INFO - Successfully installed pip 05:36:46 INFO - Cleaning up... 05:36:46 INFO - Return code: 0 05:36:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:36:46 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')]} 05:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:46 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')]} 05:36:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:46 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 0xdd41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1143090>, '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 0x1143d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x113df90>, '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': 'fa44defc139c4ba8574fe040000001db-1506947580.571284-1832286885', '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 05:36:46 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 05:36:46 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 05:36:46 INFO - Using env: {'DISPLAY': ':0', 05:36:46 INFO - 'HOME': '/home/cltbld', 05:36:46 INFO - 'LANG': 'en_US.UTF-8', 05:36:46 INFO - 'LANGUAGE': 'en_US:en', 05:36:46 INFO - 'LOGNAME': 'cltbld', 05:36:46 INFO - 'MAIL': '/var/mail/cltbld', 05:36:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:46 INFO - 'MOZ_NO_REMOTE': '1', 05:36:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:46 INFO - 'NO_EM_RESTART': '1', 05:36:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:46 INFO - 'PWD': '/builds/slave/test', 05:36:46 INFO - 'SHELL': '/bin/bash', 05:36:46 INFO - 'SHLVL': '1', 05:36:46 INFO - 'TERM': 'linux', 05:36:46 INFO - 'TMOUT': '86400', 05:36:46 INFO - 'USER': 'cltbld', 05:36:46 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506947580.571284-1832286885', 05:36:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:46 INFO - '_': '/tools/buildbot/bin/python'} 05:36:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:46 INFO - Downloading/unpacking psutil>=3.1.1 05:36: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 05:36: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 05:36: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 05:36: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 05:36:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:36:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:36:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:36:48 INFO - Installing collected packages: psutil 05:36:48 INFO - Running setup.py install for psutil 05:36:48 INFO - building 'psutil._psutil_linux' extension 05:36:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:36:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:36:48 INFO - building 'psutil._psutil_posix' extension 05:36:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:36:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:36:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:36:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:36:48 INFO - Successfully installed psutil 05:36:48 INFO - Cleaning up... 05:36:48 INFO - Return code: 0 05:36:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:36: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')]} 05:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36: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')]} 05:36:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1143090>, '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 0x1143d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x113df90>, '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': 'fa44defc139c4ba8574fe040000001db-1506947580.571284-1832286885', '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 05:36: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:36: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 mozsystemmonitor==0.3 05:36:48 INFO - Using env: {'DISPLAY': ':0', 05:36:48 INFO - 'HOME': '/home/cltbld', 05:36:48 INFO - 'LANG': 'en_US.UTF-8', 05:36:48 INFO - 'LANGUAGE': 'en_US:en', 05:36:48 INFO - 'LOGNAME': 'cltbld', 05:36:48 INFO - 'MAIL': '/var/mail/cltbld', 05:36:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:48 INFO - 'MOZ_NO_REMOTE': '1', 05:36:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:48 INFO - 'NO_EM_RESTART': '1', 05:36:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:48 INFO - 'PWD': '/builds/slave/test', 05:36:48 INFO - 'SHELL': '/bin/bash', 05:36:48 INFO - 'SHLVL': '1', 05:36:48 INFO - 'TERM': 'linux', 05:36:48 INFO - 'TMOUT': '86400', 05:36:48 INFO - 'USER': 'cltbld', 05:36:48 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506947580.571284-1832286885', 05:36:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:48 INFO - '_': '/tools/buildbot/bin/python'} 05:36:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:36:48 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 05:36:48 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 05:36:48 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 05:36:48 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 05:36:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:36:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:36:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:36:50 INFO - Installing collected packages: mozsystemmonitor 05:36:50 INFO - Running setup.py install for mozsystemmonitor 05:36:50 INFO - Successfully installed mozsystemmonitor 05:36:50 INFO - Cleaning up... 05:36:51 INFO - Return code: 0 05:36:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:36:51 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')]} 05:36:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:51 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')]} 05:36:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:51 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 0xdd41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1143090>, '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 0x1143d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x113df90>, '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': 'fa44defc139c4ba8574fe040000001db-1506947580.571284-1832286885', '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 05:36:51 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 05:36:51 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 05:36:51 INFO - Using env: {'DISPLAY': ':0', 05:36:51 INFO - 'HOME': '/home/cltbld', 05:36:51 INFO - 'LANG': 'en_US.UTF-8', 05:36:51 INFO - 'LANGUAGE': 'en_US:en', 05:36:51 INFO - 'LOGNAME': 'cltbld', 05:36:51 INFO - 'MAIL': '/var/mail/cltbld', 05:36:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:51 INFO - 'MOZ_NO_REMOTE': '1', 05:36:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:51 INFO - 'NO_EM_RESTART': '1', 05:36:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:51 INFO - 'PWD': '/builds/slave/test', 05:36:51 INFO - 'SHELL': '/bin/bash', 05:36:51 INFO - 'SHLVL': '1', 05:36:51 INFO - 'TERM': 'linux', 05:36:51 INFO - 'TMOUT': '86400', 05:36:51 INFO - 'USER': 'cltbld', 05:36:51 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506947580.571284-1832286885', 05:36:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:51 INFO - '_': '/tools/buildbot/bin/python'} 05:36:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:51 INFO - Downloading/unpacking jsonschema==2.5.1 05:36:51 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 05:36:51 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 05:36:51 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 05:36:51 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 05:36:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:36:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:36:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:52 INFO - Downloading functools32-3.2.3-2.tar.gz 05:36:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:36:52 INFO - warning: no files found matching '*.txt' 05:36:52 INFO - no previously-included directories found matching 'build' 05:36:52 INFO - no previously-included directories found matching 'dist' 05:36:52 INFO - no previously-included directories found matching '.git*' 05:36:52 INFO - Installing collected packages: jsonschema, functools32 05:36:52 INFO - Running setup.py install for functools32 05:36:52 INFO - warning: no files found matching '*.txt' 05:36:52 INFO - no previously-included directories found matching 'build' 05:36:52 INFO - no previously-included directories found matching 'dist' 05:36:52 INFO - no previously-included directories found matching '.git*' 05:36:52 INFO - Successfully installed jsonschema functools32 05:36:52 INFO - Cleaning up... 05:36:53 INFO - Return code: 0 05:36:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:36:53 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')]} 05:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:53 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')]} 05:36:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:53 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 0xdd41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1143090>, '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 0x1143d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x113df90>, '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': 'fa44defc139c4ba8574fe040000001db-1506947580.571284-1832286885', '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 05:36:53 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 05:36:53 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 05:36:53 INFO - Using env: {'DISPLAY': ':0', 05:36:53 INFO - 'HOME': '/home/cltbld', 05:36:53 INFO - 'LANG': 'en_US.UTF-8', 05:36:53 INFO - 'LANGUAGE': 'en_US:en', 05:36:53 INFO - 'LOGNAME': 'cltbld', 05:36:53 INFO - 'MAIL': '/var/mail/cltbld', 05:36:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:53 INFO - 'MOZ_NO_REMOTE': '1', 05:36:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:53 INFO - 'NO_EM_RESTART': '1', 05:36:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:53 INFO - 'PWD': '/builds/slave/test', 05:36:53 INFO - 'SHELL': '/bin/bash', 05:36:53 INFO - 'SHLVL': '1', 05:36:53 INFO - 'TERM': 'linux', 05:36:53 INFO - 'TMOUT': '86400', 05:36:53 INFO - 'USER': 'cltbld', 05:36:53 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506947580.571284-1832286885', 05:36:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:53 INFO - '_': '/tools/buildbot/bin/python'} 05:36:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:36:54 INFO - Cleaning up... 05:36:54 INFO - Return code: 0 05:36:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:36:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1143090>, '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 0x1143d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x113df90>, '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': 'fa44defc139c4ba8574fe040000001db-1506947580.571284-1832286885', '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 05:36:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:36:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:36:54 INFO - Using env: {'DISPLAY': ':0', 05:36:54 INFO - 'HOME': '/home/cltbld', 05:36:54 INFO - 'LANG': 'en_US.UTF-8', 05:36:54 INFO - 'LANGUAGE': 'en_US:en', 05:36:54 INFO - 'LOGNAME': 'cltbld', 05:36:54 INFO - 'MAIL': '/var/mail/cltbld', 05:36:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:54 INFO - 'MOZ_NO_REMOTE': '1', 05:36:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:54 INFO - 'NO_EM_RESTART': '1', 05:36:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:54 INFO - 'PWD': '/builds/slave/test', 05:36:54 INFO - 'SHELL': '/bin/bash', 05:36:54 INFO - 'SHLVL': '1', 05:36:54 INFO - 'TERM': 'linux', 05:36:54 INFO - 'TMOUT': '86400', 05:36:54 INFO - 'USER': 'cltbld', 05:36:54 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506947580.571284-1832286885', 05:36:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:54 INFO - '_': '/tools/buildbot/bin/python'} 05:36:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:54 INFO - Downloading/unpacking blobuploader==1.2.4 05:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:55 INFO - Downloading blobuploader-1.2.4.tar.gz 05:36:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:36:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:36:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:56 INFO - Downloading docopt-0.6.1.tar.gz 05:36:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:36:56 INFO - Installing collected packages: blobuploader, requests, docopt 05:36:56 INFO - Running setup.py install for blobuploader 05:36:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:36:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:36:56 INFO - Running setup.py install for requests 05:36:56 INFO - Running setup.py install for docopt 05:36:56 INFO - Successfully installed blobuploader requests docopt 05:36:56 INFO - Cleaning up... 05:36:56 INFO - Return code: 0 05:36:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:36:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1143090>, '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 0x1143d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x113df90>, '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': 'fa44defc139c4ba8574fe040000001db-1506947580.571284-1832286885', '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 05:36:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:36:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:36:56 INFO - Using env: {'DISPLAY': ':0', 05:36:56 INFO - 'HOME': '/home/cltbld', 05:36:56 INFO - 'LANG': 'en_US.UTF-8', 05:36:56 INFO - 'LANGUAGE': 'en_US:en', 05:36:56 INFO - 'LOGNAME': 'cltbld', 05:36:56 INFO - 'MAIL': '/var/mail/cltbld', 05:36:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:56 INFO - 'MOZ_NO_REMOTE': '1', 05:36:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:56 INFO - 'NO_EM_RESTART': '1', 05:36:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:56 INFO - 'PWD': '/builds/slave/test', 05:36:56 INFO - 'SHELL': '/bin/bash', 05:36:56 INFO - 'SHLVL': '1', 05:36:56 INFO - 'TERM': 'linux', 05:36:56 INFO - 'TMOUT': '86400', 05:36:56 INFO - 'USER': 'cltbld', 05:36:56 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506947580.571284-1832286885', 05:36:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:56 INFO - '_': '/tools/buildbot/bin/python'} 05:36:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:36:57 INFO - Running setup.py (path:/tmp/pip-NAcLi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:36:57 INFO - Running setup.py (path:/tmp/pip-7gZZyR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:36:57 INFO - Running setup.py (path:/tmp/pip-VhVTZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:36:57 INFO - Running setup.py (path:/tmp/pip-A12GSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:36:57 INFO - Running setup.py (path:/tmp/pip-lKGlGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:36:57 INFO - Running setup.py (path:/tmp/pip-rV0YjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:36:57 INFO - Running setup.py (path:/tmp/pip-70EG2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:36:57 INFO - Running setup.py (path:/tmp/pip-2yo7n0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:36:57 INFO - Running setup.py (path:/tmp/pip-3SwApe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:36:57 INFO - Running setup.py (path:/tmp/pip-2inbFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:36:57 INFO - Running setup.py (path:/tmp/pip-JPbS4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:36:57 INFO - Running setup.py (path:/tmp/pip-VlCXOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:36:57 INFO - Running setup.py (path:/tmp/pip-_W6Dgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:36:57 INFO - Running setup.py (path:/tmp/pip-xLWVZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:36:57 INFO - Running setup.py (path:/tmp/pip-1Kag_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:36:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:36:58 INFO - Running setup.py (path:/tmp/pip-Awv_gE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:36:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:36:58 INFO - Running setup.py (path:/tmp/pip-4T8_bf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:36:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:36:58 INFO - Running setup.py install for manifestparser 05:36:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:36:58 INFO - Running setup.py install for mozcrash 05:36:58 INFO - Running setup.py install for mozdebug 05:36:58 INFO - Running setup.py install for mozdevice 05:36:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:36:58 INFO - Running setup.py install for mozfile 05:36:58 INFO - Running setup.py install for mozhttpd 05:36:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:36:58 INFO - Running setup.py install for mozinfo 05:36:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:36:58 INFO - Running setup.py install for mozInstall 05:36:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:36:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:36:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:36:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:36:58 INFO - Running setup.py install for mozleak 05:36:59 INFO - Running setup.py install for mozlog 05:36:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:36:59 INFO - Running setup.py install for moznetwork 05:36:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:36:59 INFO - Running setup.py install for mozprocess 05:36:59 INFO - Running setup.py install for mozprofile 05:36:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:36:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:36:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:36:59 INFO - Running setup.py install for mozrunner 05:36:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:36:59 INFO - Running setup.py install for mozscreenshot 05:36:59 INFO - Running setup.py install for moztest 05:36:59 INFO - Running setup.py install for mozversion 05:36:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:36:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:36:59 INFO - Cleaning up... 05:36:59 INFO - Return code: 0 05:36:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:36:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:59 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 0xdd41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1143090>, '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 0x1143d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x113df90>, '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': 'fa44defc139c4ba8574fe040000001db-1506947580.571284-1832286885', '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 05:36:59 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 05:36:59 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 05:36:59 INFO - Using env: {'DISPLAY': ':0', 05:36:59 INFO - 'HOME': '/home/cltbld', 05:36:59 INFO - 'LANG': 'en_US.UTF-8', 05:36:59 INFO - 'LANGUAGE': 'en_US:en', 05:36:59 INFO - 'LOGNAME': 'cltbld', 05:36:59 INFO - 'MAIL': '/var/mail/cltbld', 05:36:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:59 INFO - 'MOZ_NO_REMOTE': '1', 05:36:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:59 INFO - 'NO_EM_RESTART': '1', 05:36:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:59 INFO - 'PWD': '/builds/slave/test', 05:36:59 INFO - 'SHELL': '/bin/bash', 05:36:59 INFO - 'SHLVL': '1', 05:36:59 INFO - 'TERM': 'linux', 05:36:59 INFO - 'TMOUT': '86400', 05:36:59 INFO - 'USER': 'cltbld', 05:36:59 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506947580.571284-1832286885', 05:36:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:59 INFO - '_': '/tools/buildbot/bin/python'} 05:37:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:37:00 INFO - Running setup.py (path:/tmp/pip-4W9R2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:37:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:37:00 INFO - Running setup.py (path:/tmp/pip-xd0NQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:37:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:37:00 INFO - Running setup.py (path:/tmp/pip-4sKEJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:37:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:37:00 INFO - Running setup.py (path:/tmp/pip-ERubz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:37:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:37:00 INFO - Running setup.py (path:/tmp/pip-g8GBw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:37:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:37:00 INFO - Running setup.py (path:/tmp/pip-5usfgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:37:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:37:00 INFO - Running setup.py (path:/tmp/pip-SzTvqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:37:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:37:00 INFO - Running setup.py (path:/tmp/pip-szTTg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:37:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:37:00 INFO - Running setup.py (path:/tmp/pip-G7FaeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:37:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:37:00 INFO - Running setup.py (path:/tmp/pip-WCoHrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:37:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:37:00 INFO - Running setup.py (path:/tmp/pip-mJPm9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:37:00 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)) 05:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:37:01 INFO - Running setup.py (path:/tmp/pip-FZDi1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:37:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:37:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:37:01 INFO - Running setup.py (path:/tmp/pip-Vky0Sj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:37:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:37:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:37:01 INFO - Running setup.py (path:/tmp/pip-Xeq0wV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:37:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:37:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:37:01 INFO - Running setup.py (path:/tmp/pip-jykiU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:37:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:37:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:37:01 INFO - Running setup.py (path:/tmp/pip-dCFoa9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:37:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:37:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:37:01 INFO - Running setup.py (path:/tmp/pip-x59hJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:37:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:37:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:37:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:37:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:37:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:37:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:37:01 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:37:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:02 INFO - Downloading blessings-1.6.tar.gz 05:37:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:37:02 INFO - Installing collected packages: blessings 05:37:02 INFO - Running setup.py install for blessings 05:37:02 INFO - Successfully installed blessings 05:37:02 INFO - Cleaning up... 05:37:02 INFO - Return code: 0 05:37:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:37:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:37:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:37:02 INFO - Reading from file tmpfile_stdout 05:37:02 INFO - Current package versions: 05:37:02 INFO - argparse == 1.2.1 05:37:02 INFO - blessings == 1.6 05:37:02 INFO - blobuploader == 1.2.4 05:37:02 INFO - docopt == 0.6.1 05:37:02 INFO - functools32 == 3.2.3-2 05:37:02 INFO - jsonschema == 2.5.1 05:37:02 INFO - manifestparser == 1.1 05:37:02 INFO - mozInstall == 1.13 05:37:02 INFO - mozcrash == 1.0 05:37:02 INFO - mozdebug == 0.1 05:37:02 INFO - mozdevice == 0.51 05:37:02 INFO - mozfile == 1.2 05:37:02 INFO - mozhttpd == 0.7 05:37:02 INFO - mozinfo == 0.10 05:37:02 INFO - mozleak == 0.1 05:37:02 INFO - mozlog == 3.5 05:37:02 INFO - moznetwork == 0.27 05:37:02 INFO - mozprocess == 0.25 05:37:02 INFO - mozprofile == 0.28 05:37:02 INFO - mozrunner == 6.13 05:37:02 INFO - mozscreenshot == 0.1 05:37:02 INFO - mozsystemmonitor == 0.3 05:37:02 INFO - moztest == 0.8 05:37:02 INFO - mozversion == 1.4 05:37:02 INFO - psutil == 3.1.1 05:37:02 INFO - requests == 1.2.3 05:37:03 INFO - wsgiref == 0.1.2 05:37:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:37:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1143090>, '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 0x1143d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x113df90>, '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': 'fa44defc139c4ba8574fe040000001db-1506947580.571284-1832286885', '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 05:37:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:37:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:37:03 INFO - Using env: {'DISPLAY': ':0', 05:37:03 INFO - 'HOME': '/home/cltbld', 05:37:03 INFO - 'LANG': 'en_US.UTF-8', 05:37:03 INFO - 'LANGUAGE': 'en_US:en', 05:37:03 INFO - 'LOGNAME': 'cltbld', 05:37:03 INFO - 'MAIL': '/var/mail/cltbld', 05:37:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:03 INFO - 'MOZ_NO_REMOTE': '1', 05:37:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:03 INFO - 'NO_EM_RESTART': '1', 05:37:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:03 INFO - 'PWD': '/builds/slave/test', 05:37:03 INFO - 'SHELL': '/bin/bash', 05:37:03 INFO - 'SHLVL': '1', 05:37:03 INFO - 'TERM': 'linux', 05:37:03 INFO - 'TMOUT': '86400', 05:37:03 INFO - 'USER': 'cltbld', 05:37:03 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506947580.571284-1832286885', 05:37:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:03 INFO - '_': '/tools/buildbot/bin/python'} 05:37:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:37:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:37:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:37:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:37:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:37:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:37:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:37:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:37:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:37:03 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:37:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 05:37:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:37:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:37:04 INFO - Installing collected packages: simplejson 05:37:04 INFO - Running setup.py install for simplejson 05:37:04 INFO - building 'simplejson._speedups' extension 05:37:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 05:37:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 05:37:05 INFO - Successfully installed simplejson 05:37:05 INFO - Cleaning up... 05:37:05 INFO - Return code: 0 05:37:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:37: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')]} 05:37:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37: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')]} 05:37:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1143090>, '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 0x1143d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x113df90>, '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': 'fa44defc139c4ba8574fe040000001db-1506947580.571284-1832286885', '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 05:37:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:37:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:37:05 INFO - Using env: {'DISPLAY': ':0', 05:37:05 INFO - 'HOME': '/home/cltbld', 05:37:05 INFO - 'LANG': 'en_US.UTF-8', 05:37:05 INFO - 'LANGUAGE': 'en_US:en', 05:37:05 INFO - 'LOGNAME': 'cltbld', 05:37:05 INFO - 'MAIL': '/var/mail/cltbld', 05:37:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:05 INFO - 'MOZ_NO_REMOTE': '1', 05:37:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:05 INFO - 'NO_EM_RESTART': '1', 05:37:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:05 INFO - 'PWD': '/builds/slave/test', 05:37:05 INFO - 'SHELL': '/bin/bash', 05:37:05 INFO - 'SHLVL': '1', 05:37:05 INFO - 'TERM': 'linux', 05:37:05 INFO - 'TMOUT': '86400', 05:37:05 INFO - 'USER': 'cltbld', 05:37:05 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506947580.571284-1832286885', 05:37:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:05 INFO - '_': '/tools/buildbot/bin/python'} 05:37:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:37:05 INFO - Cleaning up... 05:37:05 INFO - Return code: 0 05:37:05 INFO - Running post-action listener: _resource_record_post_action 05:37:05 INFO - Running post-action listener: _start_resource_monitoring 05:37:05 INFO - Starting resource monitoring. 05:37:05 INFO - [mozharness: 2017-10-02 12:37:05.703785Z] Finished create-virtualenv step (success) 05:37:05 INFO - [mozharness: 2017-10-02 12:37:05.704304Z] Running install step. 05:37:05 INFO - Running pre-action listener: _resource_record_pre_action 05:37:05 INFO - Running main action method: install 05:37:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:37:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:37:05 INFO - Reading from file tmpfile_stdout 05:37:05 INFO - Detecting whether we're running mozinstall >=1.0... 05:37:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:37:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:37:06 INFO - Reading from file tmpfile_stdout 05:37:06 INFO - Output received: 05:37:06 INFO - Usage: mozinstall [options] installer 05:37:06 INFO - Options: 05:37:06 INFO - -h, --help show this help message and exit 05:37:06 INFO - -d DEST, --destination=DEST 05:37:06 INFO - Directory to install application into. [default: 05:37:06 INFO - "/builds/slave/test"] 05:37:06 INFO - --app=APP Application being installed. [default: firefox] 05:37:06 INFO - mkdir: /builds/slave/test/build/application 05:37:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:37:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:37:20 INFO - Reading from file tmpfile_stdout 05:37:20 INFO - Output received: 05:37:20 INFO - /builds/slave/test/build/application/firefox/firefox 05:37:20 INFO - Running post-action listener: _resource_record_post_action 05:37:20 INFO - [mozharness: 2017-10-02 12:37:20.665950Z] Finished install step (success) 05:37:20 INFO - [mozharness: 2017-10-02 12:37:20.666289Z] Running setup-mitmproxy step. 05:37:20 INFO - Running pre-action listener: _resource_record_pre_action 05:37:20 INFO - Running main action method: setup_mitmproxy 05:37:20 INFO - Skipping: mitmproxy is not required 05:37:20 INFO - Running post-action listener: _resource_record_post_action 05:37:20 INFO - [mozharness: 2017-10-02 12:37:20.667950Z] Finished setup-mitmproxy step (success) 05:37:20 INFO - [mozharness: 2017-10-02 12:37:20.668262Z] Running run-tests step. 05:37:20 INFO - Running pre-action listener: _resource_record_pre_action 05:37:20 INFO - Running pre-action listener: _set_gcov_prefix 05:37:20 INFO - Running main action method: run_tests 05:37:20 WARNING - Try message not found. 05:37:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:37:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:37:20 INFO - Python 2.7.3 05:37:20 INFO - Return code: 0 05:37:20 INFO - grabbing minidump binary from tooltool 05:37:20 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')]} 05:37:20 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 0x1143090>, '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 0x1143d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x113df90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:37:20 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 05:37:20 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 05:37:20 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 05:37:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:37:20 INFO - Return code: 0 05:37:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:37:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:37:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:37:20 INFO - ENV: RUST_BACKTRACE is now full 05:37:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:37:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:37:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XFLjpHIBQ1-E65lN9Pg_1g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 05:37:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XFLjpHIBQ1-E65lN9Pg_1g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 05:37:20 INFO - Using env: {'DISPLAY': ':0', 05:37:20 INFO - 'HOME': '/home/cltbld', 05:37:20 INFO - 'LANG': 'en_US.UTF-8', 05:37:20 INFO - 'LANGUAGE': 'en_US:en', 05:37:20 INFO - 'LOGNAME': 'cltbld', 05:37:20 INFO - 'MAIL': '/var/mail/cltbld', 05:37:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:37:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:37:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:20 INFO - 'MOZ_NO_REMOTE': '1', 05:37:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:37:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:20 INFO - 'NO_EM_RESTART': '1', 05:37:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:20 INFO - 'PWD': '/builds/slave/test', 05:37:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:37:20 INFO - 'RUST_BACKTRACE': 'full', 05:37:20 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:37:20 INFO - 'SHELL': '/bin/bash', 05:37:20 INFO - 'SHLVL': '1', 05:37:20 INFO - 'TERM': 'linux', 05:37:20 INFO - 'TMOUT': '86400', 05:37:20 INFO - 'USER': 'cltbld', 05:37:20 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506947580.571284-1832286885', 05:37:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:20 INFO - '_': '/tools/buildbot/bin/python'} 05:37:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XFLjpHIBQ1-E65lN9Pg_1g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 05:37:21 INFO - mozversion application_buildid: 20171002111457 05:37:21 INFO - mozversion application_changeset: d248045d3695ae01b8caafb3dde608c2c6ed80ef 05:37:21 INFO - mozversion application_display_name: Firefox 05:37:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:37:21 INFO - mozversion application_name: Firefox 05:37:21 INFO - mozversion application_remotingname: firefox 05:37:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:37:21 INFO - mozversion application_vendor: Mozilla 05:37:21 INFO - mozversion application_version: 57.0 05:37:21 INFO - mozversion platform_buildid: 20171002111457 05:37:21 INFO - mozversion platform_changeset: d248045d3695ae01b8caafb3dde608c2c6ed80ef 05:37:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:37:21 INFO - mozversion platform_version: 57.0 05:37:21 INFO - using testdate: 1506947841 05:37:21 INFO - actual date: 1506947841 05:37:21 INFO - starting webserver on 'localhost:34203' 05:37:21 INFO - SUITE-START | Running 2 tests 05:37:21 INFO - TEST-START | dromaeo_css 05:37:21 INFO - Initialising browser for dromaeo_css test... 05:37:21 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34203/getInfo.html -profile /tmp/tmpu9uKJW/profile 05:37:21 INFO - TEST-INFO | started process 31060 (/builds/slave/test/build/application/firefox/firefox http://localhost:34203/getInfo.html) 05:37:26 INFO - TEST-INFO | 31060: exit 0 05:37:26 INFO - Browser initialized. 05:37:26 INFO - Running cycle 1/1 for dromaeo_css test... 05:37:26 INFO - Using env: {'DISPLAY': ':0', 05:37:26 INFO - 'HOME': '/home/cltbld', 05:37:26 INFO - 'JSGC_DISABLE_POISONING': '1', 05:37:26 INFO - 'LANG': 'en_US.UTF-8', 05:37:26 INFO - 'LANGUAGE': 'en_US:en', 05:37:26 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 05:37:26 INFO - 'LOGNAME': 'cltbld', 05:37:26 INFO - 'MAIL': '/var/mail/cltbld', 05:37:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:37:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:37:26 INFO - 'MOZ_CRASHREPORTER': '1', 05:37:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:26 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 05:37:26 INFO - 'MOZ_NO_REMOTE': '1', 05:37:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:37:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:26 INFO - 'NO_EM_RESTART': '1', 05:37:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:26 INFO - 'PWD': '/builds/slave/test', 05:37:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:37:26 INFO - 'RUST_BACKTRACE': 'full', 05:37:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:37:26 INFO - 'SHELL': '/bin/bash', 05:37:26 INFO - 'SHLVL': '1', 05:37:26 INFO - 'TERM': 'linux', 05:37:26 INFO - 'TMOUT': '86400', 05:37:26 INFO - 'USER': 'cltbld', 05:37:26 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506947580.571284-1832286885', 05:37:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:26 INFO - '_': '/tools/buildbot/bin/python'} 05:37:26 INFO - TEST-INFO | started process 31255 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu9uKJW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:37:27 INFO - PID 31255 | 05:37:27 INFO - PID 31255 | (/builds/slave/test/build/application/firefox/firefox:31305): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:37:27 INFO - PID 31255 | 05:37:37 INFO - PID 31255 | RSS: Main: 141930496 05:37:37 INFO - PID 31255 | 05:40:35 INFO - PID 31255 | Cycle 1(1): loaded http://localhost:34203/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34203/tests/dromaeo/cssquery-ext.html) 05:40:36 INFO - PID 31255 | RSS: Main: 145494016 05:40:36 INFO - PID 31255 | 05:43:38 INFO - PID 31255 | Cycle 1(1): loaded http://localhost:34203/tests/dromaeo/cssquery-ext.html (next: http://localhost:34203/tests/dromaeo/cssquery-jquery.html) 05:43:38 INFO - PID 31255 | RSS: Main: 144191488 05:43:38 INFO - PID 31255 | 05:46:40 INFO - PID 31255 | Cycle 1(1): loaded http://localhost:34203/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34203/tests/dromaeo/cssquery-mootools.html) 05:46:41 INFO - PID 31255 | RSS: Main: 145424384 05:46:41 INFO - PID 31255 | 05:49:42 INFO - PID 31255 | Cycle 1(1): loaded http://localhost:34203/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34203/tests/dromaeo/cssquery-prototype.html) 05:49:43 INFO - PID 31255 | RSS: Main: 144748544 05:49:43 INFO - PID 31255 | 05:52:45 INFO - PID 31255 | Cycle 1(1): loaded http://localhost:34203/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34203/tests/dromaeo/cssquery-yui.html) 05:52:46 INFO - PID 31255 | RSS: Main: 145924096 05:52:46 INFO - PID 31255 | 05:55:47 INFO - PID 31255 | Cycle 1(1): loaded http://localhost:34203/tests/dromaeo/cssquery-yui.html (next: http://localhost:34203/tests/dromaeo/cssquery-dojo.html) 05:55:48 INFO - PID 31255 | RSS: Main: 149221376 05:55:48 INFO - PID 31255 | 05:55:48 INFO - PID 31255 | __start_tp_report 05:55:48 INFO - PID 31255 | _x_x_mozilla_page_load 05:55:48 INFO - PID 31255 | _x_x_mozilla_page_load_details 05:55:48 INFO - PID 31255 | |i|pagename|runs| 05:55:48 INFO - PID 31255 | |0;dojo.html;4039.49506311711;4067;4071.5317738460067;4073.185362927415;4085.060436099697;6529.412352888239;6552.213734351879;6619.6028238305735;6627.86744265115;6643.468522518199;6524.967375163129;6542.051402546628;6575.14523111996;6620.404163625273;6641.070250164981;5854.590178687472;5908.113782932552;5929.110633404992;5940.821775346725;5958.553108516857;5839.065749480084;5910.645361278315;5927.940720592782;6003.8198854034445;6035.818925432222;5901.144334071557;5909.497692696104;5936.376680448534;5949.8215053548465;5958.404159584029;5832.650040997553;5921.437463440988;5968.850778730523;5990.64056156632;6010.398960103998;5818.272715910512;5832.62087964281;5842.152887831241;5895.498882594985;5988.880222395571;6441.033844923252;6470.74117035318;6484.383983521558;6506.479481641457;6540.149780528548;7016.298370162994;7033.366996970246;7110.715571377139;7110.893336599956;7156.212816590171;7034.507584469089;7091.432685385157;7094.822629434254;7173.748918787817;7186.209516953131;6535.607863528204;6558.049082882955;6640.501962352843;6648.966755166193;6661.500387470959;7302.890456643155;7305.4886157969495;7310;7363.852722945511;7404.370628496638;6872.759453419207;6969.47728920333;6997.790066298019;7090.787276381614;7116.893246601305;7094.787156385317;7105.360517553445;7107.786766397016;7115.075040244838;7118.857622847618;7018;7073.646317684198;7092.858142837114;7121.216666166718;7129.465290103263;6950.860982780316;7044.401225895754;7121.074260346122;7147.714091436284;7151.570905745672;5135.743212839343;5166.147585648401;5199.922001169985;5232.3459567554055;5247.291615631917;4661.324108004321;4676.95323046772;4726.692764970266;4736.478987311393;4770.809167633325;6730.663466826639;6746.494012949049;6748.190217173872;6811.557248778813;6828.146481689789;7088.0785497884945;7109.537880037781;7120.643967801693;7205.099362579677;7225.349718525358;6694.096296999843;6780.084688567079;6803.897941530881;6808.9659551701925;6815.863682726318;5859.384764599741;5871.941280587225;5880.147378630075;5882.02946513829;5889.116632505158;7207;7276.599787011659;7317.926820731725;7359.8160045999275;7415.3326200642205;7081.256468070778;7158.463115266376;7173.820654483471;7176.031235783311;7182.245864184186;7301.452391070585;7378.1515125761225;7393.630318483947;7488.101427828696;7504.662290196845;6979.127609048869;7041.084658994298;7058.470614703815;7065.258147894397;7074.151101867603;7092.6099064551945;7099.574025558483;7156.821079473055;7195.0646415967685;7232.240614735377;6888.48336374784;6888.586684798928;6981.5461994970165;6986.580805151707;6989.440844732511;6816.625085620339;6860.5540639858245;6883.483738719716;6891.448684105159;6904.206016308189;6787.728490860311;6789.490788190807;6842.623655698984;6864.965675171592;6890.414314783299;6840.213375461885;6909.654517274217;6947.513674042769;6975.162980442379;6987.475939304674;6654.068430419648;6656.267810540933;6669.966650166718;6744.0895479109695;6751.72993080291 05:55:48 INFO - PID 31255 | |1;ext.html;948.8956214816365;957.2246480350918;993.6720882108905;996.9451680157591;1017.1405162637569;42723.78638106809;43267.78366108165;43310.7834460828;43340.56659433405;43459.34810977834;40951;41224.58775412245;41287.38068928968;41301;41379.37930931031;7916.960415197945;8020.278174964252;8028.839423211532;8071.556064416454;8075.798105047362;8078;8170.918290817075;8199.344052475788;8204.958975205145;8208.712695055674;8686.782830429227;8860.468371897707;8870.689525866595;8872.556372181398;8881.689140880071;8739.4756314621;8741.912580874205;8772.605232764541;8790.164934331227;8806.251468625174;8504.574771261412;8548.187922147386;8559.27246184075;8564.143585641448;8565.486070835708;39803.40294895579;39816.20367592661;39937.201255974716;39948.20103597941;40023.39964900529;3796.088938654703;3837.597052309495;3839.2897313997;3852.595477474853;3881.2237552489614;33535.6646433535;33562.6643733562;33609.49585756216;33651.6634833651;33735.325293493996;5689.288838895138;5708.800191993302;5718.056520674084;5725.141228815669;5863.618864773776;231556;232207;234862;234878;235212;51969.48030519722;52501;52556;52652.47347526476;52853;61600.69199653973;61724.69137654283;62146.689266554284;63261.367386325546;63754.68122659357;18712.812871871378;18799.718004229948;18802.247910083715;18811.623767524572;18823.96468194235;15218.163001034827;15224.695506089816;15311;15408.152551609544;15441.382344706311;16119.27463264156;16165.191740412933;16199.514014579581;16252.59368515773;16282.592935176715;6511.479081673549;6527.54307198501;6572.80281591553;6645.102911106938;6704.564203326768;1116.1573012375604;1121.428071683431;1130.350048721988;1141.8801025892328;1156.0520373293818;26135.869320653655;26264.737352626613;26317.210483685136;26345.341366465607;26395.868020660157;1252.2111070025826;1261.1928365845865;1266.208619612742;1266.9176503527242;1273.496968697378;13874.098183618235;13920.30398480072;13934.790978135336;14051.156930583993;14259.857401426061;294156;294439;296361;297066;297169;58388.70805645944;62987;64072.35927640757;64102;64115.679421602596;1551.1623723189578;1563.8514341137575;1581.9841801582068;1583.5249425172171;1594.386161327897;30955.0713478596;31109.688903111586;31199.688003119678;31685.20786980344;31804.363912722078;41212.793936030124;41578.79210603928;41611.58388416077;41630.583694163885;41656.58343416527;280454;281968;282017;282129;282436;36415.63584364123;37420.06449838776;37653.62346376501;37938.8103059483;38024.23951520899;45083;46660;46668.299975499714;46794.53205468038;47113.2933006012;32470.512942306355;33744;34201.65798341985;34544.30911381708;35104.12239694028;34591.481127783605;34652.65347346494;34947.47578786371;35062.64937350696;35263.82368088143;38901;40503.797481013586;40570.39144412895;40645.593544064184;40703.59296407116;33037.17407064843;33644.49533256954;33721.32557348888;33782.324353512304;34167;24495.75504245006;24962.75037249677;25278.241652750447;25428.491430171664;25540.539865906845 05:55:48 INFO - PID 31255 | |2;jquery.html;634.5287804125402;637.1712312824884;647.9342767124507;650.4564085301863;655.5939701296239;23996;24609;24762.628560571582;24784.876075619643;24794;26450.28073175247;26845.463090738172;26970.190894273153;27082;27117.864410677917;6356.523260755439;6479.22249330081;6735.360140786617;6762.8309292267595;6770.966145169267;6689.799306020827;6768.018637297589;6774.491913106512;6777.423918966893;6778.118844550201;6555.967220163916;6699.263081061079;6699.497537684669;6797.388235058844;6808.6936087876165;6798.0822588950605;6832.897506537381;6838.316168383122;6838.863222735567;6841.863162736742;6335.619862808247;6378.521610879203;6380.489560835122;6395.744170233185;6398.07227951949;30587.847060764776;30626.84686576553;30879.691203087907;31217.21956951072;31522.36955260905;2352.235523454867;2401.2436082633913;2402.0391843262832;2403.447207142367;2404.5190961807707;20487;20922.163113475443;20979.685304720442;20985.26551570703;20997.5800483991;2448.7061552613623;2505.711843138044;2537.796976241896;2554.029468801862;2575.0343621142074;136894;143954;156640;164174;164565.17717411456;15798.9210053949;16900.57748556296;16937.830621693625;17043.318267269417;17221.138943052796;26898.193054208405;27087.1873843785;27156.185314440598;27178.456430871272;27197.456050879267;11442.542298307975;11448.3703396314;11566.248193867372;11716.297022178696;11736;10564;10672.573097076185;10694.839577406345;10816.459177041117;10887.455627218607;9898.851517227247;10037.64868229623;10041.04610062043;10063.899361006443;10173.898261017295;2786.1968413116356;2798.328401183742;2860.5137126688514;2874.655041395046;2990.3421247325555;1054.583439541377;1062.0653824634273;1063.2238465919922;1067.215596536545;1081.4484612847505;20523.692144617842;21141.788582114288;21433;21438.356849294545;21450.463738406666;1150.4937827355936;1154.8960593546622;1158.5192145259791;1162.5524173193382;1164.0338519029185;11410.714732131763;11609.419529023515;11649.12631552637;11741.589044383576;11841.526338946518;609295;634268;636911;637473;675350;132533;135690;137701.3114934419;138374.30812846072;139118.3044084773;1195.8684544700077;1252.2549083295426;1291.1026836348647;1308.2739079810797;1350.4935649131576;21455.570888581828;22185.88907055519;22209.777902221416;22270.109195631994;22385.44036399103;64123.03815442679;65003;65773.34226657673;66302;67802.30494237684;82534;84093;87626.56186719026;88567;88652.5567372159;15481.529254720783;15759.133247671489;15799.289031993818;15806.9209653951;15825.366985320457;24060;24202.75797242005;24223.152189673277;24342;24623.753762462147;19841;19975.900120499304;20269.695954560397;20363.79636203619;20383.79616203819;17663.38178163758;17943.282268709107;18094;18725.438236852915;18858.717119243498;19355.61288774245;20172.899135504227;20215;20343.4914127148;20511.589768204252;15629.687406252038;15740.921295393908;15821.762673559675;15837.683246335238;15925.522234332988;19897.801021990173;19909.402717918485;19964.3012494562;20002.39992800218;20008.49978750543 05:55:48 INFO - PID 31255 | |3;mootools.html;1395.4487977248987;1433.6487560547666;1446.0456098974678;1466.7213229486397;1474.9306752604364;17671.381501647444;18325.175367108477;18378.908105459486;18389.448316550508;18398.816011839877;17675.292988280486;17691;17749.55626109348;17803.821961780377;17859.464216073506;3090.4900691385897;3122.359916217176;3149.133988153253;3150.1022208670533;3155.2900597365524;3123.968760312402;3166.1293144385363;3170.4610216263177;3176.0948129783014;3184.5541624172633;3169.397814415254;3258.1691668624467;3261.5433839262523;3263.787853789508;3264.4450443424676;3147.0558832350316;3184.2039490127468;3200.439923013487;3204.9519257210927;3214.3571285742946;3192.2338638726537;3194.744420446382;3206.5831441912637;3206.9679303207135;3213.8071715697133;17305.307787688602;17327;17451.912740436215;17458.47624571265;17586.12069396538;9033.367664263504;9217.58520866556;9321.860172097424;9327.720168394959;9365.531723413802;5475.863103422406;5794.739236734357;5796.62321949072;5904.498117660004;5908.202392676976;1987.5528006198633;2080.136743251549;2089.9995548983493;2100.653392190287;2140.090461553849;31595.21011974696;31745.206369840707;31756.523652145235;31793.205169870707;31908;7540.3213710766295;7592.278733520307;7689.077310722637;7786.104597971306;7811.570363630055;20376.490587735425;20474.38576842697;20505.48736281605;20542;20569.69145462819;8694.913050869536;8809;8830.161134692322;8847.292216622654;8868.15752503511;7984.161663025298;8095.473794203358;8105.8378832424205;8262.545559994138;8279.296259817862;5940.495057920039;6087.604305720114;6135.049067394561;6150.969245153835;6189.978653522118;1725.5082301544;1734.6270551831417;1755.587436952315;1764.4353806781962;1894.535838719495;921.8985911549725;922.1516205091332;926.7358802741186;933.3746389918771;936.3445588088365;8990.685326013558;9095.863562046574;9181.58682859273;9185.816283674289;9235.399699019543;1054.5570860238718;1057.9735506612242;1066.7119877632995;1072.522727386321;1076.43378883724;4835.492273311322;5774.82675519735;5781.392953739881;5932.58471906971;5954.642721436728;25628.231153065437;27474;27683.307917301827;27834;27876.163715088172;26075.217743467725;26922.5961610576;26991.19026429171;27199.592006119925;27307.45385092287;11929.22460040112;11945.940270298594;11961.162718609614;11967.222130561486;12083.939580302042;9397.812043759222;9433.339666223299;9502.382345147544;9513.191378732608;9557.952210238904;22376.552468950857;22408.327750167522;22517.32448026562;22901.31296061121;23169.420764481023;23118.653220201373;23386.415339616644;23432.88283558571;23445.53108937846;23586.88206558956;12411;12417.130800843854;12490.375481225721;12522.499100035897;12541.498340066295;15652.4521641742;15731.21343932776;15826.841731582537;15839.049657020616;15886.126263055181;13054.08621396493;13443.260620665957;13502.932485337511;13631.795523066963;13639.79540306916;12804.167729097579;12835.550755723505;12906.548270810477;12929.224246545238;13279;11596.304221746723;11641.185117041725;11674;11748.295102293549;11767.823482647938;8410.369222308229;8422;8462.915370846213;8544;8566.700165494427;8393.664253430039;8510.659573616986;8515.531645759544;8528.275096616857;8630.741077767678 05:55:48 INFO - PID 31255 | |4;prototype.html;572.5276646766418;572.6649909802768;582.2576215325462;596.4780816785312;611.2725856231087;6310.747570097202;6312.873742525147;6397.680115994205;6414.198225221853;6429.485641148709;6250.687465626723;6254.7498100075945;6271.749130034805;6296.551793087592;6376.234851817777;5162.793488260465;5174.146265866128;5208.921866172001;5230.92153617696;5235.79056837728;4949.158643030693;5064;5158.3552055993005;5200.245964335169;5213.478652134794;4998.300237966688;5011.1481048221885;5040.6471546991725;5069.214271787879;5091.66904151229;5041.59667226621;5069.771860266278;5083.881546059843;5085.23721441783;5085.542301192911;4585.95414045862;4619.561141691567;4620.722756634613;4622.936724553338;4648.140094082605;6226.439620434183;6251.218597675291;6286.779962701329;6288.968555157195;6296.464800491964;5953.493953013999;5982.491488223506;5996.310424301218;5996.700164991733;6027.638341699469;6594.93405065948;6618.271990081087;6638.867222655568;6644.43522300605;6724.562903411263;4900.730459824708;5112.36095488064;5120.206368012964;5161.870953226162;5189.922151167735;6807.047013418125;6831.30163585381;6904.930950690529;6962.651867406609;6971.825704357381;5252.579793616502;5292.153255479105;5294.729264976378;5297;5319.547838433777;5332;5336.813211537655;5394.622376433612;5409.648372855751;5421.647592906448;5885;5943.286805583358;5944.7027648617395;5961.821145365646;5985.281766188085;6762.729490820312;6769.458443324522;6785.423239024738;6790;6796.490263230277;1845.1881172284152;1846.6306738652324;1855.1837191635636;1864.5431869191864;1873.7002079667188;1259.8551166615773;1309.788445687735;1311.5278499740086;1332.227308161264;1346.811431423936;6282.748690052346;6311.715972781236;6328.841778955563;6395.136656551306;6458.160439142881;6666.699998500079;6674.599524028574;6716.429103526158;6730.562513436611;6863;6343.714532846033;6347;6353.872922541524;6407.967960160169;6453.257875344396;3585.748997570145;3610.187707765732;3615.5661320641166;3622.3117607654463;3629.709623230188;7007.8598428031155;7064.540804847668;7109.146902371748;7115.501914865909;7203.171635262012;6889.448844092461;6918.204406493217;6918.411934985583;6937.306269373023;6947;6993.720251189997;7028;7092.219855815856;7147.749828755968;7154.177269614061;6744.7976560703255;6752.696128674123;6765.932340676531;6793.694283757144;6830.385265326145;6589.703463344257;6676.132102826601;6721.529492935448;6794.660266986532;6836.453083753388;7045.718171273296;7065.717371305296;7097.964510177622;7122.3589876909255;7147.213806481387;5299.735013249399;5318.654287471302;5322.813701520428;5340.866478338073;5343.278657381359;6548.279689234276;6722.697478613376;6804.489663275175;6841.3842754152365;6947.40947019509;6354.205724284465;6526.24948130971;6539.738410463528;6648.7340506379205;6669.333066693292;6588.769393071219;6611.702473388806;6635.303293154149;6647.833804154935;6681.465482761465;6497.577657452251;6593.967030164818;6603.7688680895935;6619.0733297339375;6645.966770166118;6601.834954126185;6678.699458524476;6699.497537684596;6722.495812813961;6727.519945611957;6233.407826256498;6398.168238129199;6461.838454038499;6478.497444276183;6515.078051974584 05:55:48 INFO - PID 31255 | |5;yui.html;917.8230508676611;957.7222605444422;960.5485421851731;1014.9492525373731;1031.2214278219944;20474.692879606817;21250.468738281532;21265;21275.893620531893;21296.89351553244;19471.902640486813;19658.410247692555;20478.488037799063;20954;21033.579328413423;1057.0750593230923;1059.809234337819;1060.7030031591166;1062.0972173652372;1066.2269854355607;986.6891929042365;999.2455695949548;1089.1286970423669;1096.9067629251524;1123.2474242257665;1170.9121815863803;1172.197045024157;1172.7771723372575;1172.8064869296597;1173.7300420903198;1159.8492196014506;1164.0861923390141;1165.3939951225316;1174.2895548193305;1175.1891195075457;860.0883063952231;860.7546849148025;860.7977125375531;860.8665656823202;862.0861886400436;21562.78437215639;21652.675209871864;21729.456763581038;21817.890910545346;22585.774142258695;23266.418339541648;23550;23590.7640923592;23648.408789780395;23753.88123059391;19263.711044334344;19433.611327773364;19492.610147797106;19546.120424580928;19567.21731130753;4006.1787333596544;4006.5192176938954;4010.318245898204;4011.919761604781;4012.6589239914642;157356;161197;161489;162155;163550;17415.651686966445;17773.822261777215;17842;17869;17869.374571889923;34667.306653866784;34892.30215395678;35230.471542926876;35350;35446;9022.86465703015;9159;9199.448033118035;9235.722928312161;9247.306452016126;4706.3175839503765;4746.28805679144;4751.857444276678;4752.667313288037;4756.952430475721;6417.133686952202;6433.935660643334;6463.7737679181;6471.770363630895;6503.122078519434;1133.7619099989095;1136.2216881436243;1152.688774031007;1154.6016624264614;1154.6478324111226;711.7900219435279;720.2869159532025;723.0708539526788;734.8934404511316;749.0748925077525;12848;13044.217346959213;13333.933330333286;13628.454861805614;13787.724245515234;702.5328156775789;712.4727701500852;713.1549114299571;719.7085180501905;723.1358526560709;6124.203853499017;6149.938500615026;6213.316535181217;6249.937500624936;6276.529260305495;153617;154345;154764;155653;157733;136457;138641;140061;141159.29420352832;144305;116975.41512292383;118604;120577.39711301387;121065.39467302606;121128;11492.310461372344;11573.479193436147;11778.175527712978;11847.585334513251;11907.82138267944;56329.71835140798;56388;56614;57271.140932886876;57650.13524797215;73754.63122684353;75219;75235;75763;77795;15824.446144385352;16023.679526409172;16094.597635059217;16162;16169.67660646757;17942.37201697934;18425.53936151607;18660.507159427485;18670.81329186745;18677.533061673566;15776.053436793829;16258.349666013228;16303.67392652164;16336.591585210464;16507.83492165063;15852.76220856665;16461.506154815375;16563.503094907173;16661.833381666027;16737.497875063767;16113.919430403243;16211;16240;16283.918580407497;16448.506544803677;12076.335801531;12180.57367992116;12340.197887137307;12512.37438128108;12575.748485030432;11761.235519691192;11946.34295113777;12067.75864482723;12133.090018248844;12135.029197664342 05:55:48 INFO - PID 31255 | __end_tp_report 05:55:48 INFO - PID 31255 | __start_cc_report 05:55:48 INFO - PID 31255 | _x_x_mozilla_cycle_collect,247 05:55:48 INFO - PID 31255 | __end_cc_report 05:55:48 INFO - PID 31255 | __startTimestamp1506948948170__endTimestamp 05:55:48 INFO - PID 31255 | 05:55:48 INFO - PID 31255 | ------- Summary: start ------- 05:55:48 INFO - PID 31255 | Number of tests: 6 05:55:48 INFO - PID 31255 | 05:55:48 INFO - PID 31255 | [#0] dojo.html Cycles:165 Average:6564.63 Median:6828.15 stddev:770.56 (11.3%) stddev-sans-first:747.03 05:55:48 INFO - PID 31255 | Values: 4039.5 4067.0 4071.5 4073.2 4085.1 6529.4 6552.2 6619.6 6627.9 6643.5 6525.0 6542.1 6575.1 6620.4 6641.1 5854.6 5908.1 5929.1 5940.8 5958.6 5839.1 5910.6 5927.9 6003.8 6035.8 5901.1 5909.5 5936.4 5949.8 5958.4 5832.7 5921.4 5968.9 5990.6 6010.4 5818.3 5832.6 5842.2 5895.5 5988.9 6441.0 6470.7 6484.4 6506.5 6540.1 7016.3 7033.4 7110.7 7110.9 7156.2 7034.5 7091.4 7094.8 7173.7 7186.2 6535.6 6558.0 6640.5 6649.0 6661.5 7302.9 7305.5 7310.0 7363.9 7404.4 6872.8 6969.5 6997.8 7090.8 7116.9 7094.8 7105.4 7107.8 7115.1 7118.9 7018.0 7073.6 7092.9 7121.2 7129.5 6950.9 7044.4 7121.1 7147.7 7151.6 5135.7 5166.1 5199.9 5232.3 5247.3 4661.3 4677.0 4726.7 4736.5 4770.8 6730.7 6746.5 6748.2 6811.6 6828.1 7088.1 7109.5 7120.6 7205.1 7225.3 6694.1 6780.1 6803.9 6809.0 6815.9 5859.4 5871.9 5880.1 5882.0 5889.1 7207.0 7276.6 7317.9 7359.8 7415.3 7081.3 7158.5 7173.8 7176.0 7182.2 7301.5 7378.2 7393.6 7488.1 7504.7 6979.1 7041.1 7058.5 7065.3 7074.2 7092.6 7099.6 7156.8 7195.1 7232.2 6888.5 6888.6 6981.5 6986.6 6989.4 6816.6 6860.6 6883.5 6891.4 6904.2 6787.7 6789.5 6842.6 6865.0 6890.4 6840.2 6909.7 6947.5 6975.2 6987.5 6654.1 6656.3 6670.0 6744.1 6751.7 05:55:48 INFO - PID 31255 | 05:55:48 INFO - PID 31255 | [#1] ext.html Cycles:180 Average:45167.25 Median:20910.16 stddev:70761.23 (338.4%) stddev-sans-first:70881.85 05:55:48 INFO - PID 31255 | Values: 948.9 957.2 993.7 996.9 1017.1 42723.8 43267.8 43310.8 43340.6 43459.3 40951.0 41224.6 41287.4 41301.0 41379.4 7917.0 8020.3 8028.8 8071.6 8075.8 8078.0 8170.9 8199.3 8205.0 8208.7 8686.8 8860.5 8870.7 8872.6 8881.7 8739.5 8741.9 8772.6 8790.2 8806.3 8504.6 8548.2 8559.3 8564.1 8565.5 39803.4 39816.2 39937.2 39948.2 40023.4 3796.1 3837.6 3839.3 3852.6 3881.2 33535.7 33562.7 33609.5 33651.7 33735.3 5689.3 5708.8 5718.1 5725.1 5863.6 231556.0 232207.0 234862.0 234878.0 235212.0 51969.5 52501.0 52556.0 52652.5 52853.0 61600.7 61724.7 62146.7 63261.4 63754.7 18712.8 18799.7 18802.2 18811.6 18824.0 15218.2 15224.7 15311.0 15408.2 15441.4 16119.3 16165.2 16199.5 16252.6 16282.6 6511.5 6527.5 6572.8 6645.1 6704.6 1116.2 1121.4 1130.4 1141.9 1156.1 26135.9 26264.7 26317.2 26345.3 26395.9 1252.2 1261.2 1266.2 1266.9 1273.5 13874.1 13920.3 13934.8 14051.2 14259.9 294156.0 294439.0 296361.0 297066.0 297169.0 58388.7 62987.0 64072.4 64102.0 64115.7 1551.2 1563.9 1582.0 1583.5 1594.4 30955.1 31109.7 31199.7 31685.2 31804.4 41212.8 41578.8 41611.6 41630.6 41656.6 280454.0 281968.0 282017.0 282129.0 282436.0 36415.6 37420.1 37653.6 37938.8 38024.2 45083.0 46660.0 46668.3 46794.5 47113.3 32470.5 33744.0 34201.7 34544.3 35104.1 34591.5 34652.7 34947.5 35062.6 35263.8 38901.0 40503.8 40570.4 40645.6 40703.6 33037.2 33644.5 33721.3 33782.3 34167.0 24495.8 24962.8 25278.2 25428.5 25540.5 05:55:48 INFO - PID 31255 | 05:55:48 INFO - PID 31255 | [#2] jquery.html Cycles:180 Average:41520.39 Median:22197.83 stddev:106806.07 (481.2%) stddev-sans-first:107061.57 05:55:48 INFO - PID 31255 | Values: 634.5 637.2 647.9 650.5 655.6 23996.0 24609.0 24762.6 24784.9 24794.0 26450.3 26845.5 26970.2 27082.0 27117.9 6356.5 6479.2 6735.4 6762.8 6771.0 6689.8 6768.0 6774.5 6777.4 6778.1 6556.0 6699.3 6699.5 6797.4 6808.7 6798.1 6832.9 6838.3 6838.9 6841.9 6335.6 6378.5 6380.5 6395.7 6398.1 30587.8 30626.8 30879.7 31217.2 31522.4 2352.2 2401.2 2402.0 2403.4 2404.5 20487.0 20922.2 20979.7 20985.3 20997.6 2448.7 2505.7 2537.8 2554.0 2575.0 136894.0 143954.0 156640.0 164174.0 164565.2 15798.9 16900.6 16937.8 17043.3 17221.1 26898.2 27087.2 27156.2 27178.5 27197.5 11442.5 11448.4 11566.2 11716.3 11736.0 10564.0 10672.6 10694.8 10816.5 10887.5 9898.9 10037.6 10041.0 10063.9 10173.9 2786.2 2798.3 2860.5 2874.7 2990.3 1054.6 1062.1 1063.2 1067.2 1081.4 20523.7 21141.8 21433.0 21438.4 21450.5 1150.5 1154.9 1158.5 1162.6 1164.0 11410.7 11609.4 11649.1 11741.6 11841.5 609295.0 634268.0 636911.0 637473.0 675350.0 132533.0 135690.0 137701.3 138374.3 139118.3 1195.9 1252.3 1291.1 1308.3 1350.5 21455.6 22185.9 22209.8 22270.1 22385.4 64123.0 65003.0 65773.3 66302.0 67802.3 82534.0 84093.0 87626.6 88567.0 88652.6 15481.5 15759.1 15799.3 15806.9 15825.4 24060.0 24202.8 24223.2 24342.0 24623.8 19841.0 19975.9 20269.7 20363.8 20383.8 17663.4 17943.3 18094.0 18725.4 18858.7 19355.6 20172.9 20215.0 20343.5 20511.6 15629.7 15740.9 15821.8 15837.7 15925.5 19897.8 19909.4 19964.3 20002.4 20008.5 05:55:48 INFO - PID 31255 | 05:55:48 INFO - PID 31255 | [#3] mootools.html Cycles:180 Average:10959.26 Median:3106.42 stddev:8175.79 (263.2%) stddev-sans-first:8167.15 05:55:48 INFO - PID 31255 | Values: 1395.4 1433.6 1446.0 1466.7 1474.9 17671.4 18325.2 18378.9 18389.4 18398.8 17675.3 17691.0 17749.6 17803.8 17859.5 3090.5 3122.4 3149.1 3150.1 3155.3 3124.0 3166.1 3170.5 3176.1 3184.6 3169.4 3258.2 3261.5 3263.8 3264.4 3147.1 3184.2 3200.4 3205.0 3214.4 3192.2 3194.7 3206.6 3207.0 3213.8 17305.3 17327.0 17451.9 17458.5 17586.1 9033.4 9217.6 9321.9 9327.7 9365.5 5475.9 5794.7 5796.6 5904.5 5908.2 1987.6 2080.1 2090.0 2100.7 2140.1 31595.2 31745.2 31756.5 31793.2 31908.0 7540.3 7592.3 7689.1 7786.1 7811.6 20376.5 20474.4 20505.5 20542.0 20569.7 8694.9 8809.0 8830.2 8847.3 8868.2 7984.2 8095.5 8105.8 8262.5 8279.3 5940.5 6087.6 6135.0 6151.0 6190.0 1725.5 1734.6 1755.6 1764.4 1894.5 921.9 922.2 926.7 933.4 936.3 8990.7 9095.9 9181.6 9185.8 9235.4 1054.6 1058.0 1066.7 1072.5 1076.4 4835.5 5774.8 5781.4 5932.6 5954.6 25628.2 27474.0 27683.3 27834.0 27876.2 26075.2 26922.6 26991.2 27199.6 27307.5 11929.2 11945.9 11961.2 11967.2 12083.9 9397.8 9433.3 9502.4 9513.2 9558.0 22376.6 22408.3 22517.3 22901.3 23169.4 23118.7 23386.4 23432.9 23445.5 23586.9 12411.0 12417.1 12490.4 12522.5 12541.5 15652.5 15731.2 15826.8 15839.0 15886.1 13054.1 13443.3 13502.9 13631.8 13639.8 12804.2 12835.6 12906.5 12929.2 13279.0 11596.3 11641.2 11674.0 11748.3 11767.8 8410.4 8422.0 8462.9 8544.0 8566.7 8393.7 8510.7 8515.5 8528.3 8630.7 05:55:48 INFO - PID 31255 | 05:55:48 INFO - PID 31255 | [#4] prototype.html Cycles:180 Average:5708.96 Median:6345.36 stddev:1578.93 (24.9%) stddev-sans-first:1535.57 05:55:48 INFO - PID 31255 | Values: 572.5 572.7 582.3 596.5 611.3 6310.7 6312.9 6397.7 6414.2 6429.5 6250.7 6254.7 6271.7 6296.6 6376.2 5162.8 5174.1 5208.9 5230.9 5235.8 4949.2 5064.0 5158.4 5200.2 5213.5 4998.3 5011.1 5040.6 5069.2 5091.7 5041.6 5069.8 5083.9 5085.2 5085.5 4586.0 4619.6 4620.7 4622.9 4648.1 6226.4 6251.2 6286.8 6289.0 6296.5 5953.5 5982.5 5996.3 5996.7 6027.6 6594.9 6618.3 6638.9 6644.4 6724.6 4900.7 5112.4 5120.2 5161.9 5189.9 6807.0 6831.3 6904.9 6962.7 6971.8 5252.6 5292.2 5294.7 5297.0 5319.5 5332.0 5336.8 5394.6 5409.6 5421.6 5885.0 5943.3 5944.7 5961.8 5985.3 6762.7 6769.5 6785.4 6790.0 6796.5 1845.2 1846.6 1855.2 1864.5 1873.7 1259.9 1309.8 1311.5 1332.2 1346.8 6282.7 6311.7 6328.8 6395.1 6458.2 6666.7 6674.6 6716.4 6730.6 6863.0 6343.7 6347.0 6353.9 6408.0 6453.3 3585.7 3610.2 3615.6 3622.3 3629.7 7007.9 7064.5 7109.1 7115.5 7203.2 6889.4 6918.2 6918.4 6937.3 6947.0 6993.7 7028.0 7092.2 7147.7 7154.2 6744.8 6752.7 6765.9 6793.7 6830.4 6589.7 6676.1 6721.5 6794.7 6836.5 7045.7 7065.7 7098.0 7122.4 7147.2 5299.7 5318.7 5322.8 5340.9 5343.3 6548.3 6722.7 6804.5 6841.4 6947.4 6354.2 6526.2 6539.7 6648.7 6669.3 6588.8 6611.7 6635.3 6647.8 6681.5 6497.6 6594.0 6603.8 6619.1 6646.0 6601.8 6678.7 6699.5 6722.5 6727.5 6233.4 6398.2 6461.8 6478.5 6515.1 05:55:48 INFO - PID 31255 | 05:55:48 INFO - PID 31255 | [#5] yui.html Cycles:180 Average:28892.05 Median:18183.96 stddev:43891.59 (241.4%) stddev-sans-first:43964.46 05:55:48 INFO - PID 31255 | Values: 917.8 957.7 960.5 1014.9 1031.2 20474.7 21250.5 21265.0 21275.9 21296.9 19471.9 19658.4 20478.5 20954.0 21033.6 1057.1 1059.8 1060.7 1062.1 1066.2 986.7 999.2 1089.1 1096.9 1123.2 1170.9 1172.2 1172.8 1172.8 1173.7 1159.8 1164.1 1165.4 1174.3 1175.2 860.1 860.8 860.8 860.9 862.1 21562.8 21652.7 21729.5 21817.9 22585.8 23266.4 23550.0 23590.8 23648.4 23753.9 19263.7 19433.6 19492.6 19546.1 19567.2 4006.2 4006.5 4010.3 4011.9 4012.7 157356.0 161197.0 161489.0 162155.0 163550.0 17415.7 17773.8 17842.0 17869.0 17869.4 34667.3 34892.3 35230.5 35350.0 35446.0 9022.9 9159.0 9199.4 9235.7 9247.3 4706.3 4746.3 4751.9 4752.7 4757.0 6417.1 6433.9 6463.8 6471.8 6503.1 1133.8 1136.2 1152.7 1154.6 1154.6 711.8 720.3 723.1 734.9 749.1 12848.0 13044.2 13333.9 13628.5 13787.7 702.5 712.5 713.2 719.7 723.1 6124.2 6149.9 6213.3 6249.9 6276.5 153617.0 154345.0 154764.0 155653.0 157733.0 136457.0 138641.0 140061.0 141159.3 144305.0 116975.4 118604.0 120577.4 121065.4 121128.0 11492.3 11573.5 11778.2 11847.6 11907.8 56329.7 56388.0 56614.0 57271.1 57650.1 73754.6 75219.0 75235.0 75763.0 77795.0 15824.4 16023.7 16094.6 16162.0 16169.7 17942.4 18425.5 18660.5 18670.8 18677.5 15776.1 16258.3 16303.7 16336.6 16507.8 15852.8 16461.5 16563.5 16661.8 16737.5 16113.9 16211.0 16240.0 16283.9 16448.5 12076.3 12180.6 12340.2 12512.4 12575.7 11761.2 11946.3 12067.8 12133.1 12135.0 05:55:48 INFO - PID 31255 | -------- Summary: end -------- 05:55:48 INFO - PID 31255 | 05:55:48 INFO - TEST-INFO | 31255: exit 0 05:55:48 INFO - TEST-OK | dromaeo_css | took 1107809ms 05:55:48 INFO - TEST-START | kraken 05:55:48 INFO - Initialising browser for kraken test... 05:55:48 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34203/getInfo.html -profile /tmp/tmp52c5dN/profile 05:55:48 INFO - TEST-INFO | started process 31619 (/builds/slave/test/build/application/firefox/firefox http://localhost:34203/getInfo.html) 05:55:54 INFO - TEST-INFO | 31619: exit 0 05:55:54 INFO - Browser initialized. 05:55:54 INFO - Running cycle 1/1 for kraken test... 05:55:54 INFO - Using env: {'DISPLAY': ':0', 05:55:54 INFO - 'HOME': '/home/cltbld', 05:55:54 INFO - 'JSGC_DISABLE_POISONING': '1', 05:55:54 INFO - 'LANG': 'en_US.UTF-8', 05:55:54 INFO - 'LANGUAGE': 'en_US:en', 05:55:54 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 05:55:54 INFO - 'LOGNAME': 'cltbld', 05:55:54 INFO - 'MAIL': '/var/mail/cltbld', 05:55:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:55:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:55:54 INFO - 'MOZ_CRASHREPORTER': '1', 05:55:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:54 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 05:55:54 INFO - 'MOZ_NO_REMOTE': '1', 05:55:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:55:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:54 INFO - 'NO_EM_RESTART': '1', 05:55:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:54 INFO - 'PWD': '/builds/slave/test', 05:55:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:55:54 INFO - 'RUST_BACKTRACE': 'full', 05:55:54 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:55:54 INFO - 'SHELL': '/bin/bash', 05:55:54 INFO - 'SHLVL': '1', 05:55:54 INFO - 'TERM': 'linux', 05:55:54 INFO - 'TMOUT': '86400', 05:55:54 INFO - 'USER': 'cltbld', 05:55:54 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1506947580.571284-1832286885', 05:55:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:54 INFO - '_': '/tools/buildbot/bin/python'} 05:55:54 INFO - TEST-INFO | started process 31809 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp52c5dN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:55:55 INFO - PID 31809 | 05:55:55 INFO - PID 31809 | (/builds/slave/test/build/application/firefox/firefox:31857): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:55:55 INFO - PID 31809 | 05:56:05 INFO - PID 31809 | RSS: Main: 141529088 05:56:05 INFO - PID 31809 | 05:56:08 INFO - PID 31809 | Cycle 1(1): loaded http://localhost:34203/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34203/tests/kraken/driver.html?testName=audio-beat-detection) 05:56:09 INFO - PID 31809 | RSS: Main: 147755008 05:56:09 INFO - PID 31809 | 05:56:11 INFO - PID 31809 | Cycle 1(1): loaded http://localhost:34203/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34203/tests/kraken/driver.html?testName=audio-dft) 05:56:12 INFO - PID 31809 | RSS: Main: 148275200 05:56:12 INFO - PID 31809 | 05:56:15 INFO - PID 31809 | Cycle 1(1): loaded http://localhost:34203/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34203/tests/kraken/driver.html?testName=audio-fft) 05:56:15 INFO - PID 31809 | RSS: Main: 149684224 05:56:15 INFO - PID 31809 | 05:56:17 INFO - PID 31809 | Cycle 1(1): loaded http://localhost:34203/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34203/tests/kraken/driver.html?testName=audio-oscillator) 05:56:18 INFO - PID 31809 | RSS: Main: 150302720 05:56:18 INFO - PID 31809 | 05:56:20 INFO - PID 31809 | Cycle 1(1): loaded http://localhost:34203/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34203/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:56:20 INFO - PID 31809 | RSS: Main: 149708800 05:56:20 INFO - PID 31809 | 05:56:24 INFO - PID 31809 | Cycle 1(1): loaded http://localhost:34203/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34203/tests/kraken/driver.html?testName=imaging-darkroom) 05:56:24 INFO - PID 31809 | RSS: Main: 149901312 05:56:24 INFO - PID 31809 | 05:56:28 INFO - PID 31809 | Cycle 1(1): loaded http://localhost:34203/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34203/tests/kraken/driver.html?testName=imaging-desaturate) 05:56:28 INFO - PID 31809 | RSS: Main: 152481792 05:56:28 INFO - PID 31809 | 05:56:31 INFO - PID 31809 | Cycle 1(1): loaded http://localhost:34203/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34203/tests/kraken/driver.html?testName=json-parse-financial) 05:56:32 INFO - PID 31809 | RSS: Main: 152797184 05:56:32 INFO - PID 31809 | 05:56:33 INFO - PID 31809 | Cycle 1(1): loaded http://localhost:34203/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34203/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:56:34 INFO - PID 31809 | RSS: Main: 152936448 05:56:34 INFO - PID 31809 | 05:56:35 INFO - PID 31809 | Cycle 1(1): loaded http://localhost:34203/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34203/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:56:36 INFO - PID 31809 | RSS: Main: 153038848 05:56:36 INFO - PID 31809 | 05:56:38 INFO - PID 31809 | Cycle 1(1): loaded http://localhost:34203/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34203/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:56:39 INFO - PID 31809 | RSS: Main: 149893120 05:56:39 INFO - PID 31809 | 05:56:41 INFO - PID 31809 | Cycle 1(1): loaded http://localhost:34203/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34203/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:56:42 INFO - PID 31809 | RSS: Main: 149700608 05:56:42 INFO - PID 31809 | 05:56:44 INFO - PID 31809 | Cycle 1(1): loaded http://localhost:34203/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34203/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:56:45 INFO - PID 31809 | RSS: Main: 149860352 05:56:45 INFO - PID 31809 | 05:56:46 INFO - PID 31809 | Cycle 1(1): loaded http://localhost:34203/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34203/tests/kraken/driver.html?testName=ai-astar) 05:56:47 INFO - PID 31809 | RSS: Main: 151465984 05:56:47 INFO - PID 31809 | 05:56:47 INFO - PID 31809 | __start_tp_report 05:56:47 INFO - PID 31809 | _x_x_mozilla_page_load 05:56:47 INFO - PID 31809 | _x_x_mozilla_page_load_details 05:56:47 INFO - PID 31809 | |i|pagename|runs| 05:56:47 INFO - PID 31809 | |0;ai-astar;105;105;106;105;104;107;107;106;106;107 05:56:47 INFO - PID 31809 | |1;audio-beat-detection;125;108;110;111;111;113;114;135;115;110 05:56:47 INFO - PID 31809 | |2;audio-dft;162;163;167;162;164;161;162;164;162;161 05:56:47 INFO - PID 31809 | |3;audio-fft;73;72;71;74;72;73;74;74;73;75 05:56:47 INFO - PID 31809 | |4;audio-oscillator;80;79;78;78;78;78;78;78;77;77 05:56:47 INFO - PID 31809 | |5;imaging-gaussian-blur;113;113;113;115;110;114;115;117;116;114 05:56:47 INFO - PID 31809 | |6;imaging-darkroom;149;149;147;148;148;148;150;149;149;148 05:56:47 INFO - PID 31809 | |7;imaging-desaturate;95;96;94;94;94;95;94;94;94;94 05:56:47 INFO - PID 31809 | |8;json-parse-financial;44;43;44;42;45;47;44;43;41;43 05:56:47 INFO - PID 31809 | |9;json-stringify-tinderbox;38;39;38;39;39;39;39;39;39;38 05:56:47 INFO - PID 31809 | |10;stanford-crypto-aes;77;72;71;75;75;71;70;71;71;68 05:56:47 INFO - PID 31809 | |11;stanford-crypto-ccm;111;106;103;110;108;104;108;109;101;113 05:56:47 INFO - PID 31809 | |12;stanford-crypto-pbkdf2;148;154;148;149;151;155;155;145;150;150 05:56:47 INFO - PID 31809 | |13;stanford-crypto-sha256-iterative;58;57;64;62;59;58;73;58;58;59 05:56:47 INFO - PID 31809 | __end_tp_report 05:56:47 INFO - PID 31809 | __start_cc_report 05:56:47 INFO - PID 31809 | _x_x_mozilla_cycle_collect,717 05:56:47 INFO - PID 31809 | __end_cc_report 05:56:47 INFO - PID 31809 | __startTimestamp1506949007227__endTimestamp 05:56:47 INFO - PID 31809 | 05:56:47 INFO - PID 31809 | ------- Summary: start ------- 05:56:47 INFO - PID 31809 | Number of tests: 14 05:56:47 INFO - PID 31809 | 05:56:47 INFO - PID 31809 | [#0] ai-astar Cycles:10 Average:105.80 Median:106.00 stddev:1.03 (1.0%) stddev-sans-first:1.05 05:56:47 INFO - PID 31809 | Values: 105.0 105.0 106.0 105.0 104.0 107.0 107.0 106.0 106.0 107.0 05:56:47 INFO - PID 31809 | 05:56:47 INFO - PID 31809 | [#1] audio-beat-detection Cycles:10 Average:115.20 Median:113.50 stddev:8.40 (7.4%) stddev-sans-first:8.13 05:56:47 INFO - PID 31809 | Values: 125.0 108.0 110.0 111.0 111.0 113.0 114.0 135.0 115.0 110.0 05:56:47 INFO - PID 31809 | 05:56:47 INFO - PID 31809 | [#2] audio-dft Cycles:10 Average:162.80 Median:162.50 stddev:1.81 (1.1%) stddev-sans-first:1.90 05:56:47 INFO - PID 31809 | Values: 162.0 163.0 167.0 162.0 164.0 161.0 162.0 164.0 162.0 161.0 05:56:47 INFO - PID 31809 | 05:56:47 INFO - PID 31809 | [#3] audio-fft Cycles:10 Average:73.10 Median:73.50 stddev:1.20 (1.6%) stddev-sans-first:1.27 05:56:47 INFO - PID 31809 | Values: 73.0 72.0 71.0 74.0 72.0 73.0 74.0 74.0 73.0 75.0 05:56:47 INFO - PID 31809 | 05:56:47 INFO - PID 31809 | [#4] audio-oscillator Cycles:10 Average:78.10 Median:78.00 stddev:0.88 (1.1%) stddev-sans-first:0.60 05:56:47 INFO - PID 31809 | Values: 80.0 79.0 78.0 78.0 78.0 78.0 78.0 78.0 77.0 77.0 05:56:47 INFO - PID 31809 | 05:56:47 INFO - PID 31809 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.50 stddev:1.94 (1.7%) stddev-sans-first:2.03 05:56:47 INFO - PID 31809 | Values: 113.0 113.0 113.0 115.0 110.0 114.0 115.0 117.0 116.0 114.0 05:56:47 INFO - PID 31809 | 05:56:47 INFO - PID 31809 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:149.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 05:56:47 INFO - PID 31809 | Values: 149.0 149.0 147.0 148.0 148.0 148.0 150.0 149.0 149.0 148.0 05:56:47 INFO - PID 31809 | 05:56:47 INFO - PID 31809 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 05:56:47 INFO - PID 31809 | Values: 95.0 96.0 94.0 94.0 94.0 95.0 94.0 94.0 94.0 94.0 05:56:47 INFO - PID 31809 | 05:56:47 INFO - PID 31809 | [#8] json-parse-financial Cycles:10 Average:43.60 Median:44.00 stddev:1.65 (3.7%) stddev-sans-first:1.74 05:56:47 INFO - PID 31809 | Values: 44.0 43.0 44.0 42.0 45.0 47.0 44.0 43.0 41.0 43.0 05:56:47 INFO - PID 31809 | 05:56:47 INFO - PID 31809 | [#9] json-stringify-tinderbox Cycles:10 Average:38.70 Median:39.00 stddev:0.48 (1.2%) stddev-sans-first:0.44 05:56:47 INFO - PID 31809 | Values: 38.0 39.0 38.0 39.0 39.0 39.0 39.0 39.0 39.0 38.0 05:56:47 INFO - PID 31809 | 05:56:47 INFO - PID 31809 | [#10] stanford-crypto-aes Cycles:10 Average:72.10 Median:71.50 stddev:2.73 (3.8%) stddev-sans-first:2.24 05:56:47 INFO - PID 31809 | Values: 77.0 72.0 71.0 75.0 75.0 71.0 70.0 71.0 71.0 68.0 05:56:47 INFO - PID 31809 | 05:56:47 INFO - PID 31809 | [#11] stanford-crypto-ccm Cycles:10 Average:107.30 Median:108.50 stddev:3.77 (3.5%) stddev-sans-first:3.76 05:56:47 INFO - PID 31809 | Values: 111.0 106.0 103.0 110.0 108.0 104.0 108.0 109.0 101.0 113.0 05:56:47 INFO - PID 31809 | 05:56:47 INFO - PID 31809 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.50 Median:150.50 stddev:3.31 (2.2%) stddev-sans-first:3.38 05:56:47 INFO - PID 31809 | Values: 148.0 154.0 148.0 149.0 151.0 155.0 155.0 145.0 150.0 150.0 05:56:47 INFO - PID 31809 | 05:56:47 INFO - PID 31809 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.60 Median:59.00 stddev:4.86 (8.2%) stddev-sans-first:5.06 05:56:47 INFO - PID 31809 | Values: 58.0 57.0 64.0 62.0 59.0 58.0 73.0 58.0 58.0 59.0 05:56:47 INFO - PID 31809 | -------- Summary: end -------- 05:56:47 INFO - PID 31809 | 05:56:47 INFO - PID 31809 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 05:56:47 INFO - TEST-INFO | 31809: exit 0 05:56:48 INFO - TEST-OK | kraken | took 59285ms 05:56:48 INFO - SUITE-END | took 1167s 05:56:48 INFO - Completed test suite (00:19:27) 05:56:48 INFO - javascript benchmark 05:56:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9347.034946913262, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [4039.49506311711, 4067.0, 4071.5317738460067, 4073.185362927415, 4085.060436099697, 6529.412352888239, 6552.213734351879, 6619.6028238305735, 6627.86744265115, 6643.468522518199, 6524.967375163129, 6542.051402546628, 6575.14523111996, 6620.404163625273, 6641.070250164981, 5854.590178687472, 5908.113782932552, 5929.110633404992, 5940.821775346725, 5958.553108516857, 5839.065749480084, 5910.645361278315, 5927.940720592782, 6003.8198854034445, 6035.818925432222, 5901.144334071557, 5909.497692696104, 5936.376680448534, 5949.8215053548465, 5958.404159584029, 5832.650040997553, 5921.437463440988, 5968.850778730523, 5990.64056156632, 6010.398960103998, 5818.272715910512, 5832.62087964281, 5842.152887831241, 5895.498882594985, 5988.880222395571, 6441.033844923252, 6470.74117035318, 6484.383983521558, 6506.479481641457, 6540.149780528548, 7016.298370162994, 7033.366996970246, 7110.715571377139, 7110.893336599956, 7156.212816590171, 7034.507584469089, 7091.432685385157, 7094.822629434254, 7173.748918787817, 7186.209516953131, 6535.607863528204, 6558.049082882955, 6640.501962352843, 6648.966755166193, 6661.500387470959, 7302.890456643155, 7305.4886157969495, 7310.0, 7363.852722945511, 7404.370628496638, 6872.759453419207, 6969.47728920333, 6997.790066298019, 7090.787276381614, 7116.893246601305, 7094.787156385317, 7105.360517553445, 7107.786766397016, 7115.075040244838, 7118.857622847618, 7018.0, 7073.646317684198, 7092.858142837114, 7121.216666166718, 7129.465290103263, 6950.860982780316, 7044.401225895754, 7121.074260346122, 7147.714091436284, 7151.570905745672, 5135.743212839343, 5166.147585648401, 5199.922001169985, 5232.3459567554055, 5247.291615631917, 4661.324108004321, 4676.95323046772, 4726.692764970266, 4736.478987311393, 4770.809167633325, 6730.663466826639, 6746.494012949049, 6748.190217173872, 6811.557248778813, 6828.146481689789, 7088.0785497884945, 7109.537880037781, 7120.643967801693, 7205.099362579677, 7225.349718525358, 6694.096296999843, 6780.084688567079, 6803.897941530881, 6808.9659551701925, 6815.863682726318, 5859.384764599741, 5871.941280587225, 5880.147378630075, 5882.02946513829, 5889.116632505158, 7207.0, 7276.599787011659, 7317.926820731725, 7359.8160045999275, 7415.3326200642205, 7081.256468070778, 7158.463115266376, 7173.820654483471, 7176.031235783311, 7182.245864184186, 7301.452391070585, 7378.1515125761225, 7393.630318483947, 7488.101427828696, 7504.662290196845, 6979.127609048869, 7041.084658994298, 7058.470614703815, 7065.258147894397, 7074.151101867603, 7092.6099064551945, 7099.574025558483, 7156.821079473055, 7195.0646415967685, 7232.240614735377, 6888.48336374784, 6888.586684798928, 6981.5461994970165, 6986.580805151707, 6989.440844732511, 6816.625085620339, 6860.5540639858245, 6883.483738719716, 6891.448684105159, 6904.206016308189, 6787.728490860311, 6789.490788190807, 6842.623655698984, 6864.965675171592, 6890.414314783299, 6840.213375461885, 6909.654517274217, 6947.513674042769, 6975.162980442379, 6987.475939304674, 6654.068430419648, 6656.267810540933, 6669.966650166718, 6744.0895479109695, 6751.72993080291], "value": 6512.608764425027, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [948.8956214816365, 957.2246480350918, 993.6720882108905, 996.9451680157591, 1017.1405162637569, 42723.78638106809, 43267.78366108165, 43310.7834460828, 43340.56659433405, 43459.34810977834, 40951.0, 41224.58775412245, 41287.38068928968, 41301.0, 41379.37930931031, 7916.960415197945, 8020.278174964252, 8028.839423211532, 8071.556064416454, 8075.798105047362, 8078.0, 8170.918290817075, 8199.344052475788, 8204.958975205145, 8208.712695055674, 8686.782830429227, 8860.468371897707, 8870.689525866595, 8872.556372181398, 8881.689140880071, 8739.4756314621, 8741.912580874205, 8772.605232764541, 8790.164934331227, 8806.251468625174, 8504.574771261412, 8548.187922147386, 8559.27246184075, 8564.143585641448, 8565.486070835708, 39803.40294895579, 39816.20367592661, 39937.201255974716, 39948.20103597941, 40023.39964900529, 3796.088938654703, 3837.597052309495, 3839.2897313997, 3852.595477474853, 3881.2237552489614, 33535.6646433535, 33562.6643733562, 33609.49585756216, 33651.6634833651, 33735.325293493996, 5689.288838895138, 5708.800191993302, 5718.056520674084, 5725.141228815669, 5863.618864773776, 231556.0, 232207.0, 234862.0, 234878.0, 235212.0, 51969.48030519722, 52501.0, 52556.0, 52652.47347526476, 52853.0, 61600.69199653973, 61724.69137654283, 62146.689266554284, 63261.367386325546, 63754.68122659357, 18712.812871871378, 18799.718004229948, 18802.247910083715, 18811.623767524572, 18823.96468194235, 15218.163001034827, 15224.695506089816, 15311.0, 15408.152551609544, 15441.382344706311, 16119.27463264156, 16165.191740412933, 16199.514014579581, 16252.59368515773, 16282.592935176715, 6511.479081673549, 6527.54307198501, 6572.80281591553, 6645.102911106938, 6704.564203326768, 1116.1573012375604, 1121.428071683431, 1130.350048721988, 1141.8801025892328, 1156.0520373293818, 26135.869320653655, 26264.737352626613, 26317.210483685136, 26345.341366465607, 26395.868020660157, 1252.2111070025826, 1261.1928365845865, 1266.208619612742, 1266.9176503527242, 1273.496968697378, 13874.098183618235, 13920.30398480072, 13934.790978135336, 14051.156930583993, 14259.857401426061, 294156.0, 294439.0, 296361.0, 297066.0, 297169.0, 58388.70805645944, 62987.0, 64072.35927640757, 64102.0, 64115.679421602596, 1551.1623723189578, 1563.8514341137575, 1581.9841801582068, 1583.5249425172171, 1594.386161327897, 30955.0713478596, 31109.688903111586, 31199.688003119678, 31685.20786980344, 31804.363912722078, 41212.793936030124, 41578.79210603928, 41611.58388416077, 41630.583694163885, 41656.58343416527, 280454.0, 281968.0, 282017.0, 282129.0, 282436.0, 36415.63584364123, 37420.06449838776, 37653.62346376501, 37938.8103059483, 38024.23951520899, 45083.0, 46660.0, 46668.299975499714, 46794.53205468038, 47113.2933006012, 32470.512942306355, 33744.0, 34201.65798341985, 34544.30911381708, 35104.12239694028, 34591.481127783605, 34652.65347346494, 34947.47578786371, 35062.64937350696, 35263.82368088143, 38901.0, 40503.797481013586, 40570.39144412895, 40645.593544064184, 40703.59296407116, 33037.17407064843, 33644.49533256954, 33721.32557348888, 33782.324353512304, 34167.0, 24495.75504245006, 24962.75037249677, 25278.241652750447, 25428.491430171664, 25540.539865906845], "value": 19358.17090486975, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [634.5287804125402, 637.1712312824884, 647.9342767124507, 650.4564085301863, 655.5939701296239, 23996.0, 24609.0, 24762.628560571582, 24784.876075619643, 24794.0, 26450.28073175247, 26845.463090738172, 26970.190894273153, 27082.0, 27117.864410677917, 6356.523260755439, 6479.22249330081, 6735.360140786617, 6762.8309292267595, 6770.966145169267, 6689.799306020827, 6768.018637297589, 6774.491913106512, 6777.423918966893, 6778.118844550201, 6555.967220163916, 6699.263081061079, 6699.497537684669, 6797.388235058844, 6808.6936087876165, 6798.0822588950605, 6832.897506537381, 6838.316168383122, 6838.863222735567, 6841.863162736742, 6335.619862808247, 6378.521610879203, 6380.489560835122, 6395.744170233185, 6398.07227951949, 30587.847060764776, 30626.84686576553, 30879.691203087907, 31217.21956951072, 31522.36955260905, 2352.235523454867, 2401.2436082633913, 2402.0391843262832, 2403.447207142367, 2404.5190961807707, 20487.0, 20922.163113475443, 20979.685304720442, 20985.26551570703, 20997.5800483991, 2448.7061552613623, 2505.711843138044, 2537.796976241896, 2554.029468801862, 2575.0343621142074, 136894.0, 143954.0, 156640.0, 164174.0, 164565.17717411456, 15798.9210053949, 16900.57748556296, 16937.830621693625, 17043.318267269417, 17221.138943052796, 26898.193054208405, 27087.1873843785, 27156.185314440598, 27178.456430871272, 27197.456050879267, 11442.542298307975, 11448.3703396314, 11566.248193867372, 11716.297022178696, 11736.0, 10564.0, 10672.573097076185, 10694.839577406345, 10816.459177041117, 10887.455627218607, 9898.851517227247, 10037.64868229623, 10041.04610062043, 10063.899361006443, 10173.898261017295, 2786.1968413116356, 2798.328401183742, 2860.5137126688514, 2874.655041395046, 2990.3421247325555, 1054.583439541377, 1062.0653824634273, 1063.2238465919922, 1067.215596536545, 1081.4484612847505, 20523.692144617842, 21141.788582114288, 21433.0, 21438.356849294545, 21450.463738406666, 1150.4937827355936, 1154.8960593546622, 1158.5192145259791, 1162.5524173193382, 1164.0338519029185, 11410.714732131763, 11609.419529023515, 11649.12631552637, 11741.589044383576, 11841.526338946518, 609295.0, 634268.0, 636911.0, 637473.0, 675350.0, 132533.0, 135690.0, 137701.3114934419, 138374.30812846072, 139118.3044084773, 1195.8684544700077, 1252.2549083295426, 1291.1026836348647, 1308.2739079810797, 1350.4935649131576, 21455.570888581828, 22185.88907055519, 22209.777902221416, 22270.109195631994, 22385.44036399103, 64123.03815442679, 65003.0, 65773.34226657673, 66302.0, 67802.30494237684, 82534.0, 84093.0, 87626.56186719026, 88567.0, 88652.5567372159, 15481.529254720783, 15759.133247671489, 15799.289031993818, 15806.9209653951, 15825.366985320457, 24060.0, 24202.75797242005, 24223.152189673277, 24342.0, 24623.753762462147, 19841.0, 19975.900120499304, 20269.695954560397, 20363.79636203619, 20383.79616203819, 17663.38178163758, 17943.282268709107, 18094.0, 18725.438236852915, 18858.717119243498, 19355.61288774245, 20172.899135504227, 20215.0, 20343.4914127148, 20511.589768204252, 15629.687406252038, 15740.921295393908, 15821.762673559675, 15837.683246335238, 15925.522234332988, 19897.801021990173, 19909.402717918485, 19964.3012494562, 20002.39992800218, 20008.49978750543], "value": 13180.327463498614, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1395.4487977248987, 1433.6487560547666, 1446.0456098974678, 1466.7213229486397, 1474.9306752604364, 17671.381501647444, 18325.175367108477, 18378.908105459486, 18389.448316550508, 18398.816011839877, 17675.292988280486, 17691.0, 17749.55626109348, 17803.821961780377, 17859.464216073506, 3090.4900691385897, 3122.359916217176, 3149.133988153253, 3150.1022208670533, 3155.2900597365524, 3123.968760312402, 3166.1293144385363, 3170.4610216263177, 3176.0948129783014, 3184.5541624172633, 3169.397814415254, 3258.1691668624467, 3261.5433839262523, 3263.787853789508, 3264.4450443424676, 3147.0558832350316, 3184.2039490127468, 3200.439923013487, 3204.9519257210927, 3214.3571285742946, 3192.2338638726537, 3194.744420446382, 3206.5831441912637, 3206.9679303207135, 3213.8071715697133, 17305.307787688602, 17327.0, 17451.912740436215, 17458.47624571265, 17586.12069396538, 9033.367664263504, 9217.58520866556, 9321.860172097424, 9327.720168394959, 9365.531723413802, 5475.863103422406, 5794.739236734357, 5796.62321949072, 5904.498117660004, 5908.202392676976, 1987.5528006198633, 2080.136743251549, 2089.9995548983493, 2100.653392190287, 2140.090461553849, 31595.21011974696, 31745.206369840707, 31756.523652145235, 31793.205169870707, 31908.0, 7540.3213710766295, 7592.278733520307, 7689.077310722637, 7786.104597971306, 7811.570363630055, 20376.490587735425, 20474.38576842697, 20505.48736281605, 20542.0, 20569.69145462819, 8694.913050869536, 8809.0, 8830.161134692322, 8847.292216622654, 8868.15752503511, 7984.161663025298, 8095.473794203358, 8105.8378832424205, 8262.545559994138, 8279.296259817862, 5940.495057920039, 6087.604305720114, 6135.049067394561, 6150.969245153835, 6189.978653522118, 1725.5082301544, 1734.6270551831417, 1755.587436952315, 1764.4353806781962, 1894.535838719495, 921.8985911549725, 922.1516205091332, 926.7358802741186, 933.3746389918771, 936.3445588088365, 8990.685326013558, 9095.863562046574, 9181.58682859273, 9185.816283674289, 9235.399699019543, 1054.5570860238718, 1057.9735506612242, 1066.7119877632995, 1072.522727386321, 1076.43378883724, 4835.492273311322, 5774.82675519735, 5781.392953739881, 5932.58471906971, 5954.642721436728, 25628.231153065437, 27474.0, 27683.307917301827, 27834.0, 27876.163715088172, 26075.217743467725, 26922.5961610576, 26991.19026429171, 27199.592006119925, 27307.45385092287, 11929.22460040112, 11945.940270298594, 11961.162718609614, 11967.222130561486, 12083.939580302042, 9397.812043759222, 9433.339666223299, 9502.382345147544, 9513.191378732608, 9557.952210238904, 22376.552468950857, 22408.327750167522, 22517.32448026562, 22901.31296061121, 23169.420764481023, 23118.653220201373, 23386.415339616644, 23432.88283558571, 23445.53108937846, 23586.88206558956, 12411.0, 12417.130800843854, 12490.375481225721, 12522.499100035897, 12541.498340066295, 15652.4521641742, 15731.21343932776, 15826.841731582537, 15839.049657020616, 15886.126263055181, 13054.08621396493, 13443.260620665957, 13502.932485337511, 13631.795523066963, 13639.79540306916, 12804.167729097579, 12835.550755723505, 12906.548270810477, 12929.224246545238, 13279.0, 11596.304221746723, 11641.185117041725, 11674.0, 11748.295102293549, 11767.823482647938, 8410.369222308229, 8422.0, 8462.915370846213, 8544.0, 8566.700165494427, 8393.664253430039, 8510.659573616986, 8515.531645759544, 8528.275096616857, 8630.741077767678], "value": 7683.60186027777, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.5276646766418, 572.6649909802768, 582.2576215325462, 596.4780816785312, 611.2725856231087, 6310.747570097202, 6312.873742525147, 6397.680115994205, 6414.198225221853, 6429.485641148709, 6250.687465626723, 6254.7498100075945, 6271.749130034805, 6296.551793087592, 6376.234851817777, 5162.793488260465, 5174.146265866128, 5208.921866172001, 5230.92153617696, 5235.79056837728, 4949.158643030693, 5064.0, 5158.3552055993005, 5200.245964335169, 5213.478652134794, 4998.300237966688, 5011.1481048221885, 5040.6471546991725, 5069.214271787879, 5091.66904151229, 5041.59667226621, 5069.771860266278, 5083.881546059843, 5085.23721441783, 5085.542301192911, 4585.95414045862, 4619.561141691567, 4620.722756634613, 4622.936724553338, 4648.140094082605, 6226.439620434183, 6251.218597675291, 6286.779962701329, 6288.968555157195, 6296.464800491964, 5953.493953013999, 5982.491488223506, 5996.310424301218, 5996.700164991733, 6027.638341699469, 6594.93405065948, 6618.271990081087, 6638.867222655568, 6644.43522300605, 6724.562903411263, 4900.730459824708, 5112.36095488064, 5120.206368012964, 5161.870953226162, 5189.922151167735, 6807.047013418125, 6831.30163585381, 6904.930950690529, 6962.651867406609, 6971.825704357381, 5252.579793616502, 5292.153255479105, 5294.729264976378, 5297.0, 5319.547838433777, 5332.0, 5336.813211537655, 5394.622376433612, 5409.648372855751, 5421.647592906448, 5885.0, 5943.286805583358, 5944.7027648617395, 5961.821145365646, 5985.281766188085, 6762.729490820312, 6769.458443324522, 6785.423239024738, 6790.0, 6796.490263230277, 1845.1881172284152, 1846.6306738652324, 1855.1837191635636, 1864.5431869191864, 1873.7002079667188, 1259.8551166615773, 1309.788445687735, 1311.5278499740086, 1332.227308161264, 1346.811431423936, 6282.748690052346, 6311.715972781236, 6328.841778955563, 6395.136656551306, 6458.160439142881, 6666.699998500079, 6674.599524028574, 6716.429103526158, 6730.562513436611, 6863.0, 6343.714532846033, 6347.0, 6353.872922541524, 6407.967960160169, 6453.257875344396, 3585.748997570145, 3610.187707765732, 3615.5661320641166, 3622.3117607654463, 3629.709623230188, 7007.8598428031155, 7064.540804847668, 7109.146902371748, 7115.501914865909, 7203.171635262012, 6889.448844092461, 6918.204406493217, 6918.411934985583, 6937.306269373023, 6947.0, 6993.720251189997, 7028.0, 7092.219855815856, 7147.749828755968, 7154.177269614061, 6744.7976560703255, 6752.696128674123, 6765.932340676531, 6793.694283757144, 6830.385265326145, 6589.703463344257, 6676.132102826601, 6721.529492935448, 6794.660266986532, 6836.453083753388, 7045.718171273296, 7065.717371305296, 7097.964510177622, 7122.3589876909255, 7147.213806481387, 5299.735013249399, 5318.654287471302, 5322.813701520428, 5340.866478338073, 5343.278657381359, 6548.279689234276, 6722.697478613376, 6804.489663275175, 6841.3842754152365, 6947.40947019509, 6354.205724284465, 6526.24948130971, 6539.738410463528, 6648.7340506379205, 6669.333066693292, 6588.769393071219, 6611.702473388806, 6635.303293154149, 6647.833804154935, 6681.465482761465, 6497.577657452251, 6593.967030164818, 6603.7688680895935, 6619.0733297339375, 6645.966770166118, 6601.834954126185, 6678.699458524476, 6699.497537684596, 6722.495812813961, 6727.519945611957, 6233.407826256498, 6398.168238129199, 6461.838454038499, 6478.497444276183, 6515.078051974584], "value": 5258.614203665643, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [917.8230508676611, 957.7222605444422, 960.5485421851731, 1014.9492525373731, 1031.2214278219944, 20474.692879606817, 21250.468738281532, 21265.0, 21275.893620531893, 21296.89351553244, 19471.902640486813, 19658.410247692555, 20478.488037799063, 20954.0, 21033.579328413423, 1057.0750593230923, 1059.809234337819, 1060.7030031591166, 1062.0972173652372, 1066.2269854355607, 986.6891929042365, 999.2455695949548, 1089.1286970423669, 1096.9067629251524, 1123.2474242257665, 1170.9121815863803, 1172.197045024157, 1172.7771723372575, 1172.8064869296597, 1173.7300420903198, 1159.8492196014506, 1164.0861923390141, 1165.3939951225316, 1174.2895548193305, 1175.1891195075457, 860.0883063952231, 860.7546849148025, 860.7977125375531, 860.8665656823202, 862.0861886400436, 21562.78437215639, 21652.675209871864, 21729.456763581038, 21817.890910545346, 22585.774142258695, 23266.418339541648, 23550.0, 23590.7640923592, 23648.408789780395, 23753.88123059391, 19263.711044334344, 19433.611327773364, 19492.610147797106, 19546.120424580928, 19567.21731130753, 4006.1787333596544, 4006.5192176938954, 4010.318245898204, 4011.919761604781, 4012.6589239914642, 157356.0, 161197.0, 161489.0, 162155.0, 163550.0, 17415.651686966445, 17773.822261777215, 17842.0, 17869.0, 17869.374571889923, 34667.306653866784, 34892.30215395678, 35230.471542926876, 35350.0, 35446.0, 9022.86465703015, 9159.0, 9199.448033118035, 9235.722928312161, 9247.306452016126, 4706.3175839503765, 4746.28805679144, 4751.857444276678, 4752.667313288037, 4756.952430475721, 6417.133686952202, 6433.935660643334, 6463.7737679181, 6471.770363630895, 6503.122078519434, 1133.7619099989095, 1136.2216881436243, 1152.688774031007, 1154.6016624264614, 1154.6478324111226, 711.7900219435279, 720.2869159532025, 723.0708539526788, 734.8934404511316, 749.0748925077525, 12848.0, 13044.217346959213, 13333.933330333286, 13628.454861805614, 13787.724245515234, 702.5328156775789, 712.4727701500852, 713.1549114299571, 719.7085180501905, 723.1358526560709, 6124.203853499017, 6149.938500615026, 6213.316535181217, 6249.937500624936, 6276.529260305495, 153617.0, 154345.0, 154764.0, 155653.0, 157733.0, 136457.0, 138641.0, 140061.0, 141159.29420352832, 144305.0, 116975.41512292383, 118604.0, 120577.39711301387, 121065.39467302606, 121128.0, 11492.310461372344, 11573.479193436147, 11778.175527712978, 11847.585334513251, 11907.82138267944, 56329.71835140798, 56388.0, 56614.0, 57271.140932886876, 57650.13524797215, 73754.63122684353, 75219.0, 75235.0, 75763.0, 77795.0, 15824.446144385352, 16023.679526409172, 16094.597635059217, 16162.0, 16169.67660646757, 17942.37201697934, 18425.53936151607, 18660.507159427485, 18670.81329186745, 18677.533061673566, 15776.053436793829, 16258.349666013228, 16303.67392652164, 16336.591585210464, 16507.83492165063, 15852.76220856665, 16461.506154815375, 16563.503094907173, 16661.833381666027, 16737.497875063767, 16113.919430403243, 16211.0, 16240.0, 16283.918580407497, 16448.506544803677, 12076.335801531, 12180.57367992116, 12340.197887137307, 12512.37438128108, 12575.748485030432, 11761.235519691192, 11946.34295113777, 12067.75864482723, 12133.090018248844, 12135.029197664342], "value": 9931.970144200064, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1364.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 105.0, 106.0, 105.0, 104.0, 107.0, 107.0, 106.0, 106.0, 107.0], "value": 105.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 108.0, 110.0, 111.0, 111.0, 113.0, 114.0, 135.0, 115.0, 110.0], "value": 115.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 167.0, 162.0, 164.0, 161.0, 162.0, 164.0, 162.0, 161.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 71.0, 74.0, 72.0, 73.0, 74.0, 74.0, 73.0, 75.0], "value": 73.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 78.0, 78.0, 78.0, 78.0, 78.0, 78.0, 77.0, 77.0], "value": 78.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 115.0, 110.0, 114.0, 115.0, 117.0, 116.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 147.0, 148.0, 148.0, 148.0, 150.0, 149.0, 149.0, 148.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 43.0, 44.0, 42.0, 45.0, 47.0, 44.0, 43.0, 41.0, 43.0], "value": 43.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 39.0, 38.0, 39.0, 39.0, 39.0, 39.0, 39.0, 39.0, 38.0], "value": 38.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 72.0, 71.0, 75.0, 75.0, 71.0, 70.0, 71.0, 71.0, 68.0], "value": 72.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 103.0, 110.0, 108.0, 104.0, 108.0, 109.0, 101.0, 113.0], "value": 107.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 154.0, 148.0, 149.0, 151.0, 155.0, 155.0, 145.0, 150.0, 150.0], "value": 150.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 64.0, 62.0, 59.0, 58.0, 73.0, 58.0, 58.0, 59.0], "value": 60.6, "unit": "score"}]}]} 05:56:48 INFO - Return code: 0 05:56:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:56:48 INFO - # TBPL SUCCESS # 05:56:48 INFO - Running post-action listener: _package_coverage_data 05:56:48 INFO - Running post-action listener: _resource_record_post_action 05:56:48 INFO - [mozharness: 2017-10-02 12:56:48.497052Z] Finished run-tests step (success) 05:56:48 INFO - Running post-run listener: _resource_record_post_run 05:56:48 INFO - Total resource usage - Wall time: 1182s; CPU: 13.0%; Read bytes: 8192; Write bytes: 289124352; Read time: 304; Write time: 278876 05:56:48 INFO - TinderboxPrint: CPU usage
13.0% 05:56:48 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 304 05:56:48 INFO - TinderboxPrint: I/O write bytes / time
289,124,352 / 278,876 05:56:48 INFO - TinderboxPrint: CPU idle
8,193.6 (86.9%) 05:56:48 INFO - TinderboxPrint: CPU user
1,179.0 (12.5%) 05:56:48 INFO - TinderboxPrint: Swap in / out
0 / 0 05:56:48 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 8417280; Read time: 0; Write time: 1456 05:56:48 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:56:48 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 8192; Write bytes: 280707072; Read time: 304; Write time: 277420 05:56:49 INFO - Running post-run listener: _upload_blobber_files 05:56:49 INFO - Blob upload gear active. 05:56:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:56:49 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 05:56:49 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', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:56:49 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 Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:56:49 INFO - (blobuploader) - INFO - Open directory for files ... 05:56:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:56:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:56:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:56:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:56:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:56:50 INFO - (blobuploader) - INFO - Done attempting. 05:56:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:56:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:56:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:56:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:56:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:56:51 INFO - (blobuploader) - INFO - Done attempting. 05:56:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:56:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:56:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:56:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:56:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:56:54 INFO - (blobuploader) - INFO - Done attempting. 05:56:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:56:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:56:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:56:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:56:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:56:55 INFO - (blobuploader) - INFO - Done attempting. 05:56:55 INFO - (blobuploader) - INFO - Iteration through files over. 05:56:55 INFO - Return code: 0 05:56:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:56:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:56:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/31f26943e8eddc0587429e7641a49f8e381bc5c0228b6867a3483f15da9b826023f8d107be2243b303118da6f8116966ce8c7c5fcfdae63fd9637cea761e49fc", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/a3fa6af25ca2d67be566aeeb4b3fc85f0f0933534d7481ba7aee0ce302efa7047c37c691474f196760d4a62babca36d158c8fc264bcea8d27728c2822d4dc8b5", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/40d458b1a53a19e715aaee83521e0d94cbc06fc1d57923a5707ead9335f245b721a142052f27cc3fbe4134352c3fda67e5904bc2668aaa6bd251167c45d0bf41", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/df6767f867c29b792856cc592348e50e2dd9c620868f506a83f22a17a46a13b9bf746c592ef9cfa277940c38111ddeeccb63030107cd0688e5be4407dba49a83"} 05:56:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:56:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:56:55 INFO - Contents: 05:56:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/31f26943e8eddc0587429e7641a49f8e381bc5c0228b6867a3483f15da9b826023f8d107be2243b303118da6f8116966ce8c7c5fcfdae63fd9637cea761e49fc", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/a3fa6af25ca2d67be566aeeb4b3fc85f0f0933534d7481ba7aee0ce302efa7047c37c691474f196760d4a62babca36d158c8fc264bcea8d27728c2822d4dc8b5", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/40d458b1a53a19e715aaee83521e0d94cbc06fc1d57923a5707ead9335f245b721a142052f27cc3fbe4134352c3fda67e5904bc2668aaa6bd251167c45d0bf41", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/df6767f867c29b792856cc592348e50e2dd9c620868f506a83f22a17a46a13b9bf746c592ef9cfa277940c38111ddeeccb63030107cd0688e5be4407dba49a83"} 05:56:55 INFO - Running post-run listener: copy_logs_to_upload_dir 05:56:55 INFO - Copying logs to upload dir... 05:56:55 INFO - mkdir: /builds/slave/test/build/upload/logs 05:56:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.411084 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2017-10-02 05:56:55.731527) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-02 05:56:55.736558) ========= 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=fa44defc139c4ba8574fe040000001db-1506947580.571284-1832286885 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/Mozilla-Beta-Non-PGO/sha512/31f26943e8eddc0587429e7641a49f8e381bc5c0228b6867a3483f15da9b826023f8d107be2243b303118da6f8116966ce8c7c5fcfdae63fd9637cea761e49fc", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/a3fa6af25ca2d67be566aeeb4b3fc85f0f0933534d7481ba7aee0ce302efa7047c37c691474f196760d4a62babca36d158c8fc264bcea8d27728c2822d4dc8b5", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/40d458b1a53a19e715aaee83521e0d94cbc06fc1d57923a5707ead9335f245b721a142052f27cc3fbe4134352c3fda67e5904bc2668aaa6bd251167c45d0bf41", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/df6767f867c29b792856cc592348e50e2dd9c620868f506a83f22a17a46a13b9bf746c592ef9cfa277940c38111ddeeccb63030107cd0688e5be4407dba49a83"} build_url:https://queue.taskcluster.net/v1/task/XFLjpHIBQ1-E65lN9Pg_1g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011175 build_url: 'https://queue.taskcluster.net/v1/task/XFLjpHIBQ1-E65lN9Pg_1g/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/31f26943e8eddc0587429e7641a49f8e381bc5c0228b6867a3483f15da9b826023f8d107be2243b303118da6f8116966ce8c7c5fcfdae63fd9637cea761e49fc", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/a3fa6af25ca2d67be566aeeb4b3fc85f0f0933534d7481ba7aee0ce302efa7047c37c691474f196760d4a62babca36d158c8fc264bcea8d27728c2822d4dc8b5", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/40d458b1a53a19e715aaee83521e0d94cbc06fc1d57923a5707ead9335f245b721a142052f27cc3fbe4134352c3fda67e5904bc2668aaa6bd251167c45d0bf41", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/df6767f867c29b792856cc592348e50e2dd9c620868f506a83f22a17a46a13b9bf746c592ef9cfa277940c38111ddeeccb63030107cd0688e5be4407dba49a83"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-02 05:56:55.767875) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 05:56:55.768200) ========= 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=fa44defc139c4ba8574fe040000001db-1506947580.571284-1832286885 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004582 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 05:56:55.849101) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-02 05:56:55.849416) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-02 05:56:55.849702) ========= ========= Total master_lag: 0.23 =========