builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-088 starttime: 1504345258.21 results: success (0) revision: b01a7e57425b5fe791ab091f5c33e069890753fb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-02 02:40:58.212125) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-02 02:40:58.212578) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-02 02:40:58.212904) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-02 02:40:58.422698) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-02 02:40:58.423083) ========= 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=9f7544b6a75ada7b6b576032000001a7-1504345254.899811-8515522 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-02 02:40:58-- 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% 224M=0s 2017-09-02 02:40:58 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.104674 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-02 02:40:58.598753) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-02 02:40:58.599568) ========= 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=9f7544b6a75ada7b6b576032000001a7-1504345254.899811-8515522 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018243 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-02 02:40:58.642778) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-02 02:40:58.643087) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b01a7e57425b5fe791ab091f5c33e069890753fb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev b01a7e57425b5fe791ab091f5c33e069890753fb --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=9f7544b6a75ada7b6b576032000001a7-1504345254.899811-8515522 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-02 02:40:58,759 truncating revision to first 12 chars 2017-09-02 02:40:58,759 Setting DEBUG logging. 2017-09-02 02:40:58,759 attempt 1/10 2017-09-02 02:40:58,759 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b01a7e57425b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-02 02:40:59,215 unpacking tar archive at: mozilla-central-b01a7e57425b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.767426 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-02 02:40:59.433945) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-02 02:40:59.434377) ========= script_repo_revision: b01a7e57425b5fe791ab091f5c33e069890753fb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-02 02:40:59.434933) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-02 02:40:59.435209) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-02 02:40:59.452600) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-09-02 02:40:59.452987) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9f7544b6a75ada7b6b576032000001a7-1504345254.899811-8515522 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:40:59 INFO - MultiFileLogger online at 20170902 02:40:59 in /builds/slave/test 02:40:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 02:40:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:40:59 INFO - {'append_to_log': False, 02:40:59 INFO - 'base_work_dir': '/builds/slave/test', 02:40:59 INFO - 'blob_upload_branch': 'Firefox', 02:40:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:40:59 INFO - 'branch': 'Firefox', 02:40:59 INFO - 'buildbot_json_path': 'buildprops.json', 02:40:59 INFO - 'code_coverage': False, 02:40:59 INFO - 'config_files': ('talos/linux_config.py',), 02:40:59 INFO - 'default_actions': ('clobber', 02:40:59 INFO - 'read-buildbot-config', 02:40:59 INFO - 'download-and-extract', 02:40:59 INFO - 'populate-webroot', 02:40:59 INFO - 'create-virtualenv', 02:40:59 INFO - 'install', 02:40:59 INFO - 'setup-mitmproxy', 02:40:59 INFO - 'run-tests'), 02:40:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:40:59 INFO - 'disable_ccov_upload': False, 02:40:59 INFO - 'disable_stylo': False, 02:40:59 INFO - 'download_minidump_stackwalk': True, 02:40:59 INFO - 'download_symbols': 'ondemand', 02:40:59 INFO - 'enable_stylo': False, 02:40:59 INFO - 'enable_webrender': False, 02:40:59 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 02:40:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:40:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:40:59 INFO - 'gecko_profile': False, 02:40:59 INFO - 'gecko_profile_interval': 0, 02:40:59 INFO - 'installer_path': 'installer.exe', 02:40:59 INFO - 'log_level': 'info', 02:40:59 INFO - 'log_name': 'talos', 02:40:59 INFO - 'log_to_console': True, 02:40:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:40:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:40:59 INFO - 'opt_config_files': (), 02:40:59 INFO - 'pip_index': False, 02:40:59 INFO - 'suite': 'dromaeojs-e10s', 02:40:59 INFO - 'system_bits': '32', 02:40:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:40:59 INFO - 'title': 'talos-linux64-ix-088', 02:40:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:40:59 INFO - 'use_talos_json': True, 02:40:59 INFO - 'verify': 'False', 02:40:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:40:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:40:59 INFO - 'work_dir': 'build'} 02:40:59 INFO - [mozharness: 2017-09-02 09:40:59.714155Z] Running clobber step. 02:40:59 INFO - Running pre-action listener: _resource_record_pre_action 02:40:59 INFO - Running main action method: clobber 02:40:59 INFO - rmtree: /builds/slave/test/build 02:40:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:41:01 INFO - Running post-action listener: _resource_record_post_action 02:41:01 INFO - [mozharness: 2017-09-02 09:41:01.237106Z] Finished clobber step (success) 02:41:01 INFO - [mozharness: 2017-09-02 09:41:01.237203Z] Running read-buildbot-config step. 02:41:01 INFO - Running pre-action listener: _resource_record_pre_action 02:41:01 INFO - Running main action method: read_buildbot_config 02:41:01 INFO - Using buildbot properties: 02:41:01 INFO - { 02:41:01 INFO - "project": "", 02:41:01 INFO - "product": "firefox", 02:41:01 INFO - "who": "archaeopteryx@coole-files.de", 02:41:01 INFO - "installer_path": "public/build/target.tar.bz2", 02:41:01 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 02:41:01 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 02:41:01 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 02:41:01 INFO - "stage_platform": "linux64-qr", 02:41:01 INFO - "basedir": "/builds/slave/test", 02:41:01 INFO - "buildnumber": 29, 02:41:01 INFO - "platform": "ubuntu64_hw_qr", 02:41:01 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:41:01 INFO - "slavebuilddir": "test", 02:41:01 INFO - "taskId": "Rtg9bRgnROWa77LY_eK-bg", 02:41:01 INFO - "branch": "mozilla-central", 02:41:01 INFO - "script_repo_revision": "production", 02:41:01 INFO - "revision": "b01a7e57425b5fe791ab091f5c33e069890753fb", 02:41:01 INFO - "slavename": "talos-linux64-ix-088", 02:41:01 INFO - "repo_path": "mozilla-central" 02:41:01 INFO - } 02:41:01 INFO - Finding installer, test and symbols from parent task. 02:41:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rtg9bRgnROWa77LY_eK-bg'}, attempt #1 02:41:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rtg9bRgnROWa77LY_eK-bg'}, attempt #1 02:41:02 INFO - Task dependencies: ftQy0px5TK6bx82a3KX9nw 02:41:02 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw'}, attempt #1 02:41:02 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.tar.bz2 02:41:02 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.test_packages.json 02:41:02 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.crashreporter-symbols.zip 02:41:02 INFO - Running post-action listener: _resource_record_post_action 02:41:02 INFO - [mozharness: 2017-09-02 09:41:02.599847Z] Finished read-buildbot-config step (success) 02:41:02 INFO - [mozharness: 2017-09-02 09:41:02.600068Z] Running download-and-extract step. 02:41:02 INFO - Running pre-action listener: _resource_record_pre_action 02:41:02 INFO - Running main action method: download_and_extract 02:41:02 INFO - mkdir: /builds/slave/test/build/tests 02:41:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:41:02 INFO - trying https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.test_packages.json 02:41:02 INFO - Downloading https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:41:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:41:03 INFO - Downloaded 989 bytes. 02:41:03 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:41:03 INFO - Using the following test package requirements: 02:41:03 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:41:03 INFO - u'common': [u'target.common.tests.zip'], 02:41:03 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:41:03 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:41:03 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:41:03 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:41:03 INFO - u'mozbase': [u'target.common.tests.zip'], 02:41:03 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:41:03 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:41:03 INFO - u'web-platform': [u'target.common.tests.zip', 02:41:03 INFO - u'target.web-platform.tests.tar.gz'], 02:41:03 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:41:03 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:41:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.common.tests.zip 02:41:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:41:03 INFO - Fetch https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.common.tests.zip into memory 02:41:04 INFO - Content-Length response header: 55022366 02:41:04 INFO - Bytes received: 55022366 02:41:15 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:41:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.common.tests.zip 02:41:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:41:15 INFO - Fetch https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.common.tests.zip into memory 02:41:16 INFO - Content-Length response header: 55022366 02:41:16 INFO - Bytes received: 55022366 02:41:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.talos.tests.zip 02:41:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:41:28 INFO - Fetch https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.talos.tests.zip into memory 02:41:29 INFO - Content-Length response header: 14496650 02:41:29 INFO - Bytes received: 14496650 02:41:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:41:29 INFO - trying https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.tar.bz2 02:41:29 INFO - Downloading https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:41:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:41:30 INFO - Downloaded 62600457 bytes. 02:41:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.tar.bz2 02:41:30 INFO - mkdir: /builds/slave/test/properties 02:41:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:41:30 INFO - Writing to file /builds/slave/test/properties/build_url 02:41:30 INFO - Contents: 02:41:30 INFO - build_url:https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.tar.bz2 02:41:30 INFO - Running post-action listener: _resource_record_post_action 02:41:30 INFO - Running post-action listener: find_tests_for_verification 02:41:30 INFO - Running post-action listener: set_extra_try_arguments 02:41:30 INFO - [mozharness: 2017-09-02 09:41:30.433802Z] Finished download-and-extract step (success) 02:41:30 INFO - [mozharness: 2017-09-02 09:41:30.433899Z] Running populate-webroot step. 02:41:30 INFO - Running pre-action listener: _resource_record_pre_action 02:41:30 INFO - Running main action method: populate_webroot 02:41:30 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:41:30 INFO - 'chromez-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:41:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:41:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:41:30 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:41:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:41:30 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:41:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:41:30 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:41:30 INFO - 'talos_options': ['--enable-stylo'], 02:41:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:41:30 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:41:30 INFO - 'tests': ['damp', 'tps']}, 02:41:30 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:41:30 INFO - 'talos_options': ['--enable-stylo'], 02:41:30 INFO - 'tests': ['damp', 'tps']}, 02:41:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:41:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:41:30 INFO - 'g4-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:41:30 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 02:41:30 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:41:30 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:41:30 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:41:30 INFO - 'talos_options': ['--enable-stylo'], 02:41:30 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:41:30 INFO - 'other-e10s': {'tests': ['a11yr', 02:41:30 INFO - 'ts_paint', 02:41:30 INFO - 'tpaint', 02:41:30 INFO - 'sessionrestore', 02:41:30 INFO - 'sessionrestore_many_windows', 02:41:30 INFO - 'sessionrestore_no_auto_restore', 02:41:30 INFO - 'tabpaint']}, 02:41:30 INFO - 'other-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:41:30 INFO - 'tests': ['a11yr', 02:41:30 INFO - 'ts_paint', 02:41:30 INFO - 'tpaint', 02:41:30 INFO - 'sessionrestore', 02:41:30 INFO - 'sessionrestore_many_windows', 02:41:30 INFO - 'sessionrestore_no_auto_restore', 02:41:30 INFO - 'tabpaint']}, 02:41:30 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 02:41:30 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 02:41:30 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:41:30 INFO - 'tests': ['bloom_basic_singleton']}, 02:41:30 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:41:30 INFO - 'tests': ['bloom_basic']}, 02:41:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:41:30 INFO - 'tsvgr_opacity', 02:41:30 INFO - 'tart', 02:41:30 INFO - 'tscrollx', 02:41:30 INFO - 'tsvg_static']}, 02:41:30 INFO - 'svgr-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:41:30 INFO - 'tests': ['tsvgx', 02:41:30 INFO - 'tsvgr_opacity', 02:41:30 INFO - 'tart', 02:41:30 INFO - 'tscrollx', 02:41:30 INFO - 'tsvg_static']}, 02:41:30 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:41:30 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:41:30 INFO - 'talos_options': ['--enable-stylo'], 02:41:30 INFO - 'tests': ['tp5o']}, 02:41:30 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:41:30 INFO - 'talos_options': ['--mitmproxy', 02:41:30 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:41:30 INFO - '--firstNonBlankPaint'], 02:41:30 INFO - 'tests': ['tp6_google', 02:41:30 INFO - 'tp6_youtube', 02:41:30 INFO - 'tp6_amazon', 02:41:30 INFO - 'tp6_facebook']}, 02:41:30 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:41:30 INFO - 'talos_options': ['--enable-stylo', 02:41:30 INFO - '--mitmproxy', 02:41:30 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:41:30 INFO - '--firstNonBlankPaint'], 02:41:30 INFO - 'tests': ['tp6_google', 02:41:30 INFO - 'tp6_youtube', 02:41:30 INFO - 'tp6_amazon', 02:41:30 INFO - 'tp6_facebook']}, 02:41:30 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:41:30 INFO - 'talos_options': ['--enable-stylo', 02:41:30 INFO - '--stylo-threads=1', 02:41:30 INFO - '--mitmproxy', 02:41:30 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:41:30 INFO - '--firstNonBlankPaint'], 02:41:30 INFO - 'tests': ['tp6_google', 02:41:30 INFO - 'tp6_youtube', 02:41:30 INFO - 'tp6_amazon', 02:41:30 INFO - 'tp6_facebook']}, 02:41:30 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:41:30 INFO - 'talos_options': ['--xperf_path', 02:41:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:41:30 INFO - 'tests': ['tp5n']}, 02:41:30 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:41:30 INFO - 'talos_options': ['--enable-stylo', 02:41:30 INFO - '--xperf_path', 02:41:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:41:30 INFO - 'tests': ['tp5n']}}} 02:41:30 INFO - Running post-action listener: _resource_record_post_action 02:41:30 INFO - [mozharness: 2017-09-02 09:41:30.448176Z] Finished populate-webroot step (success) 02:41:30 INFO - [mozharness: 2017-09-02 09:41:30.448265Z] Running create-virtualenv step. 02:41:30 INFO - Running pre-action listener: _resource_record_pre_action 02:41:30 INFO - Running main action method: create_virtualenv 02:41:30 INFO - Creating virtualenv /builds/slave/test/build/venv 02:41:30 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:41:30 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 02:41:30 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:41:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:41:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:41:31 INFO - Installing distribute.............................................................................................................................................................................................done. 02:41:31 INFO - Installing pip...............done. 02:41:31 INFO - Return code: 0 02:41:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:41:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:41:31 INFO - Reading from file tmpfile_stdout 02:41:31 INFO - Output received: 02:41:31 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 02:41:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:41:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:41:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:41:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bfa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c3090>, '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 0x21c3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21bdf90>, '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': '9f7544b6a75ada7b6b576032000001a7-1504345254.899811-8515522', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:41:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:41:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:41:31 INFO - Using env: {'DISPLAY': ':0', 02:41:31 INFO - 'HOME': '/home/cltbld', 02:41:31 INFO - 'LANG': 'en_US.UTF-8', 02:41:31 INFO - 'LANGUAGE': 'en_US:en', 02:41:31 INFO - 'LOGNAME': 'cltbld', 02:41:31 INFO - 'MAIL': '/var/mail/cltbld', 02:41:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:31 INFO - 'MOZ_NO_REMOTE': '1', 02:41:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:31 INFO - 'NO_EM_RESTART': '1', 02:41:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:31 INFO - 'PWD': '/builds/slave/test', 02:41:31 INFO - 'SHELL': '/bin/bash', 02:41:31 INFO - 'SHLVL': '1', 02:41:31 INFO - 'TERM': 'linux', 02:41:31 INFO - 'TMOUT': '86400', 02:41:31 INFO - 'USER': 'cltbld', 02:41:31 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1504345254.899811-8515522', 02:41:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:31 INFO - '_': '/tools/buildbot/bin/python'} 02:41:32 INFO - Ignoring indexes: http://pypi.python.org/simple/ 02:41:32 INFO - Downloading/unpacking pip>=1.5 02:41:32 INFO - Running setup.py egg_info for package pip 02:41:32 INFO - warning: no files found matching 'pip/cacert.pem' 02:41:32 INFO - warning: no files found matching '*.html' under directory 'docs' 02:41:32 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:41:32 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:41:32 INFO - Installing collected packages: pip 02:41:32 INFO - Found existing installation: pip 1.1 02:41:32 INFO - Uninstalling pip: 02:41:32 INFO - Successfully uninstalled pip 02:41:32 INFO - Running setup.py install for pip 02:41:32 INFO - warning: no files found matching 'pip/cacert.pem' 02:41:32 INFO - warning: no files found matching '*.html' under directory 'docs' 02:41:32 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:41:32 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:41:32 INFO - Installing pip script to /builds/slave/test/build/venv/bin 02:41:32 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 02:41:32 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 02:41:32 INFO - Successfully installed pip 02:41:32 INFO - Cleaning up... 02:41:32 INFO - Return code: 0 02:41:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:41:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:41:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:41:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:32 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 0x1e531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bfa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c3090>, '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 0x21c3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21bdf90>, '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': '9f7544b6a75ada7b6b576032000001a7-1504345254.899811-8515522', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:41:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:41:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:41:32 INFO - Using env: {'DISPLAY': ':0', 02:41:32 INFO - 'HOME': '/home/cltbld', 02:41:32 INFO - 'LANG': 'en_US.UTF-8', 02:41:32 INFO - 'LANGUAGE': 'en_US:en', 02:41:32 INFO - 'LOGNAME': 'cltbld', 02:41:32 INFO - 'MAIL': '/var/mail/cltbld', 02:41:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:32 INFO - 'MOZ_NO_REMOTE': '1', 02:41:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:32 INFO - 'NO_EM_RESTART': '1', 02:41:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:32 INFO - 'PWD': '/builds/slave/test', 02:41:32 INFO - 'SHELL': '/bin/bash', 02:41:32 INFO - 'SHLVL': '1', 02:41:32 INFO - 'TERM': 'linux', 02:41:32 INFO - 'TMOUT': '86400', 02:41:32 INFO - 'USER': 'cltbld', 02:41:32 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1504345254.899811-8515522', 02:41:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:32 INFO - '_': '/tools/buildbot/bin/python'} 02:41:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:32 INFO - Downloading/unpacking psutil>=3.1.1 02:41:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:41:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:41:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:41:34 INFO - Installing collected packages: psutil 02:41:34 INFO - Running setup.py install for psutil 02:41:34 INFO - building 'psutil._psutil_linux' extension 02:41:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:41:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:41:34 INFO - building 'psutil._psutil_posix' extension 02:41:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:41:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:41:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:41:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:41:34 INFO - Successfully installed psutil 02:41:34 INFO - Cleaning up... 02:41:34 INFO - Return code: 0 02:41:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:41:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:41:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:41:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bfa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c3090>, '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 0x21c3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21bdf90>, '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': '9f7544b6a75ada7b6b576032000001a7-1504345254.899811-8515522', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:41:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:41:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:41:34 INFO - Using env: {'DISPLAY': ':0', 02:41:34 INFO - 'HOME': '/home/cltbld', 02:41:34 INFO - 'LANG': 'en_US.UTF-8', 02:41:34 INFO - 'LANGUAGE': 'en_US:en', 02:41:34 INFO - 'LOGNAME': 'cltbld', 02:41:34 INFO - 'MAIL': '/var/mail/cltbld', 02:41:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:34 INFO - 'MOZ_NO_REMOTE': '1', 02:41:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:34 INFO - 'NO_EM_RESTART': '1', 02:41:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:34 INFO - 'PWD': '/builds/slave/test', 02:41:34 INFO - 'SHELL': '/bin/bash', 02:41:34 INFO - 'SHLVL': '1', 02:41:34 INFO - 'TERM': 'linux', 02:41:34 INFO - 'TMOUT': '86400', 02:41:34 INFO - 'USER': 'cltbld', 02:41:34 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1504345254.899811-8515522', 02:41:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:34 INFO - '_': '/tools/buildbot/bin/python'} 02:41:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:41:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:41:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:41:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:41:35 INFO - Installing collected packages: mozsystemmonitor 02:41:35 INFO - Running setup.py install for mozsystemmonitor 02:41:36 INFO - Successfully installed mozsystemmonitor 02:41:36 INFO - Cleaning up... 02:41:36 INFO - Return code: 0 02:41:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:41:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:41:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:41:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1e531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bfa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c3090>, '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 0x21c3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21bdf90>, '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': '9f7544b6a75ada7b6b576032000001a7-1504345254.899811-8515522', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:41:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:41:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:41:36 INFO - Using env: {'DISPLAY': ':0', 02:41:36 INFO - 'HOME': '/home/cltbld', 02:41:36 INFO - 'LANG': 'en_US.UTF-8', 02:41:36 INFO - 'LANGUAGE': 'en_US:en', 02:41:36 INFO - 'LOGNAME': 'cltbld', 02:41:36 INFO - 'MAIL': '/var/mail/cltbld', 02:41:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:36 INFO - 'MOZ_NO_REMOTE': '1', 02:41:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:36 INFO - 'NO_EM_RESTART': '1', 02:41:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:36 INFO - 'PWD': '/builds/slave/test', 02:41:36 INFO - 'SHELL': '/bin/bash', 02:41:36 INFO - 'SHLVL': '1', 02:41:36 INFO - 'TERM': 'linux', 02:41:36 INFO - 'TMOUT': '86400', 02:41:36 INFO - 'USER': 'cltbld', 02:41:36 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1504345254.899811-8515522', 02:41:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:36 INFO - '_': '/tools/buildbot/bin/python'} 02:41:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:36 INFO - Downloading/unpacking jsonschema==2.5.1 02:41:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:41:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:41:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:37 INFO - Downloading functools32-3.2.3-2.tar.gz 02:41:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:41:37 INFO - warning: no files found matching '*.txt' 02:41:37 INFO - no previously-included directories found matching 'build' 02:41:37 INFO - no previously-included directories found matching 'dist' 02:41:37 INFO - no previously-included directories found matching '.git*' 02:41:37 INFO - Installing collected packages: jsonschema, functools32 02:41:37 INFO - Running setup.py install for functools32 02:41:37 INFO - warning: no files found matching '*.txt' 02:41:37 INFO - no previously-included directories found matching 'build' 02:41:37 INFO - no previously-included directories found matching 'dist' 02:41:37 INFO - no previously-included directories found matching '.git*' 02:41:37 INFO - Successfully installed jsonschema functools32 02:41:37 INFO - Cleaning up... 02:41:37 INFO - Return code: 0 02:41:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:41:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:41:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:41:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1e531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bfa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c3090>, '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 0x21c3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21bdf90>, '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': '9f7544b6a75ada7b6b576032000001a7-1504345254.899811-8515522', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:41:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:41:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:41:37 INFO - Using env: {'DISPLAY': ':0', 02:41:37 INFO - 'HOME': '/home/cltbld', 02:41:37 INFO - 'LANG': 'en_US.UTF-8', 02:41:37 INFO - 'LANGUAGE': 'en_US:en', 02:41:37 INFO - 'LOGNAME': 'cltbld', 02:41:37 INFO - 'MAIL': '/var/mail/cltbld', 02:41:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:37 INFO - 'MOZ_NO_REMOTE': '1', 02:41:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:37 INFO - 'NO_EM_RESTART': '1', 02:41:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:37 INFO - 'PWD': '/builds/slave/test', 02:41:37 INFO - 'SHELL': '/bin/bash', 02:41:37 INFO - 'SHLVL': '1', 02:41:37 INFO - 'TERM': 'linux', 02:41:37 INFO - 'TMOUT': '86400', 02:41:37 INFO - 'USER': 'cltbld', 02:41:37 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1504345254.899811-8515522', 02:41:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:37 INFO - '_': '/tools/buildbot/bin/python'} 02:41:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:41:37 INFO - Cleaning up... 02:41:37 INFO - Return code: 0 02:41:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:41:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:41:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:41:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:38 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 0x1e531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bfa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c3090>, '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 0x21c3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21bdf90>, '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': '9f7544b6a75ada7b6b576032000001a7-1504345254.899811-8515522', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:41:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:41:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:41:38 INFO - Using env: {'DISPLAY': ':0', 02:41:38 INFO - 'HOME': '/home/cltbld', 02:41:38 INFO - 'LANG': 'en_US.UTF-8', 02:41:38 INFO - 'LANGUAGE': 'en_US:en', 02:41:38 INFO - 'LOGNAME': 'cltbld', 02:41:38 INFO - 'MAIL': '/var/mail/cltbld', 02:41:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:38 INFO - 'MOZ_NO_REMOTE': '1', 02:41:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:38 INFO - 'NO_EM_RESTART': '1', 02:41:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:38 INFO - 'PWD': '/builds/slave/test', 02:41:38 INFO - 'SHELL': '/bin/bash', 02:41:38 INFO - 'SHLVL': '1', 02:41:38 INFO - 'TERM': 'linux', 02:41:38 INFO - 'TMOUT': '86400', 02:41:38 INFO - 'USER': 'cltbld', 02:41:38 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1504345254.899811-8515522', 02:41:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:38 INFO - '_': '/tools/buildbot/bin/python'} 02:41:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:38 INFO - Downloading/unpacking blobuploader==1.2.4 02:41:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:39 INFO - Downloading blobuploader-1.2.4.tar.gz 02:41:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:41:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:41:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:41:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:41:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:39 INFO - Downloading docopt-0.6.1.tar.gz 02:41:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:41:39 INFO - Installing collected packages: blobuploader, requests, docopt 02:41:39 INFO - Running setup.py install for blobuploader 02:41:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:41:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:41:39 INFO - Running setup.py install for requests 02:41:40 INFO - Running setup.py install for docopt 02:41:40 INFO - Successfully installed blobuploader requests docopt 02:41:40 INFO - Cleaning up... 02:41:40 INFO - Return code: 0 02:41:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:41:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:41:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:41:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:40 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 0x1e531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bfa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c3090>, '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 0x21c3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21bdf90>, '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': '9f7544b6a75ada7b6b576032000001a7-1504345254.899811-8515522', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:41:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:41:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:41:40 INFO - Using env: {'DISPLAY': ':0', 02:41:40 INFO - 'HOME': '/home/cltbld', 02:41:40 INFO - 'LANG': 'en_US.UTF-8', 02:41:40 INFO - 'LANGUAGE': 'en_US:en', 02:41:40 INFO - 'LOGNAME': 'cltbld', 02:41:40 INFO - 'MAIL': '/var/mail/cltbld', 02:41:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:40 INFO - 'MOZ_NO_REMOTE': '1', 02:41:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:40 INFO - 'NO_EM_RESTART': '1', 02:41:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:40 INFO - 'PWD': '/builds/slave/test', 02:41:40 INFO - 'SHELL': '/bin/bash', 02:41:40 INFO - 'SHLVL': '1', 02:41:40 INFO - 'TERM': 'linux', 02:41:40 INFO - 'TMOUT': '86400', 02:41:40 INFO - 'USER': 'cltbld', 02:41:40 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1504345254.899811-8515522', 02:41:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:40 INFO - '_': '/tools/buildbot/bin/python'} 02:41:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:41:40 INFO - Running setup.py (path:/tmp/pip-E0mBnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:41:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:41:40 INFO - Running setup.py (path:/tmp/pip-vdW6IF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:41:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:41:40 INFO - Running setup.py (path:/tmp/pip-aDZX5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:41:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:41:40 INFO - Running setup.py (path:/tmp/pip-lC2TOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:41:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:41:40 INFO - Running setup.py (path:/tmp/pip-pGylZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:41:41 INFO - Running setup.py (path:/tmp/pip-6ideSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:41:41 INFO - Running setup.py (path:/tmp/pip-vtN4Zy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:41:41 INFO - Running setup.py (path:/tmp/pip-J8bka7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:41:41 INFO - Running setup.py (path:/tmp/pip-HDIGdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:41:41 INFO - Running setup.py (path:/tmp/pip-xCchfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:41:41 INFO - Running setup.py (path:/tmp/pip-xusG2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:41:41 INFO - Running setup.py (path:/tmp/pip-iFJjhR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:41:41 INFO - Running setup.py (path:/tmp/pip-C0lPZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:41:41 INFO - Running setup.py (path:/tmp/pip-swgEVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:41:41 INFO - Running setup.py (path:/tmp/pip-eP2End-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:41:41 INFO - Running setup.py (path:/tmp/pip-3UFrLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:41:41 INFO - Running setup.py (path:/tmp/pip-U60mMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:41:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:41:41 INFO - Running setup.py install for manifestparser 02:41:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:41:42 INFO - Running setup.py install for mozcrash 02:41:42 INFO - Running setup.py install for mozdebug 02:41:42 INFO - Running setup.py install for mozdevice 02:41:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:41:42 INFO - Running setup.py install for mozfile 02:41:42 INFO - Running setup.py install for mozhttpd 02:41:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:41:42 INFO - Running setup.py install for mozinfo 02:41:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:41:42 INFO - Running setup.py install for mozInstall 02:41:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:41:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:41:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:41:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:41:42 INFO - Running setup.py install for mozleak 02:41:42 INFO - Running setup.py install for mozlog 02:41:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:41:42 INFO - Running setup.py install for moznetwork 02:41:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:41:42 INFO - Running setup.py install for mozprocess 02:41:43 INFO - Running setup.py install for mozprofile 02:41:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:41:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:41:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:41:43 INFO - Running setup.py install for mozrunner 02:41:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:41:43 INFO - Running setup.py install for mozscreenshot 02:41:43 INFO - Running setup.py install for moztest 02:41:43 INFO - Running setup.py install for mozversion 02:41:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:41:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:41:43 INFO - Cleaning up... 02:41:43 INFO - Return code: 0 02:41:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:41:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:41:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:41:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:43 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 0x1e531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bfa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c3090>, '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 0x21c3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21bdf90>, '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': '9f7544b6a75ada7b6b576032000001a7-1504345254.899811-8515522', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:41:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:41:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:41:43 INFO - Using env: {'DISPLAY': ':0', 02:41:43 INFO - 'HOME': '/home/cltbld', 02:41:43 INFO - 'LANG': 'en_US.UTF-8', 02:41:43 INFO - 'LANGUAGE': 'en_US:en', 02:41:43 INFO - 'LOGNAME': 'cltbld', 02:41:43 INFO - 'MAIL': '/var/mail/cltbld', 02:41:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:43 INFO - 'MOZ_NO_REMOTE': '1', 02:41:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:43 INFO - 'NO_EM_RESTART': '1', 02:41:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:43 INFO - 'PWD': '/builds/slave/test', 02:41:43 INFO - 'SHELL': '/bin/bash', 02:41:43 INFO - 'SHLVL': '1', 02:41:43 INFO - 'TERM': 'linux', 02:41:43 INFO - 'TMOUT': '86400', 02:41:43 INFO - 'USER': 'cltbld', 02:41:43 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1504345254.899811-8515522', 02:41:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:43 INFO - '_': '/tools/buildbot/bin/python'} 02:41:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:41:43 INFO - Running setup.py (path:/tmp/pip-vlKIYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:41:43 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:41:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:41:43 INFO - Running setup.py (path:/tmp/pip-livEpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:41:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:41:44 INFO - Running setup.py (path:/tmp/pip-MVuTka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:41:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:41:44 INFO - Running setup.py (path:/tmp/pip-uAYvSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:41:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:41:44 INFO - Running setup.py (path:/tmp/pip-LbUReH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:41:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:41:44 INFO - Running setup.py (path:/tmp/pip-qcHqun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:41:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:41:44 INFO - Running setup.py (path:/tmp/pip-GHIazV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:41:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:41:44 INFO - Running setup.py (path:/tmp/pip-0hVlgd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:41:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:41:44 INFO - Running setup.py (path:/tmp/pip-bco1Ss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:41:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:41:44 INFO - Running setup.py (path:/tmp/pip-vYCwgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:41:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:41:44 INFO - Running setup.py (path:/tmp/pip-N4uMd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:41:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:41:44 INFO - Running setup.py (path:/tmp/pip-c2qV25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:41:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:41:44 INFO - Running setup.py (path:/tmp/pip-fuCJyx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:41:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:41:44 INFO - Running setup.py (path:/tmp/pip-yFUnjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:41:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:41:44 INFO - Running setup.py (path:/tmp/pip-kvQ6t5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:41:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:41:44 INFO - Running setup.py (path:/tmp/pip-py66f1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:41:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:41:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:41:45 INFO - Running setup.py (path:/tmp/pip-LYFMbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:41:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:41:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:41:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:41:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:41:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:41:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:41:45 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:41:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:46 INFO - Downloading blessings-1.6.tar.gz 02:41:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:41:46 INFO - Installing collected packages: blessings 02:41:46 INFO - Running setup.py install for blessings 02:41:46 INFO - Successfully installed blessings 02:41:46 INFO - Cleaning up... 02:41:46 INFO - Return code: 0 02:41:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:41:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:41:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:41:46 INFO - Reading from file tmpfile_stdout 02:41:46 INFO - Current package versions: 02:41:46 INFO - argparse == 1.2.1 02:41:46 INFO - blessings == 1.6 02:41:46 INFO - blobuploader == 1.2.4 02:41:46 INFO - docopt == 0.6.1 02:41:46 INFO - functools32 == 3.2.3-2 02:41:46 INFO - jsonschema == 2.5.1 02:41:46 INFO - manifestparser == 1.1 02:41:46 INFO - mozInstall == 1.13 02:41:46 INFO - mozcrash == 1.0 02:41:46 INFO - mozdebug == 0.1 02:41:46 INFO - mozdevice == 0.51 02:41:46 INFO - mozfile == 1.2 02:41:46 INFO - mozhttpd == 0.7 02:41:46 INFO - mozinfo == 0.10 02:41:46 INFO - mozleak == 0.1 02:41:46 INFO - mozlog == 3.5 02:41:46 INFO - moznetwork == 0.27 02:41:46 INFO - mozprocess == 0.25 02:41:46 INFO - mozprofile == 0.28 02:41:46 INFO - mozrunner == 6.13 02:41:46 INFO - mozscreenshot == 0.1 02:41:46 INFO - mozsystemmonitor == 0.3 02:41:46 INFO - moztest == 0.8 02:41:46 INFO - mozversion == 1.4 02:41:46 INFO - psutil == 3.1.1 02:41:46 INFO - requests == 1.2.3 02:41:46 INFO - wsgiref == 0.1.2 02:41:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:41: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')]} 02:41:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41: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')]} 02:41:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:46 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 0x1e531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bfa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c3090>, '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 0x21c3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21bdf90>, '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': '9f7544b6a75ada7b6b576032000001a7-1504345254.899811-8515522', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:41:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:41:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:41:46 INFO - Using env: {'DISPLAY': ':0', 02:41:46 INFO - 'HOME': '/home/cltbld', 02:41:46 INFO - 'LANG': 'en_US.UTF-8', 02:41:46 INFO - 'LANGUAGE': 'en_US:en', 02:41:46 INFO - 'LOGNAME': 'cltbld', 02:41:46 INFO - 'MAIL': '/var/mail/cltbld', 02:41:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:46 INFO - 'MOZ_NO_REMOTE': '1', 02:41:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:46 INFO - 'NO_EM_RESTART': '1', 02:41:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:46 INFO - 'PWD': '/builds/slave/test', 02:41:46 INFO - 'SHELL': '/bin/bash', 02:41:46 INFO - 'SHLVL': '1', 02:41:46 INFO - 'TERM': 'linux', 02:41:46 INFO - 'TMOUT': '86400', 02:41:46 INFO - 'USER': 'cltbld', 02:41:46 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1504345254.899811-8515522', 02:41:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:46 INFO - '_': '/tools/buildbot/bin/python'} 02:41:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:41:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:41:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:41:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:41:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:41:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:41:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:41:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:41:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:41:46 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:41: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 02:41: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 02:41: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 02:41: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 02:41:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 02:41:48 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:41:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:41:48 INFO - Installing collected packages: simplejson 02:41:48 INFO - Running setup.py install for simplejson 02:41:48 INFO - building 'simplejson._speedups' extension 02:41:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 02:41:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 02:41:49 INFO - Successfully installed simplejson 02:41:49 INFO - Cleaning up... 02:41:49 INFO - Return code: 0 02:41:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:41:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:41:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bfa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c3090>, '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 0x21c3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21bdf90>, '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': '9f7544b6a75ada7b6b576032000001a7-1504345254.899811-8515522', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:41:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:41:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:41:49 INFO - Using env: {'DISPLAY': ':0', 02:41:49 INFO - 'HOME': '/home/cltbld', 02:41:49 INFO - 'LANG': 'en_US.UTF-8', 02:41:49 INFO - 'LANGUAGE': 'en_US:en', 02:41:49 INFO - 'LOGNAME': 'cltbld', 02:41:49 INFO - 'MAIL': '/var/mail/cltbld', 02:41:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:49 INFO - 'MOZ_NO_REMOTE': '1', 02:41:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:49 INFO - 'NO_EM_RESTART': '1', 02:41:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:49 INFO - 'PWD': '/builds/slave/test', 02:41:49 INFO - 'SHELL': '/bin/bash', 02:41:49 INFO - 'SHLVL': '1', 02:41:49 INFO - 'TERM': 'linux', 02:41:49 INFO - 'TMOUT': '86400', 02:41:49 INFO - 'USER': 'cltbld', 02:41:49 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1504345254.899811-8515522', 02:41:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:49 INFO - '_': '/tools/buildbot/bin/python'} 02:41:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:41:49 INFO - Cleaning up... 02:41:49 INFO - Return code: 0 02:41:49 INFO - Running post-action listener: _resource_record_post_action 02:41:49 INFO - Running post-action listener: _start_resource_monitoring 02:41:49 INFO - Starting resource monitoring. 02:41:49 INFO - [mozharness: 2017-09-02 09:41:49.375634Z] Finished create-virtualenv step (success) 02:41:49 INFO - [mozharness: 2017-09-02 09:41:49.376141Z] Running install step. 02:41:49 INFO - Running pre-action listener: _resource_record_pre_action 02:41:49 INFO - Running main action method: install 02:41:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:41:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:41:49 INFO - Reading from file tmpfile_stdout 02:41:49 INFO - Detecting whether we're running mozinstall >=1.0... 02:41:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:41:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:41:49 INFO - Reading from file tmpfile_stdout 02:41:49 INFO - Output received: 02:41:49 INFO - Usage: mozinstall [options] installer 02:41:49 INFO - Options: 02:41:49 INFO - -h, --help show this help message and exit 02:41:49 INFO - -d DEST, --destination=DEST 02:41:49 INFO - Directory to install application into. [default: 02:41:49 INFO - "/builds/slave/test"] 02:41:49 INFO - --app=APP Application being installed. [default: firefox] 02:41:49 INFO - mkdir: /builds/slave/test/build/application 02:41:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:41:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:42:06 INFO - Reading from file tmpfile_stdout 02:42:06 INFO - Output received: 02:42:06 INFO - /builds/slave/test/build/application/firefox/firefox 02:42:06 INFO - Running post-action listener: _resource_record_post_action 02:42:06 INFO - [mozharness: 2017-09-02 09:42:06.207773Z] Finished install step (success) 02:42:06 INFO - [mozharness: 2017-09-02 09:42:06.208024Z] Running setup-mitmproxy step. 02:42:06 INFO - Running pre-action listener: _resource_record_pre_action 02:42:06 INFO - Running main action method: setup_mitmproxy 02:42:06 INFO - Skipping: mitmproxy is not required 02:42:06 INFO - Running post-action listener: _resource_record_post_action 02:42:06 INFO - [mozharness: 2017-09-02 09:42:06.209136Z] Finished setup-mitmproxy step (success) 02:42:06 INFO - [mozharness: 2017-09-02 09:42:06.209354Z] Running run-tests step. 02:42:06 INFO - Running pre-action listener: _resource_record_pre_action 02:42:06 INFO - Running pre-action listener: _set_gcov_prefix 02:42:06 INFO - Running main action method: run_tests 02:42:06 WARNING - Try message not found. 02:42:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:42:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:42:06 INFO - Python 2.7.3 02:42:06 INFO - Return code: 0 02:42:06 INFO - grabbing minidump binary from tooltool 02:42:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:06 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 0x21c3090>, '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 0x21c3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21bdf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:42:06 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:42:06 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:42:06 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:42:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:42:06 INFO - Return code: 0 02:42:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:42:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:42:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:42:06 INFO - ENV: RUST_BACKTRACE is now full 02:42:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:42:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:42:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-088', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:42:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-088 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:42:06 INFO - Using env: {'DISPLAY': ':0', 02:42:06 INFO - 'HOME': '/home/cltbld', 02:42:06 INFO - 'LANG': 'en_US.UTF-8', 02:42:06 INFO - 'LANGUAGE': 'en_US:en', 02:42:06 INFO - 'LOGNAME': 'cltbld', 02:42:06 INFO - 'MAIL': '/var/mail/cltbld', 02:42:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:42:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:42:06 INFO - 'MOZ_ACCELERATED': '1', 02:42:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:06 INFO - 'MOZ_NO_REMOTE': '1', 02:42:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:42:06 INFO - 'MOZ_WEBRENDER': '1', 02:42:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:06 INFO - 'NO_EM_RESTART': '1', 02:42:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:06 INFO - 'PWD': '/builds/slave/test', 02:42:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:42:06 INFO - 'RUST_BACKTRACE': 'full', 02:42:06 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:42:06 INFO - 'SHELL': '/bin/bash', 02:42:06 INFO - 'SHLVL': '1', 02:42:06 INFO - 'TERM': 'linux', 02:42:06 INFO - 'TMOUT': '86400', 02:42:06 INFO - 'USER': 'cltbld', 02:42:06 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1504345254.899811-8515522', 02:42:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:06 INFO - '_': '/tools/buildbot/bin/python'} 02:42:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-088', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:42:06 INFO - mozversion application_buildid: 20170902085228 02:42:06 INFO - mozversion application_changeset: b01a7e57425b5fe791ab091f5c33e069890753fb 02:42:06 INFO - mozversion application_display_name: Nightly 02:42:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:42:06 INFO - mozversion application_name: Firefox 02:42:06 INFO - mozversion application_remotingname: firefox 02:42:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:42:06 INFO - mozversion application_vendor: Mozilla 02:42:06 INFO - mozversion application_version: 57.0a1 02:42:06 INFO - mozversion platform_buildid: 20170902085228 02:42:06 INFO - mozversion platform_changeset: b01a7e57425b5fe791ab091f5c33e069890753fb 02:42:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:42:06 INFO - mozversion platform_version: 57.0a1 02:42:06 INFO - using testdate: 1504345326 02:42:06 INFO - actual date: 1504345326 02:42:06 INFO - starting webserver on 'localhost:50454' 02:42:06 INFO - SUITE-START | Running 2 tests 02:42:06 INFO - TEST-START | dromaeo_css 02:42:06 INFO - Initialising browser for dromaeo_css test... 02:42:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50454/getInfo.html -profile /tmp/tmpaftmuq/profile 02:42:06 INFO - TEST-INFO | started process 26059 (/builds/slave/test/build/application/firefox/firefox http://localhost:50454/getInfo.html) 02:42:13 INFO - TEST-INFO | 26059: exit 0 02:42:13 INFO - Browser initialized. 02:42:13 INFO - Running cycle 1/1 for dromaeo_css test... 02:42:13 INFO - Using env: {'DISPLAY': ':0', 02:42:13 INFO - 'HOME': '/home/cltbld', 02:42:13 INFO - 'JSGC_DISABLE_POISONING': '1', 02:42:13 INFO - 'LANG': 'en_US.UTF-8', 02:42:13 INFO - 'LANGUAGE': 'en_US:en', 02:42:13 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 02:42:13 INFO - 'LOGNAME': 'cltbld', 02:42:13 INFO - 'MAIL': '/var/mail/cltbld', 02:42:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:42:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:42:13 INFO - 'MOZ_ACCELERATED': '1', 02:42:13 INFO - 'MOZ_CRASHREPORTER': '1', 02:42:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:13 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 02:42:13 INFO - 'MOZ_NO_REMOTE': '1', 02:42:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:42:13 INFO - 'MOZ_WEBRENDER': '1', 02:42:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:13 INFO - 'NO_EM_RESTART': '1', 02:42:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:13 INFO - 'PWD': '/builds/slave/test', 02:42:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:42:13 INFO - 'RUST_BACKTRACE': 'full', 02:42:13 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:42:13 INFO - 'SHELL': '/bin/bash', 02:42:13 INFO - 'SHLVL': '1', 02:42:13 INFO - 'TERM': 'linux', 02:42:13 INFO - 'TMOUT': '86400', 02:42:13 INFO - 'USER': 'cltbld', 02:42:13 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1504345254.899811-8515522', 02:42:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:13 INFO - '_': '/tools/buildbot/bin/python'} 02:42:13 INFO - TEST-INFO | started process 26253 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaftmuq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:42:14 INFO - PID 26253 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 02:42:14 INFO - PID 26253 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 02:42:14 INFO - PID 26253 | 02:42:14 INFO - PID 26253 | (/builds/slave/test/build/application/firefox/firefox:26314): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:42:14 INFO - PID 26253 | 02:42:25 INFO - PID 26253 | RSS: Main: 205684736 02:42:25 INFO - PID 26253 | 02:42:29 INFO - PID 26253 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 02:45:23 INFO - PID 26253 | Cycle 1(1): loaded http://localhost:50454/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50454/tests/dromaeo/cssquery-ext.html) 02:45:25 INFO - PID 26253 | RSS: Main: 215273472 02:45:25 INFO - PID 26253 | 02:48:27 INFO - PID 26253 | Cycle 1(1): loaded http://localhost:50454/tests/dromaeo/cssquery-ext.html (next: http://localhost:50454/tests/dromaeo/cssquery-jquery.html) 02:48:28 INFO - PID 26253 | RSS: Main: 212733952 02:48:28 INFO - PID 26253 | 02:51:30 INFO - PID 26253 | Cycle 1(1): loaded http://localhost:50454/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50454/tests/dromaeo/cssquery-mootools.html) 02:51:31 INFO - PID 26253 | RSS: Main: 214663168 02:51:31 INFO - PID 26253 | 02:54:33 INFO - PID 26253 | Cycle 1(1): loaded http://localhost:50454/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50454/tests/dromaeo/cssquery-prototype.html) 02:54:33 INFO - PID 26253 | RSS: Main: 213139456 02:54:33 INFO - PID 26253 | 02:57:37 INFO - PID 26253 | Cycle 1(1): loaded http://localhost:50454/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50454/tests/dromaeo/cssquery-yui.html) 02:57:38 INFO - PID 26253 | RSS: Main: 215056384 02:57:38 INFO - PID 26253 | 03:00:40 INFO - PID 26253 | Cycle 1(1): loaded http://localhost:50454/tests/dromaeo/cssquery-yui.html (next: http://localhost:50454/tests/dromaeo/cssquery-dojo.html) 03:00:40 INFO - PID 26253 | RSS: Main: 217255936 03:00:40 INFO - PID 26253 | 03:00:40 INFO - PID 26253 | __start_tp_report 03:00:40 INFO - PID 26253 | _x_x_mozilla_page_load 03:00:40 INFO - PID 26253 | _x_x_mozilla_page_load_details 03:00:40 INFO - PID 26253 | |i|pagename|runs| 03:00:40 INFO - PID 26253 | |0;dojo.html;3292.357990191912;3329.334133173366;3369.4440417331143;3382.137554923495;3414.3171365726844;6391.840203994902;6397.58415702979;6409.90385144222;6432.163818703573;6462.806115816533;6406.199225096863;6424.132742079818;6436.485081193505;6441.7423303067935;6494.837629059276;5862.149988251701;5912.231409916705;5927.466528012478;5936.940630593704;5946.137810017545;5914.970425147868;5998.2802063752415;6007.729652165641;6022.096685497188;6032.758689652409;5873.706314684248;5968.4329988651225;5973.761049558012;6034.939650603482;6058.091286307067;5782.132680098019;5838.854028649275;5854.356020837705;5865.560082993792;5873.207117039187;5746.339170995306;5947.316058653224;5956.940430595682;5957.285125784933;5957.970210148965;6390.392912673288;6409.743610255584;6433.099366088752;6446.387593178641;6536.640484773383;6652;6806.523543351967;6898.586084834876;6902.93097069033;6983.720651173947;6949.2008419031445;6960.443164546824;6964.199117101548;6974.4420446364165;6975;6390.4248617624635;6394.616323020634;6404.4236018758065;6422.582532135443;6424.582402143846;6969.337912898267;7068.7525936593;7068.893966590505;7073.257307982691;7078.398336141486;6692.531522793455;6712.429443497357;6736.46108311334;6782.559133656297;6815.693293801692;6901.551399159039;6914.585124892523;6958.756443524452;6997.090378250795;7016.859662806817;6703.195616526048;6833.521653484208;6837.076994605764;6845.828854278683;6847.075644787989;6805.387515123563;6851.07510486088;6853.828654283583;6854.554453960576;6854.9657251713425;5315.840524784263;5358.892822143535;5370.838874833761;5393.622446428791;5400.351957765093;4072.4095006224525;4722.504137065559;4737.957649317144;4769.689970151929;4819.3012013257885;5972.820815375546;5973.49225315853;6047.455728984324;6063.939360606426;6072.878542429126;6742.898856517156;6898.551594146365;6911.550749201286;6982.2319544850025;7050.894236586455;6018.428249316308;6022.819315420545;6060;6082.1789058477425;6094.390560943959;5877.9118313225335;5889.028310328834;5958.433948774859;5974.1934838796205;5979.252593425822;6515.446187074152;6649.268580456146;6695.363940425652;6779.72881084761;6813.488988325896;6890.724371025303;6918.342757438036;6924.515283930076;6927.3419025192525;6941.409980151744;6607.405333520006;6692;6693.330666933462;6697.933020669926;6699.129113215251;6767.932320676927;6775.559588626724;6778.728850846108;6784.3894049535775;6799.388055075067;6590.209174899042;6618.702158402787;6850.965745171442;6932.549384290005;6950.513464057467;6639.103720997604;6699.598024118569;6702.765403210864;6781.355771201728;6792.966035169792;6440.742370305135;6646.136002319668;6684.532082754161;6747.797566073025;6757.358050985148;6555.967220163869;6556.442702370352;6565.310642382481;6591.143151390289;6633.469322454095;6526.967365163144;6549.377809108127;6614.305497922841;6791.422729067887;6826.897596536155;6556.737730490918;6571.934280657132;6620.668966551557;6646.136002319668;6651.7006734698025 03:00:40 INFO - PID 26253 | |1;ext.html;790.8813677948307;804.6781287485009;831.305859607228;871.978200544986;877.1009715042081;39345.606543934555;40310.1937961241;40387.596124038784;40417.59582404175;40581.797091014574;37193;37371.439428408594;37425;37450;37469;6846.246912839583;6907.929270963009;6931.826704332407;6945.340192681687;6979.616121113337;6836.487263455236;6935.757248496304;6942.479314051441;6944.72221111155;6945.47908906834;6857.108575885128;6903.447724182053;7420.554766713987;7567.054118235221;7667.34827539657;7578.280063393969;7615.086189657221;7631.084269887649;7636.618169091523;7639.04511936008;7415.70225210586;7440.8139796504975;7473.51422157558;7521.736739214101;7538.208488108779;35775.642243577495;37664.81167594172;38424;38454.42318365199;38458.03854903622;3494.4234201356744;3496.807675577842;3497.8425970831117;3536.734744894143;3537.9469307960403;31508.527372089437;31611.367772644648;31662.208444788834;31756.841215793775;31802;5069.543741063322;5076.898462030738;5094.828189516432;5114.667546609496;5173.637845350827;181020;202703;207193.9999999985;207482;208257;46367.536324636996;46393.76803115963;46665.76667116643;46918.76540617275;46998.29502557465;49383.25925111126;49429.75285123623;49479.75260123676;49666;49686.75156624266;15202.771958420633;15422.228888555528;15441.691166176613;15442.150681712388;15950.282237299349;12691.555795547112;12832.743345133045;12861.807072893915;12873.935630321788;12945.09384343087;13313.267770272534;13432.597022089352;13475.528356507475;13488.797668034988;13678.52125175634;5427.1045277528765;5437.782488700408;5455.85355130104;5504.146857237135;5590.440955904377;986.6448078691665;994.9303548751518;1003.8393856982993;1006.7583779892773;1030.8762948446235;23406.76593234046;28588.571171432446;29274.121776346743;29846.403071938876;30004.249893752396;1075.3329951157357;1100.8733995590449;1101.427257825926;1102.795982743195;1110.9777804443866;12328.938355308166;12508.81236781449;12571.245725256515;12571.371431428392;12652;223616;225573;225661;226129;226251;50166.49833501691;50746.74626626917;50828.491715082375;50978;50991.235131473055;1246.4328730427633;1269.7841366967639;1294.540438144464;1461.39352168853;1470.0811992504684;27718.584221237103;27803.30491737642;28153.43693126167;28434.573481397383;28710.42579148447;38847.41728874013;39039.41440878446;39107.21785564216;39172.80413597914;39300.803495982334;197742;198185;199856;201223;201275;33919.321613568085;34669.30661386708;34674.826625866706;34759.30481390307;34875.47686784751;42559.57440425556;42754.78622606867;42779.786101069294;42930.570694292655;42956.35565466458;30650;31106;31478.213044674067;31861.20346991344;31979.36041279208;31354.68645313518;31991.200219994687;33038.66961330356;33632.66367336393;34175.974720757426;37468.43797342988;37556.43665344967;37560;37591.24817503689;38031;32441;33028.33943321072;33218.83390583032;33282.16794580058;33693.15767105744;23768.168114116615;24397.99682130318;24752;24928.252152435456;25254.368640784127 03:00:40 INFO - PID 26253 | |2;jquery.html;559.602682095712;562.5190462154858;567.2427309541762;572.942705729427;587.0753563138057;21795.346139615816;22456.55086898261;22555.77444225559;22575.209867654634;22736.204232851855;24010;26465.603015954726;26541.734582654168;26578;26766.330841728966;6500.284968653456;6651.833704157387;6653.367930046637;6679.632620205911;6687.632180230085;6013.939860601404;6545.345465453464;6562.639054851981;6568.573042752229;6592.17597800275;6255.311915689271;6523.706433210493;6529.836754081139;6541.640209788459;6553.082568440422;6545.967270163619;6553.442957348655;6568.047633093199;6570.145881035459;6575.375339342755;6066.908996365058;6070.119832624289;6074.331823499411;6076.939230607682;6083.330833608299;28721.712782872113;29525.852370738223;29961;30067.699323006927;30145.09564713062;2002.91988320467;2054.4863784053987;2060.3921843056332;2061.2476446097066;2066.2561477867957;19504.024798760147;19879.20483180671;20023.799762002338;20044.799552004584;20057.598848023103;2285.931422057324;2365.455945132629;2372.525494901027;2381.785639292472;2480.3055144559553;127428;131363.34318328346;132475;132996.3350183243;133276.6672333274;14106.506272280421;14348.762701613836;14581.343839527246;14652.26738663084;14767.375588685236;22361.888190558944;22473.88763056174;22512.212072577382;22665.093396264296;22692.65961010586;10116.74708132288;10389.272750907516;10393.688189354332;10447.320924139907;10463.738406539898;9641.469719165372;9685.17675997548;9726.465044422624;9913.454759988126;9930.801383972424;8876.556172191495;8970.506622135845;9105.77235569116;9232.95383523078;9245.861312080324;2627.51390992667;2667.906623268176;2753.7934654900564;2762.41989182274;2855.0863723608663;924.9953750231206;973.956171972263;977.9511024448749;979.5004547680734;979.5151400057017;19090;19339.613207735765;19768.22086012266;19773.110210040584;19963.401097967086;1023.6826583758909;1038.9116925061303;1043.3270540501335;1047.837585174284;1059.3008614314515;10996.670099897015;10997.34015959045;11120;11204.439778011067;11206.943965280121;418641;421635;422671;424181;427713;108451;108765.91234087716;110030;110821;114811;1185.875483074282;1189.1616410430627;1196.3240768965507;1201.9519219231133;1207.704112492445;17516.124193790005;17691.557711057325;17721.379751708628;18236.908815455838;18243.179056942736;53438.73280633572;53700.46299536955;54548;54807.451925480236;55816;63649.363506364345;63842.3615763855;65096.674516627114;66050.66974665096;66690;14148.717025659635;14365;14540.563783086523;14787;14898;18478.722819157454;19335.709964350826;22841.65737513972;23894.641580376658;23960.520789583763;18697.439076827715;18796.248150073843;18811.435656930313;18829.435116946515;19002.42992710221;16734.246958887124;17445.82554174493;17516.562085947953;17609.471715848544;17797;19647.901760491106;20448.693269601266;20506.38480845577;20535.4866128348;20638.896805515877;20706.48233794167;21349.89325053427;21447.46381340479;21450.463738406666;21646.24238151657;18632.16155272989;18778.90610546993;18937.621247575247;19119.713204302225;19324.710129348354 03:00:40 INFO - PID 26253 | |3;mootools.html;1302.6222395505304;1357.6266526705156;1367.4256812138901;1375.7179778145476;1376.6283103562039;14800.77798833017;14996.775048374284;15443.305051272706;15445.768313475293;15472.535823925273;15814.841851581481;15986.920065399685;16072.517824465256;16092.19539023047;16109.355625774955;2711.349276173719;2763.6821765497025;2781.3185769486404;2789.316617428733;2791.5393959996677;2707.945841083177;2765.3777899972547;2779.6803367612783;2781.8748156333013;2837.304860309227;2628.6319915211884;2818.4644917465716;2818.6476690413697;2819.647544056993;2841.0766500887294;2737.6988531261545;2770.473610014091;2805.7054009329136;2814.9014784482547;2856.9857150714215;2731.7951153663357;2734.1934129431866;2766.4743698697184;2770.5844123381453;2773.126465163467;14554;14886.851131488655;14982.475613353588;15046.097234165876;15058.698826023528;8010.158933312035;8331.708390206375;8366.414350995432;8387.958060209721;8417;5306.336707911511;5394.91907621386;5462.672239665593;5549.694766787825;5560.7219639017885;1932.4492519631838;1942.2522328903333;1951.1902560437402;1956.3055115433958;1957.1975490049012;26104.34739131518;26492.470150597073;26532.86733566339;26559.203223903314;26565;6837.213720422115;6861.965690171617;6893.724251030003;6997.230304666483;7050.365467107882;16236.269367878474;16249.431269905497;16310.102944337938;16324.18379081065;16330.18349082565;7580.54516728998;7712.383009359238;7727.49771264866;7733.729319473791;7748.806279843049;7017.92982070183;7110.1112360954885;7131.82170445743;7149.642517874086;7244.855102897913;5093.668911520814;5237.450067742909;5283.049051170749;5306.8407947761625;5343.198520221998;1445.1906932117838;1459.9270036498133;1482.792409062732;1488.2930607961132;1493.27576125579;844.8268105038452;854.4616891358404;863.2834747159842;876.6975393489236;879.8064425826308;7778.49439786412;8098.676052957933;8117;8152.673893044331;8206.179382061746;978.1343510992681;980.2794945714894;1010.4594042187395;1013.8124446977333;1017.5980487707315;5016.849494515171;5051.1413059779925;5103.7192954387865;5347.625666203328;5454.181872719124;20751;21219.46951326198;21709.131634734433;21845;21979.120835166734;20638.587228255652;20942.79057209439;21127.683084753433;21167.04748286331;21235.99999999969;10884.40135792539;10943.288686235528;11032.172587056002;11131.721706957229;11189.160812939062;8105.27052565272;8604.82790344177;8729.3889427742;8753.518556479201;8845.203931646183;18387.26450942001;18737.34419295318;18791.34230301933;18837.529061773017;18922.432327030212;18741.625167496302;18742;18805;18839.90580047091;19394.418167455;11257;11381.601643942422;11424.371659558805;11449.084073274285;11449.828252576051;13669.726605468033;13834.584962451143;13862.306884655929;13864.237466939416;14130.78803817923;10890.23768336209;11054.281471704313;11061.612843550438;11123.666290011313;11236.381998989807;11032.503537340679;11043.226974112056;11139.610113645984;11276.661700149009;11419.429028548373;8945.15021072997;10218.693439196835;10396.896031039896;10397.740056498345;10407.427591482541;7088.539244949062;7231.5299505531975;7330.266973302627;7362.5214361066355;7461.030066091374;7308.707651693872;7335.633218339169;7341.302576255247;7399.075115610549;7405.666744996596 03:00:40 INFO - PID 26253 | |4;prototype.html;497.70884032840786;498.24324592571986;524.845170674651;529.5895680847343;530.4218401941882;6165.414285642868;6332.461740752035;6337.714802833872;6368.745250189999;6383;6099.939000609993;6132.264128304599;6199.504039676826;6243.438090571848;6332.240131184264;5032.57223136032;5036.546710796028;5054.974725126369;5067.920324139058;5068.8225912093085;4946.455889852114;5002.549770520653;5058.645894787348;5113.821016264432;5140.588752899759;5006.749662516878;5057.898842023157;5067.49325067494;5087.160618497944;5099.337086178792;5001.824936127255;5016.573591244749;5032.849014529534;5033.194688849803;5101.897962040757;4496.865094047183;4534.6825722199455;4544.613707834838;4546.136234115541;4567.794449249792;6219.222597175353;6256.718447669866;6270.6864656766975;6284;6335.873282534323;5768.682722450264;5812.505936995361;5834.095715164156;5840.15317778924;5855.473007429352;6615.6030638161865;6636.8672626547195;6684.2647308795995;6706.765263215812;6761.864762704768;4825.565699087099;4853.538913803183;4913.385826771653;4931.950680493221;4937.23472861707;7004.124484439445;7106.71573137079;7150.213476517579;7165.856682866313;7189;5085.542301192836;5095.757866538711;5098.898022039539;5128.640995130379;5144.614153938394;5079.314292570456;5131.332926719502;5151.433342332415;5155.793768249303;5168.767405466763;5637.323521177403;5732.197492351074;5756.222909907109;5771.538276937918;5777.913331300034;6567.9671601641685;6601.834954126185;6673.899891501631;6705.865882682417;6723.125993620798;1656.7100757367411;1700.9284150985047;1704.3097545494095;1758.7273972534279;1767.2400867626786;1173.6889724223088;1195.4560674892903;1226.4297101847683;1231.2797013747058;1238.2694210415898;5681.943180568224;5778.451047150514;5797.159411885337;5828;5884.411558844081;6549.672516374258;6868.793936181923;6905.274946130584;6909.75815846453;6932.61347730456;5876.41235876409;5878.735456904449;5946.613470124428;5955.702214889238;5970.164177015221;3616.4213725803747;3627.4558816177782;3632.945505817415;3633.691136253448;3658.9451158232646;6492.870142597121;6633.635150066696;6669.699863506154;6670.83322916931;6765.989134834951;6911.723531058802;6913.619750913647;6931.445484361239;6985.93014069863;7039.014537964689;6607.504437167232;6660.400563949268;6665.266820649725;6716.361945615061;6717.361850624183;6762.188537375547;6762.830929226809;6868.622225777431;6873.518853680194;6891.345322194384;6725.361090696376;6743.089682892943;6807.183138023469;6813.625250611066;6888.965555172192;6509.414152726277;6556.78699440605;6567.555137869661;6644.8371534980215;6688.899666504909;5039.697618142924;5044.2685810558;5053.065182941167;5060.924086138784;5072.974635126949;6423.389777971085;6846.178458585002;6972.141422016949;6980.511364204457;6998.930010699828;6385.680715964276;6503;6515.771947981798;6549.541532092708;6574.934250657432;6680.365365290289;6683.966580167068;6689.632070235989;6705.865882682417;6789.321067893171;6555.983822507519;6564.4420224281475;6585.440237579859;6653.667316634246;6700.3969642730435;6534.83662908412;6681.465482761465;6704.497162712913;6747.426468750211;6754.662266886734;6392.232932048184;6532.88940880042;6533.705983230671;6537.346265373615;6557.639329836714 03:00:40 INFO - PID 26253 | |5;yui.html;895.8745775591418;901.9639214431421;923.1230331185376;925.8472352061908;931.5156118818214;18568.814311856877;19367.322143724974;19390.22439102434;19390.80609193906;19436.319728809496;17231.31074757008;17285.395011174613;18188.545286367847;21642.35072947814;21644.675329870064;983.1004630762843;1001.279079063077;1002.0380434782618;1003.0370843989742;1016.1921272588273;1007.6372505897871;1008.5259927833906;1009.6415772400802;1009.6869970309191;1012.4735137728377;943.8772959515253;1020.6784862768242;1031.6801791444639;1032.0556690628066;1038.9480525973709;1022.7034160093564;1023.5394072667292;1027.5941003303653;1033.4884232304983;1036.2487196782347;749.6251874062968;752.7214930475704;754.0348354106752;756.3193126186476;758.9127250366223;17409.825901741075;17419;17500.737488937677;17619;17650.205740741698;21122.471938201514;21302.254421095186;21316.573668526544;21717.891410542845;21723.565528689338;16562.337506499727;16641;16914.577135571588;16922.49232523026;16939.49181524556;3540.6105328413855;3587.336342776595;3685.5577330720216;3688.22547265072;3692.667659910594;118604.40697796457;121890.3905480467;122195;123353;124653;16357.509274721777;16586.917065414837;16774.161291935354;16830.41093561744;16874.915625421796;30159;30395.2401189972;31198.68801311958;31325.373492530478;31347.216319592193;8483.787905302293;8495.490270583661;8526.31789456842;8554.315654747605;8577.614007369682;4100.630943215125;4162.438070860456;4185.937210941838;4201.306784380604;4240.109576988805;5172.405173405032;5194.8961020780125;5204.063268611686;5225.738713064332;5294.179402192666;959.1319855530755;984.1683777208248;999.7350702063959;1000.3447741729179;1002.4887307473095;642.4474951541671;654.6759354119741;664.0669858848325;671.6675245753383;676.7631329034798;11368.204225704121;11513.712157196138;11607.535698571963;11731.589394371156;12563.93718031404;683.733343995842;684.849333146707;686.6532401137393;700.5236439221378;708.8511412603308;5491.945080549143;5497.285352904097;5597.468240517144;5601.467860553241;5633.802816901389;103424.48287758663;105064.47467762612;105249;105586;108359;95823.52088239514;96127;97697.51151244198;97970;102563.97436025694;86405;86468;88038.11961880427;88487;90037;11697.532098715956;11852.170348075897;12044.457999389873;12090.395480226129;12278.570250041206;40537.391939120345;40703.38944915888;40920.59079409168;42111.157776844906;42380.788096059325;70185.64907175432;71238;71461.28538714754;74157;74322.62838685772;18490.81509184891;19194.424167275003;19319.806801932362;19645.901770491055;19917.900410497856;20586.691199631718;21518.6772198414;21858.89070554637;21983;22018;18586.070696464853;18603.69774115799;18729.998652015325;19264.711029334852;19550.413487595393;18693.626127477648;18871.622567548846;19496.1226744794;19790.307339243056;19908.70136947918;17687.646247075245;18053.819461805215;18324.90837545804;18682.813171868653;18917.90541047286;13709.862901370858;13769.449222031006;13993;14063.718725625635;14204.928975355057;13661.521846735317;13783.51757688476;14149.43402263898;14240.643983900485;14485.855141448872 03:00:40 INFO - PID 26253 | __end_tp_report 03:00:40 INFO - PID 26253 | __start_cc_report 03:00:40 INFO - PID 26253 | _x_x_mozilla_cycle_collect,367 03:00:40 INFO - PID 26253 | __end_cc_report 03:00:40 INFO - PID 26253 | __startTimestamp1504346440503__endTimestamp 03:00:40 INFO - PID 26253 | 03:00:40 INFO - PID 26253 | ------- Summary: start ------- 03:00:40 INFO - PID 26253 | Number of tests: 6 03:00:40 INFO - PID 26253 | 03:00:40 INFO - PID 26253 | [#0] dojo.html Cycles:165 Average:6332.17 Median:6565.31 stddev:744.57 (11.3%) stddev-sans-first:707.64 03:00:40 INFO - PID 26253 | Values: 3292.4 3329.3 3369.4 3382.1 3414.3 6391.8 6397.6 6409.9 6432.2 6462.8 6406.2 6424.1 6436.5 6441.7 6494.8 5862.1 5912.2 5927.5 5936.9 5946.1 5915.0 5998.3 6007.7 6022.1 6032.8 5873.7 5968.4 5973.8 6034.9 6058.1 5782.1 5838.9 5854.4 5865.6 5873.2 5746.3 5947.3 5956.9 5957.3 5958.0 6390.4 6409.7 6433.1 6446.4 6536.6 6652.0 6806.5 6898.6 6902.9 6983.7 6949.2 6960.4 6964.2 6974.4 6975.0 6390.4 6394.6 6404.4 6422.6 6424.6 6969.3 7068.8 7068.9 7073.3 7078.4 6692.5 6712.4 6736.5 6782.6 6815.7 6901.6 6914.6 6958.8 6997.1 7016.9 6703.2 6833.5 6837.1 6845.8 6847.1 6805.4 6851.1 6853.8 6854.6 6855.0 5315.8 5358.9 5370.8 5393.6 5400.4 4072.4 4722.5 4738.0 4769.7 4819.3 5972.8 5973.5 6047.5 6063.9 6072.9 6742.9 6898.6 6911.6 6982.2 7050.9 6018.4 6022.8 6060.0 6082.2 6094.4 5877.9 5889.0 5958.4 5974.2 5979.3 6515.4 6649.3 6695.4 6779.7 6813.5 6890.7 6918.3 6924.5 6927.3 6941.4 6607.4 6692.0 6693.3 6697.9 6699.1 6767.9 6775.6 6778.7 6784.4 6799.4 6590.2 6618.7 6851.0 6932.5 6950.5 6639.1 6699.6 6702.8 6781.4 6793.0 6440.7 6646.1 6684.5 6747.8 6757.4 6556.0 6556.4 6565.3 6591.1 6633.5 6527.0 6549.4 6614.3 6791.4 6826.9 6556.7 6571.9 6620.7 6646.1 6651.7 03:00:40 INFO - PID 26253 | 03:00:40 INFO - PID 26253 | [#1] ext.html Cycles:180 Average:37828.95 Median:3517.29 stddev:54127.11 (1538.9%) stddev-sans-first:54207.50 03:00:40 INFO - PID 26253 | Values: 790.9 804.7 831.3 872.0 877.1 39345.6 40310.2 40387.6 40417.6 40581.8 37193.0 37371.4 37425.0 37450.0 37469.0 6846.2 6907.9 6931.8 6945.3 6979.6 6836.5 6935.8 6942.5 6944.7 6945.5 6857.1 6903.4 7420.6 7567.1 7667.3 7578.3 7615.1 7631.1 7636.6 7639.0 7415.7 7440.8 7473.5 7521.7 7538.2 35775.6 37664.8 38424.0 38454.4 38458.0 3494.4 3496.8 3497.8 3536.7 3537.9 31508.5 31611.4 31662.2 31756.8 31802.0 5069.5 5076.9 5094.8 5114.7 5173.6 181020.0 202703.0 207194.0 207482.0 208257.0 46367.5 46393.8 46665.8 46918.8 46998.3 49383.3 49429.8 49479.8 49666.0 49686.8 15202.8 15422.2 15441.7 15442.2 15950.3 12691.6 12832.7 12861.8 12873.9 12945.1 13313.3 13432.6 13475.5 13488.8 13678.5 5427.1 5437.8 5455.9 5504.1 5590.4 986.6 994.9 1003.8 1006.8 1030.9 23406.8 28588.6 29274.1 29846.4 30004.2 1075.3 1100.9 1101.4 1102.8 1111.0 12328.9 12508.8 12571.2 12571.4 12652.0 223616.0 225573.0 225661.0 226129.0 226251.0 50166.5 50746.7 50828.5 50978.0 50991.2 1246.4 1269.8 1294.5 1461.4 1470.1 27718.6 27803.3 28153.4 28434.6 28710.4 38847.4 39039.4 39107.2 39172.8 39300.8 197742.0 198185.0 199856.0 201223.0 201275.0 33919.3 34669.3 34674.8 34759.3 34875.5 42559.6 42754.8 42779.8 42930.6 42956.4 30650.0 31106.0 31478.2 31861.2 31979.4 31354.7 31991.2 33038.7 33632.7 34176.0 37468.4 37556.4 37560.0 37591.2 38031.0 32441.0 33028.3 33218.8 33282.2 33693.2 23768.2 24398.0 24752.0 24928.3 25254.4 03:00:40 INFO - PID 26253 | 03:00:40 INFO - PID 26253 | [#2] jquery.html Cycles:180 Average:32604.80 Median:22493.05 stddev:71782.78 (319.1%) stddev-sans-first:71943.83 03:00:40 INFO - PID 26253 | Values: 559.6 562.5 567.2 572.9 587.1 21795.3 22456.6 22555.8 22575.2 22736.2 24010.0 26465.6 26541.7 26578.0 26766.3 6500.3 6651.8 6653.4 6679.6 6687.6 6013.9 6545.3 6562.6 6568.6 6592.2 6255.3 6523.7 6529.8 6541.6 6553.1 6546.0 6553.4 6568.0 6570.1 6575.4 6066.9 6070.1 6074.3 6076.9 6083.3 28721.7 29525.9 29961.0 30067.7 30145.1 2002.9 2054.5 2060.4 2061.2 2066.3 19504.0 19879.2 20023.8 20044.8 20057.6 2285.9 2365.5 2372.5 2381.8 2480.3 127428.0 131363.3 132475.0 132996.3 133276.7 14106.5 14348.8 14581.3 14652.3 14767.4 22361.9 22473.9 22512.2 22665.1 22692.7 10116.7 10389.3 10393.7 10447.3 10463.7 9641.5 9685.2 9726.5 9913.5 9930.8 8876.6 8970.5 9105.8 9233.0 9245.9 2627.5 2667.9 2753.8 2762.4 2855.1 925.0 974.0 978.0 979.5 979.5 19090.0 19339.6 19768.2 19773.1 19963.4 1023.7 1038.9 1043.3 1047.8 1059.3 10996.7 10997.3 11120.0 11204.4 11206.9 418641.0 421635.0 422671.0 424181.0 427713.0 108451.0 108765.9 110030.0 110821.0 114811.0 1185.9 1189.2 1196.3 1202.0 1207.7 17516.1 17691.6 17721.4 18236.9 18243.2 53438.7 53700.5 54548.0 54807.5 55816.0 63649.4 63842.4 65096.7 66050.7 66690.0 14148.7 14365.0 14540.6 14787.0 14898.0 18478.7 19335.7 22841.7 23894.6 23960.5 18697.4 18796.2 18811.4 18829.4 19002.4 16734.2 17445.8 17516.6 17609.5 17797.0 19647.9 20448.7 20506.4 20535.5 20638.9 20706.5 21349.9 21447.5 21450.5 21646.2 18632.2 18778.9 18937.6 19119.7 19324.7 03:00:40 INFO - PID 26253 | 03:00:40 INFO - PID 26253 | [#3] mootools.html Cycles:180 Average:9319.52 Median:26546.04 stddev:6605.20 (24.9%) stddev-sans-first:6596.26 03:00:40 INFO - PID 26253 | Values: 1302.6 1357.6 1367.4 1375.7 1376.6 14800.8 14996.8 15443.3 15445.8 15472.5 15814.8 15986.9 16072.5 16092.2 16109.4 2711.3 2763.7 2781.3 2789.3 2791.5 2707.9 2765.4 2779.7 2781.9 2837.3 2628.6 2818.5 2818.6 2819.6 2841.1 2737.7 2770.5 2805.7 2814.9 2857.0 2731.8 2734.2 2766.5 2770.6 2773.1 14554.0 14886.9 14982.5 15046.1 15058.7 8010.2 8331.7 8366.4 8388.0 8417.0 5306.3 5394.9 5462.7 5549.7 5560.7 1932.4 1942.3 1951.2 1956.3 1957.2 26104.3 26492.5 26532.9 26559.2 26565.0 6837.2 6862.0 6893.7 6997.2 7050.4 16236.3 16249.4 16310.1 16324.2 16330.2 7580.5 7712.4 7727.5 7733.7 7748.8 7017.9 7110.1 7131.8 7149.6 7244.9 5093.7 5237.5 5283.0 5306.8 5343.2 1445.2 1459.9 1482.8 1488.3 1493.3 844.8 854.5 863.3 876.7 879.8 7778.5 8098.7 8117.0 8152.7 8206.2 978.1 980.3 1010.5 1013.8 1017.6 5016.8 5051.1 5103.7 5347.6 5454.2 20751.0 21219.5 21709.1 21845.0 21979.1 20638.6 20942.8 21127.7 21167.0 21236.0 10884.4 10943.3 11032.2 11131.7 11189.2 8105.3 8604.8 8729.4 8753.5 8845.2 18387.3 18737.3 18791.3 18837.5 18922.4 18741.6 18742.0 18805.0 18839.9 19394.4 11257.0 11381.6 11424.4 11449.1 11449.8 13669.7 13834.6 13862.3 13864.2 14130.8 10890.2 11054.3 11061.6 11123.7 11236.4 11032.5 11043.2 11139.6 11276.7 11419.4 8945.2 10218.7 10396.9 10397.7 10407.4 7088.5 7231.5 7330.3 7362.5 7461.0 7308.7 7335.6 7341.3 7399.1 7405.7 03:00:40 INFO - PID 26253 | 03:00:40 INFO - PID 26253 | [#4] prototype.html Cycles:180 Average:5604.00 Median:6250.08 stddev:1586.30 (25.4%) stddev-sans-first:1543.76 03:00:40 INFO - PID 26253 | Values: 497.7 498.2 524.8 529.6 530.4 6165.4 6332.5 6337.7 6368.7 6383.0 6099.9 6132.3 6199.5 6243.4 6332.2 5032.6 5036.5 5055.0 5067.9 5068.8 4946.5 5002.5 5058.6 5113.8 5140.6 5006.7 5057.9 5067.5 5087.2 5099.3 5001.8 5016.6 5032.8 5033.2 5101.9 4496.9 4534.7 4544.6 4546.1 4567.8 6219.2 6256.7 6270.7 6284.0 6335.9 5768.7 5812.5 5834.1 5840.2 5855.5 6615.6 6636.9 6684.3 6706.8 6761.9 4825.6 4853.5 4913.4 4932.0 4937.2 7004.1 7106.7 7150.2 7165.9 7189.0 5085.5 5095.8 5098.9 5128.6 5144.6 5079.3 5131.3 5151.4 5155.8 5168.8 5637.3 5732.2 5756.2 5771.5 5777.9 6568.0 6601.8 6673.9 6705.9 6723.1 1656.7 1700.9 1704.3 1758.7 1767.2 1173.7 1195.5 1226.4 1231.3 1238.3 5681.9 5778.5 5797.2 5828.0 5884.4 6549.7 6868.8 6905.3 6909.8 6932.6 5876.4 5878.7 5946.6 5955.7 5970.2 3616.4 3627.5 3632.9 3633.7 3658.9 6492.9 6633.6 6669.7 6670.8 6766.0 6911.7 6913.6 6931.4 6985.9 7039.0 6607.5 6660.4 6665.3 6716.4 6717.4 6762.2 6762.8 6868.6 6873.5 6891.3 6725.4 6743.1 6807.2 6813.6 6889.0 6509.4 6556.8 6567.6 6644.8 6688.9 5039.7 5044.3 5053.1 5060.9 5073.0 6423.4 6846.2 6972.1 6980.5 6998.9 6385.7 6503.0 6515.8 6549.5 6574.9 6680.4 6684.0 6689.6 6705.9 6789.3 6556.0 6564.4 6585.4 6653.7 6700.4 6534.8 6681.5 6704.5 6747.4 6754.7 6392.2 6532.9 6533.7 6537.3 6557.6 03:00:40 INFO - PID 26253 | 03:00:40 INFO - PID 26253 | [#5] yui.html Cycles:180 Average:23706.93 Median:19718.10 stddev:31660.47 (160.6%) stddev-sans-first:31702.95 03:00:40 INFO - PID 26253 | Values: 895.9 902.0 923.1 925.8 931.5 18568.8 19367.3 19390.2 19390.8 19436.3 17231.3 17285.4 18188.5 21642.4 21644.7 983.1 1001.3 1002.0 1003.0 1016.2 1007.6 1008.5 1009.6 1009.7 1012.5 943.9 1020.7 1031.7 1032.1 1038.9 1022.7 1023.5 1027.6 1033.5 1036.2 749.6 752.7 754.0 756.3 758.9 17409.8 17419.0 17500.7 17619.0 17650.2 21122.5 21302.3 21316.6 21717.9 21723.6 16562.3 16641.0 16914.6 16922.5 16939.5 3540.6 3587.3 3685.6 3688.2 3692.7 118604.4 121890.4 122195.0 123353.0 124653.0 16357.5 16586.9 16774.2 16830.4 16874.9 30159.0 30395.2 31198.7 31325.4 31347.2 8483.8 8495.5 8526.3 8554.3 8577.6 4100.6 4162.4 4185.9 4201.3 4240.1 5172.4 5194.9 5204.1 5225.7 5294.2 959.1 984.2 999.7 1000.3 1002.5 642.4 654.7 664.1 671.7 676.8 11368.2 11513.7 11607.5 11731.6 12563.9 683.7 684.8 686.7 700.5 708.9 5491.9 5497.3 5597.5 5601.5 5633.8 103424.5 105064.5 105249.0 105586.0 108359.0 95823.5 96127.0 97697.5 97970.0 102564.0 86405.0 86468.0 88038.1 88487.0 90037.0 11697.5 11852.2 12044.5 12090.4 12278.6 40537.4 40703.4 40920.6 42111.2 42380.8 70185.6 71238.0 71461.3 74157.0 74322.6 18490.8 19194.4 19319.8 19645.9 19917.9 20586.7 21518.7 21858.9 21983.0 22018.0 18586.1 18603.7 18730.0 19264.7 19550.4 18693.6 18871.6 19496.1 19790.3 19908.7 17687.6 18053.8 18324.9 18682.8 18917.9 13709.9 13769.4 13993.0 14063.7 14204.9 13661.5 13783.5 14149.4 14240.6 14485.9 03:00:40 INFO - PID 26253 | -------- Summary: end -------- 03:00:40 INFO - PID 26253 | 03:00:41 INFO - TEST-INFO | 26253: exit 0 03:00:41 INFO - TEST-OK | dromaeo_css | took 1114909ms 03:00:41 INFO - TEST-START | kraken 03:00:41 INFO - Initialising browser for kraken test... 03:00:41 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50454/getInfo.html -profile /tmp/tmpLzDyph/profile 03:00:41 INFO - TEST-INFO | started process 26635 (/builds/slave/test/build/application/firefox/firefox http://localhost:50454/getInfo.html) 03:00:47 INFO - TEST-INFO | 26635: exit 0 03:00:47 INFO - Browser initialized. 03:00:47 INFO - Running cycle 1/1 for kraken test... 03:00:47 INFO - Using env: {'DISPLAY': ':0', 03:00:47 INFO - 'HOME': '/home/cltbld', 03:00:47 INFO - 'JSGC_DISABLE_POISONING': '1', 03:00:47 INFO - 'LANG': 'en_US.UTF-8', 03:00:47 INFO - 'LANGUAGE': 'en_US:en', 03:00:47 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:00:47 INFO - 'LOGNAME': 'cltbld', 03:00:47 INFO - 'MAIL': '/var/mail/cltbld', 03:00:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:00:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:00:47 INFO - 'MOZ_ACCELERATED': '1', 03:00:47 INFO - 'MOZ_CRASHREPORTER': '1', 03:00:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:47 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:00:47 INFO - 'MOZ_NO_REMOTE': '1', 03:00:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:00:47 INFO - 'MOZ_WEBRENDER': '1', 03:00:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:47 INFO - 'NO_EM_RESTART': '1', 03:00:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:47 INFO - 'PWD': '/builds/slave/test', 03:00:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:00:47 INFO - 'RUST_BACKTRACE': 'full', 03:00:47 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:00:47 INFO - 'SHELL': '/bin/bash', 03:00:47 INFO - 'SHLVL': '1', 03:00:47 INFO - 'TERM': 'linux', 03:00:47 INFO - 'TMOUT': '86400', 03:00:47 INFO - 'USER': 'cltbld', 03:00:47 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1504345254.899811-8515522', 03:00:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:47 INFO - '_': '/tools/buildbot/bin/python'} 03:00:47 INFO - TEST-INFO | started process 26830 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLzDyph/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:00:48 INFO - PID 26830 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:00:48 INFO - PID 26830 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:00:48 INFO - PID 26830 | 03:00:48 INFO - PID 26830 | (/builds/slave/test/build/application/firefox/firefox:26892): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:00:48 INFO - PID 26830 | 03:00:58 INFO - PID 26830 | RSS: Main: 205758464 03:00:58 INFO - PID 26830 | 03:01:01 INFO - PID 26830 | Cycle 1(1): loaded http://localhost:50454/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50454/tests/kraken/driver.html?testName=audio-beat-detection) 03:01:02 INFO - PID 26830 | RSS: Main: 211324928 03:01:02 INFO - PID 26830 | 03:01:05 INFO - PID 26830 | Cycle 1(1): loaded http://localhost:50454/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50454/tests/kraken/driver.html?testName=audio-dft) 03:01:05 INFO - PID 26830 | RSS: Main: 212262912 03:01:05 INFO - PID 26830 | 03:01:08 INFO - PID 26830 | Cycle 1(1): loaded http://localhost:50454/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50454/tests/kraken/driver.html?testName=audio-fft) 03:01:09 INFO - PID 26830 | RSS: Main: 206917632 03:01:09 INFO - PID 26830 | 03:01:11 INFO - PID 26830 | Cycle 1(1): loaded http://localhost:50454/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50454/tests/kraken/driver.html?testName=audio-oscillator) 03:01:12 INFO - PID 26830 | RSS: Main: 206315520 03:01:12 INFO - PID 26830 | 03:01:14 INFO - PID 26830 | Cycle 1(1): loaded http://localhost:50454/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50454/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:01:14 INFO - PID 26830 | RSS: Main: 206397440 03:01:14 INFO - PID 26830 | 03:01:18 INFO - PID 26830 | Cycle 1(1): loaded http://localhost:50454/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50454/tests/kraken/driver.html?testName=imaging-darkroom) 03:01:18 INFO - PID 26830 | RSS: Main: 210518016 03:01:18 INFO - PID 26830 | 03:01:22 INFO - PID 26830 | Cycle 1(1): loaded http://localhost:50454/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50454/tests/kraken/driver.html?testName=imaging-desaturate) 03:01:22 INFO - PID 26830 | RSS: Main: 208916480 03:01:22 INFO - PID 26830 | 03:01:25 INFO - PID 26830 | Cycle 1(1): loaded http://localhost:50454/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50454/tests/kraken/driver.html?testName=json-parse-financial) 03:01:26 INFO - PID 26830 | RSS: Main: 210575360 03:01:26 INFO - PID 26830 | 03:01:28 INFO - PID 26830 | Cycle 1(1): loaded http://localhost:50454/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50454/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:01:28 INFO - PID 26830 | RSS: Main: 210694144 03:01:28 INFO - PID 26830 | 03:01:30 INFO - PID 26830 | Cycle 1(1): loaded http://localhost:50454/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50454/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:01:31 INFO - PID 26830 | RSS: Main: 210169856 03:01:31 INFO - PID 26830 | 03:01:33 INFO - PID 26830 | Cycle 1(1): loaded http://localhost:50454/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50454/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:01:33 INFO - PID 26830 | RSS: Main: 206897152 03:01:33 INFO - PID 26830 | 03:01:36 INFO - PID 26830 | Cycle 1(1): loaded http://localhost:50454/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50454/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:01:37 INFO - PID 26830 | RSS: Main: 207368192 03:01:37 INFO - PID 26830 | 03:01:40 INFO - PID 26830 | Cycle 1(1): loaded http://localhost:50454/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50454/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:01:40 INFO - PID 26830 | RSS: Main: 208375808 03:01:40 INFO - PID 26830 | 03:01:42 INFO - PID 26830 | Cycle 1(1): loaded http://localhost:50454/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50454/tests/kraken/driver.html?testName=ai-astar) 03:01:43 INFO - PID 26830 | RSS: Main: 211034112 03:01:43 INFO - PID 26830 | 03:01:43 INFO - PID 26830 | __start_tp_report 03:01:43 INFO - PID 26830 | _x_x_mozilla_page_load 03:01:43 INFO - PID 26830 | _x_x_mozilla_page_load_details 03:01:43 INFO - PID 26830 | |i|pagename|runs| 03:01:43 INFO - PID 26830 | |0;ai-astar;99;107;113;118;112;113;115;100;108;113 03:01:43 INFO - PID 26830 | |1;audio-beat-detection;145;121;150;181;122;158;152;124;165;119 03:01:43 INFO - PID 26830 | |2;audio-dft;163;164;164;163;162;164;173;162;169;167 03:01:43 INFO - PID 26830 | |3;audio-fft;77;74;77;172;79;75;84;90;95;74 03:01:43 INFO - PID 26830 | |4;audio-oscillator;91;85;135;82;79;86;130;80;79;126 03:01:43 INFO - PID 26830 | |5;imaging-gaussian-blur;122;120;123;114;115;114;115;126;117;119 03:01:43 INFO - PID 26830 | |6;imaging-darkroom;148;150;154;148;155;153;149;149;149;156 03:01:43 INFO - PID 26830 | |7;imaging-desaturate;96;95;95;94;98;96;94;95;102;94 03:01:43 INFO - PID 26830 | |8;json-parse-financial;62;54;52;53;53;53;52;52;54;55 03:01:43 INFO - PID 26830 | |9;json-stringify-tinderbox;39;44;39;38;38;39;39;45;38;40 03:01:43 INFO - PID 26830 | |10;stanford-crypto-aes;75;76;77;76;77;76;80;77;75;81 03:01:43 INFO - PID 26830 | |11;stanford-crypto-ccm;130;123;141;135;120;129;130;116;119;161 03:01:43 INFO - PID 26830 | |12;stanford-crypto-pbkdf2;170;167;169;174;169;169;172;166;177;168 03:01:43 INFO - PID 26830 | |13;stanford-crypto-sha256-iterative;64;67;64;69;64;67;63;65;65;62 03:01:43 INFO - PID 26830 | __end_tp_report 03:01:43 INFO - PID 26830 | __start_cc_report 03:01:43 INFO - PID 26830 | _x_x_mozilla_cycle_collect,928 03:01:43 INFO - PID 26830 | __end_cc_report 03:01:43 INFO - PID 26830 | __startTimestamp1504346503008__endTimestamp 03:01:43 INFO - PID 26830 | 03:01:43 INFO - PID 26830 | ------- Summary: start ------- 03:01:43 INFO - PID 26830 | Number of tests: 14 03:01:43 INFO - PID 26830 | 03:01:43 INFO - PID 26830 | [#0] ai-astar Cycles:10 Average:109.80 Median:113.00 stddev:6.27 (5.5%) stddev-sans-first:5.29 03:01:43 INFO - PID 26830 | Values: 99.0 107.0 113.0 118.0 112.0 113.0 115.0 100.0 108.0 113.0 03:01:43 INFO - PID 26830 | 03:01:43 INFO - PID 26830 | [#1] audio-beat-detection Cycles:10 Average:143.70 Median:151.00 stddev:21.46 (14.2%) stddev-sans-first:22.75 03:01:43 INFO - PID 26830 | Values: 145.0 121.0 150.0 181.0 122.0 158.0 152.0 124.0 165.0 119.0 03:01:43 INFO - PID 26830 | 03:01:43 INFO - PID 26830 | [#2] audio-dft Cycles:10 Average:165.10 Median:164.00 stddev:3.54 (2.2%) stddev-sans-first:3.67 03:01:43 INFO - PID 26830 | Values: 163.0 164.0 164.0 163.0 162.0 164.0 173.0 162.0 169.0 167.0 03:01:43 INFO - PID 26830 | 03:01:43 INFO - PID 26830 | [#3] audio-fft Cycles:10 Average:89.70 Median:78.00 stddev:29.78 (38.2%) stddev-sans-first:31.23 03:01:43 INFO - PID 26830 | Values: 77.0 74.0 77.0 172.0 79.0 75.0 84.0 90.0 95.0 74.0 03:01:43 INFO - PID 26830 | 03:01:43 INFO - PID 26830 | [#4] audio-oscillator Cycles:10 Average:97.30 Median:81.00 stddev:23.18 (28.6%) stddev-sans-first:24.47 03:01:43 INFO - PID 26830 | Values: 91.0 85.0 135.0 82.0 79.0 86.0 130.0 80.0 79.0 126.0 03:01:43 INFO - PID 26830 | 03:01:43 INFO - PID 26830 | [#5] imaging-gaussian-blur Cycles:10 Average:118.50 Median:119.50 stddev:4.20 (3.5%) stddev-sans-first:4.26 03:01:43 INFO - PID 26830 | Values: 122.0 120.0 123.0 114.0 115.0 114.0 115.0 126.0 117.0 119.0 03:01:43 INFO - PID 26830 | 03:01:43 INFO - PID 26830 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:151.50 stddev:3.07 (2.0%) stddev-sans-first:3.05 03:01:43 INFO - PID 26830 | Values: 148.0 150.0 154.0 148.0 155.0 153.0 149.0 149.0 149.0 156.0 03:01:43 INFO - PID 26830 | 03:01:43 INFO - PID 26830 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:95.00 stddev:2.47 (2.6%) stddev-sans-first:2.62 03:01:43 INFO - PID 26830 | Values: 96.0 95.0 95.0 94.0 98.0 96.0 94.0 95.0 102.0 94.0 03:01:43 INFO - PID 26830 | 03:01:43 INFO - PID 26830 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:53.50 stddev:2.98 (5.6%) stddev-sans-first:1.05 03:01:43 INFO - PID 26830 | Values: 62.0 54.0 52.0 53.0 53.0 53.0 52.0 52.0 54.0 55.0 03:01:43 INFO - PID 26830 | 03:01:43 INFO - PID 26830 | [#9] json-stringify-tinderbox Cycles:10 Average:39.90 Median:39.00 stddev:2.51 (6.4%) stddev-sans-first:2.65 03:01:43 INFO - PID 26830 | Values: 39.0 44.0 39.0 38.0 38.0 39.0 39.0 45.0 38.0 40.0 03:01:43 INFO - PID 26830 | 03:01:43 INFO - PID 26830 | [#10] stanford-crypto-aes Cycles:10 Average:77.00 Median:77.00 stddev:2.00 (2.6%) stddev-sans-first:1.99 03:01:43 INFO - PID 26830 | Values: 75.0 76.0 77.0 76.0 77.0 76.0 80.0 77.0 75.0 81.0 03:01:43 INFO - PID 26830 | 03:01:43 INFO - PID 26830 | [#11] stanford-crypto-ccm Cycles:10 Average:130.40 Median:130.00 stddev:13.22 (10.2%) stddev-sans-first:14.02 03:01:43 INFO - PID 26830 | Values: 130.0 123.0 141.0 135.0 120.0 129.0 130.0 116.0 119.0 161.0 03:01:43 INFO - PID 26830 | 03:01:43 INFO - PID 26830 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.10 Median:169.50 stddev:3.35 (2.0%) stddev-sans-first:3.55 03:01:43 INFO - PID 26830 | Values: 170.0 167.0 169.0 174.0 169.0 169.0 172.0 166.0 177.0 168.0 03:01:43 INFO - PID 26830 | 03:01:43 INFO - PID 26830 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.00 stddev:2.11 (3.2%) stddev-sans-first:2.20 03:01:43 INFO - PID 26830 | Values: 64.0 67.0 64.0 69.0 64.0 67.0 63.0 65.0 65.0 62.0 03:01:43 INFO - PID 26830 | -------- Summary: end -------- 03:01:43 INFO - PID 26830 | 03:01:43 INFO - PID 26830 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:01:43 INFO - TEST-INFO | 26830: exit 0 03:01:43 INFO - TEST-OK | kraken | took 62504ms 03:01:43 INFO - SUITE-END | took 1177s 03:01:44 INFO - Completed test suite (00:19:37) 03:01:44 INFO - javascript benchmark 03:01:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8599.476596498564, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3292.357990191912, 3329.334133173366, 3369.4440417331143, 3382.137554923495, 3414.3171365726844, 6391.840203994902, 6397.58415702979, 6409.90385144222, 6432.163818703573, 6462.806115816533, 6406.199225096863, 6424.132742079818, 6436.485081193505, 6441.7423303067935, 6494.837629059276, 5862.149988251701, 5912.231409916705, 5927.466528012478, 5936.940630593704, 5946.137810017545, 5914.970425147868, 5998.2802063752415, 6007.729652165641, 6022.096685497188, 6032.758689652409, 5873.706314684248, 5968.4329988651225, 5973.761049558012, 6034.939650603482, 6058.091286307067, 5782.132680098019, 5838.854028649275, 5854.356020837705, 5865.560082993792, 5873.207117039187, 5746.339170995306, 5947.316058653224, 5956.940430595682, 5957.285125784933, 5957.970210148965, 6390.392912673288, 6409.743610255584, 6433.099366088752, 6446.387593178641, 6536.640484773383, 6652.0, 6806.523543351967, 6898.586084834876, 6902.93097069033, 6983.720651173947, 6949.2008419031445, 6960.443164546824, 6964.199117101548, 6974.4420446364165, 6975.0, 6390.4248617624635, 6394.616323020634, 6404.4236018758065, 6422.582532135443, 6424.582402143846, 6969.337912898267, 7068.7525936593, 7068.893966590505, 7073.257307982691, 7078.398336141486, 6692.531522793455, 6712.429443497357, 6736.46108311334, 6782.559133656297, 6815.693293801692, 6901.551399159039, 6914.585124892523, 6958.756443524452, 6997.090378250795, 7016.859662806817, 6703.195616526048, 6833.521653484208, 6837.076994605764, 6845.828854278683, 6847.075644787989, 6805.387515123563, 6851.07510486088, 6853.828654283583, 6854.554453960576, 6854.9657251713425, 5315.840524784263, 5358.892822143535, 5370.838874833761, 5393.622446428791, 5400.351957765093, 4072.4095006224525, 4722.504137065559, 4737.957649317144, 4769.689970151929, 4819.3012013257885, 5972.820815375546, 5973.49225315853, 6047.455728984324, 6063.939360606426, 6072.878542429126, 6742.898856517156, 6898.551594146365, 6911.550749201286, 6982.2319544850025, 7050.894236586455, 6018.428249316308, 6022.819315420545, 6060.0, 6082.1789058477425, 6094.390560943959, 5877.9118313225335, 5889.028310328834, 5958.433948774859, 5974.1934838796205, 5979.252593425822, 6515.446187074152, 6649.268580456146, 6695.363940425652, 6779.72881084761, 6813.488988325896, 6890.724371025303, 6918.342757438036, 6924.515283930076, 6927.3419025192525, 6941.409980151744, 6607.405333520006, 6692.0, 6693.330666933462, 6697.933020669926, 6699.129113215251, 6767.932320676927, 6775.559588626724, 6778.728850846108, 6784.3894049535775, 6799.388055075067, 6590.209174899042, 6618.702158402787, 6850.965745171442, 6932.549384290005, 6950.513464057467, 6639.103720997604, 6699.598024118569, 6702.765403210864, 6781.355771201728, 6792.966035169792, 6440.742370305135, 6646.136002319668, 6684.532082754161, 6747.797566073025, 6757.358050985148, 6555.967220163869, 6556.442702370352, 6565.310642382481, 6591.143151390289, 6633.469322454095, 6526.967365163144, 6549.377809108127, 6614.305497922841, 6791.422729067887, 6826.897596536155, 6556.737730490918, 6571.934280657132, 6620.668966551557, 6646.136002319668, 6651.7006734698025], "value": 6277.540338568377, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [790.8813677948307, 804.6781287485009, 831.305859607228, 871.978200544986, 877.1009715042081, 39345.606543934555, 40310.1937961241, 40387.596124038784, 40417.59582404175, 40581.797091014574, 37193.0, 37371.439428408594, 37425.0, 37450.0, 37469.0, 6846.246912839583, 6907.929270963009, 6931.826704332407, 6945.340192681687, 6979.616121113337, 6836.487263455236, 6935.757248496304, 6942.479314051441, 6944.72221111155, 6945.47908906834, 6857.108575885128, 6903.447724182053, 7420.554766713987, 7567.054118235221, 7667.34827539657, 7578.280063393969, 7615.086189657221, 7631.084269887649, 7636.618169091523, 7639.04511936008, 7415.70225210586, 7440.8139796504975, 7473.51422157558, 7521.736739214101, 7538.208488108779, 35775.642243577495, 37664.81167594172, 38424.0, 38454.42318365199, 38458.03854903622, 3494.4234201356744, 3496.807675577842, 3497.8425970831117, 3536.734744894143, 3537.9469307960403, 31508.527372089437, 31611.367772644648, 31662.208444788834, 31756.841215793775, 31802.0, 5069.543741063322, 5076.898462030738, 5094.828189516432, 5114.667546609496, 5173.637845350827, 181020.0, 202703.0, 207193.9999999985, 207482.0, 208257.0, 46367.536324636996, 46393.76803115963, 46665.76667116643, 46918.76540617275, 46998.29502557465, 49383.25925111126, 49429.75285123623, 49479.75260123676, 49666.0, 49686.75156624266, 15202.771958420633, 15422.228888555528, 15441.691166176613, 15442.150681712388, 15950.282237299349, 12691.555795547112, 12832.743345133045, 12861.807072893915, 12873.935630321788, 12945.09384343087, 13313.267770272534, 13432.597022089352, 13475.528356507475, 13488.797668034988, 13678.52125175634, 5427.1045277528765, 5437.782488700408, 5455.85355130104, 5504.146857237135, 5590.440955904377, 986.6448078691665, 994.9303548751518, 1003.8393856982993, 1006.7583779892773, 1030.8762948446235, 23406.76593234046, 28588.571171432446, 29274.121776346743, 29846.403071938876, 30004.249893752396, 1075.3329951157357, 1100.8733995590449, 1101.427257825926, 1102.795982743195, 1110.9777804443866, 12328.938355308166, 12508.81236781449, 12571.245725256515, 12571.371431428392, 12652.0, 223616.0, 225573.0, 225661.0, 226129.0, 226251.0, 50166.49833501691, 50746.74626626917, 50828.491715082375, 50978.0, 50991.235131473055, 1246.4328730427633, 1269.7841366967639, 1294.540438144464, 1461.39352168853, 1470.0811992504684, 27718.584221237103, 27803.30491737642, 28153.43693126167, 28434.573481397383, 28710.42579148447, 38847.41728874013, 39039.41440878446, 39107.21785564216, 39172.80413597914, 39300.803495982334, 197742.0, 198185.0, 199856.0, 201223.0, 201275.0, 33919.321613568085, 34669.30661386708, 34674.826625866706, 34759.30481390307, 34875.47686784751, 42559.57440425556, 42754.78622606867, 42779.786101069294, 42930.570694292655, 42956.35565466458, 30650.0, 31106.0, 31478.213044674067, 31861.20346991344, 31979.36041279208, 31354.68645313518, 31991.200219994687, 33038.66961330356, 33632.66367336393, 34175.974720757426, 37468.43797342988, 37556.43665344967, 37560.0, 37591.24817503689, 38031.0, 32441.0, 33028.33943321072, 33218.83390583032, 33282.16794580058, 33693.15767105744, 23768.168114116615, 24397.99682130318, 24752.0, 24928.252152435456, 25254.368640784127], "value": 17067.185531415707, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.602682095712, 562.5190462154858, 567.2427309541762, 572.942705729427, 587.0753563138057, 21795.346139615816, 22456.55086898261, 22555.77444225559, 22575.209867654634, 22736.204232851855, 24010.0, 26465.603015954726, 26541.734582654168, 26578.0, 26766.330841728966, 6500.284968653456, 6651.833704157387, 6653.367930046637, 6679.632620205911, 6687.632180230085, 6013.939860601404, 6545.345465453464, 6562.639054851981, 6568.573042752229, 6592.17597800275, 6255.311915689271, 6523.706433210493, 6529.836754081139, 6541.640209788459, 6553.082568440422, 6545.967270163619, 6553.442957348655, 6568.047633093199, 6570.145881035459, 6575.375339342755, 6066.908996365058, 6070.119832624289, 6074.331823499411, 6076.939230607682, 6083.330833608299, 28721.712782872113, 29525.852370738223, 29961.0, 30067.699323006927, 30145.09564713062, 2002.91988320467, 2054.4863784053987, 2060.3921843056332, 2061.2476446097066, 2066.2561477867957, 19504.024798760147, 19879.20483180671, 20023.799762002338, 20044.799552004584, 20057.598848023103, 2285.931422057324, 2365.455945132629, 2372.525494901027, 2381.785639292472, 2480.3055144559553, 127428.0, 131363.34318328346, 132475.0, 132996.3350183243, 133276.6672333274, 14106.506272280421, 14348.762701613836, 14581.343839527246, 14652.26738663084, 14767.375588685236, 22361.888190558944, 22473.88763056174, 22512.212072577382, 22665.093396264296, 22692.65961010586, 10116.74708132288, 10389.272750907516, 10393.688189354332, 10447.320924139907, 10463.738406539898, 9641.469719165372, 9685.17675997548, 9726.465044422624, 9913.454759988126, 9930.801383972424, 8876.556172191495, 8970.506622135845, 9105.77235569116, 9232.95383523078, 9245.861312080324, 2627.51390992667, 2667.906623268176, 2753.7934654900564, 2762.41989182274, 2855.0863723608663, 924.9953750231206, 973.956171972263, 977.9511024448749, 979.5004547680734, 979.5151400057017, 19090.0, 19339.613207735765, 19768.22086012266, 19773.110210040584, 19963.401097967086, 1023.6826583758909, 1038.9116925061303, 1043.3270540501335, 1047.837585174284, 1059.3008614314515, 10996.670099897015, 10997.34015959045, 11120.0, 11204.439778011067, 11206.943965280121, 418641.0, 421635.0, 422671.0, 424181.0, 427713.0, 108451.0, 108765.91234087716, 110030.0, 110821.0, 114811.0, 1185.875483074282, 1189.1616410430627, 1196.3240768965507, 1201.9519219231133, 1207.704112492445, 17516.124193790005, 17691.557711057325, 17721.379751708628, 18236.908815455838, 18243.179056942736, 53438.73280633572, 53700.46299536955, 54548.0, 54807.451925480236, 55816.0, 63649.363506364345, 63842.3615763855, 65096.674516627114, 66050.66974665096, 66690.0, 14148.717025659635, 14365.0, 14540.563783086523, 14787.0, 14898.0, 18478.722819157454, 19335.709964350826, 22841.65737513972, 23894.641580376658, 23960.520789583763, 18697.439076827715, 18796.248150073843, 18811.435656930313, 18829.435116946515, 19002.42992710221, 16734.246958887124, 17445.82554174493, 17516.562085947953, 17609.471715848544, 17797.0, 19647.901760491106, 20448.693269601266, 20506.38480845577, 20535.4866128348, 20638.896805515877, 20706.48233794167, 21349.89325053427, 21447.46381340479, 21450.463738406666, 21646.24238151657, 18632.16155272989, 18778.90610546993, 18937.621247575247, 19119.713204302225, 19324.710129348354], "value": 12024.869714025644, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1302.6222395505304, 1357.6266526705156, 1367.4256812138901, 1375.7179778145476, 1376.6283103562039, 14800.77798833017, 14996.775048374284, 15443.305051272706, 15445.768313475293, 15472.535823925273, 15814.841851581481, 15986.920065399685, 16072.517824465256, 16092.19539023047, 16109.355625774955, 2711.349276173719, 2763.6821765497025, 2781.3185769486404, 2789.316617428733, 2791.5393959996677, 2707.945841083177, 2765.3777899972547, 2779.6803367612783, 2781.8748156333013, 2837.304860309227, 2628.6319915211884, 2818.4644917465716, 2818.6476690413697, 2819.647544056993, 2841.0766500887294, 2737.6988531261545, 2770.473610014091, 2805.7054009329136, 2814.9014784482547, 2856.9857150714215, 2731.7951153663357, 2734.1934129431866, 2766.4743698697184, 2770.5844123381453, 2773.126465163467, 14554.0, 14886.851131488655, 14982.475613353588, 15046.097234165876, 15058.698826023528, 8010.158933312035, 8331.708390206375, 8366.414350995432, 8387.958060209721, 8417.0, 5306.336707911511, 5394.91907621386, 5462.672239665593, 5549.694766787825, 5560.7219639017885, 1932.4492519631838, 1942.2522328903333, 1951.1902560437402, 1956.3055115433958, 1957.1975490049012, 26104.34739131518, 26492.470150597073, 26532.86733566339, 26559.203223903314, 26565.0, 6837.213720422115, 6861.965690171617, 6893.724251030003, 6997.230304666483, 7050.365467107882, 16236.269367878474, 16249.431269905497, 16310.102944337938, 16324.18379081065, 16330.18349082565, 7580.54516728998, 7712.383009359238, 7727.49771264866, 7733.729319473791, 7748.806279843049, 7017.92982070183, 7110.1112360954885, 7131.82170445743, 7149.642517874086, 7244.855102897913, 5093.668911520814, 5237.450067742909, 5283.049051170749, 5306.8407947761625, 5343.198520221998, 1445.1906932117838, 1459.9270036498133, 1482.792409062732, 1488.2930607961132, 1493.27576125579, 844.8268105038452, 854.4616891358404, 863.2834747159842, 876.6975393489236, 879.8064425826308, 7778.49439786412, 8098.676052957933, 8117.0, 8152.673893044331, 8206.179382061746, 978.1343510992681, 980.2794945714894, 1010.4594042187395, 1013.8124446977333, 1017.5980487707315, 5016.849494515171, 5051.1413059779925, 5103.7192954387865, 5347.625666203328, 5454.181872719124, 20751.0, 21219.46951326198, 21709.131634734433, 21845.0, 21979.120835166734, 20638.587228255652, 20942.79057209439, 21127.683084753433, 21167.04748286331, 21235.99999999969, 10884.40135792539, 10943.288686235528, 11032.172587056002, 11131.721706957229, 11189.160812939062, 8105.27052565272, 8604.82790344177, 8729.3889427742, 8753.518556479201, 8845.203931646183, 18387.26450942001, 18737.34419295318, 18791.34230301933, 18837.529061773017, 18922.432327030212, 18741.625167496302, 18742.0, 18805.0, 18839.90580047091, 19394.418167455, 11257.0, 11381.601643942422, 11424.371659558805, 11449.084073274285, 11449.828252576051, 13669.726605468033, 13834.584962451143, 13862.306884655929, 13864.237466939416, 14130.78803817923, 10890.23768336209, 11054.281471704313, 11061.612843550438, 11123.666290011313, 11236.381998989807, 11032.503537340679, 11043.226974112056, 11139.610113645984, 11276.661700149009, 11419.429028548373, 8945.15021072997, 10218.693439196835, 10396.896031039896, 10397.740056498345, 10407.427591482541, 7088.539244949062, 7231.5299505531975, 7330.266973302627, 7362.5214361066355, 7461.030066091374, 7308.707651693872, 7335.633218339169, 7341.302576255247, 7399.075115610549, 7405.666744996596], "value": 6694.482933635081, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [497.70884032840786, 498.24324592571986, 524.845170674651, 529.5895680847343, 530.4218401941882, 6165.414285642868, 6332.461740752035, 6337.714802833872, 6368.745250189999, 6383.0, 6099.939000609993, 6132.264128304599, 6199.504039676826, 6243.438090571848, 6332.240131184264, 5032.57223136032, 5036.546710796028, 5054.974725126369, 5067.920324139058, 5068.8225912093085, 4946.455889852114, 5002.549770520653, 5058.645894787348, 5113.821016264432, 5140.588752899759, 5006.749662516878, 5057.898842023157, 5067.49325067494, 5087.160618497944, 5099.337086178792, 5001.824936127255, 5016.573591244749, 5032.849014529534, 5033.194688849803, 5101.897962040757, 4496.865094047183, 4534.6825722199455, 4544.613707834838, 4546.136234115541, 4567.794449249792, 6219.222597175353, 6256.718447669866, 6270.6864656766975, 6284.0, 6335.873282534323, 5768.682722450264, 5812.505936995361, 5834.095715164156, 5840.15317778924, 5855.473007429352, 6615.6030638161865, 6636.8672626547195, 6684.2647308795995, 6706.765263215812, 6761.864762704768, 4825.565699087099, 4853.538913803183, 4913.385826771653, 4931.950680493221, 4937.23472861707, 7004.124484439445, 7106.71573137079, 7150.213476517579, 7165.856682866313, 7189.0, 5085.542301192836, 5095.757866538711, 5098.898022039539, 5128.640995130379, 5144.614153938394, 5079.314292570456, 5131.332926719502, 5151.433342332415, 5155.793768249303, 5168.767405466763, 5637.323521177403, 5732.197492351074, 5756.222909907109, 5771.538276937918, 5777.913331300034, 6567.9671601641685, 6601.834954126185, 6673.899891501631, 6705.865882682417, 6723.125993620798, 1656.7100757367411, 1700.9284150985047, 1704.3097545494095, 1758.7273972534279, 1767.2400867626786, 1173.6889724223088, 1195.4560674892903, 1226.4297101847683, 1231.2797013747058, 1238.2694210415898, 5681.943180568224, 5778.451047150514, 5797.159411885337, 5828.0, 5884.411558844081, 6549.672516374258, 6868.793936181923, 6905.274946130584, 6909.75815846453, 6932.61347730456, 5876.41235876409, 5878.735456904449, 5946.613470124428, 5955.702214889238, 5970.164177015221, 3616.4213725803747, 3627.4558816177782, 3632.945505817415, 3633.691136253448, 3658.9451158232646, 6492.870142597121, 6633.635150066696, 6669.699863506154, 6670.83322916931, 6765.989134834951, 6911.723531058802, 6913.619750913647, 6931.445484361239, 6985.93014069863, 7039.014537964689, 6607.504437167232, 6660.400563949268, 6665.266820649725, 6716.361945615061, 6717.361850624183, 6762.188537375547, 6762.830929226809, 6868.622225777431, 6873.518853680194, 6891.345322194384, 6725.361090696376, 6743.089682892943, 6807.183138023469, 6813.625250611066, 6888.965555172192, 6509.414152726277, 6556.78699440605, 6567.555137869661, 6644.8371534980215, 6688.899666504909, 5039.697618142924, 5044.2685810558, 5053.065182941167, 5060.924086138784, 5072.974635126949, 6423.389777971085, 6846.178458585002, 6972.141422016949, 6980.511364204457, 6998.930010699828, 6385.680715964276, 6503.0, 6515.771947981798, 6549.541532092708, 6574.934250657432, 6680.365365290289, 6683.966580167068, 6689.632070235989, 6705.865882682417, 6789.321067893171, 6555.983822507519, 6564.4420224281475, 6585.440237579859, 6653.667316634246, 6700.3969642730435, 6534.83662908412, 6681.465482761465, 6704.497162712913, 6747.426468750211, 6754.662266886734, 6392.232932048184, 6532.88940880042, 6533.705983230671, 6537.346265373615, 6557.639329836714], "value": 5132.022162604108, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [895.8745775591418, 901.9639214431421, 923.1230331185376, 925.8472352061908, 931.5156118818214, 18568.814311856877, 19367.322143724974, 19390.22439102434, 19390.80609193906, 19436.319728809496, 17231.31074757008, 17285.395011174613, 18188.545286367847, 21642.35072947814, 21644.675329870064, 983.1004630762843, 1001.279079063077, 1002.0380434782618, 1003.0370843989742, 1016.1921272588273, 1007.6372505897871, 1008.5259927833906, 1009.6415772400802, 1009.6869970309191, 1012.4735137728377, 943.8772959515253, 1020.6784862768242, 1031.6801791444639, 1032.0556690628066, 1038.9480525973709, 1022.7034160093564, 1023.5394072667292, 1027.5941003303653, 1033.4884232304983, 1036.2487196782347, 749.6251874062968, 752.7214930475704, 754.0348354106752, 756.3193126186476, 758.9127250366223, 17409.825901741075, 17419.0, 17500.737488937677, 17619.0, 17650.205740741698, 21122.471938201514, 21302.254421095186, 21316.573668526544, 21717.891410542845, 21723.565528689338, 16562.337506499727, 16641.0, 16914.577135571588, 16922.49232523026, 16939.49181524556, 3540.6105328413855, 3587.336342776595, 3685.5577330720216, 3688.22547265072, 3692.667659910594, 118604.40697796457, 121890.3905480467, 122195.0, 123353.0, 124653.0, 16357.509274721777, 16586.917065414837, 16774.161291935354, 16830.41093561744, 16874.915625421796, 30159.0, 30395.2401189972, 31198.68801311958, 31325.373492530478, 31347.216319592193, 8483.787905302293, 8495.490270583661, 8526.31789456842, 8554.315654747605, 8577.614007369682, 4100.630943215125, 4162.438070860456, 4185.937210941838, 4201.306784380604, 4240.109576988805, 5172.405173405032, 5194.8961020780125, 5204.063268611686, 5225.738713064332, 5294.179402192666, 959.1319855530755, 984.1683777208248, 999.7350702063959, 1000.3447741729179, 1002.4887307473095, 642.4474951541671, 654.6759354119741, 664.0669858848325, 671.6675245753383, 676.7631329034798, 11368.204225704121, 11513.712157196138, 11607.535698571963, 11731.589394371156, 12563.93718031404, 683.733343995842, 684.849333146707, 686.6532401137393, 700.5236439221378, 708.8511412603308, 5491.945080549143, 5497.285352904097, 5597.468240517144, 5601.467860553241, 5633.802816901389, 103424.48287758663, 105064.47467762612, 105249.0, 105586.0, 108359.0, 95823.52088239514, 96127.0, 97697.51151244198, 97970.0, 102563.97436025694, 86405.0, 86468.0, 88038.11961880427, 88487.0, 90037.0, 11697.532098715956, 11852.170348075897, 12044.457999389873, 12090.395480226129, 12278.570250041206, 40537.391939120345, 40703.38944915888, 40920.59079409168, 42111.157776844906, 42380.788096059325, 70185.64907175432, 71238.0, 71461.28538714754, 74157.0, 74322.62838685772, 18490.81509184891, 19194.424167275003, 19319.806801932362, 19645.901770491055, 19917.900410497856, 20586.691199631718, 21518.6772198414, 21858.89070554637, 21983.0, 22018.0, 18586.070696464853, 18603.69774115799, 18729.998652015325, 19264.711029334852, 19550.413487595393, 18693.626127477648, 18871.622567548846, 19496.1226744794, 19790.307339243056, 19908.70136947918, 17687.646247075245, 18053.819461805215, 18324.90837545804, 18682.813171868653, 18917.90541047286, 13709.862901370858, 13769.449222031006, 13993.0, 14063.718725625635, 14204.928975355057, 13661.521846735317, 13783.51757688476, 14149.43402263898, 14240.643983900485, 14485.855141448872], "value": 9136.292449780623, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1507.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 107.0, 113.0, 118.0, 112.0, 113.0, 115.0, 100.0, 108.0, 113.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 121.0, 150.0, 181.0, 122.0, 158.0, 152.0, 124.0, 165.0, 119.0], "value": 143.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 164.0, 163.0, 162.0, 164.0, 173.0, 162.0, 169.0, 167.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 77.0, 172.0, 79.0, 75.0, 84.0, 90.0, 95.0, 74.0], "value": 89.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 85.0, 135.0, 82.0, 79.0, 86.0, 130.0, 80.0, 79.0, 126.0], "value": 97.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 120.0, 123.0, 114.0, 115.0, 114.0, 115.0, 126.0, 117.0, 119.0], "value": 118.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 150.0, 154.0, 148.0, 155.0, 153.0, 149.0, 149.0, 149.0, 156.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 94.0, 98.0, 96.0, 94.0, 95.0, 102.0, 94.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 54.0, 52.0, 53.0, 53.0, 53.0, 52.0, 52.0, 54.0, 55.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 44.0, 39.0, 38.0, 38.0, 39.0, 39.0, 45.0, 38.0, 40.0], "value": 39.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 76.0, 77.0, 76.0, 80.0, 77.0, 75.0, 81.0], "value": 77.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 123.0, 141.0, 135.0, 120.0, 129.0, 130.0, 116.0, 119.0, 161.0], "value": 130.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 167.0, 169.0, 174.0, 169.0, 169.0, 172.0, 166.0, 177.0, 168.0], "value": 170.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 64.0, 69.0, 64.0, 67.0, 63.0, 65.0, 65.0, 62.0], "value": 65.0, "unit": "score"}]}]} 03:01:44 INFO - Return code: 0 03:01:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:01:44 INFO - # TBPL SUCCESS # 03:01:44 INFO - Running post-action listener: _package_coverage_data 03:01:44 INFO - Running post-action listener: _resource_record_post_action 03:01:44 INFO - [mozharness: 2017-09-02 10:01:44.294094Z] Finished run-tests step (success) 03:01:44 INFO - Running post-run listener: _resource_record_post_run 03:01:44 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 10149888; Write bytes: 389419008; Read time: 5552; Write time: 243500 03:01:44 INFO - TinderboxPrint: CPU usage
13.3% 03:01:44 INFO - TinderboxPrint: I/O read bytes / time
10,149,888 / 5,552 03:01:44 INFO - TinderboxPrint: I/O write bytes / time
389,419,008 / 243,500 03:01:44 INFO - TinderboxPrint: CPU idle
8,252.2 (86.7%) 03:01:44 INFO - TinderboxPrint: CPU user
1,200.5 (12.6%) 03:01:44 INFO - TinderboxPrint: Swap in / out
0 / 0 03:01:44 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 106098688; Read time: 0; Write time: 82156 03:01:44 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:01:44 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 10149888; Write bytes: 283320320; Read time: 5552; Write time: 161344 03:01:44 INFO - Running post-run listener: _upload_blobber_files 03:01:44 INFO - Blob upload gear active. 03:01:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:01:44 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 03:01:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:01:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:01:45 INFO - (blobuploader) - INFO - Open directory for files ... 03:01:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:01:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:01:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:01:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:01:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:01:46 INFO - (blobuploader) - INFO - Done attempting. 03:01:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:01:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:01:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:01:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:01:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:01:53 INFO - (blobuploader) - INFO - Done attempting. 03:01:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:01:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:01:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:01:54 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:01:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:01:54 INFO - (blobuploader) - INFO - Done attempting. 03:01:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:01:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:01:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:01:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:01:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:01:55 INFO - (blobuploader) - INFO - Done attempting. 03:01:55 INFO - (blobuploader) - INFO - Iteration through files over. 03:01:55 INFO - Return code: 0 03:01:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:01:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:01:55 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5337d9b9806385eaa62acc08367f7c20fb6e9c49f0bf48119e271704b0e0a001074d1dfc6b16ef27302bb2bdd317ce3131e23d1b8e7bb05184fbcbc9b072116", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9db43f38e32d1fc95838bf5f923e66b370f5db555d2aa6e22940139547138ad28bee6bf5f525f50ced6821a48e4f56c03eab66c341ae840f9c722d8e7b684acc", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87bb9e89c30519b2f5490984b398136c1bb36b7387ad78a59465114759ad9383e5ad18df77f3585b51e1219168927247b88ee8a25fd57b9f74ecb9b5a24ba8bd", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9258b8f3e9255933fc72e9df63248c2f537010b576a4962e5b4a4f2bc1a9fbad3df274dfc7a41f3b9ad5dbbb87397cccf8c7f9b3726b1c83f4b951de8094e4cc"} 03:01:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:01:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:01:55 INFO - Contents: 03:01:55 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5337d9b9806385eaa62acc08367f7c20fb6e9c49f0bf48119e271704b0e0a001074d1dfc6b16ef27302bb2bdd317ce3131e23d1b8e7bb05184fbcbc9b072116", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9db43f38e32d1fc95838bf5f923e66b370f5db555d2aa6e22940139547138ad28bee6bf5f525f50ced6821a48e4f56c03eab66c341ae840f9c722d8e7b684acc", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87bb9e89c30519b2f5490984b398136c1bb36b7387ad78a59465114759ad9383e5ad18df77f3585b51e1219168927247b88ee8a25fd57b9f74ecb9b5a24ba8bd", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9258b8f3e9255933fc72e9df63248c2f537010b576a4962e5b4a4f2bc1a9fbad3df274dfc7a41f3b9ad5dbbb87397cccf8c7f9b3726b1c83f4b951de8094e4cc"} 03:01:55 INFO - Running post-run listener: copy_logs_to_upload_dir 03:01:55 INFO - Copying logs to upload dir... 03:01:55 INFO - mkdir: /builds/slave/test/build/upload/logs 03:01:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.916834 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-09-02 03:01:55.386806) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-02 03:01:55.394075) ========= 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=9f7544b6a75ada7b6b576032000001a7-1504345254.899811-8515522 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5337d9b9806385eaa62acc08367f7c20fb6e9c49f0bf48119e271704b0e0a001074d1dfc6b16ef27302bb2bdd317ce3131e23d1b8e7bb05184fbcbc9b072116", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9db43f38e32d1fc95838bf5f923e66b370f5db555d2aa6e22940139547138ad28bee6bf5f525f50ced6821a48e4f56c03eab66c341ae840f9c722d8e7b684acc", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87bb9e89c30519b2f5490984b398136c1bb36b7387ad78a59465114759ad9383e5ad18df77f3585b51e1219168927247b88ee8a25fd57b9f74ecb9b5a24ba8bd", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9258b8f3e9255933fc72e9df63248c2f537010b576a4962e5b4a4f2bc1a9fbad3df274dfc7a41f3b9ad5dbbb87397cccf8c7f9b3726b1c83f4b951de8094e4cc"} build_url:https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011426 build_url: 'https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5337d9b9806385eaa62acc08367f7c20fb6e9c49f0bf48119e271704b0e0a001074d1dfc6b16ef27302bb2bdd317ce3131e23d1b8e7bb05184fbcbc9b072116", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9db43f38e32d1fc95838bf5f923e66b370f5db555d2aa6e22940139547138ad28bee6bf5f525f50ced6821a48e4f56c03eab66c341ae840f9c722d8e7b684acc", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87bb9e89c30519b2f5490984b398136c1bb36b7387ad78a59465114759ad9383e5ad18df77f3585b51e1219168927247b88ee8a25fd57b9f74ecb9b5a24ba8bd", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9258b8f3e9255933fc72e9df63248c2f537010b576a4962e5b4a4f2bc1a9fbad3df274dfc7a41f3b9ad5dbbb87397cccf8c7f9b3726b1c83f4b951de8094e4cc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-02 03:01:55.428588) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-02 03:01:55.428999) ========= 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=9f7544b6a75ada7b6b576032000001a7-1504345254.899811-8515522 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004523 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-02 03:01:55.483394) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-02 03:01:55.483754) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-02 03:01:55.484095) ========= ========= Total master_lag: 0.21 =========