builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-049 starttime: 1503267337.88 results: success (0) revision: 0286df0f0eba0e81e2c628c332f90457c38ea926 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-20 15:15:37.880504) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-20 15:15:37.880918) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-20 15:15:37.881180) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-20 15:15:37.899009) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 15:15:37.899298) ========= 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=db7e7c15f3ca076d53731445000001ba-1503267337.373495-921092190 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-20 15:15:38-- 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% 211M=0s 2017-08-20 15:15:38 (211 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127700 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 15:15:38.042587) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 15:15:38.042904) ========= 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=db7e7c15f3ca076d53731445000001ba-1503267337.373495-921092190 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017959 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 15:15:38.096415) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-08-20 15:15:38.099740) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0286df0f0eba0e81e2c628c332f90457c38ea926 --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 0286df0f0eba0e81e2c628c332f90457c38ea926 --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=db7e7c15f3ca076d53731445000001ba-1503267337.373495-921092190 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-20 15:15:38,524 truncating revision to first 12 chars 2017-08-20 15:15:38,524 Setting DEBUG logging. 2017-08-20 15:15:38,524 attempt 1/10 2017-08-20 15:15:38,524 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0286df0f0eba?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-20 15:15:39,149 attempt 1/10 2017-08-20 15:15:39,734 current task status: no status available at this point. state: STARTED 2017-08-20 15:15:39,734 sleeping for 9.00s (attempt 1/10) 2017-08-20 15:15:48,744 attempt 2/10 2017-08-20 15:15:49,152 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-08-20 15:15:49,375 unpacking tar archive at: mozilla-central-0286df0f0eba/testing/mozharness/ program finished with exit code 0 elapsedTime=11.179091 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-08-20 15:15:49.296845) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-20 15:15:49.297187) ========= script_repo_revision: 0286df0f0eba0e81e2c628c332f90457c38ea926 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-20 15:15:49.297554) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-20 15:15:49.297826) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-20 15:15:49.309941) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-20 15:15:49.310306) ========= /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=db7e7c15f3ca076d53731445000001ba-1503267337.373495-921092190 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:15:49 INFO - MultiFileLogger online at 20170820 15:15:49 in /builds/slave/test 15:15:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 15:15:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:15:49 INFO - {'append_to_log': False, 15:15:49 INFO - 'base_work_dir': '/builds/slave/test', 15:15:49 INFO - 'blob_upload_branch': 'Firefox', 15:15:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:15:49 INFO - 'branch': 'Firefox', 15:15:49 INFO - 'buildbot_json_path': 'buildprops.json', 15:15:49 INFO - 'code_coverage': False, 15:15:49 INFO - 'config_files': ('talos/linux_config.py',), 15:15:49 INFO - 'default_actions': ('clobber', 15:15:49 INFO - 'read-buildbot-config', 15:15:49 INFO - 'download-and-extract', 15:15:49 INFO - 'populate-webroot', 15:15:49 INFO - 'create-virtualenv', 15:15:49 INFO - 'install', 15:15:49 INFO - 'setup-mitmproxy', 15:15:49 INFO - 'run-tests'), 15:15:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:15:49 INFO - 'disable_ccov_upload': False, 15:15:49 INFO - 'download_minidump_stackwalk': True, 15:15:49 INFO - 'download_symbols': 'ondemand', 15:15:49 INFO - 'enable_stylo': False, 15:15:49 INFO - 'enable_webrender': False, 15:15:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:15:49 INFO - 'tooltool.py': '/tools/tooltool.py', 15:15:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:15:49 INFO - '/tools/misc-python/virtualenv.py')}, 15:15:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:15:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:15:49 INFO - 'gecko_profile': False, 15:15:49 INFO - 'gecko_profile_interval': 0, 15:15:49 INFO - 'installer_path': 'installer.exe', 15:15:49 INFO - 'log_level': 'info', 15:15:49 INFO - 'log_name': 'talos', 15:15:49 INFO - 'log_to_console': True, 15:15:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:15:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:15:49 INFO - 'opt_config_files': (), 15:15:49 INFO - 'pip_index': False, 15:15:49 INFO - 'suite': 'dromaeojs-e10s', 15:15:49 INFO - 'system_bits': '32', 15:15:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:15:49 INFO - 'title': 'talos-linux64-ix-049', 15:15:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:15:49 INFO - 'use_talos_json': True, 15:15:49 INFO - 'verify': 'False', 15:15:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:15:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:15:49 INFO - 'work_dir': 'build'} 15:15:49 INFO - [mozharness: 2017-08-20 22:15:49.872387Z] Running clobber step. 15:15:49 INFO - Running pre-action listener: _resource_record_pre_action 15:15:49 INFO - Running main action method: clobber 15:15:49 INFO - rmtree: /builds/slave/test/build 15:15:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:15:50 INFO - Running post-action listener: _resource_record_post_action 15:15:50 INFO - [mozharness: 2017-08-20 22:15:50.908795Z] Finished clobber step (success) 15:15:50 INFO - [mozharness: 2017-08-20 22:15:50.908893Z] Running read-buildbot-config step. 15:15:50 INFO - Running pre-action listener: _resource_record_pre_action 15:15:50 INFO - Running main action method: read_buildbot_config 15:15:50 INFO - Using buildbot properties: 15:15:50 INFO - { 15:15:50 INFO - "project": "", 15:15:50 INFO - "product": "firefox", 15:15:50 INFO - "who": "archaeopteryx@coole-files.de", 15:15:50 INFO - "installer_path": "public/build/target.tar.bz2", 15:15:50 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 15:15:50 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:15:50 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 15:15:50 INFO - "stage_platform": "linux64-stylo", 15:15:50 INFO - "basedir": "/builds/slave/test", 15:15:50 INFO - "buildnumber": 46, 15:15:50 INFO - "platform": "ubuntu64_hw_stylo", 15:15:50 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:15:50 INFO - "slavebuilddir": "test", 15:15:50 INFO - "taskId": "CuAhDGo0RY2o9wkkDYhUDw", 15:15:50 INFO - "branch": "mozilla-central", 15:15:50 INFO - "script_repo_revision": "production", 15:15:50 INFO - "revision": "0286df0f0eba0e81e2c628c332f90457c38ea926", 15:15:50 INFO - "slavename": "talos-linux64-ix-049", 15:15:50 INFO - "repo_path": "mozilla-central" 15:15:50 INFO - } 15:15:50 INFO - Finding installer, test and symbols from parent task. 15:15:50 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CuAhDGo0RY2o9wkkDYhUDw'}, attempt #1 15:15:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CuAhDGo0RY2o9wkkDYhUDw'}, attempt #1 15:15:51 INFO - Task dependencies: IloK1kyWQ36ATXk4aJc2wg 15:15:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IloK1kyWQ36ATXk4aJc2wg'}, attempt #1 15:15:52 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/IloK1kyWQ36ATXk4aJc2wg/artifacts/public/build/target.tar.bz2 15:15:52 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/IloK1kyWQ36ATXk4aJc2wg/artifacts/public/build/target.test_packages.json 15:15:52 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/IloK1kyWQ36ATXk4aJc2wg/artifacts/public/build/target.crashreporter-symbols.zip 15:15:52 INFO - Running post-action listener: _resource_record_post_action 15:15:52 INFO - [mozharness: 2017-08-20 22:15:52.265259Z] Finished read-buildbot-config step (success) 15:15:52 INFO - [mozharness: 2017-08-20 22:15:52.265475Z] Running download-and-extract step. 15:15:52 INFO - Running pre-action listener: _resource_record_pre_action 15:15:52 INFO - Running main action method: download_and_extract 15:15:52 INFO - mkdir: /builds/slave/test/build/tests 15:15:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:52 INFO - trying https://queue.taskcluster.net/v1/task/IloK1kyWQ36ATXk4aJc2wg/artifacts/public/build/target.test_packages.json 15:15:52 INFO - Downloading https://queue.taskcluster.net/v1/task/IloK1kyWQ36ATXk4aJc2wg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:15:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IloK1kyWQ36ATXk4aJc2wg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:15:52 INFO - Downloaded 989 bytes. 15:15:52 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:15:52 INFO - Using the following test package requirements: 15:15:52 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:15:52 INFO - u'common': [u'target.common.tests.zip'], 15:15:52 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:15:52 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:15:52 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:15:52 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:15:52 INFO - u'mozbase': [u'target.common.tests.zip'], 15:15:52 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:15:52 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:15:52 INFO - u'web-platform': [u'target.common.tests.zip', 15:15:52 INFO - u'target.web-platform.tests.tar.gz'], 15:15:52 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:15:52 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 15:15:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IloK1kyWQ36ATXk4aJc2wg/artifacts/public/build/target.common.tests.zip 15:15:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IloK1kyWQ36ATXk4aJc2wg/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:15:52 INFO - Fetch https://queue.taskcluster.net/v1/task/IloK1kyWQ36ATXk4aJc2wg/artifacts/public/build/target.common.tests.zip into memory 15:15:55 INFO - Content-Length response header: 54005739 15:15:55 INFO - Bytes received: 54005739 15:16:05 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 15:16:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IloK1kyWQ36ATXk4aJc2wg/artifacts/public/build/target.common.tests.zip 15:16:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IloK1kyWQ36ATXk4aJc2wg/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:16:05 INFO - Fetch https://queue.taskcluster.net/v1/task/IloK1kyWQ36ATXk4aJc2wg/artifacts/public/build/target.common.tests.zip into memory 15:16:06 INFO - Content-Length response header: 54005739 15:16:06 INFO - Bytes received: 54005739 15:16:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IloK1kyWQ36ATXk4aJc2wg/artifacts/public/build/target.talos.tests.zip 15:16:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IloK1kyWQ36ATXk4aJc2wg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:16:18 INFO - Fetch https://queue.taskcluster.net/v1/task/IloK1kyWQ36ATXk4aJc2wg/artifacts/public/build/target.talos.tests.zip into memory 15:16:20 INFO - Content-Length response header: 14496256 15:16:20 INFO - Bytes received: 14496256 15:16:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:20 INFO - trying https://queue.taskcluster.net/v1/task/IloK1kyWQ36ATXk4aJc2wg/artifacts/public/build/target.tar.bz2 15:16:20 INFO - Downloading https://queue.taskcluster.net/v1/task/IloK1kyWQ36ATXk4aJc2wg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:16:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IloK1kyWQ36ATXk4aJc2wg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:16:22 INFO - Downloaded 62182506 bytes. 15:16:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IloK1kyWQ36ATXk4aJc2wg/artifacts/public/build/target.tar.bz2 15:16:22 INFO - mkdir: /builds/slave/test/properties 15:16:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:16:22 INFO - Writing to file /builds/slave/test/properties/build_url 15:16:22 INFO - Contents: 15:16:22 INFO - build_url:https://queue.taskcluster.net/v1/task/IloK1kyWQ36ATXk4aJc2wg/artifacts/public/build/target.tar.bz2 15:16:22 INFO - Running post-action listener: _resource_record_post_action 15:16:22 INFO - Running post-action listener: find_tests_for_verification 15:16:22 INFO - Running post-action listener: set_extra_try_arguments 15:16:22 INFO - [mozharness: 2017-08-20 22:16:22.878624Z] Finished download-and-extract step (success) 15:16:22 INFO - [mozharness: 2017-08-20 22:16:22.878723Z] Running populate-webroot step. 15:16:22 INFO - Running pre-action listener: _resource_record_pre_action 15:16:22 INFO - Running main action method: populate_webroot 15:16:22 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:16:22 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 15:16:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:16:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:16:22 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 15:16:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:16:22 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:16:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:16:22 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:16:22 INFO - 'talos_options': ['--stylo'], 15:16:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:16:22 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:16:22 INFO - 'tests': ['damp', 'tps']}, 15:16:22 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:16:22 INFO - 'talos_options': ['--stylo'], 15:16:22 INFO - 'tests': ['damp', 'tps']}, 15:16:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:16:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:16:22 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 15:16:22 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 15:16:22 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:16:22 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:16:22 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:16:22 INFO - 'talos_options': ['--stylo'], 15:16:22 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:16:22 INFO - 'other-e10s': {'tests': ['a11yr', 15:16:22 INFO - 'ts_paint', 15:16:22 INFO - 'tpaint', 15:16:22 INFO - 'sessionrestore', 15:16:22 INFO - 'sessionrestore_many_windows', 15:16:22 INFO - 'sessionrestore_no_auto_restore', 15:16:22 INFO - 'tabpaint']}, 15:16:22 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 15:16:22 INFO - 'tests': ['a11yr', 15:16:22 INFO - 'ts_paint', 15:16:22 INFO - 'tpaint', 15:16:22 INFO - 'sessionrestore', 15:16:22 INFO - 'sessionrestore_many_windows', 15:16:22 INFO - 'sessionrestore_no_auto_restore', 15:16:22 INFO - 'tabpaint']}, 15:16:22 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:16:22 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 15:16:22 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 15:16:22 INFO - 'tests': ['bloom_basic_singleton']}, 15:16:22 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 15:16:22 INFO - 'tests': ['bloom_basic']}, 15:16:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:16:22 INFO - 'tsvgr_opacity', 15:16:22 INFO - 'tart', 15:16:22 INFO - 'tscrollx', 15:16:22 INFO - 'tsvg_static']}, 15:16:22 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 15:16:22 INFO - 'tests': ['tsvgx', 15:16:22 INFO - 'tsvgr_opacity', 15:16:22 INFO - 'tart', 15:16:22 INFO - 'tscrollx', 15:16:22 INFO - 'tsvg_static']}, 15:16:22 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:16:22 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:16:22 INFO - 'talos_options': ['--stylo'], 15:16:22 INFO - 'tests': ['tp5o']}, 15:16:22 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:16:22 INFO - 'talos_options': ['--mitmproxy', 15:16:22 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:16:22 INFO - '--firstNonBlankPaint'], 15:16:22 INFO - 'tests': ['tp6_google', 15:16:22 INFO - 'tp6_youtube', 15:16:22 INFO - 'tp6_amazon', 15:16:22 INFO - 'tp6_facebook']}, 15:16:22 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:16:22 INFO - 'talos_options': ['--stylo', 15:16:22 INFO - '--mitmproxy', 15:16:22 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:16:22 INFO - '--firstNonBlankPaint'], 15:16:22 INFO - 'tests': ['tp6_google', 15:16:22 INFO - 'tp6_youtube', 15:16:22 INFO - 'tp6_amazon', 15:16:22 INFO - 'tp6_facebook']}, 15:16:22 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:16:22 INFO - 'talos_options': ['--stylo', 15:16:22 INFO - '--stylo-threads=1', 15:16:22 INFO - '--mitmproxy', 15:16:22 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:16:22 INFO - '--firstNonBlankPaint'], 15:16:22 INFO - 'tests': ['tp6_google', 15:16:22 INFO - 'tp6_youtube', 15:16:22 INFO - 'tp6_amazon', 15:16:22 INFO - 'tp6_facebook']}, 15:16:22 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:16:22 INFO - 'talos_options': ['--xperf_path', 15:16:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:16:22 INFO - 'tests': ['tp5n']}, 15:16:22 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:16:22 INFO - 'talos_options': ['--stylo', 15:16:22 INFO - '--xperf_path', 15:16:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:16:22 INFO - 'tests': ['tp5n']}}} 15:16:22 INFO - Running post-action listener: _resource_record_post_action 15:16:22 INFO - [mozharness: 2017-08-20 22:16:22.893049Z] Finished populate-webroot step (success) 15:16:22 INFO - [mozharness: 2017-08-20 22:16:22.893139Z] Running create-virtualenv step. 15:16:22 INFO - Running pre-action listener: _resource_record_pre_action 15:16:22 INFO - Running main action method: create_virtualenv 15:16:22 INFO - Creating virtualenv /builds/slave/test/build/venv 15:16:22 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:16:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:16:22 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:16:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:16:22 INFO - Using real prefix '/usr' 15:16:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:16:23 INFO - Installing distribute.............................................................................................................................................................................................done. 15:16:25 INFO - Installing pip.................done. 15:16:25 INFO - Return code: 0 15:16:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:16:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:16:25 INFO - Reading from file tmpfile_stdout 15:16:25 INFO - Output received: 15:16:25 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 15:16:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:25 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 0x1fa41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2312f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2310130>, '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 0x2311030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23114c0>, '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': 'db7e7c15f3ca076d53731445000001ba-1503267337.373495-921092190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:16:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:16:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:16:25 INFO - Using env: {'DISPLAY': ':0', 15:16:25 INFO - 'HOME': '/home/cltbld', 15:16:25 INFO - 'LANG': 'en_US.UTF-8', 15:16:25 INFO - 'LANGUAGE': 'en_US:en', 15:16:25 INFO - 'LOGNAME': 'cltbld', 15:16:25 INFO - 'MAIL': '/var/mail/cltbld', 15:16:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:25 INFO - 'MOZ_NO_REMOTE': '1', 15:16:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:25 INFO - 'NO_EM_RESTART': '1', 15:16:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:25 INFO - 'PWD': '/builds/slave/test', 15:16:25 INFO - 'SHELL': '/bin/bash', 15:16:25 INFO - 'SHLVL': '1', 15:16:25 INFO - 'TERM': 'linux', 15:16:25 INFO - 'TMOUT': '86400', 15:16:25 INFO - 'USER': 'cltbld', 15:16:25 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1503267337.373495-921092190', 15:16:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:25 INFO - '_': '/tools/buildbot/bin/python'} 15:16:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:25 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:16:25 INFO - Cleaning up... 15:16:25 INFO - Return code: 0 15:16:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:25 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 0x1fa41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2312f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2310130>, '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 0x2311030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23114c0>, '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': 'db7e7c15f3ca076d53731445000001ba-1503267337.373495-921092190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:16:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:16:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:16:25 INFO - Using env: {'DISPLAY': ':0', 15:16:25 INFO - 'HOME': '/home/cltbld', 15:16:25 INFO - 'LANG': 'en_US.UTF-8', 15:16:25 INFO - 'LANGUAGE': 'en_US:en', 15:16:25 INFO - 'LOGNAME': 'cltbld', 15:16:25 INFO - 'MAIL': '/var/mail/cltbld', 15:16:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:25 INFO - 'MOZ_NO_REMOTE': '1', 15:16:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:25 INFO - 'NO_EM_RESTART': '1', 15:16:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:25 INFO - 'PWD': '/builds/slave/test', 15:16:25 INFO - 'SHELL': '/bin/bash', 15:16:25 INFO - 'SHLVL': '1', 15:16:25 INFO - 'TERM': 'linux', 15:16:25 INFO - 'TMOUT': '86400', 15:16:25 INFO - 'USER': 'cltbld', 15:16:25 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1503267337.373495-921092190', 15:16:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:25 INFO - '_': '/tools/buildbot/bin/python'} 15:16:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:26 INFO - Downloading/unpacking psutil>=3.1.1 15:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:16:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:16:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:16:27 INFO - Installing collected packages: psutil 15:16:27 INFO - Running setup.py install for psutil 15:16:27 INFO - building 'psutil._psutil_linux' extension 15:16:27 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:16:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:16:27 INFO - building 'psutil._psutil_posix' extension 15:16:27 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:16:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:16:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:16:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:16:27 INFO - Successfully installed psutil 15:16:27 INFO - Cleaning up... 15:16:27 INFO - Return code: 0 15:16:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:27 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 0x1fa41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2312f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2310130>, '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 0x2311030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23114c0>, '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': 'db7e7c15f3ca076d53731445000001ba-1503267337.373495-921092190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:16:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:16:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:16:27 INFO - Using env: {'DISPLAY': ':0', 15:16:27 INFO - 'HOME': '/home/cltbld', 15:16:27 INFO - 'LANG': 'en_US.UTF-8', 15:16:27 INFO - 'LANGUAGE': 'en_US:en', 15:16:27 INFO - 'LOGNAME': 'cltbld', 15:16:27 INFO - 'MAIL': '/var/mail/cltbld', 15:16:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:27 INFO - 'MOZ_NO_REMOTE': '1', 15:16:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:27 INFO - 'NO_EM_RESTART': '1', 15:16:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:27 INFO - 'PWD': '/builds/slave/test', 15:16:27 INFO - 'SHELL': '/bin/bash', 15:16:27 INFO - 'SHLVL': '1', 15:16:27 INFO - 'TERM': 'linux', 15:16:27 INFO - 'TMOUT': '86400', 15:16:27 INFO - 'USER': 'cltbld', 15:16:27 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1503267337.373495-921092190', 15:16:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:27 INFO - '_': '/tools/buildbot/bin/python'} 15:16:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:16:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:16:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:16:29 INFO - Installing collected packages: mozsystemmonitor 15:16:29 INFO - Running setup.py install for mozsystemmonitor 15:16:29 INFO - Successfully installed mozsystemmonitor 15:16:29 INFO - Cleaning up... 15:16:29 INFO - Return code: 0 15:16:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:16:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1fa41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2312f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2310130>, '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 0x2311030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23114c0>, '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': 'db7e7c15f3ca076d53731445000001ba-1503267337.373495-921092190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:16:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:16:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:16:29 INFO - Using env: {'DISPLAY': ':0', 15:16:29 INFO - 'HOME': '/home/cltbld', 15:16:29 INFO - 'LANG': 'en_US.UTF-8', 15:16:29 INFO - 'LANGUAGE': 'en_US:en', 15:16:29 INFO - 'LOGNAME': 'cltbld', 15:16:29 INFO - 'MAIL': '/var/mail/cltbld', 15:16:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:29 INFO - 'MOZ_NO_REMOTE': '1', 15:16:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:29 INFO - 'NO_EM_RESTART': '1', 15:16:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:29 INFO - 'PWD': '/builds/slave/test', 15:16:29 INFO - 'SHELL': '/bin/bash', 15:16:29 INFO - 'SHLVL': '1', 15:16:29 INFO - 'TERM': 'linux', 15:16:29 INFO - 'TMOUT': '86400', 15:16:29 INFO - 'USER': 'cltbld', 15:16:29 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1503267337.373495-921092190', 15:16:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:29 INFO - '_': '/tools/buildbot/bin/python'} 15:16:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:29 INFO - Downloading/unpacking jsonschema==2.5.1 15:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:16:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:30 INFO - Downloading functools32-3.2.3-2.tar.gz 15:16:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:16:30 INFO - warning: no files found matching '*.txt' 15:16:30 INFO - no previously-included directories found matching 'build' 15:16:30 INFO - no previously-included directories found matching 'dist' 15:16:30 INFO - no previously-included directories found matching '.git*' 15:16:30 INFO - Installing collected packages: jsonschema, functools32 15:16:30 INFO - Running setup.py install for functools32 15:16:30 INFO - warning: no files found matching '*.txt' 15:16:30 INFO - no previously-included directories found matching 'build' 15:16:30 INFO - no previously-included directories found matching 'dist' 15:16:30 INFO - no previously-included directories found matching '.git*' 15:16:30 INFO - Successfully installed jsonschema functools32 15:16:30 INFO - Cleaning up... 15:16:30 INFO - Return code: 0 15:16:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:16:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16: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', '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 0x1fa41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2312f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2310130>, '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 0x2311030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23114c0>, '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': 'db7e7c15f3ca076d53731445000001ba-1503267337.373495-921092190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:16: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:16: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 functools32==3.2.3-2 15:16:31 INFO - Using env: {'DISPLAY': ':0', 15:16:31 INFO - 'HOME': '/home/cltbld', 15:16:31 INFO - 'LANG': 'en_US.UTF-8', 15:16:31 INFO - 'LANGUAGE': 'en_US:en', 15:16:31 INFO - 'LOGNAME': 'cltbld', 15:16:31 INFO - 'MAIL': '/var/mail/cltbld', 15:16:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:31 INFO - 'MOZ_NO_REMOTE': '1', 15:16:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:31 INFO - 'NO_EM_RESTART': '1', 15:16:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:31 INFO - 'PWD': '/builds/slave/test', 15:16:31 INFO - 'SHELL': '/bin/bash', 15:16:31 INFO - 'SHLVL': '1', 15:16:31 INFO - 'TERM': 'linux', 15:16:31 INFO - 'TMOUT': '86400', 15:16:31 INFO - 'USER': 'cltbld', 15:16:31 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1503267337.373495-921092190', 15:16:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:31 INFO - '_': '/tools/buildbot/bin/python'} 15:16:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:16:31 INFO - Cleaning up... 15:16:31 INFO - Return code: 0 15:16:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:16: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')]} 15:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16: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')]} 15:16:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16: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', '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 0x1fa41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2312f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2310130>, '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 0x2311030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23114c0>, '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': 'db7e7c15f3ca076d53731445000001ba-1503267337.373495-921092190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:16: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:16: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 blobuploader==1.2.4 15:16:31 INFO - Using env: {'DISPLAY': ':0', 15:16:31 INFO - 'HOME': '/home/cltbld', 15:16:31 INFO - 'LANG': 'en_US.UTF-8', 15:16:31 INFO - 'LANGUAGE': 'en_US:en', 15:16:31 INFO - 'LOGNAME': 'cltbld', 15:16:31 INFO - 'MAIL': '/var/mail/cltbld', 15:16:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:31 INFO - 'MOZ_NO_REMOTE': '1', 15:16:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:31 INFO - 'NO_EM_RESTART': '1', 15:16:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:31 INFO - 'PWD': '/builds/slave/test', 15:16:31 INFO - 'SHELL': '/bin/bash', 15:16:31 INFO - 'SHLVL': '1', 15:16:31 INFO - 'TERM': 'linux', 15:16:31 INFO - 'TMOUT': '86400', 15:16:31 INFO - 'USER': 'cltbld', 15:16:31 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1503267337.373495-921092190', 15:16:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:31 INFO - '_': '/tools/buildbot/bin/python'} 15:16:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:31 INFO - Downloading/unpacking blobuploader==1.2.4 15:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:32 INFO - Downloading blobuploader-1.2.4.tar.gz 15:16:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:16:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:16: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 15:16: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 15:16: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 15:16: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 15:16:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:16:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:16: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 15:16: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 15:16: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 15:16: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 15:16:33 INFO - Downloading docopt-0.6.1.tar.gz 15:16:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:16:33 INFO - Installing collected packages: blobuploader, requests, docopt 15:16:33 INFO - Running setup.py install for blobuploader 15:16:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:16:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:16:33 INFO - Running setup.py install for requests 15:16:33 INFO - Running setup.py install for docopt 15:16:33 INFO - Successfully installed blobuploader requests docopt 15:16:33 INFO - Cleaning up... 15:16:33 INFO - Return code: 0 15:16:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:16:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:33 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 0x1fa41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2312f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2310130>, '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 0x2311030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23114c0>, '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': 'db7e7c15f3ca076d53731445000001ba-1503267337.373495-921092190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:16:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:16:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:16:33 INFO - Using env: {'DISPLAY': ':0', 15:16:33 INFO - 'HOME': '/home/cltbld', 15:16:33 INFO - 'LANG': 'en_US.UTF-8', 15:16:33 INFO - 'LANGUAGE': 'en_US:en', 15:16:33 INFO - 'LOGNAME': 'cltbld', 15:16:33 INFO - 'MAIL': '/var/mail/cltbld', 15:16:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:33 INFO - 'MOZ_NO_REMOTE': '1', 15:16:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:33 INFO - 'NO_EM_RESTART': '1', 15:16:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:33 INFO - 'PWD': '/builds/slave/test', 15:16:33 INFO - 'SHELL': '/bin/bash', 15:16:33 INFO - 'SHLVL': '1', 15:16:33 INFO - 'TERM': 'linux', 15:16:33 INFO - 'TMOUT': '86400', 15:16:33 INFO - 'USER': 'cltbld', 15:16:33 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1503267337.373495-921092190', 15:16:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:33 INFO - '_': '/tools/buildbot/bin/python'} 15:16:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:16:33 INFO - Running setup.py (path:/tmp/pip-5Eju7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:16:34 INFO - Running setup.py (path:/tmp/pip-FCjKkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:16:34 INFO - Running setup.py (path:/tmp/pip-05oVuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:16:34 INFO - Running setup.py (path:/tmp/pip-9fSuQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:16:34 INFO - Running setup.py (path:/tmp/pip-rP7g28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:16:34 INFO - Running setup.py (path:/tmp/pip-7LdLXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:16:34 INFO - Running setup.py (path:/tmp/pip-cV64Vt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:16:34 INFO - Running setup.py (path:/tmp/pip-9z6Jqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:16:34 INFO - Running setup.py (path:/tmp/pip-3ekYPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:16:34 INFO - Running setup.py (path:/tmp/pip-hhmP3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:16:34 INFO - Running setup.py (path:/tmp/pip-XCkGzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:16:34 INFO - Running setup.py (path:/tmp/pip-wKkUlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:16:34 INFO - Running setup.py (path:/tmp/pip-96KTs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:16:34 INFO - Running setup.py (path:/tmp/pip-IG1SwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:16:34 INFO - Running setup.py (path:/tmp/pip-SzmSaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:16:35 INFO - Running setup.py (path:/tmp/pip-wFXBEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:16:35 INFO - Running setup.py (path:/tmp/pip-LFQPUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:16:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:16:35 INFO - Running setup.py install for manifestparser 15:16:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:16:35 INFO - Running setup.py install for mozcrash 15:16:35 INFO - Running setup.py install for mozdebug 15:16:35 INFO - Running setup.py install for mozdevice 15:16:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:16:35 INFO - Running setup.py install for mozfile 15:16:35 INFO - Running setup.py install for mozhttpd 15:16:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:16:35 INFO - Running setup.py install for mozinfo 15:16:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:16:35 INFO - Running setup.py install for mozInstall 15:16:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:16:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:16:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:16:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:16:35 INFO - Running setup.py install for mozleak 15:16:36 INFO - Running setup.py install for mozlog 15:16:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:16:36 INFO - Running setup.py install for moznetwork 15:16:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:16:36 INFO - Running setup.py install for mozprocess 15:16:36 INFO - Running setup.py install for mozprofile 15:16:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:16:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:16:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:16:36 INFO - Running setup.py install for mozrunner 15:16:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:16:36 INFO - Running setup.py install for mozscreenshot 15:16:36 INFO - Running setup.py install for moztest 15:16:36 INFO - Running setup.py install for mozversion 15:16:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:16:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:16:36 INFO - Cleaning up... 15:16:36 INFO - Return code: 0 15:16:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:16: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')]} 15:16:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16: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')]} 15:16:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:36 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 0x1fa41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2312f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2310130>, '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 0x2311030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23114c0>, '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': 'db7e7c15f3ca076d53731445000001ba-1503267337.373495-921092190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:16:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:16:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:16:36 INFO - Using env: {'DISPLAY': ':0', 15:16:36 INFO - 'HOME': '/home/cltbld', 15:16:36 INFO - 'LANG': 'en_US.UTF-8', 15:16:36 INFO - 'LANGUAGE': 'en_US:en', 15:16:36 INFO - 'LOGNAME': 'cltbld', 15:16:36 INFO - 'MAIL': '/var/mail/cltbld', 15:16:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:36 INFO - 'MOZ_NO_REMOTE': '1', 15:16:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:36 INFO - 'NO_EM_RESTART': '1', 15:16:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:36 INFO - 'PWD': '/builds/slave/test', 15:16:36 INFO - 'SHELL': '/bin/bash', 15:16:36 INFO - 'SHLVL': '1', 15:16:36 INFO - 'TERM': 'linux', 15:16:36 INFO - 'TMOUT': '86400', 15:16:36 INFO - 'USER': 'cltbld', 15:16:36 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1503267337.373495-921092190', 15:16:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:36 INFO - '_': '/tools/buildbot/bin/python'} 15:16:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:16:37 INFO - Running setup.py (path:/tmp/pip-I1kYWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:16:37 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:16:37 INFO - Running setup.py (path:/tmp/pip-DBUc16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:16:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:16:37 INFO - Running setup.py (path:/tmp/pip-bIj_BJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:16:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:16:37 INFO - Running setup.py (path:/tmp/pip-YIkgQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:16:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:16:37 INFO - Running setup.py (path:/tmp/pip-B6aG6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:16:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:16:37 INFO - Running setup.py (path:/tmp/pip-WaVZli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:16:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:16:37 INFO - Running setup.py (path:/tmp/pip-C4Ob4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:16:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:16:37 INFO - Running setup.py (path:/tmp/pip-nWWTSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:16:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:16:37 INFO - Running setup.py (path:/tmp/pip-4Bj8nf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:16:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:16:37 INFO - Running setup.py (path:/tmp/pip-wcHcEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:16:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:16:37 INFO - Running setup.py (path:/tmp/pip-VvZSbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:16:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:16:37 INFO - Running setup.py (path:/tmp/pip-ogNtS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:16:38 INFO - Running setup.py (path:/tmp/pip-LB9HS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:16:38 INFO - Running setup.py (path:/tmp/pip-GgfHs3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:16:38 INFO - Running setup.py (path:/tmp/pip-OPMp2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:16:38 INFO - Running setup.py (path:/tmp/pip-GPTcgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:16:38 INFO - Running setup.py (path:/tmp/pip-m67iog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:16:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:16: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 15:16: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 15:16: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 15:16: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 15:16:39 INFO - Downloading blessings-1.6.tar.gz 15:16:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:16:39 INFO - Installing collected packages: blessings 15:16:39 INFO - Running setup.py install for blessings 15:16:39 INFO - Successfully installed blessings 15:16:39 INFO - Cleaning up... 15:16:39 INFO - Return code: 0 15:16:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:16:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:16:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:16:39 INFO - Reading from file tmpfile_stdout 15:16:39 INFO - Current package versions: 15:16:39 INFO - argparse == 1.2.1 15:16:39 INFO - blessings == 1.6 15:16:39 INFO - blobuploader == 1.2.4 15:16:39 INFO - docopt == 0.6.1 15:16:39 INFO - functools32 == 3.2.3-2 15:16:39 INFO - jsonschema == 2.5.1 15:16:39 INFO - manifestparser == 1.1 15:16:39 INFO - mozInstall == 1.13 15:16:39 INFO - mozcrash == 1.0 15:16:39 INFO - mozdebug == 0.1 15:16:39 INFO - mozdevice == 0.51 15:16:39 INFO - mozfile == 1.2 15:16:39 INFO - mozhttpd == 0.7 15:16:39 INFO - mozinfo == 0.10 15:16:39 INFO - mozleak == 0.1 15:16:39 INFO - mozlog == 3.5 15:16:39 INFO - moznetwork == 0.27 15:16:39 INFO - mozprocess == 0.25 15:16:39 INFO - mozprofile == 0.28 15:16:39 INFO - mozrunner == 6.13 15:16:39 INFO - mozscreenshot == 0.1 15:16:39 INFO - mozsystemmonitor == 0.3 15:16:39 INFO - moztest == 0.8 15:16:39 INFO - mozversion == 1.4 15:16:39 INFO - psutil == 3.1.1 15:16:39 INFO - requests == 1.2.3 15:16:39 INFO - wsgiref == 0.1.2 15:16:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:39 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 0x1fa41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2312f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2310130>, '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 0x2311030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23114c0>, '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': 'db7e7c15f3ca076d53731445000001ba-1503267337.373495-921092190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:16:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:16:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:16:39 INFO - Using env: {'DISPLAY': ':0', 15:16:39 INFO - 'HOME': '/home/cltbld', 15:16:39 INFO - 'LANG': 'en_US.UTF-8', 15:16:39 INFO - 'LANGUAGE': 'en_US:en', 15:16:39 INFO - 'LOGNAME': 'cltbld', 15:16:39 INFO - 'MAIL': '/var/mail/cltbld', 15:16:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:39 INFO - 'MOZ_NO_REMOTE': '1', 15:16:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:39 INFO - 'NO_EM_RESTART': '1', 15:16:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:39 INFO - 'PWD': '/builds/slave/test', 15:16:39 INFO - 'SHELL': '/bin/bash', 15:16:39 INFO - 'SHLVL': '1', 15:16:39 INFO - 'TERM': 'linux', 15:16:39 INFO - 'TMOUT': '86400', 15:16:39 INFO - 'USER': 'cltbld', 15:16:39 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1503267337.373495-921092190', 15:16:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:39 INFO - '_': '/tools/buildbot/bin/python'} 15:16:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:16:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:16:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:16:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:16:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:16:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:16:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:16:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:16:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:16:40 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:16:41 INFO - Installing collected packages: simplejson 15:16:41 INFO - Running setup.py install for simplejson 15:16:41 INFO - building 'simplejson._speedups' extension 15:16:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 15:16:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 15:16:42 INFO - Successfully installed simplejson 15:16:42 INFO - Cleaning up... 15:16:42 INFO - Return code: 0 15:16:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:16:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:42 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 0x1fa41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2312f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2310130>, '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 0x2311030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23114c0>, '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': 'db7e7c15f3ca076d53731445000001ba-1503267337.373495-921092190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:16:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:16:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:16:42 INFO - Using env: {'DISPLAY': ':0', 15:16:42 INFO - 'HOME': '/home/cltbld', 15:16:42 INFO - 'LANG': 'en_US.UTF-8', 15:16:42 INFO - 'LANGUAGE': 'en_US:en', 15:16:42 INFO - 'LOGNAME': 'cltbld', 15:16:42 INFO - 'MAIL': '/var/mail/cltbld', 15:16:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:42 INFO - 'MOZ_NO_REMOTE': '1', 15:16:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:42 INFO - 'NO_EM_RESTART': '1', 15:16:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:42 INFO - 'PWD': '/builds/slave/test', 15:16:42 INFO - 'SHELL': '/bin/bash', 15:16:42 INFO - 'SHLVL': '1', 15:16:42 INFO - 'TERM': 'linux', 15:16:42 INFO - 'TMOUT': '86400', 15:16:42 INFO - 'USER': 'cltbld', 15:16:42 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1503267337.373495-921092190', 15:16:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:42 INFO - '_': '/tools/buildbot/bin/python'} 15:16:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:16:42 INFO - Cleaning up... 15:16:42 INFO - Return code: 0 15:16:42 INFO - Running post-action listener: _resource_record_post_action 15:16:42 INFO - Running post-action listener: _start_resource_monitoring 15:16:42 INFO - Starting resource monitoring. 15:16:42 INFO - [mozharness: 2017-08-20 22:16:42.692736Z] Finished create-virtualenv step (success) 15:16:42 INFO - [mozharness: 2017-08-20 22:16:42.693243Z] Running install step. 15:16:42 INFO - Running pre-action listener: _resource_record_pre_action 15:16:42 INFO - Running main action method: install 15:16:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:16:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:16:42 INFO - Reading from file tmpfile_stdout 15:16:42 INFO - Detecting whether we're running mozinstall >=1.0... 15:16:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:16:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:16:43 INFO - Reading from file tmpfile_stdout 15:16:43 INFO - Output received: 15:16:43 INFO - Usage: mozinstall [options] installer 15:16:43 INFO - Options: 15:16:43 INFO - -h, --help show this help message and exit 15:16:43 INFO - -d DEST, --destination=DEST 15:16:43 INFO - Directory to install application into. [default: 15:16:43 INFO - "/builds/slave/test"] 15:16:43 INFO - --app=APP Application being installed. [default: firefox] 15:16:43 INFO - mkdir: /builds/slave/test/build/application 15:16:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:16:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:17:01 INFO - Reading from file tmpfile_stdout 15:17:01 INFO - Output received: 15:17:01 INFO - /builds/slave/test/build/application/firefox/firefox 15:17:01 INFO - Running post-action listener: _resource_record_post_action 15:17:01 INFO - [mozharness: 2017-08-20 22:17:01.018746Z] Finished install step (success) 15:17:01 INFO - [mozharness: 2017-08-20 22:17:01.019110Z] Running setup-mitmproxy step. 15:17:01 INFO - Running pre-action listener: _resource_record_pre_action 15:17:01 INFO - Running main action method: setup_mitmproxy 15:17:01 INFO - Skipping: mitmproxy is not required 15:17:01 INFO - Running post-action listener: _resource_record_post_action 15:17:01 INFO - [mozharness: 2017-08-20 22:17:01.020256Z] Finished setup-mitmproxy step (success) 15:17:01 INFO - [mozharness: 2017-08-20 22:17:01.020474Z] Running run-tests step. 15:17:01 INFO - Running pre-action listener: _resource_record_pre_action 15:17:01 INFO - Running pre-action listener: _set_gcov_prefix 15:17:01 INFO - Running main action method: run_tests 15:17:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:17:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:17:01 INFO - Python 2.7.3 15:17:01 INFO - Return code: 0 15:17:01 INFO - grabbing minidump binary from tooltool 15:17:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:17:01 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 0x2310130>, '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 0x2311030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23114c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:17:01 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:17:01 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:17:01 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:17:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:17:01 INFO - Return code: 0 15:17:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:17:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:17:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:17:01 INFO - ENV: RUST_BACKTRACE is now full 15:17:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:17:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:17:01 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/IloK1kyWQ36ATXk4aJc2wg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:17:01 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/IloK1kyWQ36ATXk4aJc2wg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-049 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:17:01 INFO - Using env: {'DISPLAY': ':0', 15:17:01 INFO - 'HOME': '/home/cltbld', 15:17:01 INFO - 'LANG': 'en_US.UTF-8', 15:17:01 INFO - 'LANGUAGE': 'en_US:en', 15:17:01 INFO - 'LOGNAME': 'cltbld', 15:17:01 INFO - 'MAIL': '/var/mail/cltbld', 15:17:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:17:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:17:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:01 INFO - 'MOZ_NO_REMOTE': '1', 15:17:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:17:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:01 INFO - 'NO_EM_RESTART': '1', 15:17:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:01 INFO - 'PWD': '/builds/slave/test', 15:17:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:17:01 INFO - 'RUST_BACKTRACE': 'full', 15:17:01 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:17:01 INFO - 'SHELL': '/bin/bash', 15:17:01 INFO - 'SHLVL': '1', 15:17:01 INFO - 'STYLO_FORCE_ENABLED': '1', 15:17:01 INFO - 'TERM': 'linux', 15:17:01 INFO - 'TMOUT': '86400', 15:17:01 INFO - 'USER': 'cltbld', 15:17:01 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1503267337.373495-921092190', 15:17:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:01 INFO - '_': '/tools/buildbot/bin/python'} 15:17:01 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/IloK1kyWQ36ATXk4aJc2wg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:17:01 INFO - mozversion application_buildid: 20170820212203 15:17:01 INFO - mozversion application_changeset: 0286df0f0eba0e81e2c628c332f90457c38ea926 15:17:01 INFO - mozversion application_display_name: Nightly 15:17:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:17:01 INFO - mozversion application_name: Firefox 15:17:01 INFO - mozversion application_remotingname: firefox 15:17:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:17:01 INFO - mozversion application_vendor: Mozilla 15:17:01 INFO - mozversion application_version: 57.0a1 15:17:01 INFO - mozversion platform_buildid: 20170820212203 15:17:01 INFO - mozversion platform_changeset: 0286df0f0eba0e81e2c628c332f90457c38ea926 15:17:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:17:01 INFO - mozversion platform_version: 57.0a1 15:17:01 INFO - using testdate: 1503267421 15:17:01 INFO - actual date: 1503267421 15:17:01 INFO - starting webserver on 'localhost:49934' 15:17:01 INFO - SUITE-START | Running 2 tests 15:17:01 INFO - TEST-START | dromaeo_css 15:17:01 INFO - Initialising browser for dromaeo_css test... 15:17:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49934/getInfo.html -profile /tmp/tmpmVNLzJ/profile 15:17:01 INFO - TEST-INFO | started process 17875 (/builds/slave/test/build/application/firefox/firefox http://localhost:49934/getInfo.html) 15:17:07 INFO - TEST-INFO | 17875: exit 0 15:17:07 INFO - Browser initialized. 15:17:07 INFO - Running cycle 1/1 for dromaeo_css test... 15:17:07 INFO - TEST-INFO | started process 18066 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmVNLzJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:17:08 INFO - PID 18066 | 15:17:08 INFO - PID 18066 | (/builds/slave/test/build/application/firefox/firefox:18117): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:17:08 INFO - PID 18066 | 15:17:09 INFO - PID 18066 | 15:17:09 INFO - PID 18066 | (/builds/slave/test/build/application/firefox/firefox:18178): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:17:09 INFO - PID 18066 | 15:17:09 INFO - PID 18066 | __metrics Screen width/height:1600/1200 15:17:09 INFO - PID 18066 | colorDepth:24 15:17:09 INFO - PID 18066 | Browser inner width/height: 1024/768 15:17:09 INFO - PID 18066 | __metrics 15:17:18 INFO - PID 18066 | RSS: Main: 174784512 15:17:18 INFO - PID 18066 | 15:20:17 INFO - PID 18066 | Cycle 1(1): loaded http://localhost:49934/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49934/tests/dromaeo/cssquery-ext.html) 15:20:18 INFO - PID 18066 | RSS: Main: 178556928 15:20:18 INFO - PID 18066 | 15:23:20 INFO - PID 18066 | Cycle 1(1): loaded http://localhost:49934/tests/dromaeo/cssquery-ext.html (next: http://localhost:49934/tests/dromaeo/cssquery-jquery.html) 15:23:21 INFO - PID 18066 | RSS: Main: 175493120 15:23:21 INFO - PID 18066 | 15:26:23 INFO - PID 18066 | Cycle 1(1): loaded http://localhost:49934/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49934/tests/dromaeo/cssquery-mootools.html) 15:26:23 INFO - PID 18066 | RSS: Main: 175243264 15:26:23 INFO - PID 18066 | 15:29:25 INFO - PID 18066 | Cycle 1(1): loaded http://localhost:49934/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49934/tests/dromaeo/cssquery-prototype.html) 15:29:26 INFO - PID 18066 | RSS: Main: 175755264 15:29:26 INFO - PID 18066 | 15:32:29 INFO - PID 18066 | Cycle 1(1): loaded http://localhost:49934/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49934/tests/dromaeo/cssquery-yui.html) 15:32:30 INFO - PID 18066 | RSS: Main: 178606080 15:32:30 INFO - PID 18066 | 15:35:32 INFO - PID 18066 | Cycle 1(1): loaded http://localhost:49934/tests/dromaeo/cssquery-yui.html (next: http://localhost:49934/tests/dromaeo/cssquery-dojo.html) 15:35:32 INFO - PID 18066 | RSS: Main: 179904512 15:35:32 INFO - PID 18066 | 15:35:32 INFO - PID 18066 | __start_tp_report 15:35:32 INFO - PID 18066 | _x_x_mozilla_page_load 15:35:32 INFO - PID 18066 | _x_x_mozilla_page_load_details 15:35:32 INFO - PID 18066 | |i|pagename|runs| 15:35:32 INFO - PID 18066 | |0;dojo.html;3130.968690313096;3168.857401416936;3172.6668699786514;3186.872525098996;3195.233144045428;6124.724387402566;6232.563720539559;6234.688265586714;6284.120223168754;6285.528585356099;5898.852528686785;5921.496672782819;5979.282486101674;6009.759609615621;6014.218151640281;5643.322801263854;5662.17898404731;5672.347680016789;5675.8581035474235;5748.971255143719;5727.484526392624;5731.426857314256;5785.884282314351;5786.392428794979;5791.971040144794;5592.7762889484375;5640.492355687967;5752.194692743019;5811.157382179582;5858.297004359461;5674.971625141848;5700.629459085146;5733.713314334266;5794.652320860761;5824.737886795105;5685.403032681592;5717.456841600041;5774.624649397776;5774.88450230993;5780.132980052984;5969.462748352626;6007.279126504804;6021.729022194012;6031.547633927473;6196.504279657616;6499.1876015498065;6576.473882089422;6649.6010239385305;6699.464042876558;6757.425618822406;6711.060451536789;6712.160979877515;6735.259121496631;6771.119754431941;6782.898256526156;6191.81424557264;6208.192934918432;6238.563300568962;6268.1851359323455;6288.87422251557;6772.390484856386;6872.725090996404;6920.826979325557;6948.0272761813385;6950;6472.126262954535;6544.181977252843;6578.440832529289;6628.734850606018;6676.165479315086;6740.528163028541;6742.6291553965;6757.831054223684;6763;6776.627285499345;6686.331366863372;6690.866182676416;6765.52641315113;6766.966165169143;6790.287019862942;6637.568558043712;6684.799456016327;6702.463802895757;6796.490263230277;6805.3875151236625;5314.043472174968;5330.786768529293;5399.595030372738;5401.432849550819;5411;4682.953170468251;4701.976490117596;4709.599684026896;4716.57550820421;4728.739919304402;5758.798442054508;5765.394633563499;5820.854478638068;5856.8535786604825;5872.7357268923;6675.9332406676285;6721.66391680414;6761.594304341756;6770.119884414995;6801.693923773442;5646.97176514123;5768.105943578752;5771.134329850556;5826.73779679907;5841.065429531254;5900.350961394243;5949.494292985059;5949.553783466171;5956.761729530857;5957.851053723605;6491;6591.736330546724;6602.86794264112;6603.669816509251;6620.801375958729;6699.095622090956;6772.9661351694895;6773.254941956479;6778.932210678027;6805.523613347018;6444.742210311535;6473.838154045998;6478.578892371981;6551.6069035858;6557.180352455943;6372.55392122547;6445.806625801233;6465.482761378984;6519.967400162969;6657.167854018247;6657.933420665731;6730.798076057726;6741.494387921024;6744.831379215559;6778.3221677831825;6505.41451269388;6585.901211481927;6588.604683718992;6597.472202223715;6604;6501.934980650133;6510.3489651034515;6583.111279977142;6590.670466476753;6601.33986601336;6301.0863424804065;6371.904421433775;6375.77684781049;6395.649922320071;6487.18910136233;6470.741170353322;6481.8703625928165;6498.610083395011;6566.9343306566325;6590.637514936533;6292.402221788922;6393.584417012879;6396.680165991775;6420.582662126947;6425.710843011982 15:35:32 INFO - PID 18066 | |1;ext.html;804.2640983500098;824.2622852546967;833.1959658929133;868.91745284198;875.3041332140947;39662.20675586486;40309;40322.59677403229;40352.1929561409;40367.39448908269;36433.81783091081;36619.26761464769;36640;36701.632983670155;36828;6718.496112791536;6827.112475378194;6839.623820689885;6841.110655614788;6844.2813504582045;6782.5252232343755;7384.778456646282;7619.80950476237;7625.084989801232;7641.61791910405;7662.731804386847;7713.807154821118;7726.343260822809;7746.38028957682;7750.224977502261;7572.924270757305;7584.355329796974;7760.883586746203;7761.805954851174;7762.883556746653;7565.432592555525;7572.697092116308;7586.62066896653;7607.391408687292;7610.619469026582;36998.63001369979;37190;37362;37387.439188412194;37465.81267093674;3415.197428604276;3446.052335607703;3449.120474279068;3449.5515582974303;3451.879184228565;30663;30689.69310306891;30731.846340768378;30761.384772304653;30916.845415773;4860.716032378176;5013;5019.64862459628;5021.046001259749;5028.522290382408;191461;191684;192143;192732;193016;47056;47175.76412117918;47237;47286.52713472821;47354.76322618365;49429;49488.25767613489;49497.25754113691;49527;49554.75222623864;15951.20243987796;16305.836941630432;16315.265813038443;16325.102119383311;16349.264283107288;13418;13422.395992180376;13425.798613020812;13445.596632101053;13453.865461345456;14169.858301416854;14209;14241.145531268157;14258.42966281337;14383.856161438462;5707.486326230659;5717.142428635738;5765.164051212634;5786.189933409326;5924.229850119543;982.9705108846603;992;1007.6775431861734;1011.9089281964658;1022.1311884897777;22189.11243550272;22418.663720044213;22457.887710561343;22532.436689082577;22658;1115.7489564847845;1117.636768050387;1121.966341009771;1122.590254557097;1125;11732.12009099304;11762.529498819951;11771.764564708657;11806.645800625995;11947.522099116111;225609;225927;226929;227054;227232;48927.75536122368;49431.25853112206;50493.74753126211;53555.19667204995;53614;1439.4458133618423;1468.8531146885225;1477.5271912987955;1480.4892312152506;1495.4915328788263;25622.615660765478;25745.61228161308;26278.474430511666;26508.7349126514;26650.46699065969;35886.820565897004;35894.461583076794;35937.46093808542;35949.28101438009;35953.460698089024;188936;189165;189228;190087;190106;31437;31447.52828707617;31493.055208343787;31494.685053149176;34080.65919340874;45096.323555146046;45227.32159017552;45909.31136032895;45938.77030614825;45992.7700361496;32837.17907052247;32845.835770820995;33550.328993419505;33685;33815.83092084622;32593.348133036732;32691.50962735513;32985.84549540754;33219.33561328711;33348.33303333968;35748.28503429865;35907.64092359043;36083.63916360908;36287.81856090703;36385.63614363928;31999.680003200603;32126.35747285088;32450;32740;33071.173220669676;23660.645090323316;23979.160729375086;24141;24399.878000609882;24724.38189045288 15:35:32 INFO - PID 18066 | |2;jquery.html;553.1951011278587;569.6866723302182;573.197523467146;578.4909279833747;578.7655999320275;22024.669629955562;22599.661005084916;22676.54646907063;22809.08763649456;23537.529249415045;26018.21945341638;26864.462710745822;26884;26885.327866803338;26926.46147077062;6344.841378965528;6478.838029049288;6480.675966201695;6490;6492.448141907944;5938;6212.65830379329;6452.580582262161;6480.092787009822;6487.3836985486305;6440.838979025515;6447.7098530566;6449.580777249487;6453.419192272694;6454.774082907099;6410.8076757697345;6456.1284226629505;6476.417122458978;6477;6478.384553467413;5994.940050599482;6005.069214271794;6008.128821320884;6012.699365031731;6020.066889632114;29360.706392936012;29524.96662616798;30223.395532089457;30901.072967811;30943.535846962088;1902.8858268503934;1945.7567804024497;1945.824875761174;1952.6582848001542;1952.8437724981968;19202.711959320623;19577.510562236057;20052.799472005237;20203.292884748964;20224;2399.9880000599887;2413.553492603874;2457.1400009996537;2460.7662272084303;2480.057578120303;137021.31489342588;140804;141864.58135418617;141930;141936;14541.182352205975;15289.235538223043;15313.923430383;15408.383664653513;15453.922730386275;23640;23657.881710591337;23734.525309493714;23736.64395034076;23758.406039849142;9997.950010249902;10092;10111.887692353836;10138.543765530569;10276.280660353703;8499.830003399897;9104.408213466104;9159.816803663889;9241.630334786532;9287.349885508085;8146.266835984789;9357.719268421959;9504.192143667728;9589.616415343307;9612.663556775618;2776.54187059133;2799.2581965779086;2841.786865985059;2857.157138644105;2937.3684657798676;946.2382781860531;979.9412035277907;983.6901376066517;983.9114479696862;986.2356673577891;19087.90456047711;19368.128434220493;19689.310874119623;19703.50741231452;20147.59704805925;1028.3161697471098;1028.639976008406;1029.7528593137592;1032.9431881246453;1040.817856875059;10729.302595331279;10766.461676916122;10788.78422431547;10898.891011089787;11138.108951283877;451261;458049;528893;540239;555463;118621.40689296671;122765;126831;127577;128129.35935320264;1223.321056813477;1244.5830646733264;1279.0407194604047;1281.3465132782162;1292.043887523226;20403.38789836307;20567.177312907315;20633.89683051575;20725.68911466299;20963.895180524;57836.71081644565;58277.4172258272;58473.415265846794;61326.386736132066;61765.07352389628;75349.62325188339;75831;75867;76474.61762691151;76782;14217.21805300677;14313;14509.274536273355;14576.271186440848;14597.708045838812;22690;22738;22799.65800513027;22949.770502294763;22966.311010669706;17495.30018799234;17600.119994000506;17782.199801009243;17783.911080444515;18028.188731506852;16011.439599613957;16126.113063781135;16641.83358166403;16644.750328744838;17346.47960561185;18615.44153675392;18633.440996770118;18732.625347493245;18866.905665471586;18906;14308.856911430752;14385.784213237019;14415.855841441871;14459.060161089496;14544.41822327095;18031.819681803016;18070.096495174927;18104.81895181084;18149.727754083437;18170.36403725916 15:35:32 INFO - PID 18066 | |3;mootools.html;1357.321339330335;1415.1226239731366;1417.8015077889097;1423.1603354021127;1425.9857401425982;13829.308534573269;14855.777163342545;14858.777118343207;14863.777043344346;14901.180435076067;14690.118592884408;14970.251487425612;14972.775408368856;14976.326065327059;14978.925105374457;2710.810243282971;2741.465414244223;2753.7796976241852;2755.586662000706;2756.021612327625;2610.5170543449426;2662.773664238542;2695.1240846724795;2695.43395886864;2697;2602.1933200707745;2660.933476663089;2661.7870570354326;2662.241261240547;2669.346010227497;2613.8170328077044;2625.251803236078;2633.5391306521474;2636.3277364272085;2642.2733748219202;2531.746825317472;2577.1495406515805;2589.326775038485;2593.1313010141434;2594.3514121469634;13870.4451821927;14129;14134.434622615083;14189.290535473185;14196.50312239077;7840.41196910234;7923.12845586985;8099.514029158269;8104.230098140667;8111.310538604167;5119.308893299394;5274.340707411574;5350.197470379435;5382.219578161184;5382.650127741724;1849.34348306352;1872.485066606694;1877.6714075036814;1914.961700765977;1920.7791104023077;23650.76349236503;23987.760122398726;24086.759132408628;24105.758942410528;24145;6913.965430172918;7052.92947070533;7085;7247.60138192394;7271.490995630361;18659.253629854655;18747.906260468884;18813.059347032595;18819.90590047041;18837.623247535248;7855.842883142305;7960.203979602109;7981.9623448952425;7986.0816006158875;7987.121416644164;6932.722691092401;7139.607321597362;7142.750003749948;7228;7268.963655181796;5430.456954304538;5615;5637.098064309691;5650.4349565043985;5666.206731057655;1694.3900195929702;1751.1331890713923;1757.0863151161325;1762.7003409420429;1769.6372243690012;858.5578427110044;887.9556022198864;906.7642412972675;908.0510866144895;910.1399177776938;7175.820604484825;7258.205068195089;8486.533240671823;8559.572021398904;8674.826503469896;945.5366870233536;968.704545113747;991.3159919655415;998.8701468809154;1024.1908891975256;5004.899902001939;5031.899362012812;5123.052235336475;5238.73806309683;5258.106121959276;19551.80448195528;19833.10751016179;20291.492712682302;20294.898525507277;20318.187272508934;18973.533440652904;19466.70799938002;19876.304329348404;20171.899140504498;20266.797332026785;10408.427536485566;10692.946535267429;10744.409057501913;10817.296875703054;10818.837717434244;8015.519068855887;8299.709510167115;8314.62584183701;8441.282490988335;8578.91421085781;17105.828941710923;17207.56981075483;17671.734923976408;17984.460466186036;18027.549311267325;17108.401205957733;17342.913285433493;17497.47507574775;17636.73544896853;17893.73159402584;11483.712907177052;11543.71140721455;11661.35862527569;11665.59170429031;11693.064554835422;12997.805032924703;13039.869601304244;13126.803097953347;13155.079144459796;13159.407826647632;10829.133669306595;10873.07578855806;10964.780704385708;11012.17408694335;11028.503717332578;10413.583456661649;10559.208059395729;10631.308964917256;10715.839262410915;10907.890921090688;9291.396059256127;9336.813263734823;9354.485503297112;9403.106704863027;9493.572789224363;6599.109120268894;6606.8678626426245;6686.933130668631;6768.2216545097945;6825.317468253135;6935.202451718117;7053.259407762111;7079.2566780487305;7101.218865924641;7159.284071592799 15:35:32 INFO - PID 18066 | |4;prototype.html;490.92881532177836;493.63471031436734;512.8948565544064;521.2832355511172;531.6517680919;6146.723397447115;6160.414760597741;6250.124982502453;6313.905291420632;6314.8737025259525;5980.162777211194;6020.397960203977;6071.392860713926;6092.60398074126;6176.166217560628;4966.950330496685;4969.180085285923;4988.954528643257;5011.624128190382;5021;4964.056829202458;4985.6759310644875;4987.850364489072;5001.44984051754;5017.422996355411;4804.303376010494;4936.136176169174;4974.527419895104;4977.975110124463;4981.626378021645;4911.852644420673;4945.950540494603;4953.801847926079;4975.179095449246;4976.925346119811;4436.889077773049;4464.2187617166865;4474.753888536129;4485.372047913294;4493.865184044484;6076.453119219292;6087.147799308101;6130.976777663361;6145.555794388315;6166.691665416712;5632.7746890124345;5642.633228840113;5671.517920976722;5734.254546908917;5762.9135562966585;6485;6511.38141876521;6518.282988871268;6556.18047744032;6568.6058836469965;4827.51724827518;4845.3216549683075;4865.637621465995;4866.537678920497;4870.732109733964;6873.759418420382;6899.517033807686;6917.169939607279;6973.755918542877;7012.614306213156;4963.503649635008;4970.701757894538;4982.227754698028;4994.126027945095;5000.874978125503;5042.520960508746;5046.646734728533;5054.267131265946;5094.312267843868;5098.745062746922;5636.323641163087;5677.914831277534;5678.3186017678145;5693.259876216065;5712.371639119777;6500.674966251669;6520.445762110274;6551.6069035857045;6606.8017959461295;6618.900716489256;1648.7939007624047;1674.1712852138269;1683.8231985641576;1720.80404119136;1761.2426656537555;1170.373849990251;1172.724409763705;1190.0776897904193;1193.844800175989;1209.2804781155198;5659.717014149276;5687.146927960839;5714.285714285681;5808.94191058084;5824.446677565625;6409.423151916257;6594;6595.274519802818;6729.6971636276485;6741.932580674229;5704.229928959538;5713.8285851424525;5733.827985160452;5755;5778.3643799182055;3513.80674062929;3531.4702794581017;3550.3254381667402;3580.6930470378124;3581.3732596795458;6424.903626445607;6425.807225783234;6474.5791523550815;6528.608283503005;6552.508561857784;6786.864262714718;6833.428311488386;6835.7949261522235;6927.203371612329;6973;6414.999999999906;6524.510661700297;6559.868802623921;6567.474602031731;6574.8356291093105;6739.393454588914;6743.831404214934;6746.426553742791;6811.250762416031;6825.419839313714;6642.966785166043;6706.865862682816;6707.128073350434;6719.294474080347;6763.830904227434;6387.840303992437;6445.517530967997;6518.80578516514;6521.152250207443;6534.575252608565;4912.189488734319;4915.11527924977;4918.188498897642;4921.753912304299;4964.826231081895;6714.597124172566;6755.459563235027;6777.390034896883;6781.491388145811;6886.311368863074;6428.228612566522;6479.416852483299;6494.772682956074;6507.503274246855;6581.407673309425;6547.312532184243;6562.475001999924;6588.769393071411;6591.747567962072;6593.637349945799;6166.352532983972;6253.687315634291;6462.795716112584;6520.054592084027;6523;6477.8704425912165;6479.514036447191;6482.50423586913;6568.6058836469965;6610;6230.875382492234;6243.469305109116;6261.3112557617715;6407.263164736115;6425.22897252314 15:35:32 INFO - PID 18066 | |5;yui.html;880.5773228850156;906.4833045164255;913.9543022848858;915.9633614655414;924.237504059151;18709.812901870977;19732.21071157152;19846.20615175393;19954.60090798185;19980.300689475873;17704.20331085101;18218.45344639663;22412.103515859348;22504.437389065282;22594.774052259472;1037.7924415116988;1072.0244577434537;1075.1076606416696;1077.531273895854;1082.1288862465713;970.9271804614647;1016.9084782369586;1068.305601359115;1069.802086613975;1070.6199299248733;1122.81473556863;1127.7067962329813;1132.30363326554;1132.898039176474;1133.167122165208;1106.6403418888813;1115.6764538283887;1116.0903863351423;1118.5302173087282;1126.6957921361227;823.9382046346548;824.6289169873581;824.7319621123158;824.7360844529693;826.1614461321703;19146.521336966547;19161.61676766471;19203.71194432071;19243.711344329848;20342.08460619276;21489.46276343088;22332.88833555822;22366;22798.202062927885;22902.77097229023;16825;16879.578010549834;16888.915555422267;16919.23863426149;17056.57358566046;3658.304922064799;3681.8159092045557;3696.0390298522307;3703.6851867591286;3714.4056950888;123128.38435807853;125728.37135814354;127098;127601.36199318944;129442;16549.50351489457;17099.914500427418;17133.05768182737;17154.39959601408;17191.226394812264;30363;30989.845050774602;31020.379592408026;31114.68885311163;31543;8808.339374546935;8837.29301655866;8874.556272186364;8875.28997680184;8875.644974201088;4236.512801027921;4248.320268756984;4261.87214383569;4365.607095361433;4369.6722745794195;5354.544863686552;5459.617826752169;5469.589780766459;5489.149181876815;5492.80775172867;1008.7931973945324;1037.273908264218;1051.232600201857;1053.4837929414684;1059.4014381874217;706.6360824175554;717.5622870049266;718.0772707071388;727.3671905442299;738.6712912753881;11446.511953446;11521.423928803693;11904;12502.124851260325;12576.37118144089;703.1105651351045;708.7802781137864;716.451914285572;718.3857801579678;720.045939130654;5555.611107222537;5743.827685169452;5762.855928601818;5777.884442311214;5931.525477961753;107871;108493.45753271184;108707;111364.44317778522;114664.42667786774;86920.56539717388;99006;101496.49251753694;105333;105361.47319263508;89642;89796;89955.99999999869;91399;92498.53750731338;13063.934680326538;13552.593422196955;13554.186748795104;13701.931490342484;13794.448222071005;39733.00667483336;40474.59525404826;40746;40977.38533921934;41867;51138;51290.74354628203;51563;52701.7364913173;54074.72962635162;18487.722684160017;18596.907015464836;18728.812711873252;18825.24699012079;18920.7161892569;21455.678164827226;21648.89175554112;21776.45558861041;21790.237341692966;21989.780102199413;19041.532908302175;19500.804991950467;19565.8043419564;19567.60864782725;19792.505187369854;18059.277628895223;18097.18562664657;18120.365787197385;18135.637287253918;18316.450506484827;18671.439856804318;19018.23927042903;19039.333623323117;19103.904480478064;19217;12761.744765104831;12856.357182141042;12933.805992909925;12960.287184204959;13193.099454904812;14651.120932743643;14665.120092794466;14792.704145917236;14958.40166393332;15538.300776465312 15:35:32 INFO - PID 18066 | __end_tp_report 15:35:32 INFO - PID 18066 | __start_cc_report 15:35:32 INFO - PID 18066 | _x_x_mozilla_cycle_collect,384 15:35:32 INFO - PID 18066 | __end_cc_report 15:35:32 INFO - PID 18066 | __startTimestamp1503268532617__endTimestamp 15:35:32 INFO - PID 18066 | 15:35:32 INFO - PID 18066 | ------- Summary: start ------- 15:35:32 INFO - PID 18066 | Number of tests: 6 15:35:32 INFO - PID 18066 | 15:35:32 INFO - PID 18066 | [#0] dojo.html Cycles:165 Average:6159.02 Median:6396.68 stddev:727.27 (11.4%) stddev-sans-first:689.61 15:35:32 INFO - PID 18066 | Values: 3131.0 3168.9 3172.7 3186.9 3195.2 6124.7 6232.6 6234.7 6284.1 6285.5 5898.9 5921.5 5979.3 6009.8 6014.2 5643.3 5662.2 5672.3 5675.9 5749.0 5727.5 5731.4 5785.9 5786.4 5792.0 5592.8 5640.5 5752.2 5811.2 5858.3 5675.0 5700.6 5733.7 5794.7 5824.7 5685.4 5717.5 5774.6 5774.9 5780.1 5969.5 6007.3 6021.7 6031.5 6196.5 6499.2 6576.5 6649.6 6699.5 6757.4 6711.1 6712.2 6735.3 6771.1 6782.9 6191.8 6208.2 6238.6 6268.2 6288.9 6772.4 6872.7 6920.8 6948.0 6950.0 6472.1 6544.2 6578.4 6628.7 6676.2 6740.5 6742.6 6757.8 6763.0 6776.6 6686.3 6690.9 6765.5 6767.0 6790.3 6637.6 6684.8 6702.5 6796.5 6805.4 5314.0 5330.8 5399.6 5401.4 5411.0 4683.0 4702.0 4709.6 4716.6 4728.7 5758.8 5765.4 5820.9 5856.9 5872.7 6675.9 6721.7 6761.6 6770.1 6801.7 5647.0 5768.1 5771.1 5826.7 5841.1 5900.4 5949.5 5949.6 5956.8 5957.9 6491.0 6591.7 6602.9 6603.7 6620.8 6699.1 6773.0 6773.3 6778.9 6805.5 6444.7 6473.8 6478.6 6551.6 6557.2 6372.6 6445.8 6465.5 6520.0 6657.2 6657.9 6730.8 6741.5 6744.8 6778.3 6505.4 6585.9 6588.6 6597.5 6604.0 6501.9 6510.3 6583.1 6590.7 6601.3 6301.1 6371.9 6375.8 6395.6 6487.2 6470.7 6481.9 6498.6 6566.9 6590.6 6292.4 6393.6 6396.7 6420.6 6425.7 15:35:32 INFO - PID 18066 | 15:35:32 INFO - PID 18066 | [#1] ext.html Cycles:180 Average:37052.59 Median:3449.34 stddev:52646.54 (1526.3%) stddev-sans-first:52723.87 15:35:32 INFO - PID 18066 | Values: 804.3 824.3 833.2 868.9 875.3 39662.2 40309.0 40322.6 40352.2 40367.4 36433.8 36619.3 36640.0 36701.6 36828.0 6718.5 6827.1 6839.6 6841.1 6844.3 6782.5 7384.8 7619.8 7625.1 7641.6 7662.7 7713.8 7726.3 7746.4 7750.2 7572.9 7584.4 7760.9 7761.8 7762.9 7565.4 7572.7 7586.6 7607.4 7610.6 36998.6 37190.0 37362.0 37387.4 37465.8 3415.2 3446.1 3449.1 3449.6 3451.9 30663.0 30689.7 30731.8 30761.4 30916.8 4860.7 5013.0 5019.6 5021.0 5028.5 191461.0 191684.0 192143.0 192732.0 193016.0 47056.0 47175.8 47237.0 47286.5 47354.8 49429.0 49488.3 49497.3 49527.0 49554.8 15951.2 16305.8 16315.3 16325.1 16349.3 13418.0 13422.4 13425.8 13445.6 13453.9 14169.9 14209.0 14241.1 14258.4 14383.9 5707.5 5717.1 5765.2 5786.2 5924.2 983.0 992.0 1007.7 1011.9 1022.1 22189.1 22418.7 22457.9 22532.4 22658.0 1115.7 1117.6 1122.0 1122.6 1125.0 11732.1 11762.5 11771.8 11806.6 11947.5 225609.0 225927.0 226929.0 227054.0 227232.0 48927.8 49431.3 50493.7 53555.2 53614.0 1439.4 1468.9 1477.5 1480.5 1495.5 25622.6 25745.6 26278.5 26508.7 26650.5 35886.8 35894.5 35937.5 35949.3 35953.5 188936.0 189165.0 189228.0 190087.0 190106.0 31437.0 31447.5 31493.1 31494.7 34080.7 45096.3 45227.3 45909.3 45938.8 45992.8 32837.2 32845.8 33550.3 33685.0 33815.8 32593.3 32691.5 32985.8 33219.3 33348.3 35748.3 35907.6 36083.6 36287.8 36385.6 31999.7 32126.4 32450.0 32740.0 33071.2 23660.6 23979.2 24141.0 24399.9 24724.4 15:35:32 INFO - PID 18066 | 15:35:32 INFO - PID 18066 | [#2] jquery.html Cycles:180 Average:35872.60 Median:22879.43 stddev:85884.57 (375.4%) stddev-sans-first:86084.56 15:35:32 INFO - PID 18066 | Values: 553.2 569.7 573.2 578.5 578.8 22024.7 22599.7 22676.5 22809.1 23537.5 26018.2 26864.5 26884.0 26885.3 26926.5 6344.8 6478.8 6480.7 6490.0 6492.4 5938.0 6212.7 6452.6 6480.1 6487.4 6440.8 6447.7 6449.6 6453.4 6454.8 6410.8 6456.1 6476.4 6477.0 6478.4 5994.9 6005.1 6008.1 6012.7 6020.1 29360.7 29525.0 30223.4 30901.1 30943.5 1902.9 1945.8 1945.8 1952.7 1952.8 19202.7 19577.5 20052.8 20203.3 20224.0 2400.0 2413.6 2457.1 2460.8 2480.1 137021.3 140804.0 141864.6 141930.0 141936.0 14541.2 15289.2 15313.9 15408.4 15453.9 23640.0 23657.9 23734.5 23736.6 23758.4 9998.0 10092.0 10111.9 10138.5 10276.3 8499.8 9104.4 9159.8 9241.6 9287.3 8146.3 9357.7 9504.2 9589.6 9612.7 2776.5 2799.3 2841.8 2857.2 2937.4 946.2 979.9 983.7 983.9 986.2 19087.9 19368.1 19689.3 19703.5 20147.6 1028.3 1028.6 1029.8 1032.9 1040.8 10729.3 10766.5 10788.8 10898.9 11138.1 451261.0 458049.0 528893.0 540239.0 555463.0 118621.4 122765.0 126831.0 127577.0 128129.4 1223.3 1244.6 1279.0 1281.3 1292.0 20403.4 20567.2 20633.9 20725.7 20963.9 57836.7 58277.4 58473.4 61326.4 61765.1 75349.6 75831.0 75867.0 76474.6 76782.0 14217.2 14313.0 14509.3 14576.3 14597.7 22690.0 22738.0 22799.7 22949.8 22966.3 17495.3 17600.1 17782.2 17783.9 18028.2 16011.4 16126.1 16641.8 16644.8 17346.5 18615.4 18633.4 18732.6 18866.9 18906.0 14308.9 14385.8 14415.9 14459.1 14544.4 18031.8 18070.1 18104.8 18149.7 18170.4 15:35:32 INFO - PID 18066 | 15:35:32 INFO - PID 18066 | [#3] mootools.html Cycles:180 Average:9008.41 Median:2598.27 stddev:6217.28 (239.3%) stddev-sans-first:6208.14 15:35:32 INFO - PID 18066 | Values: 1357.3 1415.1 1417.8 1423.2 1426.0 13829.3 14855.8 14858.8 14863.8 14901.2 14690.1 14970.3 14972.8 14976.3 14978.9 2710.8 2741.5 2753.8 2755.6 2756.0 2610.5 2662.8 2695.1 2695.4 2697.0 2602.2 2660.9 2661.8 2662.2 2669.3 2613.8 2625.3 2633.5 2636.3 2642.3 2531.7 2577.1 2589.3 2593.1 2594.4 13870.4 14129.0 14134.4 14189.3 14196.5 7840.4 7923.1 8099.5 8104.2 8111.3 5119.3 5274.3 5350.2 5382.2 5382.7 1849.3 1872.5 1877.7 1915.0 1920.8 23650.8 23987.8 24086.8 24105.8 24145.0 6914.0 7052.9 7085.0 7247.6 7271.5 18659.3 18747.9 18813.1 18819.9 18837.6 7855.8 7960.2 7982.0 7986.1 7987.1 6932.7 7139.6 7142.8 7228.0 7269.0 5430.5 5615.0 5637.1 5650.4 5666.2 1694.4 1751.1 1757.1 1762.7 1769.6 858.6 888.0 906.8 908.1 910.1 7175.8 7258.2 8486.5 8559.6 8674.8 945.5 968.7 991.3 998.9 1024.2 5004.9 5031.9 5123.1 5238.7 5258.1 19551.8 19833.1 20291.5 20294.9 20318.2 18973.5 19466.7 19876.3 20171.9 20266.8 10408.4 10692.9 10744.4 10817.3 10818.8 8015.5 8299.7 8314.6 8441.3 8578.9 17105.8 17207.6 17671.7 17984.5 18027.5 17108.4 17342.9 17497.5 17636.7 17893.7 11483.7 11543.7 11661.4 11665.6 11693.1 12997.8 13039.9 13126.8 13155.1 13159.4 10829.1 10873.1 10964.8 11012.2 11028.5 10413.6 10559.2 10631.3 10715.8 10907.9 9291.4 9336.8 9354.5 9403.1 9493.6 6599.1 6606.9 6686.9 6768.2 6825.3 6935.2 7053.3 7079.3 7101.2 7159.3 15:35:32 INFO - PID 18066 | 15:35:32 INFO - PID 18066 | [#4] prototype.html Cycles:180 Average:5498.66 Median:6111.79 stddev:1553.58 (25.4%) stddev-sans-first:1511.78 15:35:32 INFO - PID 18066 | Values: 490.9 493.6 512.9 521.3 531.7 6146.7 6160.4 6250.1 6313.9 6314.9 5980.2 6020.4 6071.4 6092.6 6176.2 4967.0 4969.2 4989.0 5011.6 5021.0 4964.1 4985.7 4987.9 5001.4 5017.4 4804.3 4936.1 4974.5 4978.0 4981.6 4911.9 4946.0 4953.8 4975.2 4976.9 4436.9 4464.2 4474.8 4485.4 4493.9 6076.5 6087.1 6131.0 6145.6 6166.7 5632.8 5642.6 5671.5 5734.3 5762.9 6485.0 6511.4 6518.3 6556.2 6568.6 4827.5 4845.3 4865.6 4866.5 4870.7 6873.8 6899.5 6917.2 6973.8 7012.6 4963.5 4970.7 4982.2 4994.1 5000.9 5042.5 5046.6 5054.3 5094.3 5098.7 5636.3 5677.9 5678.3 5693.3 5712.4 6500.7 6520.4 6551.6 6606.8 6618.9 1648.8 1674.2 1683.8 1720.8 1761.2 1170.4 1172.7 1190.1 1193.8 1209.3 5659.7 5687.1 5714.3 5808.9 5824.4 6409.4 6594.0 6595.3 6729.7 6741.9 5704.2 5713.8 5733.8 5755.0 5778.4 3513.8 3531.5 3550.3 3580.7 3581.4 6424.9 6425.8 6474.6 6528.6 6552.5 6786.9 6833.4 6835.8 6927.2 6973.0 6415.0 6524.5 6559.9 6567.5 6574.8 6739.4 6743.8 6746.4 6811.3 6825.4 6643.0 6706.9 6707.1 6719.3 6763.8 6387.8 6445.5 6518.8 6521.2 6534.6 4912.2 4915.1 4918.2 4921.8 4964.8 6714.6 6755.5 6777.4 6781.5 6886.3 6428.2 6479.4 6494.8 6507.5 6581.4 6547.3 6562.5 6588.8 6591.7 6593.6 6166.4 6253.7 6462.8 6520.1 6523.0 6477.9 6479.5 6482.5 6568.6 6610.0 6230.9 6243.5 6261.3 6407.3 6425.2 15:35:32 INFO - PID 18066 | 15:35:32 INFO - PID 18066 | [#5] yui.html Cycles:180 Average:23727.28 Median:19533.30 stddev:31939.57 (163.5%) stddev-sans-first:31983.09 15:35:32 INFO - PID 18066 | Values: 880.6 906.5 914.0 916.0 924.2 18709.8 19732.2 19846.2 19954.6 19980.3 17704.2 18218.5 22412.1 22504.4 22594.8 1037.8 1072.0 1075.1 1077.5 1082.1 970.9 1016.9 1068.3 1069.8 1070.6 1122.8 1127.7 1132.3 1132.9 1133.2 1106.6 1115.7 1116.1 1118.5 1126.7 823.9 824.6 824.7 824.7 826.2 19146.5 19161.6 19203.7 19243.7 20342.1 21489.5 22332.9 22366.0 22798.2 22902.8 16825.0 16879.6 16888.9 16919.2 17056.6 3658.3 3681.8 3696.0 3703.7 3714.4 123128.4 125728.4 127098.0 127601.4 129442.0 16549.5 17099.9 17133.1 17154.4 17191.2 30363.0 30989.8 31020.4 31114.7 31543.0 8808.3 8837.3 8874.6 8875.3 8875.6 4236.5 4248.3 4261.9 4365.6 4369.7 5354.5 5459.6 5469.6 5489.1 5492.8 1008.8 1037.3 1051.2 1053.5 1059.4 706.6 717.6 718.1 727.4 738.7 11446.5 11521.4 11904.0 12502.1 12576.4 703.1 708.8 716.5 718.4 720.0 5555.6 5743.8 5762.9 5777.9 5931.5 107871.0 108493.5 108707.0 111364.4 114664.4 86920.6 99006.0 101496.5 105333.0 105361.5 89642.0 89796.0 89956.0 91399.0 92498.5 13063.9 13552.6 13554.2 13701.9 13794.4 39733.0 40474.6 40746.0 40977.4 41867.0 51138.0 51290.7 51563.0 52701.7 54074.7 18487.7 18596.9 18728.8 18825.2 18920.7 21455.7 21648.9 21776.5 21790.2 21989.8 19041.5 19500.8 19565.8 19567.6 19792.5 18059.3 18097.2 18120.4 18135.6 18316.5 18671.4 19018.2 19039.3 19103.9 19217.0 12761.7 12856.4 12933.8 12960.3 13193.1 14651.1 14665.1 14792.7 14958.4 15538.3 15:35:32 INFO - PID 18066 | -------- Summary: end -------- 15:35:32 INFO - PID 18066 | 15:35:33 INFO - TEST-INFO | 18066: exit 0 15:35:33 INFO - TEST-OK | dromaeo_css | took 1111898ms 15:35:33 INFO - TEST-START | kraken 15:35:33 INFO - Initialising browser for kraken test... 15:35:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49934/getInfo.html -profile /tmp/tmpPma9Lp/profile 15:35:33 INFO - TEST-INFO | started process 18484 (/builds/slave/test/build/application/firefox/firefox http://localhost:49934/getInfo.html) 15:35:39 INFO - TEST-INFO | 18484: exit 0 15:35:39 INFO - Browser initialized. 15:35:39 INFO - Running cycle 1/1 for kraken test... 15:35:39 INFO - TEST-INFO | started process 18674 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPma9Lp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:35:40 INFO - PID 18674 | 15:35:40 INFO - PID 18674 | (/builds/slave/test/build/application/firefox/firefox:18723): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:35:40 INFO - PID 18674 | 15:35:40 INFO - PID 18674 | 15:35:40 INFO - PID 18674 | (/builds/slave/test/build/application/firefox/firefox:18787): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:35:40 INFO - PID 18674 | 15:35:40 INFO - PID 18674 | __metrics Screen width/height:1600/1200 15:35:40 INFO - PID 18674 | colorDepth:24 15:35:40 INFO - PID 18674 | Browser inner width/height: 1024/768 15:35:40 INFO - PID 18674 | __metrics 15:35:50 INFO - PID 18674 | RSS: Main: 173998080 15:35:50 INFO - PID 18674 | 15:35:53 INFO - PID 18674 | Cycle 1(1): loaded http://localhost:49934/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49934/tests/kraken/driver.html?testName=audio-beat-detection) 15:35:54 INFO - PID 18674 | RSS: Main: 178225152 15:35:54 INFO - PID 18674 | 15:35:56 INFO - PID 18674 | Cycle 1(1): loaded http://localhost:49934/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49934/tests/kraken/driver.html?testName=audio-dft) 15:35:57 INFO - PID 18674 | RSS: Main: 180445184 15:35:57 INFO - PID 18674 | 15:36:00 INFO - PID 18674 | Cycle 1(1): loaded http://localhost:49934/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49934/tests/kraken/driver.html?testName=audio-fft) 15:36:01 INFO - PID 18674 | RSS: Main: 174514176 15:36:01 INFO - PID 18674 | 15:36:03 INFO - PID 18674 | Cycle 1(1): loaded http://localhost:49934/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49934/tests/kraken/driver.html?testName=audio-oscillator) 15:36:04 INFO - PID 18674 | RSS: Main: 174895104 15:36:04 INFO - PID 18674 | 15:36:06 INFO - PID 18674 | Cycle 1(1): loaded http://localhost:49934/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49934/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:36:06 INFO - PID 18674 | RSS: Main: 174960640 15:36:06 INFO - PID 18674 | 15:36:10 INFO - PID 18674 | Cycle 1(1): loaded http://localhost:49934/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49934/tests/kraken/driver.html?testName=imaging-darkroom) 15:36:10 INFO - PID 18674 | RSS: Main: 176267264 15:36:10 INFO - PID 18674 | 15:36:14 INFO - PID 18674 | Cycle 1(1): loaded http://localhost:49934/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49934/tests/kraken/driver.html?testName=imaging-desaturate) 15:36:14 INFO - PID 18674 | RSS: Main: 176271360 15:36:14 INFO - PID 18674 | 15:36:17 INFO - PID 18674 | Cycle 1(1): loaded http://localhost:49934/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49934/tests/kraken/driver.html?testName=json-parse-financial) 15:36:18 INFO - PID 18674 | RSS: Main: 176877568 15:36:18 INFO - PID 18674 | 15:36:20 INFO - PID 18674 | Cycle 1(1): loaded http://localhost:49934/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49934/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:36:20 INFO - PID 18674 | RSS: Main: 176865280 15:36:20 INFO - PID 18674 | 15:36:22 INFO - PID 18674 | Cycle 1(1): loaded http://localhost:49934/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49934/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:36:23 INFO - PID 18674 | RSS: Main: 177393664 15:36:23 INFO - PID 18674 | 15:36:25 INFO - PID 18674 | Cycle 1(1): loaded http://localhost:49934/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49934/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:36:26 INFO - PID 18674 | RSS: Main: 177012736 15:36:26 INFO - PID 18674 | 15:36:28 INFO - PID 18674 | Cycle 1(1): loaded http://localhost:49934/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49934/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:36:29 INFO - PID 18674 | RSS: Main: 177385472 15:36:29 INFO - PID 18674 | 15:36:32 INFO - PID 18674 | Cycle 1(1): loaded http://localhost:49934/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49934/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:36:33 INFO - PID 18674 | RSS: Main: 177643520 15:36:33 INFO - PID 18674 | 15:36:35 INFO - PID 18674 | Cycle 1(1): loaded http://localhost:49934/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49934/tests/kraken/driver.html?testName=ai-astar) 15:36:35 INFO - PID 18674 | RSS: Main: 179138560 15:36:35 INFO - PID 18674 | 15:36:35 INFO - PID 18674 | __start_tp_report 15:36:35 INFO - PID 18674 | _x_x_mozilla_page_load 15:36:35 INFO - PID 18674 | _x_x_mozilla_page_load_details 15:36:35 INFO - PID 18674 | |i|pagename|runs| 15:36:35 INFO - PID 18674 | |0;ai-astar;101;108;104;113;108;109;114;99;111;112 15:36:35 INFO - PID 18674 | |1;audio-beat-detection;142;119;152;179;124;148;150;116;185;125 15:36:35 INFO - PID 18674 | |2;audio-dft;165;167;163;163;163;161;168;170;166;165 15:36:35 INFO - PID 18674 | |3;audio-fft;80;75;74;184;81;81;76;82;109;84 15:36:35 INFO - PID 18674 | |4;audio-oscillator;80;79;133;79;78;78;124;80;79;129 15:36:35 INFO - PID 18674 | |5;imaging-gaussian-blur;116;114;114;115;117;121;115;113;115;118 15:36:35 INFO - PID 18674 | |6;imaging-darkroom;154;152;157;150;150;151;151;149;150;149 15:36:35 INFO - PID 18674 | |7;imaging-desaturate;95;93;94;94;95;94;94;95;94;94 15:36:35 INFO - PID 18674 | |8;json-parse-financial;55;55;55;58;57;54;62;55;55;60 15:36:35 INFO - PID 18674 | |9;json-stringify-tinderbox;55;54;54;54;61;57;55;55;56;55 15:36:35 INFO - PID 18674 | |10;stanford-crypto-aes;80;76;77;84;75;76;76;75;80;77 15:36:35 INFO - PID 18674 | |11;stanford-crypto-ccm;125;125;120;135;128;119;122;123;119;160 15:36:35 INFO - PID 18674 | |12;stanford-crypto-pbkdf2;171;188;174;183;199;181;181;172;185;180 15:36:35 INFO - PID 18674 | |13;stanford-crypto-sha256-iterative;75;68;71;76;67;68;70;69;68;71 15:36:35 INFO - PID 18674 | __end_tp_report 15:36:35 INFO - PID 18674 | __start_cc_report 15:36:35 INFO - PID 18674 | _x_x_mozilla_cycle_collect,1016 15:36:35 INFO - PID 18674 | __end_cc_report 15:36:35 INFO - PID 18674 | __startTimestamp1503268595375__endTimestamp 15:36:35 INFO - PID 18674 | 15:36:35 INFO - PID 18674 | ------- Summary: start ------- 15:36:35 INFO - PID 18674 | Number of tests: 14 15:36:35 INFO - PID 18674 | 15:36:35 INFO - PID 18674 | [#0] ai-astar Cycles:10 Average:107.90 Median:111.50 stddev:5.09 (4.6%) stddev-sans-first:4.74 15:36:35 INFO - PID 18674 | Values: 101.0 108.0 104.0 113.0 108.0 109.0 114.0 99.0 111.0 112.0 15:36:35 INFO - PID 18674 | 15:36:35 INFO - PID 18674 | [#1] audio-beat-detection Cycles:10 Average:144.00 Median:149.00 stddev:24.03 (16.1%) stddev-sans-first:25.47 15:36:35 INFO - PID 18674 | Values: 142.0 119.0 152.0 179.0 124.0 148.0 150.0 116.0 185.0 125.0 15:36:35 INFO - PID 18674 | 15:36:35 INFO - PID 18674 | [#2] audio-dft Cycles:10 Average:165.10 Median:165.50 stddev:2.73 (1.6%) stddev-sans-first:2.89 15:36:35 INFO - PID 18674 | Values: 165.0 167.0 163.0 163.0 163.0 161.0 168.0 170.0 166.0 165.0 15:36:35 INFO - PID 18674 | 15:36:35 INFO - PID 18674 | [#3] audio-fft Cycles:10 Average:92.60 Median:80.50 stddev:33.61 (41.8%) stddev-sans-first:35.34 15:36:35 INFO - PID 18674 | Values: 80.0 75.0 74.0 184.0 81.0 81.0 76.0 82.0 109.0 84.0 15:36:35 INFO - PID 18674 | 15:36:35 INFO - PID 18674 | [#4] audio-oscillator Cycles:10 Average:93.90 Median:79.00 stddev:24.09 (30.5%) stddev-sans-first:25.03 15:36:35 INFO - PID 18674 | Values: 80.0 79.0 133.0 79.0 78.0 78.0 124.0 80.0 79.0 129.0 15:36:35 INFO - PID 18674 | 15:36:35 INFO - PID 18674 | [#5] imaging-gaussian-blur Cycles:10 Average:115.80 Median:115.50 stddev:2.35 (2.0%) stddev-sans-first:2.49 15:36:35 INFO - PID 18674 | Values: 116.0 114.0 114.0 115.0 117.0 121.0 115.0 113.0 115.0 118.0 15:36:35 INFO - PID 18674 | 15:36:35 INFO - PID 18674 | [#6] imaging-darkroom Cycles:10 Average:151.30 Median:151.00 stddev:2.50 (1.7%) stddev-sans-first:2.45 15:36:35 INFO - PID 18674 | Values: 154.0 152.0 157.0 150.0 150.0 151.0 151.0 149.0 150.0 149.0 15:36:35 INFO - PID 18674 | 15:36:35 INFO - PID 18674 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 15:36:35 INFO - PID 18674 | Values: 95.0 93.0 94.0 94.0 95.0 94.0 94.0 95.0 94.0 94.0 15:36:35 INFO - PID 18674 | 15:36:35 INFO - PID 18674 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:56.00 stddev:2.63 (4.7%) stddev-sans-first:2.73 15:36:35 INFO - PID 18674 | Values: 55.0 55.0 55.0 58.0 57.0 54.0 62.0 55.0 55.0 60.0 15:36:35 INFO - PID 18674 | 15:36:35 INFO - PID 18674 | [#9] json-stringify-tinderbox Cycles:10 Average:55.60 Median:55.00 stddev:2.12 (3.9%) stddev-sans-first:2.24 15:36:35 INFO - PID 18674 | Values: 55.0 54.0 54.0 54.0 61.0 57.0 55.0 55.0 56.0 55.0 15:36:35 INFO - PID 18674 | 15:36:35 INFO - PID 18674 | [#10] stanford-crypto-aes Cycles:10 Average:77.60 Median:77.00 stddev:2.88 (3.7%) stddev-sans-first:2.92 15:36:35 INFO - PID 18674 | Values: 80.0 76.0 77.0 84.0 75.0 76.0 76.0 75.0 80.0 77.0 15:36:35 INFO - PID 18674 | 15:36:35 INFO - PID 18674 | [#11] stanford-crypto-ccm Cycles:10 Average:127.60 Median:125.00 stddev:12.37 (9.9%) stddev-sans-first:13.08 15:36:35 INFO - PID 18674 | Values: 125.0 125.0 120.0 135.0 128.0 119.0 122.0 123.0 119.0 160.0 15:36:35 INFO - PID 18674 | 15:36:35 INFO - PID 18674 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.40 Median:182.00 stddev:8.32 (4.6%) stddev-sans-first:7.92 15:36:35 INFO - PID 18674 | Values: 171.0 188.0 174.0 183.0 199.0 181.0 181.0 172.0 185.0 180.0 15:36:35 INFO - PID 18674 | 15:36:35 INFO - PID 18674 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:70.50 stddev:3.06 (4.3%) stddev-sans-first:2.73 15:36:35 INFO - PID 18674 | Values: 75.0 68.0 71.0 76.0 67.0 68.0 70.0 69.0 68.0 71.0 15:36:35 INFO - PID 18674 | -------- Summary: end -------- 15:36:35 INFO - PID 18674 | 15:36:35 INFO - PID 18674 | 15:36:35 INFO - PID 18674 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150079,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 15:36:35 INFO - PID 18674 | 15:36:35 INFO - PID 18674 | 15:36:35 INFO - PID 18674 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 15:36:35 INFO - PID 18674 | 15:36:35 INFO - PID 18674 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 15:36:36 INFO - TEST-INFO | 18674: exit 0 15:36:36 INFO - TEST-OK | kraken | took 62766ms 15:36:36 INFO - SUITE-END | took 1174s 15:36:36 INFO - Completed test suite (00:19:35) 15:36:36 INFO - javascript benchmark 15:36:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8537.406224799775, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3130.968690313096, 3168.857401416936, 3172.6668699786514, 3186.872525098996, 3195.233144045428, 6124.724387402566, 6232.563720539559, 6234.688265586714, 6284.120223168754, 6285.528585356099, 5898.852528686785, 5921.496672782819, 5979.282486101674, 6009.759609615621, 6014.218151640281, 5643.322801263854, 5662.17898404731, 5672.347680016789, 5675.8581035474235, 5748.971255143719, 5727.484526392624, 5731.426857314256, 5785.884282314351, 5786.392428794979, 5791.971040144794, 5592.7762889484375, 5640.492355687967, 5752.194692743019, 5811.157382179582, 5858.297004359461, 5674.971625141848, 5700.629459085146, 5733.713314334266, 5794.652320860761, 5824.737886795105, 5685.403032681592, 5717.456841600041, 5774.624649397776, 5774.88450230993, 5780.132980052984, 5969.462748352626, 6007.279126504804, 6021.729022194012, 6031.547633927473, 6196.504279657616, 6499.1876015498065, 6576.473882089422, 6649.6010239385305, 6699.464042876558, 6757.425618822406, 6711.060451536789, 6712.160979877515, 6735.259121496631, 6771.119754431941, 6782.898256526156, 6191.81424557264, 6208.192934918432, 6238.563300568962, 6268.1851359323455, 6288.87422251557, 6772.390484856386, 6872.725090996404, 6920.826979325557, 6948.0272761813385, 6950.0, 6472.126262954535, 6544.181977252843, 6578.440832529289, 6628.734850606018, 6676.165479315086, 6740.528163028541, 6742.6291553965, 6757.831054223684, 6763.0, 6776.627285499345, 6686.331366863372, 6690.866182676416, 6765.52641315113, 6766.966165169143, 6790.287019862942, 6637.568558043712, 6684.799456016327, 6702.463802895757, 6796.490263230277, 6805.3875151236625, 5314.043472174968, 5330.786768529293, 5399.595030372738, 5401.432849550819, 5411.0, 4682.953170468251, 4701.976490117596, 4709.599684026896, 4716.57550820421, 4728.739919304402, 5758.798442054508, 5765.394633563499, 5820.854478638068, 5856.8535786604825, 5872.7357268923, 6675.9332406676285, 6721.66391680414, 6761.594304341756, 6770.119884414995, 6801.693923773442, 5646.97176514123, 5768.105943578752, 5771.134329850556, 5826.73779679907, 5841.065429531254, 5900.350961394243, 5949.494292985059, 5949.553783466171, 5956.761729530857, 5957.851053723605, 6491.0, 6591.736330546724, 6602.86794264112, 6603.669816509251, 6620.801375958729, 6699.095622090956, 6772.9661351694895, 6773.254941956479, 6778.932210678027, 6805.523613347018, 6444.742210311535, 6473.838154045998, 6478.578892371981, 6551.6069035858, 6557.180352455943, 6372.55392122547, 6445.806625801233, 6465.482761378984, 6519.967400162969, 6657.167854018247, 6657.933420665731, 6730.798076057726, 6741.494387921024, 6744.831379215559, 6778.3221677831825, 6505.41451269388, 6585.901211481927, 6588.604683718992, 6597.472202223715, 6604.0, 6501.934980650133, 6510.3489651034515, 6583.111279977142, 6590.670466476753, 6601.33986601336, 6301.0863424804065, 6371.904421433775, 6375.77684781049, 6395.649922320071, 6487.18910136233, 6470.741170353322, 6481.8703625928165, 6498.610083395011, 6566.9343306566325, 6590.637514936533, 6292.402221788922, 6393.584417012879, 6396.680165991775, 6420.582662126947, 6425.710843011982], "value": 6104.7358482386735, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [804.2640983500098, 824.2622852546967, 833.1959658929133, 868.91745284198, 875.3041332140947, 39662.20675586486, 40309.0, 40322.59677403229, 40352.1929561409, 40367.39448908269, 36433.81783091081, 36619.26761464769, 36640.0, 36701.632983670155, 36828.0, 6718.496112791536, 6827.112475378194, 6839.623820689885, 6841.110655614788, 6844.2813504582045, 6782.5252232343755, 7384.778456646282, 7619.80950476237, 7625.084989801232, 7641.61791910405, 7662.731804386847, 7713.807154821118, 7726.343260822809, 7746.38028957682, 7750.224977502261, 7572.924270757305, 7584.355329796974, 7760.883586746203, 7761.805954851174, 7762.883556746653, 7565.432592555525, 7572.697092116308, 7586.62066896653, 7607.391408687292, 7610.619469026582, 36998.63001369979, 37190.0, 37362.0, 37387.439188412194, 37465.81267093674, 3415.197428604276, 3446.052335607703, 3449.120474279068, 3449.5515582974303, 3451.879184228565, 30663.0, 30689.69310306891, 30731.846340768378, 30761.384772304653, 30916.845415773, 4860.716032378176, 5013.0, 5019.64862459628, 5021.046001259749, 5028.522290382408, 191461.0, 191684.0, 192143.0, 192732.0, 193016.0, 47056.0, 47175.76412117918, 47237.0, 47286.52713472821, 47354.76322618365, 49429.0, 49488.25767613489, 49497.25754113691, 49527.0, 49554.75222623864, 15951.20243987796, 16305.836941630432, 16315.265813038443, 16325.102119383311, 16349.264283107288, 13418.0, 13422.395992180376, 13425.798613020812, 13445.596632101053, 13453.865461345456, 14169.858301416854, 14209.0, 14241.145531268157, 14258.42966281337, 14383.856161438462, 5707.486326230659, 5717.142428635738, 5765.164051212634, 5786.189933409326, 5924.229850119543, 982.9705108846603, 992.0, 1007.6775431861734, 1011.9089281964658, 1022.1311884897777, 22189.11243550272, 22418.663720044213, 22457.887710561343, 22532.436689082577, 22658.0, 1115.7489564847845, 1117.636768050387, 1121.966341009771, 1122.590254557097, 1125.0, 11732.12009099304, 11762.529498819951, 11771.764564708657, 11806.645800625995, 11947.522099116111, 225609.0, 225927.0, 226929.0, 227054.0, 227232.0, 48927.75536122368, 49431.25853112206, 50493.74753126211, 53555.19667204995, 53614.0, 1439.4458133618423, 1468.8531146885225, 1477.5271912987955, 1480.4892312152506, 1495.4915328788263, 25622.615660765478, 25745.61228161308, 26278.474430511666, 26508.7349126514, 26650.46699065969, 35886.820565897004, 35894.461583076794, 35937.46093808542, 35949.28101438009, 35953.460698089024, 188936.0, 189165.0, 189228.0, 190087.0, 190106.0, 31437.0, 31447.52828707617, 31493.055208343787, 31494.685053149176, 34080.65919340874, 45096.323555146046, 45227.32159017552, 45909.31136032895, 45938.77030614825, 45992.7700361496, 32837.17907052247, 32845.835770820995, 33550.328993419505, 33685.0, 33815.83092084622, 32593.348133036732, 32691.50962735513, 32985.84549540754, 33219.33561328711, 33348.33303333968, 35748.28503429865, 35907.64092359043, 36083.63916360908, 36287.81856090703, 36385.63614363928, 31999.680003200603, 32126.35747285088, 32450.0, 32740.0, 33071.173220669676, 23660.645090323316, 23979.160729375086, 24141.0, 24399.878000609882, 24724.38189045288], "value": 16969.783466324778, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.1951011278587, 569.6866723302182, 573.197523467146, 578.4909279833747, 578.7655999320275, 22024.669629955562, 22599.661005084916, 22676.54646907063, 22809.08763649456, 23537.529249415045, 26018.21945341638, 26864.462710745822, 26884.0, 26885.327866803338, 26926.46147077062, 6344.841378965528, 6478.838029049288, 6480.675966201695, 6490.0, 6492.448141907944, 5938.0, 6212.65830379329, 6452.580582262161, 6480.092787009822, 6487.3836985486305, 6440.838979025515, 6447.7098530566, 6449.580777249487, 6453.419192272694, 6454.774082907099, 6410.8076757697345, 6456.1284226629505, 6476.417122458978, 6477.0, 6478.384553467413, 5994.940050599482, 6005.069214271794, 6008.128821320884, 6012.699365031731, 6020.066889632114, 29360.706392936012, 29524.96662616798, 30223.395532089457, 30901.072967811, 30943.535846962088, 1902.8858268503934, 1945.7567804024497, 1945.824875761174, 1952.6582848001542, 1952.8437724981968, 19202.711959320623, 19577.510562236057, 20052.799472005237, 20203.292884748964, 20224.0, 2399.9880000599887, 2413.553492603874, 2457.1400009996537, 2460.7662272084303, 2480.057578120303, 137021.31489342588, 140804.0, 141864.58135418617, 141930.0, 141936.0, 14541.182352205975, 15289.235538223043, 15313.923430383, 15408.383664653513, 15453.922730386275, 23640.0, 23657.881710591337, 23734.525309493714, 23736.64395034076, 23758.406039849142, 9997.950010249902, 10092.0, 10111.887692353836, 10138.543765530569, 10276.280660353703, 8499.830003399897, 9104.408213466104, 9159.816803663889, 9241.630334786532, 9287.349885508085, 8146.266835984789, 9357.719268421959, 9504.192143667728, 9589.616415343307, 9612.663556775618, 2776.54187059133, 2799.2581965779086, 2841.786865985059, 2857.157138644105, 2937.3684657798676, 946.2382781860531, 979.9412035277907, 983.6901376066517, 983.9114479696862, 986.2356673577891, 19087.90456047711, 19368.128434220493, 19689.310874119623, 19703.50741231452, 20147.59704805925, 1028.3161697471098, 1028.639976008406, 1029.7528593137592, 1032.9431881246453, 1040.817856875059, 10729.302595331279, 10766.461676916122, 10788.78422431547, 10898.891011089787, 11138.108951283877, 451261.0, 458049.0, 528893.0, 540239.0, 555463.0, 118621.40689296671, 122765.0, 126831.0, 127577.0, 128129.35935320264, 1223.321056813477, 1244.5830646733264, 1279.0407194604047, 1281.3465132782162, 1292.043887523226, 20403.38789836307, 20567.177312907315, 20633.89683051575, 20725.68911466299, 20963.895180524, 57836.71081644565, 58277.4172258272, 58473.415265846794, 61326.386736132066, 61765.07352389628, 75349.62325188339, 75831.0, 75867.0, 76474.61762691151, 76782.0, 14217.21805300677, 14313.0, 14509.274536273355, 14576.271186440848, 14597.708045838812, 22690.0, 22738.0, 22799.65800513027, 22949.770502294763, 22966.311010669706, 17495.30018799234, 17600.119994000506, 17782.199801009243, 17783.911080444515, 18028.188731506852, 16011.439599613957, 16126.113063781135, 16641.83358166403, 16644.750328744838, 17346.47960561185, 18615.44153675392, 18633.440996770118, 18732.625347493245, 18866.905665471586, 18906.0, 14308.856911430752, 14385.784213237019, 14415.855841441871, 14459.060161089496, 14544.41822327095, 18031.819681803016, 18070.096495174927, 18104.81895181084, 18149.727754083437, 18170.36403725916], "value": 12093.519642149062, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1357.321339330335, 1415.1226239731366, 1417.8015077889097, 1423.1603354021127, 1425.9857401425982, 13829.308534573269, 14855.777163342545, 14858.777118343207, 14863.777043344346, 14901.180435076067, 14690.118592884408, 14970.251487425612, 14972.775408368856, 14976.326065327059, 14978.925105374457, 2710.810243282971, 2741.465414244223, 2753.7796976241852, 2755.586662000706, 2756.021612327625, 2610.5170543449426, 2662.773664238542, 2695.1240846724795, 2695.43395886864, 2697.0, 2602.1933200707745, 2660.933476663089, 2661.7870570354326, 2662.241261240547, 2669.346010227497, 2613.8170328077044, 2625.251803236078, 2633.5391306521474, 2636.3277364272085, 2642.2733748219202, 2531.746825317472, 2577.1495406515805, 2589.326775038485, 2593.1313010141434, 2594.3514121469634, 13870.4451821927, 14129.0, 14134.434622615083, 14189.290535473185, 14196.50312239077, 7840.41196910234, 7923.12845586985, 8099.514029158269, 8104.230098140667, 8111.310538604167, 5119.308893299394, 5274.340707411574, 5350.197470379435, 5382.219578161184, 5382.650127741724, 1849.34348306352, 1872.485066606694, 1877.6714075036814, 1914.961700765977, 1920.7791104023077, 23650.76349236503, 23987.760122398726, 24086.759132408628, 24105.758942410528, 24145.0, 6913.965430172918, 7052.92947070533, 7085.0, 7247.60138192394, 7271.490995630361, 18659.253629854655, 18747.906260468884, 18813.059347032595, 18819.90590047041, 18837.623247535248, 7855.842883142305, 7960.203979602109, 7981.9623448952425, 7986.0816006158875, 7987.121416644164, 6932.722691092401, 7139.607321597362, 7142.750003749948, 7228.0, 7268.963655181796, 5430.456954304538, 5615.0, 5637.098064309691, 5650.4349565043985, 5666.206731057655, 1694.3900195929702, 1751.1331890713923, 1757.0863151161325, 1762.7003409420429, 1769.6372243690012, 858.5578427110044, 887.9556022198864, 906.7642412972675, 908.0510866144895, 910.1399177776938, 7175.820604484825, 7258.205068195089, 8486.533240671823, 8559.572021398904, 8674.826503469896, 945.5366870233536, 968.704545113747, 991.3159919655415, 998.8701468809154, 1024.1908891975256, 5004.899902001939, 5031.899362012812, 5123.052235336475, 5238.73806309683, 5258.106121959276, 19551.80448195528, 19833.10751016179, 20291.492712682302, 20294.898525507277, 20318.187272508934, 18973.533440652904, 19466.70799938002, 19876.304329348404, 20171.899140504498, 20266.797332026785, 10408.427536485566, 10692.946535267429, 10744.409057501913, 10817.296875703054, 10818.837717434244, 8015.519068855887, 8299.709510167115, 8314.62584183701, 8441.282490988335, 8578.91421085781, 17105.828941710923, 17207.56981075483, 17671.734923976408, 17984.460466186036, 18027.549311267325, 17108.401205957733, 17342.913285433493, 17497.47507574775, 17636.73544896853, 17893.73159402584, 11483.712907177052, 11543.71140721455, 11661.35862527569, 11665.59170429031, 11693.064554835422, 12997.805032924703, 13039.869601304244, 13126.803097953347, 13155.079144459796, 13159.407826647632, 10829.133669306595, 10873.07578855806, 10964.780704385708, 11012.17408694335, 11028.503717332578, 10413.583456661649, 10559.208059395729, 10631.308964917256, 10715.839262410915, 10907.890921090688, 9291.396059256127, 9336.813263734823, 9354.485503297112, 9403.106704863027, 9493.572789224363, 6599.109120268894, 6606.8678626426245, 6686.933130668631, 6768.2216545097945, 6825.317468253135, 6935.202451718117, 7053.259407762111, 7079.2566780487305, 7101.218865924641, 7159.284071592799], "value": 6558.706145438693, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.92881532177836, 493.63471031436734, 512.8948565544064, 521.2832355511172, 531.6517680919, 6146.723397447115, 6160.414760597741, 6250.124982502453, 6313.905291420632, 6314.8737025259525, 5980.162777211194, 6020.397960203977, 6071.392860713926, 6092.60398074126, 6176.166217560628, 4966.950330496685, 4969.180085285923, 4988.954528643257, 5011.624128190382, 5021.0, 4964.056829202458, 4985.6759310644875, 4987.850364489072, 5001.44984051754, 5017.422996355411, 4804.303376010494, 4936.136176169174, 4974.527419895104, 4977.975110124463, 4981.626378021645, 4911.852644420673, 4945.950540494603, 4953.801847926079, 4975.179095449246, 4976.925346119811, 4436.889077773049, 4464.2187617166865, 4474.753888536129, 4485.372047913294, 4493.865184044484, 6076.453119219292, 6087.147799308101, 6130.976777663361, 6145.555794388315, 6166.691665416712, 5632.7746890124345, 5642.633228840113, 5671.517920976722, 5734.254546908917, 5762.9135562966585, 6485.0, 6511.38141876521, 6518.282988871268, 6556.18047744032, 6568.6058836469965, 4827.51724827518, 4845.3216549683075, 4865.637621465995, 4866.537678920497, 4870.732109733964, 6873.759418420382, 6899.517033807686, 6917.169939607279, 6973.755918542877, 7012.614306213156, 4963.503649635008, 4970.701757894538, 4982.227754698028, 4994.126027945095, 5000.874978125503, 5042.520960508746, 5046.646734728533, 5054.267131265946, 5094.312267843868, 5098.745062746922, 5636.323641163087, 5677.914831277534, 5678.3186017678145, 5693.259876216065, 5712.371639119777, 6500.674966251669, 6520.445762110274, 6551.6069035857045, 6606.8017959461295, 6618.900716489256, 1648.7939007624047, 1674.1712852138269, 1683.8231985641576, 1720.80404119136, 1761.2426656537555, 1170.373849990251, 1172.724409763705, 1190.0776897904193, 1193.844800175989, 1209.2804781155198, 5659.717014149276, 5687.146927960839, 5714.285714285681, 5808.94191058084, 5824.446677565625, 6409.423151916257, 6594.0, 6595.274519802818, 6729.6971636276485, 6741.932580674229, 5704.229928959538, 5713.8285851424525, 5733.827985160452, 5755.0, 5778.3643799182055, 3513.80674062929, 3531.4702794581017, 3550.3254381667402, 3580.6930470378124, 3581.3732596795458, 6424.903626445607, 6425.807225783234, 6474.5791523550815, 6528.608283503005, 6552.508561857784, 6786.864262714718, 6833.428311488386, 6835.7949261522235, 6927.203371612329, 6973.0, 6414.999999999906, 6524.510661700297, 6559.868802623921, 6567.474602031731, 6574.8356291093105, 6739.393454588914, 6743.831404214934, 6746.426553742791, 6811.250762416031, 6825.419839313714, 6642.966785166043, 6706.865862682816, 6707.128073350434, 6719.294474080347, 6763.830904227434, 6387.840303992437, 6445.517530967997, 6518.80578516514, 6521.152250207443, 6534.575252608565, 4912.189488734319, 4915.11527924977, 4918.188498897642, 4921.753912304299, 4964.826231081895, 6714.597124172566, 6755.459563235027, 6777.390034896883, 6781.491388145811, 6886.311368863074, 6428.228612566522, 6479.416852483299, 6494.772682956074, 6507.503274246855, 6581.407673309425, 6547.312532184243, 6562.475001999924, 6588.769393071411, 6591.747567962072, 6593.637349945799, 6166.352532983972, 6253.687315634291, 6462.795716112584, 6520.054592084027, 6523.0, 6477.8704425912165, 6479.514036447191, 6482.50423586913, 6568.6058836469965, 6610.0, 6230.875382492234, 6243.469305109116, 6261.3112557617715, 6407.263164736115, 6425.22897252314], "value": 5037.247110933647, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [880.5773228850156, 906.4833045164255, 913.9543022848858, 915.9633614655414, 924.237504059151, 18709.812901870977, 19732.21071157152, 19846.20615175393, 19954.60090798185, 19980.300689475873, 17704.20331085101, 18218.45344639663, 22412.103515859348, 22504.437389065282, 22594.774052259472, 1037.7924415116988, 1072.0244577434537, 1075.1076606416696, 1077.531273895854, 1082.1288862465713, 970.9271804614647, 1016.9084782369586, 1068.305601359115, 1069.802086613975, 1070.6199299248733, 1122.81473556863, 1127.7067962329813, 1132.30363326554, 1132.898039176474, 1133.167122165208, 1106.6403418888813, 1115.6764538283887, 1116.0903863351423, 1118.5302173087282, 1126.6957921361227, 823.9382046346548, 824.6289169873581, 824.7319621123158, 824.7360844529693, 826.1614461321703, 19146.521336966547, 19161.61676766471, 19203.71194432071, 19243.711344329848, 20342.08460619276, 21489.46276343088, 22332.88833555822, 22366.0, 22798.202062927885, 22902.77097229023, 16825.0, 16879.578010549834, 16888.915555422267, 16919.23863426149, 17056.57358566046, 3658.304922064799, 3681.8159092045557, 3696.0390298522307, 3703.6851867591286, 3714.4056950888, 123128.38435807853, 125728.37135814354, 127098.0, 127601.36199318944, 129442.0, 16549.50351489457, 17099.914500427418, 17133.05768182737, 17154.39959601408, 17191.226394812264, 30363.0, 30989.845050774602, 31020.379592408026, 31114.68885311163, 31543.0, 8808.339374546935, 8837.29301655866, 8874.556272186364, 8875.28997680184, 8875.644974201088, 4236.512801027921, 4248.320268756984, 4261.87214383569, 4365.607095361433, 4369.6722745794195, 5354.544863686552, 5459.617826752169, 5469.589780766459, 5489.149181876815, 5492.80775172867, 1008.7931973945324, 1037.273908264218, 1051.232600201857, 1053.4837929414684, 1059.4014381874217, 706.6360824175554, 717.5622870049266, 718.0772707071388, 727.3671905442299, 738.6712912753881, 11446.511953446, 11521.423928803693, 11904.0, 12502.124851260325, 12576.37118144089, 703.1105651351045, 708.7802781137864, 716.451914285572, 718.3857801579678, 720.045939130654, 5555.611107222537, 5743.827685169452, 5762.855928601818, 5777.884442311214, 5931.525477961753, 107871.0, 108493.45753271184, 108707.0, 111364.44317778522, 114664.42667786774, 86920.56539717388, 99006.0, 101496.49251753694, 105333.0, 105361.47319263508, 89642.0, 89796.0, 89955.99999999869, 91399.0, 92498.53750731338, 13063.934680326538, 13552.593422196955, 13554.186748795104, 13701.931490342484, 13794.448222071005, 39733.00667483336, 40474.59525404826, 40746.0, 40977.38533921934, 41867.0, 51138.0, 51290.74354628203, 51563.0, 52701.7364913173, 54074.72962635162, 18487.722684160017, 18596.907015464836, 18728.812711873252, 18825.24699012079, 18920.7161892569, 21455.678164827226, 21648.89175554112, 21776.45558861041, 21790.237341692966, 21989.780102199413, 19041.532908302175, 19500.804991950467, 19565.8043419564, 19567.60864782725, 19792.505187369854, 18059.277628895223, 18097.18562664657, 18120.365787197385, 18135.637287253918, 18316.450506484827, 18671.439856804318, 19018.23927042903, 19039.333623323117, 19103.904480478064, 19217.0, 12761.744765104831, 12856.357182141042, 12933.805992909925, 12960.287184204959, 13193.099454904812, 14651.120932743643, 14665.120092794466, 14792.704145917236, 14958.40166393332, 15538.300776465312], "value": 9354.532266648564, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1533.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 108.0, 104.0, 113.0, 108.0, 109.0, 114.0, 99.0, 111.0, 112.0], "value": 107.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 119.0, 152.0, 179.0, 124.0, 148.0, 150.0, 116.0, 185.0, 125.0], "value": 144.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 167.0, 163.0, 163.0, 163.0, 161.0, 168.0, 170.0, 166.0, 165.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 75.0, 74.0, 184.0, 81.0, 81.0, 76.0, 82.0, 109.0, 84.0], "value": 92.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 133.0, 79.0, 78.0, 78.0, 124.0, 80.0, 79.0, 129.0], "value": 93.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 114.0, 114.0, 115.0, 117.0, 121.0, 115.0, 113.0, 115.0, 118.0], "value": 115.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 152.0, 157.0, 150.0, 150.0, 151.0, 151.0, 149.0, 150.0, 149.0], "value": 151.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 93.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 58.0, 57.0, 54.0, 62.0, 55.0, 55.0, 60.0], "value": 56.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 54.0, 61.0, 57.0, 55.0, 55.0, 56.0, 55.0], "value": 55.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 76.0, 77.0, 84.0, 75.0, 76.0, 76.0, 75.0, 80.0, 77.0], "value": 77.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 125.0, 120.0, 135.0, 128.0, 119.0, 122.0, 123.0, 119.0, 160.0], "value": 127.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 188.0, 174.0, 183.0, 199.0, 181.0, 181.0, 172.0, 185.0, 180.0], "value": 181.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 68.0, 71.0, 76.0, 67.0, 68.0, 70.0, 69.0, 68.0, 71.0], "value": 70.3, "unit": "score"}]}]} 15:36:36 INFO - Return code: 0 15:36:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:36:36 INFO - # TBPL SUCCESS # 15:36:36 INFO - Running post-action listener: _package_coverage_data 15:36:36 INFO - Running post-action listener: _resource_record_post_action 15:36:36 INFO - [mozharness: 2017-08-20 22:36:36.645212Z] Finished run-tests step (success) 15:36:36 INFO - Running post-run listener: _resource_record_post_run 15:36:36 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 435769344; Read time: 16; Write time: 271468 15:36:36 INFO - TinderboxPrint: CPU usage
13.2% 15:36:36 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 15:36:36 INFO - TinderboxPrint: I/O write bytes / time
435,769,344 / 271,468 15:36:36 INFO - TinderboxPrint: CPU idle
8,259.4 (86.8%) 15:36:36 INFO - TinderboxPrint: CPU user
1,202.1 (12.6%) 15:36:36 INFO - TinderboxPrint: Swap in / out
0 / 0 15:36:36 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106766336; Read time: 0; Write time: 69012 15:36:36 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 15:36:36 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 328384512; Read time: 0; Write time: 202420 15:36:37 INFO - Running post-run listener: _upload_blobber_files 15:36:37 INFO - Blob upload gear active. 15:36:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:36:37 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:36:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:36:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:36:37 INFO - (blobuploader) - INFO - Open directory for files ... 15:36:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:36:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:36:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:36:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:36:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:36:38 INFO - (blobuploader) - INFO - Done attempting. 15:36:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:36:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:36:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:36:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:36:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:36:39 INFO - (blobuploader) - INFO - Done attempting. 15:36:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:36:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:36:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:36:39 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:36:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:36:39 INFO - (blobuploader) - INFO - Done attempting. 15:36:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:36:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:36:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:36:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:36:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:36:46 INFO - (blobuploader) - INFO - Done attempting. 15:36:46 INFO - (blobuploader) - INFO - Iteration through files over. 15:36:46 INFO - Return code: 0 15:36:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:36:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:36:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2d2390a07d48b585b75783fd9d8c6961d2ed47df572ed1af72e22e510ef4d75dd3b67e4d22cb1ff0021daacd4c2c14d5f0d0ce7e1dcea94854ba073e52fd8bfb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f3065b0a4b5fc03919079a26d60c0915b8706eb992b1a1b863eb3972d62910d7426aefad8f30589f031b9b0349f8f1633a9465c790fbec1d351a163a7566a01f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a819e3737d6efbdcd47f949f06a0f07090aa57b29f8900374829c62f0a3b22a0a758e82eefd9a24a3614a431a61c6e17ef00d32496f35ce4e9ed958c25620be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d7ebb73fc9348671dd7f1946c4ba55cf0816ccd0f66d1634997a30a4e70de1e61760006491d39170c9f17cd4580ceeffd586d86323e8eba75479d716c3941533"} 15:36:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:36:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:36:46 INFO - Contents: 15:36:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2d2390a07d48b585b75783fd9d8c6961d2ed47df572ed1af72e22e510ef4d75dd3b67e4d22cb1ff0021daacd4c2c14d5f0d0ce7e1dcea94854ba073e52fd8bfb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f3065b0a4b5fc03919079a26d60c0915b8706eb992b1a1b863eb3972d62910d7426aefad8f30589f031b9b0349f8f1633a9465c790fbec1d351a163a7566a01f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a819e3737d6efbdcd47f949f06a0f07090aa57b29f8900374829c62f0a3b22a0a758e82eefd9a24a3614a431a61c6e17ef00d32496f35ce4e9ed958c25620be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d7ebb73fc9348671dd7f1946c4ba55cf0816ccd0f66d1634997a30a4e70de1e61760006491d39170c9f17cd4580ceeffd586d86323e8eba75479d716c3941533"} 15:36:46 INFO - Running post-run listener: copy_logs_to_upload_dir 15:36:46 INFO - Copying logs to upload dir... 15:36:46 INFO - mkdir: /builds/slave/test/build/upload/logs 15:36:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.170201 ========= master_lag: -0.37 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-20 15:36:46.114317) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-20 15:36:46.118251) ========= 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=db7e7c15f3ca076d53731445000001ba-1503267337.373495-921092190 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2d2390a07d48b585b75783fd9d8c6961d2ed47df572ed1af72e22e510ef4d75dd3b67e4d22cb1ff0021daacd4c2c14d5f0d0ce7e1dcea94854ba073e52fd8bfb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f3065b0a4b5fc03919079a26d60c0915b8706eb992b1a1b863eb3972d62910d7426aefad8f30589f031b9b0349f8f1633a9465c790fbec1d351a163a7566a01f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a819e3737d6efbdcd47f949f06a0f07090aa57b29f8900374829c62f0a3b22a0a758e82eefd9a24a3614a431a61c6e17ef00d32496f35ce4e9ed958c25620be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d7ebb73fc9348671dd7f1946c4ba55cf0816ccd0f66d1634997a30a4e70de1e61760006491d39170c9f17cd4580ceeffd586d86323e8eba75479d716c3941533"} build_url:https://queue.taskcluster.net/v1/task/IloK1kyWQ36ATXk4aJc2wg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011923 build_url: 'https://queue.taskcluster.net/v1/task/IloK1kyWQ36ATXk4aJc2wg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2d2390a07d48b585b75783fd9d8c6961d2ed47df572ed1af72e22e510ef4d75dd3b67e4d22cb1ff0021daacd4c2c14d5f0d0ce7e1dcea94854ba073e52fd8bfb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f3065b0a4b5fc03919079a26d60c0915b8706eb992b1a1b863eb3972d62910d7426aefad8f30589f031b9b0349f8f1633a9465c790fbec1d351a163a7566a01f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a819e3737d6efbdcd47f949f06a0f07090aa57b29f8900374829c62f0a3b22a0a758e82eefd9a24a3614a431a61c6e17ef00d32496f35ce4e9ed958c25620be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d7ebb73fc9348671dd7f1946c4ba55cf0816ccd0f66d1634997a30a4e70de1e61760006491d39170c9f17cd4580ceeffd586d86323e8eba75479d716c3941533"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-20 15:36:46.148648) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 15:36:46.149002) ========= 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=db7e7c15f3ca076d53731445000001ba-1503267337.373495-921092190 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004507 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 15:36:46.231756) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-20 15:36:46.232094) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-20 15:36:46.232440) ========= ========= Total master_lag: -0.20 =========