builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-030 starttime: 1501519702.23 results: success (0) revision: 1be0c1da06076f85c69cd8a9d244e0164ec544d9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-31 09:48:22.230609) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-31 09:48:22.231198) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-31 09:48:22.231524) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-31 09:48:22.247931) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 09:48:22.248368) ========= 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=3836458cccd887f2d2de3cf1000001de-1501519625.521125-1167683589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-31 09:48:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 99.8M=0s 2017-07-31 09:48:22 (99.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.135631 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 09:48:22.398057) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 09:48:22.398434) ========= 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=3836458cccd887f2d2de3cf1000001de-1501519625.521125-1167683589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020562 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 09:48:22.449094) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 10 secs) (at 2017-07-31 09:48:22.449478) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1be0c1da06076f85c69cd8a9d244e0164ec544d9 --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 1be0c1da06076f85c69cd8a9d244e0164ec544d9 --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=3836458cccd887f2d2de3cf1000001de-1501519625.521125-1167683589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-31 09:48:22,477 truncating revision to first 12 chars 2017-07-31 09:48:22,477 Setting DEBUG logging. 2017-07-31 09:48:22,477 attempt 1/10 2017-07-31 09:48:22,477 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1be0c1da0607?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-31 09:48:22,866 attempt 1/10 2017-07-31 09:48:23,426 current task status: no status available at this point. state: STARTED 2017-07-31 09:48:23,426 sleeping for 9.00s (attempt 1/10) 2017-07-31 09:48:32,436 attempt 2/10 2017-07-31 09:48:32,735 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-07-31 09:48:32,994 unpacking tar archive at: mozilla-central-1be0c1da0607/testing/mozharness/ program finished with exit code 0 elapsedTime=10.857661 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 10 secs) (at 2017-07-31 09:48:33.322711) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-31 09:48:33.323516) ========= script_repo_revision: 1be0c1da06076f85c69cd8a9d244e0164ec544d9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-31 09:48:33.324486) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-31 09:48:33.325197) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-31 09:48:33.336009) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-07-31 09:48:33.336329) ========= /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=3836458cccd887f2d2de3cf1000001de-1501519625.521125-1167683589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:48:33 INFO - MultiFileLogger online at 20170731 09:48:33 in /builds/slave/test 09:48:33 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 09:48:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:48:33 INFO - {'append_to_log': False, 09:48:33 INFO - 'base_work_dir': '/builds/slave/test', 09:48:33 INFO - 'blob_upload_branch': 'Firefox', 09:48:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:48:33 INFO - 'branch': 'Firefox', 09:48:33 INFO - 'buildbot_json_path': 'buildprops.json', 09:48:33 INFO - 'code_coverage': False, 09:48:33 INFO - 'config_files': ('talos/linux_config.py',), 09:48:33 INFO - 'default_actions': ('clobber', 09:48:33 INFO - 'read-buildbot-config', 09:48:33 INFO - 'download-and-extract', 09:48:33 INFO - 'populate-webroot', 09:48:33 INFO - 'create-virtualenv', 09:48:33 INFO - 'install', 09:48:33 INFO - 'setup-mitmproxy', 09:48:33 INFO - 'run-tests'), 09:48:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:48:33 INFO - 'disable_ccov_upload': False, 09:48:33 INFO - 'download_minidump_stackwalk': True, 09:48:33 INFO - 'download_symbols': 'ondemand', 09:48:33 INFO - 'enable_stylo': False, 09:48:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:48:33 INFO - 'tooltool.py': '/tools/tooltool.py', 09:48:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:48:33 INFO - '/tools/misc-python/virtualenv.py')}, 09:48:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:48:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:48:33 INFO - 'gecko_profile': False, 09:48:33 INFO - 'gecko_profile_interval': 0, 09:48:33 INFO - 'installer_path': 'installer.exe', 09:48:33 INFO - 'log_level': 'info', 09:48:33 INFO - 'log_name': 'talos', 09:48:33 INFO - 'log_to_console': True, 09:48:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:48:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:48:33 INFO - 'opt_config_files': (), 09:48:33 INFO - 'pip_index': False, 09:48:33 INFO - 'suite': 'dromaeojs-e10s', 09:48:33 INFO - 'system_bits': '32', 09:48:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:48:33 INFO - 'title': 'talos-linux64-ix-030', 09:48:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:48:33 INFO - 'use_talos_json': True, 09:48:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:48:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:48:33 INFO - 'work_dir': 'build'} 09:48:33 INFO - [mozharness: 2017-07-31 16:48:33.471472Z] Running clobber step. 09:48:33 INFO - Running pre-action listener: _resource_record_pre_action 09:48:33 INFO - Running main action method: clobber 09:48:33 INFO - rmtree: /builds/slave/test/build 09:48:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:48:34 INFO - Running post-action listener: _resource_record_post_action 09:48:34 INFO - [mozharness: 2017-07-31 16:48:34.995935Z] Finished clobber step (success) 09:48:34 INFO - [mozharness: 2017-07-31 16:48:34.996038Z] Running read-buildbot-config step. 09:48:34 INFO - Running pre-action listener: _resource_record_pre_action 09:48:34 INFO - Running main action method: read_buildbot_config 09:48:34 INFO - Using buildbot properties: 09:48:34 INFO - { 09:48:34 INFO - "project": "", 09:48:34 INFO - "product": "firefox", 09:48:34 INFO - "who": "dmitchell@mozilla.com", 09:48:34 INFO - "installer_path": "public/build/target.tar.bz2", 09:48:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 09:48:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 09:48:34 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 09:48:34 INFO - "stage_platform": "linux64-stylosequential", 09:48:34 INFO - "basedir": "/builds/slave/test", 09:48:34 INFO - "buildnumber": 161, 09:48:34 INFO - "platform": "ubuntu64_hw_styloseq", 09:48:34 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:48:34 INFO - "slavebuilddir": "test", 09:48:34 INFO - "taskId": "RtJgXTfgRD677Pfh6Fq-cw", 09:48:34 INFO - "branch": "mozilla-central", 09:48:34 INFO - "script_repo_revision": "production", 09:48:34 INFO - "revision": "1be0c1da06076f85c69cd8a9d244e0164ec544d9", 09:48:34 INFO - "slavename": "talos-linux64-ix-030", 09:48:34 INFO - "repo_path": "mozilla-central" 09:48:34 INFO - } 09:48:34 INFO - Finding installer, test and symbols from parent task. 09:48:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RtJgXTfgRD677Pfh6Fq-cw'}, attempt #1 09:48:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RtJgXTfgRD677Pfh6Fq-cw'}, attempt #1 09:48:35 INFO - Task dependencies: GJIFbv4yTaKDTYEmSbl0jw 09:48:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GJIFbv4yTaKDTYEmSbl0jw'}, attempt #1 09:48:36 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/GJIFbv4yTaKDTYEmSbl0jw/artifacts/public/build/target.tar.bz2 09:48:36 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/GJIFbv4yTaKDTYEmSbl0jw/artifacts/public/build/target.test_packages.json 09:48:36 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/GJIFbv4yTaKDTYEmSbl0jw/artifacts/public/build/target.crashreporter-symbols.zip 09:48:36 INFO - Running post-action listener: _resource_record_post_action 09:48:36 INFO - [mozharness: 2017-07-31 16:48:36.416009Z] Finished read-buildbot-config step (success) 09:48:36 INFO - [mozharness: 2017-07-31 16:48:36.416234Z] Running download-and-extract step. 09:48:36 INFO - Running pre-action listener: _resource_record_pre_action 09:48:36 INFO - Running main action method: download_and_extract 09:48:36 INFO - mkdir: /builds/slave/test/build/tests 09:48: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')]} 09:48:36 INFO - trying https://queue.taskcluster.net/v1/task/GJIFbv4yTaKDTYEmSbl0jw/artifacts/public/build/target.test_packages.json 09:48:36 INFO - Downloading https://queue.taskcluster.net/v1/task/GJIFbv4yTaKDTYEmSbl0jw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:48:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GJIFbv4yTaKDTYEmSbl0jw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:48:36 INFO - Downloaded 989 bytes. 09:48:36 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:48:36 INFO - Using the following test package requirements: 09:48:36 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:48:36 INFO - u'common': [u'target.common.tests.zip'], 09:48:36 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:48:36 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:48:36 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:48:36 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:48:36 INFO - u'mozbase': [u'target.common.tests.zip'], 09:48:36 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:48:36 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:48:36 INFO - u'web-platform': [u'target.common.tests.zip', 09:48:36 INFO - u'target.web-platform.tests.tar.gz'], 09:48:36 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:48:36 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:48:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GJIFbv4yTaKDTYEmSbl0jw/artifacts/public/build/target.common.tests.zip 09:48:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GJIFbv4yTaKDTYEmSbl0jw/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:48:36 INFO - Fetch https://queue.taskcluster.net/v1/task/GJIFbv4yTaKDTYEmSbl0jw/artifacts/public/build/target.common.tests.zip into memory 09:48:39 INFO - Content-Length response header: 72396228 09:48:39 INFO - Bytes received: 72396228 09:48:50 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:48:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GJIFbv4yTaKDTYEmSbl0jw/artifacts/public/build/target.common.tests.zip 09:48:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GJIFbv4yTaKDTYEmSbl0jw/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:48:50 INFO - Fetch https://queue.taskcluster.net/v1/task/GJIFbv4yTaKDTYEmSbl0jw/artifacts/public/build/target.common.tests.zip into memory 09:48:51 INFO - Content-Length response header: 72396228 09:48:51 INFO - Bytes received: 72396228 09:49:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GJIFbv4yTaKDTYEmSbl0jw/artifacts/public/build/target.talos.tests.zip 09:49:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GJIFbv4yTaKDTYEmSbl0jw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:49:05 INFO - Fetch https://queue.taskcluster.net/v1/task/GJIFbv4yTaKDTYEmSbl0jw/artifacts/public/build/target.talos.tests.zip into memory 09:49:05 INFO - Content-Length response header: 14496686 09:49:05 INFO - Bytes received: 14496686 09:49:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:06 INFO - trying https://queue.taskcluster.net/v1/task/GJIFbv4yTaKDTYEmSbl0jw/artifacts/public/build/target.tar.bz2 09:49:06 INFO - Downloading https://queue.taskcluster.net/v1/task/GJIFbv4yTaKDTYEmSbl0jw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:49:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GJIFbv4yTaKDTYEmSbl0jw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:49:07 INFO - Downloaded 62275901 bytes. 09:49:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GJIFbv4yTaKDTYEmSbl0jw/artifacts/public/build/target.tar.bz2 09:49:07 INFO - mkdir: /builds/slave/test/properties 09:49:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:49:07 INFO - Writing to file /builds/slave/test/properties/build_url 09:49:07 INFO - Contents: 09:49:07 INFO - build_url:https://queue.taskcluster.net/v1/task/GJIFbv4yTaKDTYEmSbl0jw/artifacts/public/build/target.tar.bz2 09:49:07 INFO - Running post-action listener: _resource_record_post_action 09:49:07 INFO - Running post-action listener: set_extra_try_arguments 09:49:07 INFO - [mozharness: 2017-07-31 16:49:07.250615Z] Finished download-and-extract step (success) 09:49:07 INFO - [mozharness: 2017-07-31 16:49:07.250714Z] Running populate-webroot step. 09:49:07 INFO - Running pre-action listener: _resource_record_pre_action 09:49:07 INFO - Running main action method: populate_webroot 09:49:07 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:49:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:49:07 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:49:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:49:07 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:49:07 INFO - 'tests': ['damp', 'tps']}, 09:49:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:49:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:49:07 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:49:07 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 09:49:07 INFO - 'other-e10s': {'tests': ['a11yr', 09:49:07 INFO - 'ts_paint', 09:49:07 INFO - 'tpaint', 09:49:07 INFO - 'sessionrestore', 09:49:07 INFO - 'sessionrestore_many_windows', 09:49:07 INFO - 'sessionrestore_no_auto_restore', 09:49:07 INFO - 'tabpaint']}, 09:49:07 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 09:49:07 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 09:49:07 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:49:07 INFO - 'talos_options': ['--mitmproxy', 09:49:07 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:49:07 INFO - '--firstNonBlankPaint'], 09:49:07 INFO - 'tests': ['quantum_pageload_google', 09:49:07 INFO - 'quantum_pageload_youtube', 09:49:07 INFO - 'quantum_pageload_amazon', 09:49:07 INFO - 'quantum_pageload_facebook']}, 09:49:07 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:49:07 INFO - 'talos_options': ['--stylo', 09:49:07 INFO - '--mitmproxy', 09:49:07 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:49:07 INFO - '--firstNonBlankPaint'], 09:49:07 INFO - 'tests': ['quantum_pageload_google', 09:49:07 INFO - 'quantum_pageload_youtube', 09:49:07 INFO - 'quantum_pageload_amazon', 09:49:07 INFO - 'quantum_pageload_facebook']}, 09:49:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:49:07 INFO - 'tsvgr_opacity', 09:49:07 INFO - 'tart', 09:49:07 INFO - 'tscrollx', 09:49:07 INFO - 'cart', 09:49:07 INFO - 'tsvg_static']}, 09:49:07 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:49:07 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:49:07 INFO - 'talos_options': ['--stylo', 09:49:07 INFO - '--stylo-threads=1', 09:49:07 INFO - '--mitmproxy', 09:49:07 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:49:07 INFO - '--firstNonBlankPaint'], 09:49:07 INFO - 'tests': ['tp6_google', 09:49:07 INFO - 'tp6_youtube', 09:49:07 INFO - 'tp6_amazon', 09:49:07 INFO - 'tp6_facebook']}, 09:49:07 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:49:07 INFO - 'talos_options': ['--xperf_path', 09:49:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:49:07 INFO - 'tests': ['tp5n']}}} 09:49:07 INFO - Running post-action listener: _resource_record_post_action 09:49:07 INFO - [mozharness: 2017-07-31 16:49:07.259429Z] Finished populate-webroot step (success) 09:49:07 INFO - [mozharness: 2017-07-31 16:49:07.259520Z] Running create-virtualenv step. 09:49:07 INFO - Running pre-action listener: _resource_record_pre_action 09:49:07 INFO - Running main action method: create_virtualenv 09:49:07 INFO - Creating virtualenv /builds/slave/test/build/venv 09:49:07 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 09:49:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:49:07 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 09:49:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:49:07 INFO - Using real prefix '/usr' 09:49:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:49:07 INFO - Installing distribute.............................................................................................................................................................................................done. 09:49:09 INFO - Installing pip.................done. 09:49:09 INFO - Return code: 0 09:49:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:49:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:49:10 INFO - Reading from file tmpfile_stdout 09:49:10 INFO - Output received: 09:49:10 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) 09:49:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:49:10 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')]} 09:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:10 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')]} 09:49:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:10 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 0x20261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2395d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2392eb0>, '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 0x2393db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2394240>, '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': '3836458cccd887f2d2de3cf1000001de-1501519625.521125-1167683589', '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 09:49:10 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 09:49:10 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 09:49:10 INFO - Using env: {'DISPLAY': ':0', 09:49:10 INFO - 'HOME': '/home/cltbld', 09:49:10 INFO - 'LANG': 'en_US.UTF-8', 09:49:10 INFO - 'LANGUAGE': 'en_US:en', 09:49:10 INFO - 'LOGNAME': 'cltbld', 09:49:10 INFO - 'MAIL': '/var/mail/cltbld', 09:49:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:10 INFO - 'MOZ_NO_REMOTE': '1', 09:49:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:10 INFO - 'NO_EM_RESTART': '1', 09:49:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:10 INFO - 'PWD': '/builds/slave/test', 09:49:10 INFO - 'SHELL': '/bin/bash', 09:49:10 INFO - 'SHLVL': '1', 09:49:10 INFO - 'TERM': 'linux', 09:49:10 INFO - 'TMOUT': '86400', 09:49:10 INFO - 'USER': 'cltbld', 09:49:10 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501519625.521125-1167683589', 09:49:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:10 INFO - '_': '/tools/buildbot/bin/python'} 09:49:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:10 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 09:49:10 INFO - Cleaning up... 09:49:10 INFO - Return code: 0 09:49:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:49:10 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')]} 09:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:10 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')]} 09:49:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:10 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 0x20261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2395d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2392eb0>, '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 0x2393db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2394240>, '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': '3836458cccd887f2d2de3cf1000001de-1501519625.521125-1167683589', '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 09:49:10 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 09:49:10 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 09:49:10 INFO - Using env: {'DISPLAY': ':0', 09:49:10 INFO - 'HOME': '/home/cltbld', 09:49:10 INFO - 'LANG': 'en_US.UTF-8', 09:49:10 INFO - 'LANGUAGE': 'en_US:en', 09:49:10 INFO - 'LOGNAME': 'cltbld', 09:49:10 INFO - 'MAIL': '/var/mail/cltbld', 09:49:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:10 INFO - 'MOZ_NO_REMOTE': '1', 09:49:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:10 INFO - 'NO_EM_RESTART': '1', 09:49:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:10 INFO - 'PWD': '/builds/slave/test', 09:49:10 INFO - 'SHELL': '/bin/bash', 09:49:10 INFO - 'SHLVL': '1', 09:49:10 INFO - 'TERM': 'linux', 09:49:10 INFO - 'TMOUT': '86400', 09:49:10 INFO - 'USER': 'cltbld', 09:49:10 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501519625.521125-1167683589', 09:49:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:10 INFO - '_': '/tools/buildbot/bin/python'} 09:49:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:10 INFO - Downloading/unpacking psutil>=3.1.1 09:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:49:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:49:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:49:11 INFO - Installing collected packages: psutil 09:49:11 INFO - Running setup.py install for psutil 09:49:11 INFO - building 'psutil._psutil_linux' extension 09:49:11 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 09:49:11 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 09:49:11 INFO - building 'psutil._psutil_posix' extension 09:49:11 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 09:49:12 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 09:49:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:49:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:49:12 INFO - Successfully installed psutil 09:49:12 INFO - Cleaning up... 09:49:12 INFO - Return code: 0 09:49:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:49:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2395d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2392eb0>, '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 0x2393db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2394240>, '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': '3836458cccd887f2d2de3cf1000001de-1501519625.521125-1167683589', '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 09:49:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:49:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:49:12 INFO - Using env: {'DISPLAY': ':0', 09:49:12 INFO - 'HOME': '/home/cltbld', 09:49:12 INFO - 'LANG': 'en_US.UTF-8', 09:49:12 INFO - 'LANGUAGE': 'en_US:en', 09:49:12 INFO - 'LOGNAME': 'cltbld', 09:49:12 INFO - 'MAIL': '/var/mail/cltbld', 09:49:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:12 INFO - 'MOZ_NO_REMOTE': '1', 09:49:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:12 INFO - 'NO_EM_RESTART': '1', 09:49:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:12 INFO - 'PWD': '/builds/slave/test', 09:49:12 INFO - 'SHELL': '/bin/bash', 09:49:12 INFO - 'SHLVL': '1', 09:49:12 INFO - 'TERM': 'linux', 09:49:12 INFO - 'TMOUT': '86400', 09:49:12 INFO - 'USER': 'cltbld', 09:49:12 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501519625.521125-1167683589', 09:49:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:12 INFO - '_': '/tools/buildbot/bin/python'} 09:49:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:49:12 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 09:49:12 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 09:49:12 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 09:49:12 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 09:49:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:49:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:49:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:49:13 INFO - Installing collected packages: mozsystemmonitor 09:49:13 INFO - Running setup.py install for mozsystemmonitor 09:49:13 INFO - Successfully installed mozsystemmonitor 09:49:13 INFO - Cleaning up... 09:49:13 INFO - Return code: 0 09:49:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:49:13 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')]} 09:49:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:13 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')]} 09:49:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:13 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 0x20261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2395d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2392eb0>, '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 0x2393db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2394240>, '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': '3836458cccd887f2d2de3cf1000001de-1501519625.521125-1167683589', '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 09:49:13 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 09:49:13 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 09:49:13 INFO - Using env: {'DISPLAY': ':0', 09:49:13 INFO - 'HOME': '/home/cltbld', 09:49:13 INFO - 'LANG': 'en_US.UTF-8', 09:49:13 INFO - 'LANGUAGE': 'en_US:en', 09:49:13 INFO - 'LOGNAME': 'cltbld', 09:49:13 INFO - 'MAIL': '/var/mail/cltbld', 09:49:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:13 INFO - 'MOZ_NO_REMOTE': '1', 09:49:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:13 INFO - 'NO_EM_RESTART': '1', 09:49:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:13 INFO - 'PWD': '/builds/slave/test', 09:49:13 INFO - 'SHELL': '/bin/bash', 09:49:13 INFO - 'SHLVL': '1', 09:49:13 INFO - 'TERM': 'linux', 09:49:13 INFO - 'TMOUT': '86400', 09:49:13 INFO - 'USER': 'cltbld', 09:49:13 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501519625.521125-1167683589', 09:49:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:13 INFO - '_': '/tools/buildbot/bin/python'} 09:49:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:13 INFO - Downloading/unpacking jsonschema==2.5.1 09:49:13 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 09:49:13 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 09:49:13 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 09:49:13 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 09:49:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:49:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:49:14 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 09:49:14 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 09:49:14 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 09:49:14 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 09:49:15 INFO - Downloading functools32-3.2.3-2.tar.gz 09:49:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:49:15 INFO - warning: no files found matching '*.txt' 09:49:15 INFO - no previously-included directories found matching 'build' 09:49:15 INFO - no previously-included directories found matching 'dist' 09:49:15 INFO - no previously-included directories found matching '.git*' 09:49:15 INFO - Installing collected packages: jsonschema, functools32 09:49:15 INFO - Running setup.py install for functools32 09:49:15 INFO - warning: no files found matching '*.txt' 09:49:15 INFO - no previously-included directories found matching 'build' 09:49:15 INFO - no previously-included directories found matching 'dist' 09:49:15 INFO - no previously-included directories found matching '.git*' 09:49:15 INFO - Successfully installed jsonschema functools32 09:49:15 INFO - Cleaning up... 09:49:15 INFO - Return code: 0 09:49:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:49:15 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')]} 09:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:15 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')]} 09:49:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:15 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 0x20261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2395d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2392eb0>, '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 0x2393db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2394240>, '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': '3836458cccd887f2d2de3cf1000001de-1501519625.521125-1167683589', '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 09:49:15 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 09:49:15 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 09:49:15 INFO - Using env: {'DISPLAY': ':0', 09:49:15 INFO - 'HOME': '/home/cltbld', 09:49:15 INFO - 'LANG': 'en_US.UTF-8', 09:49:15 INFO - 'LANGUAGE': 'en_US:en', 09:49:15 INFO - 'LOGNAME': 'cltbld', 09:49:15 INFO - 'MAIL': '/var/mail/cltbld', 09:49:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:15 INFO - 'MOZ_NO_REMOTE': '1', 09:49:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:15 INFO - 'NO_EM_RESTART': '1', 09:49:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:15 INFO - 'PWD': '/builds/slave/test', 09:49:15 INFO - 'SHELL': '/bin/bash', 09:49:15 INFO - 'SHLVL': '1', 09:49:15 INFO - 'TERM': 'linux', 09:49:15 INFO - 'TMOUT': '86400', 09:49:15 INFO - 'USER': 'cltbld', 09:49:15 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501519625.521125-1167683589', 09:49:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:15 INFO - '_': '/tools/buildbot/bin/python'} 09:49:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:49:15 INFO - Cleaning up... 09:49:15 INFO - Return code: 0 09:49:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:49:15 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')]} 09:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:15 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')]} 09:49:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:15 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 0x20261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2395d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2392eb0>, '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 0x2393db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2394240>, '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': '3836458cccd887f2d2de3cf1000001de-1501519625.521125-1167683589', '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 09:49:15 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 09:49:15 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 09:49:15 INFO - Using env: {'DISPLAY': ':0', 09:49:15 INFO - 'HOME': '/home/cltbld', 09:49:15 INFO - 'LANG': 'en_US.UTF-8', 09:49:15 INFO - 'LANGUAGE': 'en_US:en', 09:49:15 INFO - 'LOGNAME': 'cltbld', 09:49:15 INFO - 'MAIL': '/var/mail/cltbld', 09:49:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:15 INFO - 'MOZ_NO_REMOTE': '1', 09:49:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:15 INFO - 'NO_EM_RESTART': '1', 09:49:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:15 INFO - 'PWD': '/builds/slave/test', 09:49:15 INFO - 'SHELL': '/bin/bash', 09:49:15 INFO - 'SHLVL': '1', 09:49:15 INFO - 'TERM': 'linux', 09:49:15 INFO - 'TMOUT': '86400', 09:49:15 INFO - 'USER': 'cltbld', 09:49:15 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501519625.521125-1167683589', 09:49:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:15 INFO - '_': '/tools/buildbot/bin/python'} 09:49:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:15 INFO - Downloading/unpacking blobuploader==1.2.4 09:49:15 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 09:49:15 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 09:49:15 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 09:49:15 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 09:49:16 INFO - Downloading blobuploader-1.2.4.tar.gz 09:49:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:49:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:49:16 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 09:49:16 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 09:49:16 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 09:49:16 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 09:49:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:49:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:49:17 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 09:49:17 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 09:49:17 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 09:49:17 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 09:49:17 INFO - Downloading docopt-0.6.1.tar.gz 09:49:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:49:17 INFO - Installing collected packages: blobuploader, requests, docopt 09:49:17 INFO - Running setup.py install for blobuploader 09:49:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:49:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:49:17 INFO - Running setup.py install for requests 09:49:17 INFO - Running setup.py install for docopt 09:49:18 INFO - Successfully installed blobuploader requests docopt 09:49:18 INFO - Cleaning up... 09:49:18 INFO - Return code: 0 09:49:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:49:18 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')]} 09:49:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:18 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')]} 09:49:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:18 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 0x20261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2395d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2392eb0>, '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 0x2393db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2394240>, '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': '3836458cccd887f2d2de3cf1000001de-1501519625.521125-1167683589', '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 09:49:18 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 09:49:18 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 09:49:18 INFO - Using env: {'DISPLAY': ':0', 09:49:18 INFO - 'HOME': '/home/cltbld', 09:49:18 INFO - 'LANG': 'en_US.UTF-8', 09:49:18 INFO - 'LANGUAGE': 'en_US:en', 09:49:18 INFO - 'LOGNAME': 'cltbld', 09:49:18 INFO - 'MAIL': '/var/mail/cltbld', 09:49:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:18 INFO - 'MOZ_NO_REMOTE': '1', 09:49:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:18 INFO - 'NO_EM_RESTART': '1', 09:49:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:18 INFO - 'PWD': '/builds/slave/test', 09:49:18 INFO - 'SHELL': '/bin/bash', 09:49:18 INFO - 'SHLVL': '1', 09:49:18 INFO - 'TERM': 'linux', 09:49:18 INFO - 'TMOUT': '86400', 09:49:18 INFO - 'USER': 'cltbld', 09:49:18 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501519625.521125-1167683589', 09:49:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:18 INFO - '_': '/tools/buildbot/bin/python'} 09:49:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:49:18 INFO - Running setup.py (path:/tmp/pip-0auzRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:49:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:49:18 INFO - Running setup.py (path:/tmp/pip-UA_Db5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:49:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:49:18 INFO - Running setup.py (path:/tmp/pip-l3BZbo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:49:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:49:18 INFO - Running setup.py (path:/tmp/pip-Nipkq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:49:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:49:18 INFO - Running setup.py (path:/tmp/pip-1QdZjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:49:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:49:18 INFO - Running setup.py (path:/tmp/pip-rkXWPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:49:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:49:18 INFO - Running setup.py (path:/tmp/pip-59lNW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:49:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:49:18 INFO - Running setup.py (path:/tmp/pip-lew2cX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:49:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:49:18 INFO - Running setup.py (path:/tmp/pip-3GnMzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:49:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:49:18 INFO - Running setup.py (path:/tmp/pip-KimG8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:49:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:49:19 INFO - Running setup.py (path:/tmp/pip-eu3iTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:49:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:49:19 INFO - Running setup.py (path:/tmp/pip-pBekhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:49:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:49:19 INFO - Running setup.py (path:/tmp/pip-lFvj9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:49:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:49:19 INFO - Running setup.py (path:/tmp/pip-k82MCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:49:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:49:19 INFO - Running setup.py (path:/tmp/pip-Njrd3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:49:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:49:19 INFO - Running setup.py (path:/tmp/pip-oVHHTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:49:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:49:19 INFO - Running setup.py (path:/tmp/pip-BZQgQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:49:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:49:19 INFO - Running setup.py install for manifestparser 09:49:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:49:19 INFO - Running setup.py install for mozcrash 09:49:19 INFO - Running setup.py install for mozdebug 09:49:19 INFO - Running setup.py install for mozdevice 09:49:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:49:19 INFO - Running setup.py install for mozfile 09:49:20 INFO - Running setup.py install for mozhttpd 09:49:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:49:20 INFO - Running setup.py install for mozinfo 09:49:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:49:20 INFO - Running setup.py install for mozInstall 09:49:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:49:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:49:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:49:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:49:20 INFO - Running setup.py install for mozleak 09:49:20 INFO - Running setup.py install for mozlog 09:49:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:49:20 INFO - Running setup.py install for moznetwork 09:49:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:49:20 INFO - Running setup.py install for mozprocess 09:49:20 INFO - Running setup.py install for mozprofile 09:49:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:49:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:49:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:49:20 INFO - Running setup.py install for mozrunner 09:49:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:49:20 INFO - Running setup.py install for mozscreenshot 09:49:21 INFO - Running setup.py install for moztest 09:49:21 INFO - Running setup.py install for mozversion 09:49:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:49:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:49:21 INFO - Cleaning up... 09:49:21 INFO - Return code: 0 09:49:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:49:21 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')]} 09:49:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:21 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')]} 09:49:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:21 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 0x20261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2395d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2392eb0>, '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 0x2393db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2394240>, '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': '3836458cccd887f2d2de3cf1000001de-1501519625.521125-1167683589', '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 09:49:21 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 09:49:21 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 09:49:21 INFO - Using env: {'DISPLAY': ':0', 09:49:21 INFO - 'HOME': '/home/cltbld', 09:49:21 INFO - 'LANG': 'en_US.UTF-8', 09:49:21 INFO - 'LANGUAGE': 'en_US:en', 09:49:21 INFO - 'LOGNAME': 'cltbld', 09:49:21 INFO - 'MAIL': '/var/mail/cltbld', 09:49:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:21 INFO - 'MOZ_NO_REMOTE': '1', 09:49:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:21 INFO - 'NO_EM_RESTART': '1', 09:49:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:21 INFO - 'PWD': '/builds/slave/test', 09:49:21 INFO - 'SHELL': '/bin/bash', 09:49:21 INFO - 'SHLVL': '1', 09:49:21 INFO - 'TERM': 'linux', 09:49:21 INFO - 'TMOUT': '86400', 09:49:21 INFO - 'USER': 'cltbld', 09:49:21 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501519625.521125-1167683589', 09:49:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:21 INFO - '_': '/tools/buildbot/bin/python'} 09:49:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:49:21 INFO - Running setup.py (path:/tmp/pip-PUOdbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:49:21 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)) 09:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:49:21 INFO - Running setup.py (path:/tmp/pip-fbEuCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:49:21 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)) 09:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:49:21 INFO - Running setup.py (path:/tmp/pip-aWXn1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:49:21 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)) 09:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:49:21 INFO - Running setup.py (path:/tmp/pip-cobwag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:49:21 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)) 09:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:49:21 INFO - Running setup.py (path:/tmp/pip-iSBWJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:49:21 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)) 09:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:49:21 INFO - Running setup.py (path:/tmp/pip-Kc3sSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:49:21 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)) 09:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:49:21 INFO - Running setup.py (path:/tmp/pip-fyh5Va-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:49:22 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)) 09:49:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:49:22 INFO - Running setup.py (path:/tmp/pip-Z5kkzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:49:22 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)) 09:49:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:49:22 INFO - Running setup.py (path:/tmp/pip-QTOVED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:49:22 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)) 09:49:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:49:22 INFO - Running setup.py (path:/tmp/pip-CFNKO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:49:22 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)) 09:49:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:49:22 INFO - Running setup.py (path:/tmp/pip-KPnLMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:49:22 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)) 09:49:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:49:22 INFO - Running setup.py (path:/tmp/pip-0PTbat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:49:22 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)) 09:49:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:49:22 INFO - Running setup.py (path:/tmp/pip-NK5Szq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:49:22 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)) 09:49:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:49:22 INFO - Running setup.py (path:/tmp/pip-jgFTvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:49:22 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)) 09:49:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:49:22 INFO - Running setup.py (path:/tmp/pip-71sIaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:49:22 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)) 09:49:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:49:22 INFO - Running setup.py (path:/tmp/pip-exILgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:49:22 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)) 09:49:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:49:22 INFO - Running setup.py (path:/tmp/pip-c2c7UH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:49:22 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)) 09:49:22 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)) 09:49:22 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)) 09:49:22 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)) 09:49:22 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)) 09:49:22 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)) 09:49:22 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)) 09:49:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:49:22 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 09:49:22 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 09:49:22 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 09:49:22 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 09:49:23 INFO - Downloading blessings-1.6.tar.gz 09:49:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:49:23 INFO - Installing collected packages: blessings 09:49:23 INFO - Running setup.py install for blessings 09:49:24 INFO - Successfully installed blessings 09:49:24 INFO - Cleaning up... 09:49:24 INFO - Return code: 0 09:49:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:49:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:49:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:49:24 INFO - Reading from file tmpfile_stdout 09:49:24 INFO - Current package versions: 09:49:24 INFO - argparse == 1.2.1 09:49:24 INFO - blessings == 1.6 09:49:24 INFO - blobuploader == 1.2.4 09:49:24 INFO - docopt == 0.6.1 09:49:24 INFO - functools32 == 3.2.3-2 09:49:24 INFO - jsonschema == 2.5.1 09:49:24 INFO - manifestparser == 1.1 09:49:24 INFO - mozInstall == 1.13 09:49:24 INFO - mozcrash == 1.0 09:49:24 INFO - mozdebug == 0.1 09:49:24 INFO - mozdevice == 0.51 09:49:24 INFO - mozfile == 1.2 09:49:24 INFO - mozhttpd == 0.7 09:49:24 INFO - mozinfo == 0.10 09:49:24 INFO - mozleak == 0.1 09:49:24 INFO - mozlog == 3.5 09:49:24 INFO - moznetwork == 0.27 09:49:24 INFO - mozprocess == 0.25 09:49:24 INFO - mozprofile == 0.28 09:49:24 INFO - mozrunner == 6.13 09:49:24 INFO - mozscreenshot == 0.1 09:49:24 INFO - mozsystemmonitor == 0.3 09:49:24 INFO - moztest == 0.8 09:49:24 INFO - mozversion == 1.4 09:49:24 INFO - psutil == 3.1.1 09:49:24 INFO - requests == 1.2.3 09:49:24 INFO - wsgiref == 0.1.2 09:49:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:49:24 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')]} 09:49:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:24 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')]} 09:49:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:24 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 0x20261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2395d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2392eb0>, '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 0x2393db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2394240>, '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': '3836458cccd887f2d2de3cf1000001de-1501519625.521125-1167683589', '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 09:49:24 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 09:49:24 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 09:49:24 INFO - Using env: {'DISPLAY': ':0', 09:49:24 INFO - 'HOME': '/home/cltbld', 09:49:24 INFO - 'LANG': 'en_US.UTF-8', 09:49:24 INFO - 'LANGUAGE': 'en_US:en', 09:49:24 INFO - 'LOGNAME': 'cltbld', 09:49:24 INFO - 'MAIL': '/var/mail/cltbld', 09:49:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:24 INFO - 'MOZ_NO_REMOTE': '1', 09:49:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:24 INFO - 'NO_EM_RESTART': '1', 09:49:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:24 INFO - 'PWD': '/builds/slave/test', 09:49:24 INFO - 'SHELL': '/bin/bash', 09:49:24 INFO - 'SHLVL': '1', 09:49:24 INFO - 'TERM': 'linux', 09:49:24 INFO - 'TMOUT': '86400', 09:49:24 INFO - 'USER': 'cltbld', 09:49:24 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501519625.521125-1167683589', 09:49:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:24 INFO - '_': '/tools/buildbot/bin/python'} 09:49:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:24 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)) 09:49:24 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)) 09:49:24 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)) 09:49:24 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)) 09:49:24 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)) 09:49:24 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)) 09:49:24 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)) 09:49:24 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)) 09:49:24 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)) 09:49:24 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:49:24 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 09:49:24 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 09:49:24 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 09:49:24 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 09:49:25 INFO - Downloading marionette_driver-1.4.0.tar.gz 09:49:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 09:49:25 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 09:49:25 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 09:49:25 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 09:49:25 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 09:49:25 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 09:49:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 09:49:25 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)) 09:49:25 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)) 09:49:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:49:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:49:25 INFO - Installing collected packages: marionette-driver, simplejson 09:49:25 INFO - Running setup.py install for marionette-driver 09:49:26 INFO - Running setup.py install for simplejson 09:49:26 INFO - building 'simplejson._speedups' extension 09:49:26 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 09:49:26 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 09:49:27 INFO - Successfully installed marionette-driver simplejson 09:49:27 INFO - Cleaning up... 09:49:27 INFO - Return code: 0 09:49:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:49: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')]} 09:49:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49: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')]} 09:49:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2395d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2392eb0>, '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 0x2393db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2394240>, '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': '3836458cccd887f2d2de3cf1000001de-1501519625.521125-1167683589', '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 09:49: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', 'jsonschema'] in /builds/slave/test/build 09:49: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 jsonschema 09:49:27 INFO - Using env: {'DISPLAY': ':0', 09:49:27 INFO - 'HOME': '/home/cltbld', 09:49:27 INFO - 'LANG': 'en_US.UTF-8', 09:49:27 INFO - 'LANGUAGE': 'en_US:en', 09:49:27 INFO - 'LOGNAME': 'cltbld', 09:49:27 INFO - 'MAIL': '/var/mail/cltbld', 09:49:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:27 INFO - 'MOZ_NO_REMOTE': '1', 09:49:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:27 INFO - 'NO_EM_RESTART': '1', 09:49:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:27 INFO - 'PWD': '/builds/slave/test', 09:49:27 INFO - 'SHELL': '/bin/bash', 09:49:27 INFO - 'SHLVL': '1', 09:49:27 INFO - 'TERM': 'linux', 09:49:27 INFO - 'TMOUT': '86400', 09:49:27 INFO - 'USER': 'cltbld', 09:49:27 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501519625.521125-1167683589', 09:49:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:27 INFO - '_': '/tools/buildbot/bin/python'} 09:49:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:49:27 INFO - Cleaning up... 09:49:27 INFO - Return code: 0 09:49:27 INFO - Running post-action listener: _resource_record_post_action 09:49:27 INFO - Running post-action listener: _start_resource_monitoring 09:49:27 INFO - Starting resource monitoring. 09:49:27 INFO - [mozharness: 2017-07-31 16:49:27.342303Z] Finished create-virtualenv step (success) 09:49:27 INFO - [mozharness: 2017-07-31 16:49:27.342812Z] Running install step. 09:49:27 INFO - Running pre-action listener: _resource_record_pre_action 09:49:27 INFO - Running main action method: install 09:49:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:49:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:49:27 INFO - Reading from file tmpfile_stdout 09:49:27 INFO - Detecting whether we're running mozinstall >=1.0... 09:49:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:49:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:49:27 INFO - Reading from file tmpfile_stdout 09:49:27 INFO - Output received: 09:49:27 INFO - Usage: mozinstall [options] installer 09:49:27 INFO - Options: 09:49:27 INFO - -h, --help show this help message and exit 09:49:27 INFO - -d DEST, --destination=DEST 09:49:27 INFO - Directory to install application into. [default: 09:49:27 INFO - "/builds/slave/test"] 09:49:27 INFO - --app=APP Application being installed. [default: firefox] 09:49:27 INFO - mkdir: /builds/slave/test/build/application 09:49:27 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'] 09:49:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:49:45 INFO - Reading from file tmpfile_stdout 09:49:45 INFO - Output received: 09:49:45 INFO - /builds/slave/test/build/application/firefox/firefox 09:49:45 INFO - Running post-action listener: _resource_record_post_action 09:49:45 INFO - [mozharness: 2017-07-31 16:49:45.802571Z] Finished install step (success) 09:49:45 INFO - [mozharness: 2017-07-31 16:49:45.802829Z] Running setup-mitmproxy step. 09:49:45 INFO - Running pre-action listener: _resource_record_pre_action 09:49:45 INFO - Running main action method: setup_mitmproxy 09:49:45 INFO - Skipping: mitmproxy is not required 09:49:45 INFO - Running post-action listener: _resource_record_post_action 09:49:45 INFO - [mozharness: 2017-07-31 16:49:45.803978Z] Finished setup-mitmproxy step (success) 09:49:45 INFO - [mozharness: 2017-07-31 16:49:45.804202Z] Running run-tests step. 09:49:45 INFO - Running pre-action listener: _resource_record_pre_action 09:49:45 INFO - Running pre-action listener: _set_gcov_prefix 09:49:45 INFO - Running main action method: run_tests 09:49:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:49:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:49:45 INFO - Python 2.7.3 09:49:45 INFO - Return code: 0 09:49:45 INFO - grabbing minidump binary from tooltool 09:49:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:45 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 0x2392eb0>, '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 0x2393db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2394240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:49:45 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 09:49:45 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 09:49:45 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 09:49:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:49:45 INFO - Return code: 0 09:49:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:49:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:49:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:49:45 INFO - ENV: RUST_BACKTRACE is now 1 09:49:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:49:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:49:45 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/GJIFbv4yTaKDTYEmSbl0jw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 09:49:45 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/GJIFbv4yTaKDTYEmSbl0jw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-030 --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 09:49:45 INFO - Using env: {'DISPLAY': ':0', 09:49:45 INFO - 'HOME': '/home/cltbld', 09:49:45 INFO - 'LANG': 'en_US.UTF-8', 09:49:45 INFO - 'LANGUAGE': 'en_US:en', 09:49:45 INFO - 'LOGNAME': 'cltbld', 09:49:45 INFO - 'MAIL': '/var/mail/cltbld', 09:49:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:49:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:49:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:45 INFO - 'MOZ_NO_REMOTE': '1', 09:49:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:49:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:45 INFO - 'NO_EM_RESTART': '1', 09:49:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:45 INFO - 'PWD': '/builds/slave/test', 09:49:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:49:45 INFO - 'RUST_BACKTRACE': '1', 09:49:45 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:49:45 INFO - 'SHELL': '/bin/bash', 09:49:45 INFO - 'SHLVL': '1', 09:49:45 INFO - 'STYLO_FORCE_ENABLED': '1', 09:49:45 INFO - 'TERM': 'linux', 09:49:45 INFO - 'TMOUT': '86400', 09:49:45 INFO - 'USER': 'cltbld', 09:49:45 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501519625.521125-1167683589', 09:49:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:45 INFO - '_': '/tools/buildbot/bin/python'} 09:49:45 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/GJIFbv4yTaKDTYEmSbl0jw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 09:49:46 INFO - mozversion application_buildid: 20170731160448 09:49:46 INFO - mozversion application_changeset: 1be0c1da06076f85c69cd8a9d244e0164ec544d9 09:49:46 INFO - mozversion application_display_name: Nightly 09:49:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:49:46 INFO - mozversion application_name: Firefox 09:49:46 INFO - mozversion application_remotingname: firefox 09:49:46 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:49:46 INFO - mozversion application_vendor: Mozilla 09:49:46 INFO - mozversion application_version: 56.0a1 09:49:46 INFO - mozversion platform_buildid: 20170731160448 09:49:46 INFO - mozversion platform_changeset: 1be0c1da06076f85c69cd8a9d244e0164ec544d9 09:49:46 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:49:46 INFO - mozversion platform_version: 56.0a1 09:49:46 INFO - using testdate: 1501519786 09:49:46 INFO - actual date: 1501519786 09:49:46 INFO - starting webserver on 'localhost:46617' 09:49:46 INFO - SUITE-START | Running 2 tests 09:49:46 INFO - TEST-START | dromaeo_css 09:49:46 INFO - Initialising browser for dromaeo_css test... 09:49:46 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46617/getInfo.html -profile /tmp/tmpjkiLwF/profile 09:49:46 INFO - TEST-INFO | started process 12252 (/builds/slave/test/build/application/firefox/firefox http://localhost:46617/getInfo.html) 09:49:52 INFO - TEST-INFO | 12252: exit 0 09:49:52 INFO - Browser initialized. 09:49:52 INFO - Running cycle 1/1 for dromaeo_css test... 09:49:52 INFO - TEST-INFO | started process 12474 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjkiLwF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:49:53 INFO - PID 12474 | 09:49:53 INFO - PID 12474 | (/builds/slave/test/build/application/firefox/firefox:12528): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 09:49:53 INFO - PID 12474 | 09:50:04 INFO - PID 12474 | RSS: Main: 173158400 09:50:04 INFO - PID 12474 | 09:53:04 INFO - PID 12474 | Cycle 1(1): loaded http://localhost:46617/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46617/tests/dromaeo/cssquery-ext.html) 09:53:05 INFO - PID 12474 | RSS: Main: 175206400 09:53:05 INFO - PID 12474 | 09:56:07 INFO - PID 12474 | Cycle 1(1): loaded http://localhost:46617/tests/dromaeo/cssquery-ext.html (next: http://localhost:46617/tests/dromaeo/cssquery-jquery.html) 09:56:07 INFO - PID 12474 | RSS: Main: 172572672 09:56:07 INFO - PID 12474 | 09:59:09 INFO - PID 12474 | Cycle 1(1): loaded http://localhost:46617/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46617/tests/dromaeo/cssquery-mootools.html) 09:59:10 INFO - PID 12474 | RSS: Main: 175157248 09:59:10 INFO - PID 12474 | 10:02:12 INFO - PID 12474 | Cycle 1(1): loaded http://localhost:46617/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46617/tests/dromaeo/cssquery-prototype.html) 10:02:12 INFO - PID 12474 | RSS: Main: 173518848 10:02:12 INFO - PID 12474 | 10:05:16 INFO - PID 12474 | Cycle 1(1): loaded http://localhost:46617/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46617/tests/dromaeo/cssquery-yui.html) 10:05:17 INFO - PID 12474 | RSS: Main: 177053696 10:05:17 INFO - PID 12474 | 10:08:19 INFO - PID 12474 | Cycle 1(1): loaded http://localhost:46617/tests/dromaeo/cssquery-yui.html (next: http://localhost:46617/tests/dromaeo/cssquery-dojo.html) 10:08:19 INFO - PID 12474 | RSS: Main: 177405952 10:08:19 INFO - PID 12474 | 10:08:19 INFO - PID 12474 | __start_tp_report 10:08:19 INFO - PID 12474 | _x_x_mozilla_page_load 10:08:19 INFO - PID 12474 | _x_x_mozilla_page_load_details 10:08:19 INFO - PID 12474 | |i|pagename|runs| 10:08:19 INFO - PID 12474 | |0;dojo.html;3119.3449375631117;3144.2768163322435;3149.5275708643717;3166.335069635376;3187.7768556201077;6043.335233124359;6104.42008009239;6118.724657390417;6122.724477398517;6277.466415354689;6188.8143355699285;6203.565750397474;6265.718042688079;6266.279377871546;6275.560710750249;5594.356648985368;5683.545316374701;5684.090545512719;5717.3139223293265;5731.742071606787;5498.367687715924;5539.446055394448;5589.552835773128;5605.523530499912;5705.286839145107;5571.637843540157;5642.802501912434;5675.2054712340305;5694.174344720013;5723.856903577403;5607.831765047055;5631.493165615114;5689.061304884731;5701.087825947829;5707.286589176353;5492.258545096441;5587.776488940438;5601.495865372136;5633.80281690143;5634.267545219095;6117.938820611781;6126.019836826086;6138.294096178952;6148.907766383508;6153.230846144232;6521.608703477807;6522.054302126166;6596.93403065968;6598.274189839114;6623.834404139887;6666.733330666768;6668.366505182;6764.255931847493;6771.72913083476;6776.491763117786;6018.969905150446;6092.116643086772;6127.2953610334935;6193.4425901669065;6199.504039676815;6762.053312536249;6800.863982720318;6834.965825170942;6851.2806155353965;6862.725490980305;6402.551821372459;6440.935590644127;6516.055172000033;6529.771457998947;6548.083268342436;6552.63960482178;6584.374484423972;6616.536842420985;6622.139121914121;6678.465722742169;6538.673066346663;6550.803475895731;6565.080888675589;6571.2771595124495;6595.307492713292;6591.472682185414;6645.401913827779;6648.700808463631;6666.699998500079;6677.699503522354;5305.708186049805;5330.8933821324135;5393.2449457076045;5399;5408.5402740766685;4550.47669518003;4573.245414506636;4636.188666983265;4658.743769092733;4667.183242932473;5737.3688894221605;5737.85655358611;5743.54051675865;5772.3938986406665;5777.24895763548;6717.798466046026;6730.562513436611;6741.831454213586;6741.932580674131;6742.662866856637;5693;5784.913226301609;5811.331696854916;5811.912821307684;5837.357890632027;5858.7070646468355;5869.4717475427415;5918.4377484139795;5955.880882382328;5965.135055417027;6389.904151437825;6410.647414392253;6497.090407342976;6521.64130972801;6538.1500404947055;6530.216374035146;6628.07206991012;6673.566218195801;6685.498587606046;6685.6322902240845;6405.455536279282;6417.326180750954;6435.710393032231;6441.227052753699;6501.382368674968;6529.575577587441;6538.150040494896;6553.967230163818;6592.406683398517;6634.767783127568;6611.338866113542;6639.70121344531;6735.158105236846;6738.764143254963;6739.528233023641;6379.840503987438;6398.424141827258;6407.583507072025;6432.742690292336;6477.77327793525;6337.366263373626;6388.968055159695;6393.200849893763;6400.071989561395;6416.358364163546;6298.811035668938;6311.147995020613;6335.018072198816;6349.873002539831;6358.2687990879795;6378.489720822416;6446.774362897464;6452.870942581216;6471.4499267560905;6478.967605161944;6158.969205153946;6169.321374648875;6260.311365749672;6310.11658367838;6378.138951241709 10:08:19 INFO - PID 12474 | |1;ext.html;840.9621567029483;880.1198801198801;900.9504477253753;901.7294811556534;1148.8563929508812;31084.06747797567;41306.58693413069;42235.36646950298;42348.78825605867;42392.15215695684;43385;43691.34462983058;43740;43791.12417751643;43913.34129988045;7631.961840190791;7835.373170146375;7842.686292548291;7849.411294152933;7852.803679907991;7697.461177717562;7807.609619519029;7828.295453409192;7834.099078605947;7835.451518393715;7760.534367937914;7807.375409967218;7816.843663126734;7827.882581761278;7856.135825059239;7725.61371931404;7804.102528209243;7810.0627924649125;7828.804279892991;7846.176151504124;7690.653920573588;7741.7677469676;7772.494787838772;7791.8831217531215;7793.376529877596;39645.60354396448;39881;39918.600813991776;39924.201515969515;39975.600243997476;3489.5812502499607;3530.6998905093096;3531.5938667053106;3535.381308271068;3537.4163263061564;31658.52512212319;31743.84128079368;31753.206169845707;31801.204969875937;31865.76939614228;4859.975700121512;4863.902721945541;4873.805047798084;4906.803727850882;4988.251762235657;182180;182861;182989;183647.99999999866;183712;48370.758146209046;48496.5150348492;48630;49078.26382604264;49098.75450622795;52112.21831672528;52658;52801.471985279655;52806.15178468812;52859.20711189335;12126.333051682243;12226.938865305616;14002.719945601031;14401.711965760625;14558.927205363905;11283.605073822377;11312.377819219857;11316.886831131747;11338.263012904135;11343.149263805248;14563.92718036403;14568.198749068903;14646.853531464549;14665.56003319902;14739.189344586151;5608.186812912105;5716.599838011382;5744.310682718101;5777.19119323295;5854.736536855852;994.2195376629311;999.1257649556638;1005.4872015272117;1015.1779544313357;1025.876894772632;22170.667439988414;22366.552668946857;22383.776162238493;23029.884850575974;23179.420514486934;1088.6570730219955;1088.8747794003632;1098.9780204396027;1120.3110087296254;1122.421952694363;11851;11921.642350729491;11931.701707457209;12233.877661223452;16498.917505412635;230297;231869;233328;233415;233589;60103.69948150231;60161.39838601558;60635.69682151561;60648.39351606427;60743.69628151831;1487.2043456750587;1521.3458212968308;1522.117172040214;1540.7072656195287;1550.8061492313461;27405.451890962468;28017.29956751016;28165.15504534867;28252.86988520436;28664;38683.80658096691;38755.2248955025;39280.41079383869;39284.41073383844;39509.80245098756;219343;220997;221030;221301;221997;32410.35179296448;32525.34949301048;32878;35772.284554308244;36519.08702282464;44344.55655443404;44602.330965034904;44793.552064478936;44959;45072.77463612661;27716.861415692794;27988.30029249285;28013.159605211877;28165.718342816308;28753;25281;26842.731572684803;29868.253293667833;29874.402511949203;29964.550531742476;37972.81013595025;39494.21011579695;39593.208135837696;39654;39662.40506392464;31511;32934.83532582322;34504.65495345015;34561.827190863885;34991.82504087463;23248.302550923498;24126.207533511537;24484.75515244896;24639.876800615883;24699.382515437257 10:08:19 INFO - PID 12474 | |2;jquery.html;555.1949672974189;573.1545969694698;574.6379780738134;577.4052725692535;589.6462122726365;22606.321810345675;22837;23571.175008874692;23677.881610591965;23686.289411317666;26052;26381.076662316776;26469;26472.735272647267;26574.867125664343;6548.377904099115;6729.528932974694;6740.224874139488;6744.4941629377745;6750.797476075701;5921.555883308748;6471.611703297794;6476.967615161918;6556.14770079889;6636.93363066368;6401.487880969535;6464.515161362917;6468.838279043038;6470;6472.093906853044;6357.968210158942;6392.20097487814;6399.552031357807;6440.967795161041;6450.612963222175;5954.434328738763;5968.731407086691;5971;6000.609960352563;6004.459598636144;28679.139625811258;29060;29606;30978.84510577455;31309.530357044663;1891.754071970635;1943.4266891266968;1945.8151475609795;1948.8733232339994;1949.1423773539739;18524;19128.808711912843;19163.520911977314;19239.711404328948;19312.32406865753;2263.9886800566055;2287.085165933623;2323.430759463942;2328.883555822202;2330.6154484510034;138900.5274868126;141713;142393.99999999895;142561.28719356336;142966.28516857454;14348.06737562055;15037.473688420852;15126.848731512764;15152.242387880562;15286.159261240738;22937.655935160987;23116.53766924652;23119;23169.304920852403;23196.884015579813;9475.6683516078;9851.556679949419;9872.001839255114;9890.20878329732;9968.950155249322;9028.18746312835;9043.819123617623;9045.502497362577;9058.5017824019;9148.2681385489;8401.411901166983;9202.35583509148;9216.216621587106;9279.39683920543;9287.349885507949;2677.8259413138085;2763.4473105379006;2763.668359796837;2823.675277343091;2858.2711408591094;926.2533053797406;937.3953799799092;941.1670671455674;971.1745016735719;975.9268054895912;19158.808411915983;19370;19726.506837328896;19799.20803167886;19990.100445479988;969.0793745941384;1007.9496025198711;1009.152312057875;1009.5709323537467;1016.1565900302732;10998.945005275082;12952.093353465167;13274.867251327556;14071.507497237548;14356.49752258666;521713;525660;534109;536317;538574;118831;119551;119732;119973;122465.38767306106;1200.1573650320913;1214.5688280660415;1263.6398626391617;1264.4942023190613;1270.1172684984033;20702.378928632166;20897;20981.370558883256;21317;21586.460338491663;57325.713371432874;58232.708836455546;58781.41218587759;59822.102668459134;60423;71741.6412917932;71854;72454.27545724476;72555;72808.63595681988;12425.875741242833;12900.612981610566;13513.594592162252;14008.859911401163;14362.784558231426;22871;22930.19744309008;23045.07819687194;23397;23404;18261.08694565293;18311.72532411988;18599.628007440046;18641.161147748113;18705.25178992825;14084.22536760488;14934.551963441114;14944.994118867746;15279.236038198267;15337;18003.2798688051;18189.363372281907;18357.173927173575;18383.54041148982;18410.447686569423;14829.777553336493;14841.109533428029;14891.776623350876;14893.85106148968;14898.925505372838;18022.5494362642;18057.367992120213;18121.912685238927;18179.727304090713;18263 10:08:19 INFO - PID 12474 | |3;mootools.html;1337.498438085718;1408.43662534986;1411.675314677624;1413.2933533233384;1414.9929250353746;13510.392032358543;14071.08537945033;14140.363683634236;14174.291285435726;14182.078164919272;14754.114753114794;14954.177520236382;15050.548483545512;15056.322465489053;15072;2603.1019298342044;2655.389260470093;2657.0965871603653;2657.2692509559834;2659.7340265973344;2574.729653386386;2755.2973991632107;2759.4481103779226;2771.9584206236923;2774.9861250693716;2601.7788487978546;2631.5921032240035;2660.3349162709324;2663.4673065386905;2665.7734092602154;2578.200757765099;2595.922122336333;2631.250093723299;2631.2632462910415;2632.1577095329408;2453.460238747473;2497.5504409206337;2498.100683753847;2526.873656317195;2555.731648176933;13987.720245595032;14095.295235238196;14106.92946535271;14112.92943535286;14117.435302587885;7189.964050179716;7549.811254718621;7561.168271490132;7564.394848412114;7566.886496702554;4720.409948756405;4859.514048595112;5019.974900125512;5034.84895453137;5035.345405097314;1604.3582566973187;1645.5310236582516;1665.6335606166624;1687.3503701075051;1698.1678977301158;23032.539349212922;23249.3025209244;23297;23330.300090997127;23330.416739581477;6112.572119951649;6227.470664993526;6309.066284177879;6395.328490508523;6475.093486911836;15681.607959800867;15786.684266314609;15818.130002849724;15863;15928.203589820463;7091.6454177290925;7362.116546014406;7363.190049094595;7376.336129748348;7381.66782494789;6636.104125943032;6696.397324240842;6792.218894827158;6798.626075565891;6819.420349270268;4859.34398856157;5006.674566153189;5030.547250747451;5044.924326135111;5065.366829146356;1427.4361627157214;1451.310627451973;1461.926903654813;1474.402866838932;1477.0546850015999;796.5300472721123;814.3770015937812;816.5917041479261;838.0781140745131;849.8172892827948;7378.926210737931;7471.589062601609;7634.160242373335;7637.579933103621;7657.310842024244;951.414879848888;965.1747755668943;987.7579992901785;992.3103443106971;1005.7083445800782;4355.716878402894;4998.750062496861;5183.14478111115;5252.343457067866;5256;18496.81503184978;18790.154443050094;19410;19417.708734368996;19423.611527769364;18940.337088201846;19299;19367.12847921847;19403.8059619402;19438.222471101;10312.742181445525;10723.46382680863;10980.231383803217;11010.614628487965;11012.39431831241;6975.546589471871;7218.963905180441;7501.774946751606;7571.242875712384;7729.420293478124;15849.762253566436;16276.755848662517;16386.918065409598;16497.91751041237;16746.330146793993;16614.58463538373;16629.66740665156;16716.164191790118;16825;16985.40551080706;11010.559577616805;11143.721406964567;11178.27341222818;11178.72053198644;11208.55165793359;12516;12538.623841284776;12580.811287830507;12592.181508201938;12674.429650665557;9597.712068637951;9711.465869376969;9941.25440591944;10073.949630251802;10274.537645805807;9234.538273086453;9553.904460955302;9586.808263834544;9788.706338809847;9789.412635241908;8624.18070283322;8689.522076285864;8998.685046023358;9004.144606262395;9029.277657787492;5684.77260909559;5863.941360586339;6069.36271691466;6072.544559158169;6083.756649733961;6560.737570497317;6658.167729033871;6804.897926531007;6813.523053386215;6842.110525631835 10:08:19 INFO - PID 12474 | |4;prototype.html;454.2130182070134;477.4270874950059;478.715164477136;480.7235839392349;495.2101398269759;6214.782482613109;6217.5958562693395;6224.533160013006;6228.408301211383;6324.1462402575635;5838.970805145979;6070;6102.755889764404;6108.3280839107665;6124.510039196864;4829.855104346858;4860.173770459013;4879.121758083544;4885.853424397274;4901.387326584177;4783.856484305476;4900.534449227318;4911.45973942866;4942.604591632678;4953.4798846121175;4846.39420072491;4871.658983871131;4877.292792545079;4907.141250281186;4912.97851821131;4858.17411040124;4867.075255701406;4875.317455556225;4881.95118048822;4898;4350.586694264071;4385.429894113745;4402.823887044515;4413.823447062114;4427.22523558376;6053.848653783691;6055.545834062419;6086;6086.726097325631;6092.482139018189;5583.860403489945;5611.130274807411;5613.354464236624;5627.71861406928;5630.15547667849;6348.777792777277;6403.199600049994;6431.22825260967;6485.286618471964;6506.446952009085;4782.378290822171;4784.162771514971;4807.759612019385;4827.106985207748;4827.203511420611;6877.6217308048535;6887.552309099992;6897.862042759117;6899.896501552481;6901.585904845675;4930.852074437773;4933.062718083553;4945.8021679132435;4950.2822090796635;4956.405231372259;4924.72913989734;4951.455339912607;4952.90094198114;5012.473690262543;5028.446870844205;5549.861253468695;5589.217509548666;5604.523615492729;5627.268455100892;5631.324241091095;6459.224893012774;6493.896037673607;6521.902171467432;6529.608223506605;6553.606783593;1653.9338426463048;1671.807742109673;1696.8897021693797;1702.2425020865844;1711.1187738314777;1165.1901928160016;1169.5964892112208;1175.588544009607;1184.1474138620179;1194.3669854976877;5683;5701.971490142523;5705.828825135252;5740.995325817965;5767;6496.512761542903;6618.139641846529;6627.271000189975;6651.16860392451;6661.500387470959;5674.2266392849115;5705.315362156568;5739.483446489836;5753.309602847601;5754.813170994995;3527.206378564854;3537.5401197844117;3567.375709250871;3594.9688426039206;3610.205754733954;6468.514861385415;6484.157059582224;6488.480921526267;6493.740250390026;6560.507961902781;6780.423663988616;6788.7284508619105;6837;6842.452603791685;6890.483213758988;6444.548881578245;6483.675816209171;6492.577982431221;6516.869662606816;6528.988006858945;6630.900536492053;6741.52809303344;6768.390844823989;6782.626955517297;6807.421369183675;6589.110470086669;6610.669466526559;6630.933690663224;6635.23694775107;6758.8648227036165;6399.8720025598295;6460.709268083042;6492.383223593751;6513.250976137805;6540.476761859135;4878;4892.217245240744;4907.190313598359;4913.164761990399;4934.457209707001;6625.238097618642;6802.14973128359;6805;6814.466744982339;6847.931520684929;6397.488200944006;6480.222373315232;6484.416402523795;6506.3493650634555;6506.41442270198;6056.36408177135;6375.362463753588;6420.711068001858;6445.645489497935;6502.837429064311;6287.779927702509;6308.038903236397;6324.7153878076515;6373.681315934277;6440.13058237132;6419.45434638061;6451.387118223761;6571;6585.604863708193;6591.274959754327;6227.813165605039;6245.500359971283;6299.30707622152;6337.841553961188;6343.270523889627 10:08:19 INFO - PID 12474 | |5;yui.html;849.4478588917199;866.0906048648917;871.7907702151485;903.20969151992;912.730744430393;18363.357282495097;19169.904150479262;19170.520736981565;19240.23039078437;22224.333270001927;18093.638127237446;18317.7252341215;18330.35843745466;18374;18381.90809045953;998.981039339873;1006.7332156978388;1028.6913925822223;1039.636127355427;1044.634377967713;1044.7022598559413;1047.659510659035;1052.0268751404958;1052.6210564196883;1052.984205236922;1086.8532748079026;1089.0307626212677;1089.0470838016736;1089.803835309644;1090.4329748530758;1065.3288428290205;1069.1553672598639;1071.7802850415646;1075.0700643943012;1076.6877605494396;795.0737390939606;796.4424902568226;796.7729197178834;799.7320897499345;802.4984384759525;16873.915630421892;16942.3223071077;17142.914285428495;18080.367187148517;20486.692699609517;20065.398038058735;20492.897535512377;20789.79210207909;20930.47673808167;21182.894085529628;15148.545543633709;15298.546638069476;15315.31081101353;15335.539933802003;16188.514344569681;3624.746267761258;3629.3648611493145;3650.890473285779;3651.7991510466913;3653.1962968146963;112597.43701281524;116170.41914790457;118870;119950;121774.39112804379;16056;16713.164341782864;16720.080395578116;16726;16733.414330498374;28422.147335579964;30377.392452151274;30461.390772184433;30502.694973049984;30665.38669226603;8228.42401031934;8295.751127466187;8302.045264794626;8303.626336814857;8404.747857564284;3465;3600.207954250061;3615.837287322077;3961.544422391404;4058.350663893763;5102.719350435687;5190.6366554341585;5239.056969745482;5239.973800130975;5248.816291429858;969.8884628267698;1009.5658866687395;1009.6420314676748;1019.7297716105238;1025.9076683098558;654.6988385342796;675.0717763075771;683.7880257120308;695.1415002471944;698.9231184569693;10931.672049838518;11667;12186.878131218751;12440.81338779919;13022.934885325512;662.6885363878969;682.5120039172016;703.1632357494667;707.1231672725783;723.6417973103347;5154;5282;5484.149956756709;5619.775208991677;5685.0619647758485;100595;101645;103447;103761.48119259506;108034.45982770192;85415;90568;90834.54582727044;92864;95587;70480;75912.24087759163;76576.23423765802;77973;79670.60164699255;11788.823167652321;12732.363381830686;12781.808272875729;13225.206487610774;13272.933635331761;34866.82566587252;35205.82397087998;35484.64515354813;35529.28941421105;35570.644293557765;61034.694826525585;64466;64917.37706557185;68916;69829;18061;19003.23987040558;19160.712589310893;19355.12901919389;19386;20682.896585516977;20749.481262967944;20790.376288711363;21029.474263143544;21204.25785097514;19238.326658566883;19419.70870436973;19728.408147755592;19792.109355078766;20040.59918801645;18599.44201673952;18912.62174756525;19503.804961950198;19645.410637680892;19673.704894426883;17488;17751.201195946473;18762.15570299367;18935.14791834343;18958.620827583094;11871.406429678655;12332.445039973043;12648.241105533698;12778.61664150077;13477.123986940818;13639.931800340935;14071.788923166365;14179.22014289224;14379.352929118424;14492.492762753674 10:08:19 INFO - PID 12474 | __end_tp_report 10:08:19 INFO - PID 12474 | __start_cc_report 10:08:19 INFO - PID 12474 | _x_x_mozilla_cycle_collect,361 10:08:19 INFO - PID 12474 | __end_cc_report 10:08:19 INFO - PID 12474 | __startTimestamp1501520899603__endTimestamp 10:08:19 INFO - PID 12474 | 10:08:19 INFO - PID 12474 | ------- Summary: start ------- 10:08:19 INFO - PID 12474 | Number of tests: 6 10:08:19 INFO - PID 12474 | 10:08:19 INFO - PID 12474 | [#0] dojo.html Cycles:165 Average:6098.16 Median:6337.37 stddev:715.86 (11.3%) stddev-sans-first:678.85 10:08:19 INFO - PID 12474 | Values: 3119.3 3144.3 3149.5 3166.3 3187.8 6043.3 6104.4 6118.7 6122.7 6277.5 6188.8 6203.6 6265.7 6266.3 6275.6 5594.4 5683.5 5684.1 5717.3 5731.7 5498.4 5539.4 5589.6 5605.5 5705.3 5571.6 5642.8 5675.2 5694.2 5723.9 5607.8 5631.5 5689.1 5701.1 5707.3 5492.3 5587.8 5601.5 5633.8 5634.3 6117.9 6126.0 6138.3 6148.9 6153.2 6521.6 6522.1 6596.9 6598.3 6623.8 6666.7 6668.4 6764.3 6771.7 6776.5 6019.0 6092.1 6127.3 6193.4 6199.5 6762.1 6800.9 6835.0 6851.3 6862.7 6402.6 6440.9 6516.1 6529.8 6548.1 6552.6 6584.4 6616.5 6622.1 6678.5 6538.7 6550.8 6565.1 6571.3 6595.3 6591.5 6645.4 6648.7 6666.7 6677.7 5305.7 5330.9 5393.2 5399.0 5408.5 4550.5 4573.2 4636.2 4658.7 4667.2 5737.4 5737.9 5743.5 5772.4 5777.2 6717.8 6730.6 6741.8 6741.9 6742.7 5693.0 5784.9 5811.3 5811.9 5837.4 5858.7 5869.5 5918.4 5955.9 5965.1 6389.9 6410.6 6497.1 6521.6 6538.2 6530.2 6628.1 6673.6 6685.5 6685.6 6405.5 6417.3 6435.7 6441.2 6501.4 6529.6 6538.2 6554.0 6592.4 6634.8 6611.3 6639.7 6735.2 6738.8 6739.5 6379.8 6398.4 6407.6 6432.7 6477.8 6337.4 6389.0 6393.2 6400.1 6416.4 6298.8 6311.1 6335.0 6349.9 6358.3 6378.5 6446.8 6452.9 6471.4 6479.0 6159.0 6169.3 6260.3 6310.1 6378.1 10:08:19 INFO - PID 12474 | 10:08:19 INFO - PID 12474 | [#1] ext.html Cycles:180 Average:38497.12 Median:3533.49 stddev:55403.70 (1568.0%) stddev-sans-first:55486.97 10:08:19 INFO - PID 12474 | Values: 841.0 880.1 901.0 901.7 1148.9 31084.1 41306.6 42235.4 42348.8 42392.2 43385.0 43691.3 43740.0 43791.1 43913.3 7632.0 7835.4 7842.7 7849.4 7852.8 7697.5 7807.6 7828.3 7834.1 7835.5 7760.5 7807.4 7816.8 7827.9 7856.1 7725.6 7804.1 7810.1 7828.8 7846.2 7690.7 7741.8 7772.5 7791.9 7793.4 39645.6 39881.0 39918.6 39924.2 39975.6 3489.6 3530.7 3531.6 3535.4 3537.4 31658.5 31743.8 31753.2 31801.2 31865.8 4860.0 4863.9 4873.8 4906.8 4988.3 182180.0 182861.0 182989.0 183648.0 183712.0 48370.8 48496.5 48630.0 49078.3 49098.8 52112.2 52658.0 52801.5 52806.2 52859.2 12126.3 12226.9 14002.7 14401.7 14558.9 11283.6 11312.4 11316.9 11338.3 11343.1 14563.9 14568.2 14646.9 14665.6 14739.2 5608.2 5716.6 5744.3 5777.2 5854.7 994.2 999.1 1005.5 1015.2 1025.9 22170.7 22366.6 22383.8 23029.9 23179.4 1088.7 1088.9 1099.0 1120.3 1122.4 11851.0 11921.6 11931.7 12233.9 16498.9 230297.0 231869.0 233328.0 233415.0 233589.0 60103.7 60161.4 60635.7 60648.4 60743.7 1487.2 1521.3 1522.1 1540.7 1550.8 27405.5 28017.3 28165.2 28252.9 28664.0 38683.8 38755.2 39280.4 39284.4 39509.8 219343.0 220997.0 221030.0 221301.0 221997.0 32410.4 32525.3 32878.0 35772.3 36519.1 44344.6 44602.3 44793.6 44959.0 45072.8 27716.9 27988.3 28013.2 28165.7 28753.0 25281.0 26842.7 29868.3 29874.4 29964.6 37972.8 39494.2 39593.2 39654.0 39662.4 31511.0 32934.8 34504.7 34561.8 34991.8 23248.3 24126.2 24484.8 24639.9 24699.4 10:08:19 INFO - PID 12474 | 10:08:19 INFO - PID 12474 | [#2] jquery.html Cycles:180 Average:36301.52 Median:12760.16 stddev:89219.89 (699.2%) stddev-sans-first:89429.81 10:08:19 INFO - PID 12474 | Values: 555.2 573.2 574.6 577.4 589.6 22606.3 22837.0 23571.2 23677.9 23686.3 26052.0 26381.1 26469.0 26472.7 26574.9 6548.4 6729.5 6740.2 6744.5 6750.8 5921.6 6471.6 6477.0 6556.1 6636.9 6401.5 6464.5 6468.8 6470.0 6472.1 6358.0 6392.2 6399.6 6441.0 6450.6 5954.4 5968.7 5971.0 6000.6 6004.5 28679.1 29060.0 29606.0 30978.8 31309.5 1891.8 1943.4 1945.8 1948.9 1949.1 18524.0 19128.8 19163.5 19239.7 19312.3 2264.0 2287.1 2323.4 2328.9 2330.6 138900.5 141713.0 142394.0 142561.3 142966.3 14348.1 15037.5 15126.8 15152.2 15286.2 22937.7 23116.5 23119.0 23169.3 23196.9 9475.7 9851.6 9872.0 9890.2 9969.0 9028.2 9043.8 9045.5 9058.5 9148.3 8401.4 9202.4 9216.2 9279.4 9287.3 2677.8 2763.4 2763.7 2823.7 2858.3 926.3 937.4 941.2 971.2 975.9 19158.8 19370.0 19726.5 19799.2 19990.1 969.1 1007.9 1009.2 1009.6 1016.2 10998.9 12952.1 13274.9 14071.5 14356.5 521713.0 525660.0 534109.0 536317.0 538574.0 118831.0 119551.0 119732.0 119973.0 122465.4 1200.2 1214.6 1263.6 1264.5 1270.1 20702.4 20897.0 20981.4 21317.0 21586.5 57325.7 58232.7 58781.4 59822.1 60423.0 71741.6 71854.0 72454.3 72555.0 72808.6 12425.9 12900.6 13513.6 14008.9 14362.8 22871.0 22930.2 23045.1 23397.0 23404.0 18261.1 18311.7 18599.6 18641.2 18705.3 14084.2 14934.6 14945.0 15279.2 15337.0 18003.3 18189.4 18357.2 18383.5 18410.4 14829.8 14841.1 14891.8 14893.9 14898.9 18022.5 18057.4 18121.9 18179.7 18263.0 10:08:19 INFO - PID 12474 | 10:08:19 INFO - PID 12474 | [#3] mootools.html Cycles:180 Average:8512.72 Median:2631.87 stddev:5933.58 (225.5%) stddev-sans-first:5925.74 10:08:19 INFO - PID 12474 | Values: 1337.5 1408.4 1411.7 1413.3 1415.0 13510.4 14071.1 14140.4 14174.3 14182.1 14754.1 14954.2 15050.5 15056.3 15072.0 2603.1 2655.4 2657.1 2657.3 2659.7 2574.7 2755.3 2759.4 2772.0 2775.0 2601.8 2631.6 2660.3 2663.5 2665.8 2578.2 2595.9 2631.3 2631.3 2632.2 2453.5 2497.6 2498.1 2526.9 2555.7 13987.7 14095.3 14106.9 14112.9 14117.4 7190.0 7549.8 7561.2 7564.4 7566.9 4720.4 4859.5 5020.0 5034.8 5035.3 1604.4 1645.5 1665.6 1687.4 1698.2 23032.5 23249.3 23297.0 23330.3 23330.4 6112.6 6227.5 6309.1 6395.3 6475.1 15681.6 15786.7 15818.1 15863.0 15928.2 7091.6 7362.1 7363.2 7376.3 7381.7 6636.1 6696.4 6792.2 6798.6 6819.4 4859.3 5006.7 5030.5 5044.9 5065.4 1427.4 1451.3 1461.9 1474.4 1477.1 796.5 814.4 816.6 838.1 849.8 7378.9 7471.6 7634.2 7637.6 7657.3 951.4 965.2 987.8 992.3 1005.7 4355.7 4998.8 5183.1 5252.3 5256.0 18496.8 18790.2 19410.0 19417.7 19423.6 18940.3 19299.0 19367.1 19403.8 19438.2 10312.7 10723.5 10980.2 11010.6 11012.4 6975.5 7219.0 7501.8 7571.2 7729.4 15849.8 16276.8 16386.9 16497.9 16746.3 16614.6 16629.7 16716.2 16825.0 16985.4 11010.6 11143.7 11178.3 11178.7 11208.6 12516.0 12538.6 12580.8 12592.2 12674.4 9597.7 9711.5 9941.3 10073.9 10274.5 9234.5 9553.9 9586.8 9788.7 9789.4 8624.2 8689.5 8998.7 9004.1 9029.3 5684.8 5863.9 6069.4 6072.5 6083.8 6560.7 6658.2 6804.9 6813.5 6842.1 10:08:19 INFO - PID 12474 | 10:08:19 INFO - PID 12474 | [#4] prototype.html Cycles:180 Average:5455.72 Median:6086.36 stddev:1550.26 (25.5%) stddev-sans-first:1508.47 10:08:19 INFO - PID 12474 | Values: 454.2 477.4 478.7 480.7 495.2 6214.8 6217.6 6224.5 6228.4 6324.1 5839.0 6070.0 6102.8 6108.3 6124.5 4829.9 4860.2 4879.1 4885.9 4901.4 4783.9 4900.5 4911.5 4942.6 4953.5 4846.4 4871.7 4877.3 4907.1 4913.0 4858.2 4867.1 4875.3 4882.0 4898.0 4350.6 4385.4 4402.8 4413.8 4427.2 6053.8 6055.5 6086.0 6086.7 6092.5 5583.9 5611.1 5613.4 5627.7 5630.2 6348.8 6403.2 6431.2 6485.3 6506.4 4782.4 4784.2 4807.8 4827.1 4827.2 6877.6 6887.6 6897.9 6899.9 6901.6 4930.9 4933.1 4945.8 4950.3 4956.4 4924.7 4951.5 4952.9 5012.5 5028.4 5549.9 5589.2 5604.5 5627.3 5631.3 6459.2 6493.9 6521.9 6529.6 6553.6 1653.9 1671.8 1696.9 1702.2 1711.1 1165.2 1169.6 1175.6 1184.1 1194.4 5683.0 5702.0 5705.8 5741.0 5767.0 6496.5 6618.1 6627.3 6651.2 6661.5 5674.2 5705.3 5739.5 5753.3 5754.8 3527.2 3537.5 3567.4 3595.0 3610.2 6468.5 6484.2 6488.5 6493.7 6560.5 6780.4 6788.7 6837.0 6842.5 6890.5 6444.5 6483.7 6492.6 6516.9 6529.0 6630.9 6741.5 6768.4 6782.6 6807.4 6589.1 6610.7 6630.9 6635.2 6758.9 6399.9 6460.7 6492.4 6513.3 6540.5 4878.0 4892.2 4907.2 4913.2 4934.5 6625.2 6802.1 6805.0 6814.5 6847.9 6397.5 6480.2 6484.4 6506.3 6506.4 6056.4 6375.4 6420.7 6445.6 6502.8 6287.8 6308.0 6324.7 6373.7 6440.1 6419.5 6451.4 6571.0 6585.6 6591.3 6227.8 6245.5 6299.3 6337.8 6343.3 10:08:19 INFO - PID 12474 | 10:08:19 INFO - PID 12474 | [#5] yui.html Cycles:180 Average:22549.09 Median:19574.61 stddev:29725.11 (151.9%) stddev-sans-first:29763.83 10:08:19 INFO - PID 12474 | Values: 849.4 866.1 871.8 903.2 912.7 18363.4 19169.9 19170.5 19240.2 22224.3 18093.6 18317.7 18330.4 18374.0 18381.9 999.0 1006.7 1028.7 1039.6 1044.6 1044.7 1047.7 1052.0 1052.6 1053.0 1086.9 1089.0 1089.0 1089.8 1090.4 1065.3 1069.2 1071.8 1075.1 1076.7 795.1 796.4 796.8 799.7 802.5 16873.9 16942.3 17142.9 18080.4 20486.7 20065.4 20492.9 20789.8 20930.5 21182.9 15148.5 15298.5 15315.3 15335.5 16188.5 3624.7 3629.4 3650.9 3651.8 3653.2 112597.4 116170.4 118870.0 119950.0 121774.4 16056.0 16713.2 16720.1 16726.0 16733.4 28422.1 30377.4 30461.4 30502.7 30665.4 8228.4 8295.8 8302.0 8303.6 8404.7 3465.0 3600.2 3615.8 3961.5 4058.4 5102.7 5190.6 5239.1 5240.0 5248.8 969.9 1009.6 1009.6 1019.7 1025.9 654.7 675.1 683.8 695.1 698.9 10931.7 11667.0 12186.9 12440.8 13022.9 662.7 682.5 703.2 707.1 723.6 5154.0 5282.0 5484.1 5619.8 5685.1 100595.0 101645.0 103447.0 103761.5 108034.5 85415.0 90568.0 90834.5 92864.0 95587.0 70480.0 75912.2 76576.2 77973.0 79670.6 11788.8 12732.4 12781.8 13225.2 13272.9 34866.8 35205.8 35484.6 35529.3 35570.6 61034.7 64466.0 64917.4 68916.0 69829.0 18061.0 19003.2 19160.7 19355.1 19386.0 20682.9 20749.5 20790.4 21029.5 21204.3 19238.3 19419.7 19728.4 19792.1 20040.6 18599.4 18912.6 19503.8 19645.4 19673.7 17488.0 17751.2 18762.2 18935.1 18958.6 11871.4 12332.4 12648.2 12778.6 13477.1 13639.9 14071.8 14179.2 14379.4 14492.5 10:08:19 INFO - PID 12474 | -------- Summary: end -------- 10:08:19 INFO - PID 12474 | 10:08:20 INFO - TEST-INFO | 12474: exit 0 10:08:20 INFO - TEST-OK | dromaeo_css | took 1114111ms 10:08:20 INFO - TEST-START | kraken 10:08:20 INFO - Initialising browser for kraken test... 10:08:20 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46617/getInfo.html -profile /tmp/tmpDe83hM/profile 10:08:20 INFO - TEST-INFO | started process 12851 (/builds/slave/test/build/application/firefox/firefox http://localhost:46617/getInfo.html) 10:08:26 INFO - TEST-INFO | 12851: exit 0 10:08:26 INFO - Browser initialized. 10:08:26 INFO - Running cycle 1/1 for kraken test... 10:08:26 INFO - TEST-INFO | started process 13079 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDe83hM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:08:27 INFO - PID 13079 | 10:08:27 INFO - PID 13079 | (/builds/slave/test/build/application/firefox/firefox:13134): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 10:08:27 INFO - PID 13079 | 10:08:37 INFO - PID 13079 | RSS: Main: 173252608 10:08:37 INFO - PID 13079 | 10:08:40 INFO - PID 13079 | Cycle 1(1): loaded http://localhost:46617/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46617/tests/kraken/driver.html?testName=audio-beat-detection) 10:08:41 INFO - PID 13079 | RSS: Main: 178483200 10:08:41 INFO - PID 13079 | 10:08:44 INFO - PID 13079 | Cycle 1(1): loaded http://localhost:46617/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46617/tests/kraken/driver.html?testName=audio-dft) 10:08:44 INFO - PID 13079 | RSS: Main: 178565120 10:08:44 INFO - PID 13079 | 10:08:48 INFO - PID 13079 | Cycle 1(1): loaded http://localhost:46617/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46617/tests/kraken/driver.html?testName=audio-fft) 10:08:48 INFO - PID 13079 | RSS: Main: 173387776 10:08:48 INFO - PID 13079 | 10:08:50 INFO - PID 13079 | Cycle 1(1): loaded http://localhost:46617/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46617/tests/kraken/driver.html?testName=audio-oscillator) 10:08:51 INFO - PID 13079 | RSS: Main: 173748224 10:08:51 INFO - PID 13079 | 10:08:53 INFO - PID 13079 | Cycle 1(1): loaded http://localhost:46617/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46617/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:08:54 INFO - PID 13079 | RSS: Main: 174596096 10:08:54 INFO - PID 13079 | 10:08:57 INFO - PID 13079 | Cycle 1(1): loaded http://localhost:46617/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46617/tests/kraken/driver.html?testName=imaging-darkroom) 10:08:58 INFO - PID 13079 | RSS: Main: 176885760 10:08:58 INFO - PID 13079 | 10:09:01 INFO - PID 13079 | Cycle 1(1): loaded http://localhost:46617/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46617/tests/kraken/driver.html?testName=imaging-desaturate) 10:09:02 INFO - PID 13079 | RSS: Main: 176541696 10:09:02 INFO - PID 13079 | 10:09:05 INFO - PID 13079 | Cycle 1(1): loaded http://localhost:46617/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46617/tests/kraken/driver.html?testName=json-parse-financial) 10:09:05 INFO - PID 13079 | RSS: Main: 177700864 10:09:05 INFO - PID 13079 | 10:09:07 INFO - PID 13079 | Cycle 1(1): loaded http://localhost:46617/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46617/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:09:08 INFO - PID 13079 | RSS: Main: 177704960 10:09:08 INFO - PID 13079 | 10:09:10 INFO - PID 13079 | Cycle 1(1): loaded http://localhost:46617/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46617/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:09:10 INFO - PID 13079 | RSS: Main: 174260224 10:09:10 INFO - PID 13079 | 10:09:12 INFO - PID 13079 | Cycle 1(1): loaded http://localhost:46617/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46617/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:09:13 INFO - PID 13079 | RSS: Main: 174551040 10:09:13 INFO - PID 13079 | 10:09:16 INFO - PID 13079 | Cycle 1(1): loaded http://localhost:46617/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46617/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:09:17 INFO - PID 13079 | RSS: Main: 175169536 10:09:17 INFO - PID 13079 | 10:09:20 INFO - PID 13079 | Cycle 1(1): loaded http://localhost:46617/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46617/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:09:21 INFO - PID 13079 | RSS: Main: 175063040 10:09:21 INFO - PID 13079 | 10:09:22 INFO - PID 13079 | Cycle 1(1): loaded http://localhost:46617/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46617/tests/kraken/driver.html?testName=ai-astar) 10:09:23 INFO - PID 13079 | RSS: Main: 176648192 10:09:23 INFO - PID 13079 | 10:09:23 INFO - PID 13079 | __start_tp_report 10:09:23 INFO - PID 13079 | _x_x_mozilla_page_load 10:09:23 INFO - PID 13079 | _x_x_mozilla_page_load_details 10:09:23 INFO - PID 13079 | |i|pagename|runs| 10:09:23 INFO - PID 13079 | |0;ai-astar;99;110;105;107;117;110;112;104;108;109 10:09:23 INFO - PID 13079 | |1;audio-beat-detection;147;116;139;190;125;150;147;118;172;119 10:09:23 INFO - PID 13079 | |2;audio-dft;165;162;162;165;167;174;167;171;164;168 10:09:23 INFO - PID 13079 | |3;audio-fft;74;75;76;169;75;75;75;76;172;78 10:09:23 INFO - PID 13079 | |4;audio-oscillator;80;79;132;79;79;86;127;84;80;128 10:09:23 INFO - PID 13079 | |5;imaging-gaussian-blur;117;117;113;114;115;115;114;116;114;114 10:09:23 INFO - PID 13079 | |6;imaging-darkroom;151;155;152;150;153;151;156;150;150;150 10:09:23 INFO - PID 13079 | |7;imaging-desaturate;99;94;94;99;94;96;94;94;93;98 10:09:23 INFO - PID 13079 | |8;json-parse-financial;57;57;57;56;58;58;60;56;60;61 10:09:23 INFO - PID 13079 | |9;json-stringify-tinderbox;53;58;56;55;58;54;54;55;54;54 10:09:23 INFO - PID 13079 | |10;stanford-crypto-aes;81;81;89;91;82;99;79;90;80;88 10:09:23 INFO - PID 13079 | |11;stanford-crypto-ccm;133;130;127;140;127;133;135;130;137;174 10:09:23 INFO - PID 13079 | |12;stanford-crypto-pbkdf2;194;184;182;184;191;187;196;190;190;190 10:09:23 INFO - PID 13079 | |13;stanford-crypto-sha256-iterative;71;71;67;68;69;67;66;66;67;71 10:09:23 INFO - PID 13079 | __end_tp_report 10:09:23 INFO - PID 13079 | __start_cc_report 10:09:23 INFO - PID 13079 | _x_x_mozilla_cycle_collect,959 10:09:23 INFO - PID 13079 | __end_cc_report 10:09:23 INFO - PID 13079 | __startTimestamp1501520963096__endTimestamp 10:09:23 INFO - PID 13079 | 10:09:23 INFO - PID 13079 | ------- Summary: start ------- 10:09:23 INFO - PID 13079 | Number of tests: 14 10:09:23 INFO - PID 13079 | 10:09:23 INFO - PID 13079 | [#0] ai-astar Cycles:10 Average:108.10 Median:110.00 stddev:4.86 (4.4%) stddev-sans-first:3.89 10:09:23 INFO - PID 13079 | Values: 99.0 110.0 105.0 107.0 117.0 110.0 112.0 104.0 108.0 109.0 10:09:23 INFO - PID 13079 | 10:09:23 INFO - PID 13079 | [#1] audio-beat-detection Cycles:10 Average:142.30 Median:147.00 stddev:24.49 (16.7%) stddev-sans-first:25.91 10:09:23 INFO - PID 13079 | Values: 147.0 116.0 139.0 190.0 125.0 150.0 147.0 118.0 172.0 119.0 10:09:23 INFO - PID 13079 | 10:09:23 INFO - PID 13079 | [#2] audio-dft Cycles:10 Average:166.50 Median:167.00 stddev:3.81 (2.3%) stddev-sans-first:4.00 10:09:23 INFO - PID 13079 | Values: 165.0 162.0 162.0 165.0 167.0 174.0 167.0 171.0 164.0 168.0 10:09:23 INFO - PID 13079 | 10:09:23 INFO - PID 13079 | [#3] audio-fft Cycles:10 Average:94.50 Median:75.00 stddev:40.08 (53.4%) stddev-sans-first:41.81 10:09:23 INFO - PID 13079 | Values: 74.0 75.0 76.0 169.0 75.0 75.0 75.0 76.0 172.0 78.0 10:09:23 INFO - PID 13079 | 10:09:23 INFO - PID 13079 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:79.50 stddev:23.33 (29.4%) stddev-sans-first:24.08 10:09:23 INFO - PID 13079 | Values: 80.0 79.0 132.0 79.0 79.0 86.0 127.0 84.0 80.0 128.0 10:09:23 INFO - PID 13079 | 10:09:23 INFO - PID 13079 | [#5] imaging-gaussian-blur Cycles:10 Average:114.90 Median:115.00 stddev:1.37 (1.2%) stddev-sans-first:1.22 10:09:23 INFO - PID 13079 | Values: 117.0 117.0 113.0 114.0 115.0 115.0 114.0 116.0 114.0 114.0 10:09:23 INFO - PID 13079 | 10:09:23 INFO - PID 13079 | [#6] imaging-darkroom Cycles:10 Average:151.80 Median:151.50 stddev:2.20 (1.5%) stddev-sans-first:2.32 10:09:23 INFO - PID 13079 | Values: 151.0 155.0 152.0 150.0 153.0 151.0 156.0 150.0 150.0 150.0 10:09:23 INFO - PID 13079 | 10:09:23 INFO - PID 13079 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.00 stddev:2.32 (2.4%) stddev-sans-first:2.09 10:09:23 INFO - PID 13079 | Values: 99.0 94.0 94.0 99.0 94.0 96.0 94.0 94.0 93.0 98.0 10:09:23 INFO - PID 13079 | 10:09:23 INFO - PID 13079 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:58.00 stddev:1.76 (3.0%) stddev-sans-first:1.83 10:09:23 INFO - PID 13079 | Values: 57.0 57.0 57.0 56.0 58.0 58.0 60.0 56.0 60.0 61.0 10:09:23 INFO - PID 13079 | 10:09:23 INFO - PID 13079 | [#9] json-stringify-tinderbox Cycles:10 Average:55.10 Median:55.00 stddev:1.73 (3.1%) stddev-sans-first:1.66 10:09:23 INFO - PID 13079 | Values: 53.0 58.0 56.0 55.0 58.0 54.0 54.0 55.0 54.0 54.0 10:09:23 INFO - PID 13079 | 10:09:23 INFO - PID 13079 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:88.50 stddev:6.45 (7.3%) stddev-sans-first:6.58 10:09:23 INFO - PID 13079 | Values: 81.0 81.0 89.0 91.0 82.0 99.0 79.0 90.0 80.0 88.0 10:09:23 INFO - PID 13079 | 10:09:23 INFO - PID 13079 | [#11] stanford-crypto-ccm Cycles:10 Average:136.60 Median:134.00 stddev:13.79 (10.3%) stddev-sans-first:14.56 10:09:23 INFO - PID 13079 | Values: 133.0 130.0 127.0 140.0 127.0 133.0 135.0 130.0 137.0 174.0 10:09:23 INFO - PID 13079 | 10:09:23 INFO - PID 13079 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.80 Median:190.00 stddev:4.52 (2.4%) stddev-sans-first:4.38 10:09:23 INFO - PID 13079 | Values: 194.0 184.0 182.0 184.0 191.0 187.0 196.0 190.0 190.0 190.0 10:09:23 INFO - PID 13079 | 10:09:23 INFO - PID 13079 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:2.06 (3.0%) stddev-sans-first:1.94 10:09:23 INFO - PID 13079 | Values: 71.0 71.0 67.0 68.0 69.0 67.0 66.0 66.0 67.0 71.0 10:09:23 INFO - PID 13079 | -------- Summary: end -------- 10:09:23 INFO - PID 13079 | 10:09:23 INFO - PID 13079 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 10:09:23 INFO - TEST-INFO | 13079: exit 0 10:09:23 INFO - TEST-OK | kraken | took 63480ms 10:09:23 INFO - SUITE-END | took 1177s 10:09:24 INFO - Completed test suite (00:19:38) 10:09:24 INFO - javascript benchmark 10:09:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8393.650077071878, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3119.3449375631117, 3144.2768163322435, 3149.5275708643717, 3166.335069635376, 3187.7768556201077, 6043.335233124359, 6104.42008009239, 6118.724657390417, 6122.724477398517, 6277.466415354689, 6188.8143355699285, 6203.565750397474, 6265.718042688079, 6266.279377871546, 6275.560710750249, 5594.356648985368, 5683.545316374701, 5684.090545512719, 5717.3139223293265, 5731.742071606787, 5498.367687715924, 5539.446055394448, 5589.552835773128, 5605.523530499912, 5705.286839145107, 5571.637843540157, 5642.802501912434, 5675.2054712340305, 5694.174344720013, 5723.856903577403, 5607.831765047055, 5631.493165615114, 5689.061304884731, 5701.087825947829, 5707.286589176353, 5492.258545096441, 5587.776488940438, 5601.495865372136, 5633.80281690143, 5634.267545219095, 6117.938820611781, 6126.019836826086, 6138.294096178952, 6148.907766383508, 6153.230846144232, 6521.608703477807, 6522.054302126166, 6596.93403065968, 6598.274189839114, 6623.834404139887, 6666.733330666768, 6668.366505182, 6764.255931847493, 6771.72913083476, 6776.491763117786, 6018.969905150446, 6092.116643086772, 6127.2953610334935, 6193.4425901669065, 6199.504039676815, 6762.053312536249, 6800.863982720318, 6834.965825170942, 6851.2806155353965, 6862.725490980305, 6402.551821372459, 6440.935590644127, 6516.055172000033, 6529.771457998947, 6548.083268342436, 6552.63960482178, 6584.374484423972, 6616.536842420985, 6622.139121914121, 6678.465722742169, 6538.673066346663, 6550.803475895731, 6565.080888675589, 6571.2771595124495, 6595.307492713292, 6591.472682185414, 6645.401913827779, 6648.700808463631, 6666.699998500079, 6677.699503522354, 5305.708186049805, 5330.8933821324135, 5393.2449457076045, 5399.0, 5408.5402740766685, 4550.47669518003, 4573.245414506636, 4636.188666983265, 4658.743769092733, 4667.183242932473, 5737.3688894221605, 5737.85655358611, 5743.54051675865, 5772.3938986406665, 5777.24895763548, 6717.798466046026, 6730.562513436611, 6741.831454213586, 6741.932580674131, 6742.662866856637, 5693.0, 5784.913226301609, 5811.331696854916, 5811.912821307684, 5837.357890632027, 5858.7070646468355, 5869.4717475427415, 5918.4377484139795, 5955.880882382328, 5965.135055417027, 6389.904151437825, 6410.647414392253, 6497.090407342976, 6521.64130972801, 6538.1500404947055, 6530.216374035146, 6628.07206991012, 6673.566218195801, 6685.498587606046, 6685.6322902240845, 6405.455536279282, 6417.326180750954, 6435.710393032231, 6441.227052753699, 6501.382368674968, 6529.575577587441, 6538.150040494896, 6553.967230163818, 6592.406683398517, 6634.767783127568, 6611.338866113542, 6639.70121344531, 6735.158105236846, 6738.764143254963, 6739.528233023641, 6379.840503987438, 6398.424141827258, 6407.583507072025, 6432.742690292336, 6477.77327793525, 6337.366263373626, 6388.968055159695, 6393.200849893763, 6400.071989561395, 6416.358364163546, 6298.811035668938, 6311.147995020613, 6335.018072198816, 6349.873002539831, 6358.2687990879795, 6378.489720822416, 6446.774362897464, 6452.870942581216, 6471.4499267560905, 6478.967605161944, 6158.969205153946, 6169.321374648875, 6260.311365749672, 6310.11658367838, 6378.138951241709], "value": 6044.905493499369, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [840.9621567029483, 880.1198801198801, 900.9504477253753, 901.7294811556534, 1148.8563929508812, 31084.06747797567, 41306.58693413069, 42235.36646950298, 42348.78825605867, 42392.15215695684, 43385.0, 43691.34462983058, 43740.0, 43791.12417751643, 43913.34129988045, 7631.961840190791, 7835.373170146375, 7842.686292548291, 7849.411294152933, 7852.803679907991, 7697.461177717562, 7807.609619519029, 7828.295453409192, 7834.099078605947, 7835.451518393715, 7760.534367937914, 7807.375409967218, 7816.843663126734, 7827.882581761278, 7856.135825059239, 7725.61371931404, 7804.102528209243, 7810.0627924649125, 7828.804279892991, 7846.176151504124, 7690.653920573588, 7741.7677469676, 7772.494787838772, 7791.8831217531215, 7793.376529877596, 39645.60354396448, 39881.0, 39918.600813991776, 39924.201515969515, 39975.600243997476, 3489.5812502499607, 3530.6998905093096, 3531.5938667053106, 3535.381308271068, 3537.4163263061564, 31658.52512212319, 31743.84128079368, 31753.206169845707, 31801.204969875937, 31865.76939614228, 4859.975700121512, 4863.902721945541, 4873.805047798084, 4906.803727850882, 4988.251762235657, 182180.0, 182861.0, 182989.0, 183647.99999999866, 183712.0, 48370.758146209046, 48496.5150348492, 48630.0, 49078.26382604264, 49098.75450622795, 52112.21831672528, 52658.0, 52801.471985279655, 52806.15178468812, 52859.20711189335, 12126.333051682243, 12226.938865305616, 14002.719945601031, 14401.711965760625, 14558.927205363905, 11283.605073822377, 11312.377819219857, 11316.886831131747, 11338.263012904135, 11343.149263805248, 14563.92718036403, 14568.198749068903, 14646.853531464549, 14665.56003319902, 14739.189344586151, 5608.186812912105, 5716.599838011382, 5744.310682718101, 5777.19119323295, 5854.736536855852, 994.2195376629311, 999.1257649556638, 1005.4872015272117, 1015.1779544313357, 1025.876894772632, 22170.667439988414, 22366.552668946857, 22383.776162238493, 23029.884850575974, 23179.420514486934, 1088.6570730219955, 1088.8747794003632, 1098.9780204396027, 1120.3110087296254, 1122.421952694363, 11851.0, 11921.642350729491, 11931.701707457209, 12233.877661223452, 16498.917505412635, 230297.0, 231869.0, 233328.0, 233415.0, 233589.0, 60103.69948150231, 60161.39838601558, 60635.69682151561, 60648.39351606427, 60743.69628151831, 1487.2043456750587, 1521.3458212968308, 1522.117172040214, 1540.7072656195287, 1550.8061492313461, 27405.451890962468, 28017.29956751016, 28165.15504534867, 28252.86988520436, 28664.0, 38683.80658096691, 38755.2248955025, 39280.41079383869, 39284.41073383844, 39509.80245098756, 219343.0, 220997.0, 221030.0, 221301.0, 221997.0, 32410.35179296448, 32525.34949301048, 32878.0, 35772.284554308244, 36519.08702282464, 44344.55655443404, 44602.330965034904, 44793.552064478936, 44959.0, 45072.77463612661, 27716.861415692794, 27988.30029249285, 28013.159605211877, 28165.718342816308, 28753.0, 25281.0, 26842.731572684803, 29868.253293667833, 29874.402511949203, 29964.550531742476, 37972.81013595025, 39494.21011579695, 39593.208135837696, 39654.0, 39662.40506392464, 31511.0, 32934.83532582322, 34504.65495345015, 34561.827190863885, 34991.82504087463, 23248.302550923498, 24126.207533511537, 24484.75515244896, 24639.876800615883, 24699.382515437257], "value": 17344.36825541734, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.1949672974189, 573.1545969694698, 574.6379780738134, 577.4052725692535, 589.6462122726365, 22606.321810345675, 22837.0, 23571.175008874692, 23677.881610591965, 23686.289411317666, 26052.0, 26381.076662316776, 26469.0, 26472.735272647267, 26574.867125664343, 6548.377904099115, 6729.528932974694, 6740.224874139488, 6744.4941629377745, 6750.797476075701, 5921.555883308748, 6471.611703297794, 6476.967615161918, 6556.14770079889, 6636.93363066368, 6401.487880969535, 6464.515161362917, 6468.838279043038, 6470.0, 6472.093906853044, 6357.968210158942, 6392.20097487814, 6399.552031357807, 6440.967795161041, 6450.612963222175, 5954.434328738763, 5968.731407086691, 5971.0, 6000.609960352563, 6004.459598636144, 28679.139625811258, 29060.0, 29606.0, 30978.84510577455, 31309.530357044663, 1891.754071970635, 1943.4266891266968, 1945.8151475609795, 1948.8733232339994, 1949.1423773539739, 18524.0, 19128.808711912843, 19163.520911977314, 19239.711404328948, 19312.32406865753, 2263.9886800566055, 2287.085165933623, 2323.430759463942, 2328.883555822202, 2330.6154484510034, 138900.5274868126, 141713.0, 142393.99999999895, 142561.28719356336, 142966.28516857454, 14348.06737562055, 15037.473688420852, 15126.848731512764, 15152.242387880562, 15286.159261240738, 22937.655935160987, 23116.53766924652, 23119.0, 23169.304920852403, 23196.884015579813, 9475.6683516078, 9851.556679949419, 9872.001839255114, 9890.20878329732, 9968.950155249322, 9028.18746312835, 9043.819123617623, 9045.502497362577, 9058.5017824019, 9148.2681385489, 8401.411901166983, 9202.35583509148, 9216.216621587106, 9279.39683920543, 9287.349885507949, 2677.8259413138085, 2763.4473105379006, 2763.668359796837, 2823.675277343091, 2858.2711408591094, 926.2533053797406, 937.3953799799092, 941.1670671455674, 971.1745016735719, 975.9268054895912, 19158.808411915983, 19370.0, 19726.506837328896, 19799.20803167886, 19990.100445479988, 969.0793745941384, 1007.9496025198711, 1009.152312057875, 1009.5709323537467, 1016.1565900302732, 10998.945005275082, 12952.093353465167, 13274.867251327556, 14071.507497237548, 14356.49752258666, 521713.0, 525660.0, 534109.0, 536317.0, 538574.0, 118831.0, 119551.0, 119732.0, 119973.0, 122465.38767306106, 1200.1573650320913, 1214.5688280660415, 1263.6398626391617, 1264.4942023190613, 1270.1172684984033, 20702.378928632166, 20897.0, 20981.370558883256, 21317.0, 21586.460338491663, 57325.713371432874, 58232.708836455546, 58781.41218587759, 59822.102668459134, 60423.0, 71741.6412917932, 71854.0, 72454.27545724476, 72555.0, 72808.63595681988, 12425.875741242833, 12900.612981610566, 13513.594592162252, 14008.859911401163, 14362.784558231426, 22871.0, 22930.19744309008, 23045.07819687194, 23397.0, 23404.0, 18261.08694565293, 18311.72532411988, 18599.628007440046, 18641.161147748113, 18705.25178992825, 14084.22536760488, 14934.551963441114, 14944.994118867746, 15279.236038198267, 15337.0, 18003.2798688051, 18189.363372281907, 18357.173927173575, 18383.54041148982, 18410.447686569423, 14829.777553336493, 14841.109533428029, 14891.776623350876, 14893.85106148968, 14898.925505372838, 18022.5494362642, 18057.367992120213, 18121.912685238927, 18179.727304090713, 18263.0], "value": 12032.210528047899, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1337.498438085718, 1408.43662534986, 1411.675314677624, 1413.2933533233384, 1414.9929250353746, 13510.392032358543, 14071.08537945033, 14140.363683634236, 14174.291285435726, 14182.078164919272, 14754.114753114794, 14954.177520236382, 15050.548483545512, 15056.322465489053, 15072.0, 2603.1019298342044, 2655.389260470093, 2657.0965871603653, 2657.2692509559834, 2659.7340265973344, 2574.729653386386, 2755.2973991632107, 2759.4481103779226, 2771.9584206236923, 2774.9861250693716, 2601.7788487978546, 2631.5921032240035, 2660.3349162709324, 2663.4673065386905, 2665.7734092602154, 2578.200757765099, 2595.922122336333, 2631.250093723299, 2631.2632462910415, 2632.1577095329408, 2453.460238747473, 2497.5504409206337, 2498.100683753847, 2526.873656317195, 2555.731648176933, 13987.720245595032, 14095.295235238196, 14106.92946535271, 14112.92943535286, 14117.435302587885, 7189.964050179716, 7549.811254718621, 7561.168271490132, 7564.394848412114, 7566.886496702554, 4720.409948756405, 4859.514048595112, 5019.974900125512, 5034.84895453137, 5035.345405097314, 1604.3582566973187, 1645.5310236582516, 1665.6335606166624, 1687.3503701075051, 1698.1678977301158, 23032.539349212922, 23249.3025209244, 23297.0, 23330.300090997127, 23330.416739581477, 6112.572119951649, 6227.470664993526, 6309.066284177879, 6395.328490508523, 6475.093486911836, 15681.607959800867, 15786.684266314609, 15818.130002849724, 15863.0, 15928.203589820463, 7091.6454177290925, 7362.116546014406, 7363.190049094595, 7376.336129748348, 7381.66782494789, 6636.104125943032, 6696.397324240842, 6792.218894827158, 6798.626075565891, 6819.420349270268, 4859.34398856157, 5006.674566153189, 5030.547250747451, 5044.924326135111, 5065.366829146356, 1427.4361627157214, 1451.310627451973, 1461.926903654813, 1474.402866838932, 1477.0546850015999, 796.5300472721123, 814.3770015937812, 816.5917041479261, 838.0781140745131, 849.8172892827948, 7378.926210737931, 7471.589062601609, 7634.160242373335, 7637.579933103621, 7657.310842024244, 951.414879848888, 965.1747755668943, 987.7579992901785, 992.3103443106971, 1005.7083445800782, 4355.716878402894, 4998.750062496861, 5183.14478111115, 5252.343457067866, 5256.0, 18496.81503184978, 18790.154443050094, 19410.0, 19417.708734368996, 19423.611527769364, 18940.337088201846, 19299.0, 19367.12847921847, 19403.8059619402, 19438.222471101, 10312.742181445525, 10723.46382680863, 10980.231383803217, 11010.614628487965, 11012.39431831241, 6975.546589471871, 7218.963905180441, 7501.774946751606, 7571.242875712384, 7729.420293478124, 15849.762253566436, 16276.755848662517, 16386.918065409598, 16497.91751041237, 16746.330146793993, 16614.58463538373, 16629.66740665156, 16716.164191790118, 16825.0, 16985.40551080706, 11010.559577616805, 11143.721406964567, 11178.27341222818, 11178.72053198644, 11208.55165793359, 12516.0, 12538.623841284776, 12580.811287830507, 12592.181508201938, 12674.429650665557, 9597.712068637951, 9711.465869376969, 9941.25440591944, 10073.949630251802, 10274.537645805807, 9234.538273086453, 9553.904460955302, 9586.808263834544, 9788.706338809847, 9789.412635241908, 8624.18070283322, 8689.522076285864, 8998.685046023358, 9004.144606262395, 9029.277657787492, 5684.77260909559, 5863.941360586339, 6069.36271691466, 6072.544559158169, 6083.756649733961, 6560.737570497317, 6658.167729033871, 6804.897926531007, 6813.523053386215, 6842.110525631835], "value": 6186.462146874077, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [454.2130182070134, 477.4270874950059, 478.715164477136, 480.7235839392349, 495.2101398269759, 6214.782482613109, 6217.5958562693395, 6224.533160013006, 6228.408301211383, 6324.1462402575635, 5838.970805145979, 6070.0, 6102.755889764404, 6108.3280839107665, 6124.510039196864, 4829.855104346858, 4860.173770459013, 4879.121758083544, 4885.853424397274, 4901.387326584177, 4783.856484305476, 4900.534449227318, 4911.45973942866, 4942.604591632678, 4953.4798846121175, 4846.39420072491, 4871.658983871131, 4877.292792545079, 4907.141250281186, 4912.97851821131, 4858.17411040124, 4867.075255701406, 4875.317455556225, 4881.95118048822, 4898.0, 4350.586694264071, 4385.429894113745, 4402.823887044515, 4413.823447062114, 4427.22523558376, 6053.848653783691, 6055.545834062419, 6086.0, 6086.726097325631, 6092.482139018189, 5583.860403489945, 5611.130274807411, 5613.354464236624, 5627.71861406928, 5630.15547667849, 6348.777792777277, 6403.199600049994, 6431.22825260967, 6485.286618471964, 6506.446952009085, 4782.378290822171, 4784.162771514971, 4807.759612019385, 4827.106985207748, 4827.203511420611, 6877.6217308048535, 6887.552309099992, 6897.862042759117, 6899.896501552481, 6901.585904845675, 4930.852074437773, 4933.062718083553, 4945.8021679132435, 4950.2822090796635, 4956.405231372259, 4924.72913989734, 4951.455339912607, 4952.90094198114, 5012.473690262543, 5028.446870844205, 5549.861253468695, 5589.217509548666, 5604.523615492729, 5627.268455100892, 5631.324241091095, 6459.224893012774, 6493.896037673607, 6521.902171467432, 6529.608223506605, 6553.606783593, 1653.9338426463048, 1671.807742109673, 1696.8897021693797, 1702.2425020865844, 1711.1187738314777, 1165.1901928160016, 1169.5964892112208, 1175.588544009607, 1184.1474138620179, 1194.3669854976877, 5683.0, 5701.971490142523, 5705.828825135252, 5740.995325817965, 5767.0, 6496.512761542903, 6618.139641846529, 6627.271000189975, 6651.16860392451, 6661.500387470959, 5674.2266392849115, 5705.315362156568, 5739.483446489836, 5753.309602847601, 5754.813170994995, 3527.206378564854, 3537.5401197844117, 3567.375709250871, 3594.9688426039206, 3610.205754733954, 6468.514861385415, 6484.157059582224, 6488.480921526267, 6493.740250390026, 6560.507961902781, 6780.423663988616, 6788.7284508619105, 6837.0, 6842.452603791685, 6890.483213758988, 6444.548881578245, 6483.675816209171, 6492.577982431221, 6516.869662606816, 6528.988006858945, 6630.900536492053, 6741.52809303344, 6768.390844823989, 6782.626955517297, 6807.421369183675, 6589.110470086669, 6610.669466526559, 6630.933690663224, 6635.23694775107, 6758.8648227036165, 6399.8720025598295, 6460.709268083042, 6492.383223593751, 6513.250976137805, 6540.476761859135, 4878.0, 4892.217245240744, 4907.190313598359, 4913.164761990399, 4934.457209707001, 6625.238097618642, 6802.14973128359, 6805.0, 6814.466744982339, 6847.931520684929, 6397.488200944006, 6480.222373315232, 6484.416402523795, 6506.3493650634555, 6506.41442270198, 6056.36408177135, 6375.362463753588, 6420.711068001858, 6445.645489497935, 6502.837429064311, 6287.779927702509, 6308.038903236397, 6324.7153878076515, 6373.681315934277, 6440.13058237132, 6419.45434638061, 6451.387118223761, 6571.0, 6585.604863708193, 6591.274959754327, 6227.813165605039, 6245.500359971283, 6299.30707622152, 6337.841553961188, 6343.270523889627], "value": 4989.290582543169, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [849.4478588917199, 866.0906048648917, 871.7907702151485, 903.20969151992, 912.730744430393, 18363.357282495097, 19169.904150479262, 19170.520736981565, 19240.23039078437, 22224.333270001927, 18093.638127237446, 18317.7252341215, 18330.35843745466, 18374.0, 18381.90809045953, 998.981039339873, 1006.7332156978388, 1028.6913925822223, 1039.636127355427, 1044.634377967713, 1044.7022598559413, 1047.659510659035, 1052.0268751404958, 1052.6210564196883, 1052.984205236922, 1086.8532748079026, 1089.0307626212677, 1089.0470838016736, 1089.803835309644, 1090.4329748530758, 1065.3288428290205, 1069.1553672598639, 1071.7802850415646, 1075.0700643943012, 1076.6877605494396, 795.0737390939606, 796.4424902568226, 796.7729197178834, 799.7320897499345, 802.4984384759525, 16873.915630421892, 16942.3223071077, 17142.914285428495, 18080.367187148517, 20486.692699609517, 20065.398038058735, 20492.897535512377, 20789.79210207909, 20930.47673808167, 21182.894085529628, 15148.545543633709, 15298.546638069476, 15315.31081101353, 15335.539933802003, 16188.514344569681, 3624.746267761258, 3629.3648611493145, 3650.890473285779, 3651.7991510466913, 3653.1962968146963, 112597.43701281524, 116170.41914790457, 118870.0, 119950.0, 121774.39112804379, 16056.0, 16713.164341782864, 16720.080395578116, 16726.0, 16733.414330498374, 28422.147335579964, 30377.392452151274, 30461.390772184433, 30502.694973049984, 30665.38669226603, 8228.42401031934, 8295.751127466187, 8302.045264794626, 8303.626336814857, 8404.747857564284, 3465.0, 3600.207954250061, 3615.837287322077, 3961.544422391404, 4058.350663893763, 5102.719350435687, 5190.6366554341585, 5239.056969745482, 5239.973800130975, 5248.816291429858, 969.8884628267698, 1009.5658866687395, 1009.6420314676748, 1019.7297716105238, 1025.9076683098558, 654.6988385342796, 675.0717763075771, 683.7880257120308, 695.1415002471944, 698.9231184569693, 10931.672049838518, 11667.0, 12186.878131218751, 12440.81338779919, 13022.934885325512, 662.6885363878969, 682.5120039172016, 703.1632357494667, 707.1231672725783, 723.6417973103347, 5154.0, 5282.0, 5484.149956756709, 5619.775208991677, 5685.0619647758485, 100595.0, 101645.0, 103447.0, 103761.48119259506, 108034.45982770192, 85415.0, 90568.0, 90834.54582727044, 92864.0, 95587.0, 70480.0, 75912.24087759163, 76576.23423765802, 77973.0, 79670.60164699255, 11788.823167652321, 12732.363381830686, 12781.808272875729, 13225.206487610774, 13272.933635331761, 34866.82566587252, 35205.82397087998, 35484.64515354813, 35529.28941421105, 35570.644293557765, 61034.694826525585, 64466.0, 64917.37706557185, 68916.0, 69829.0, 18061.0, 19003.23987040558, 19160.712589310893, 19355.12901919389, 19386.0, 20682.896585516977, 20749.481262967944, 20790.376288711363, 21029.474263143544, 21204.25785097514, 19238.326658566883, 19419.70870436973, 19728.408147755592, 19792.109355078766, 20040.59918801645, 18599.44201673952, 18912.62174756525, 19503.804961950198, 19645.410637680892, 19673.704894426883, 17488.0, 17751.201195946473, 18762.15570299367, 18935.14791834343, 18958.620827583094, 11871.406429678655, 12332.445039973043, 12648.241105533698, 12778.61664150077, 13477.123986940818, 13639.931800340935, 14071.788923166365, 14179.22014289224, 14379.352929118424, 14492.492762753674], "value": 8980.53986974608, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1561.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 110.0, 105.0, 107.0, 117.0, 110.0, 112.0, 104.0, 108.0, 109.0], "value": 108.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 116.0, 139.0, 190.0, 125.0, 150.0, 147.0, 118.0, 172.0, 119.0], "value": 142.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 162.0, 165.0, 167.0, 174.0, 167.0, 171.0, 164.0, 168.0], "value": 166.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 169.0, 75.0, 75.0, 75.0, 76.0, 172.0, 78.0], "value": 94.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 132.0, 79.0, 79.0, 86.0, 127.0, 84.0, 80.0, 128.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 113.0, 114.0, 115.0, 115.0, 114.0, 116.0, 114.0, 114.0], "value": 114.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 155.0, 152.0, 150.0, 153.0, 151.0, 156.0, 150.0, 150.0, 150.0], "value": 151.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 94.0, 94.0, 99.0, 94.0, 96.0, 94.0, 94.0, 93.0, 98.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 56.0, 58.0, 58.0, 60.0, 56.0, 60.0, 61.0], "value": 58.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 58.0, 56.0, 55.0, 58.0, 54.0, 54.0, 55.0, 54.0, 54.0], "value": 55.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 89.0, 91.0, 82.0, 99.0, 79.0, 90.0, 80.0, 88.0], "value": 86.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 130.0, 127.0, 140.0, 127.0, 133.0, 135.0, 130.0, 137.0, 174.0], "value": 136.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 184.0, 182.0, 184.0, 191.0, 187.0, 196.0, 190.0, 190.0, 190.0], "value": 188.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 67.0, 68.0, 69.0, 67.0, 66.0, 66.0, 67.0, 71.0], "value": 68.3, "unit": "score"}]}]} 10:09:24 INFO - Return code: 0 10:09:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:09:24 INFO - # TBPL SUCCESS # 10:09:24 INFO - Running post-action listener: _package_coverage_data 10:09:24 INFO - Running post-action listener: _resource_record_post_action 10:09:24 INFO - [mozharness: 2017-07-31 17:09:24.376108Z] Finished run-tests step (success) 10:09:24 INFO - Running post-run listener: _resource_record_post_run 10:09:24 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 12288; Write bytes: 442445824; Read time: 64; Write time: 396436 10:09:24 INFO - TinderboxPrint: CPU usage
13.2% 10:09:24 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 64 10:09:24 INFO - TinderboxPrint: I/O write bytes / time
442,445,824 / 396,436 10:09:24 INFO - TinderboxPrint: CPU idle
8,286.4 (86.8%) 10:09:24 INFO - TinderboxPrint: CPU user
1,205.0 (12.6%) 10:09:24 INFO - TinderboxPrint: Swap in / out
0 / 0 10:09:24 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 119078912; Read time: 52; Write time: 106472 10:09:24 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 10:09:24 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 323366912; Read time: 0; Write time: 289964 10:09:25 INFO - Running post-run listener: _upload_blobber_files 10:09:25 INFO - Blob upload gear active. 10:09:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:09:25 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 10:09:25 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'] 10:09:25 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 10:09:25 INFO - (blobuploader) - INFO - Open directory for files ... 10:09:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:09:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:09:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:09:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:09:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:09:34 INFO - (blobuploader) - INFO - Done attempting. 10:09:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:09:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:09:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:09:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:09:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:09:34 INFO - (blobuploader) - INFO - Done attempting. 10:09:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:09:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:09:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:09:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:09:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:09:35 INFO - (blobuploader) - INFO - Done attempting. 10:09:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:09:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:09:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:09:36 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:09:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:09:36 INFO - (blobuploader) - INFO - Done attempting. 10:09:36 INFO - (blobuploader) - INFO - Iteration through files over. 10:09:36 INFO - Return code: 0 10:09:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:09:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:09:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8ee97a56600c65883cf4d4b99d244932d0f2fb2cf3a79c51e7c5e9c26823d936910047e073d80099dac0531b3fcbb34342243b047606ed321b5cca0d766c1d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fab471036928f4683c73761b6f9878b3dcf01946a1f704506996df5949ca06d5ef75680c39cb9feef5348bbe3dbb27ae8aea87111c7f9becadec51e574120e95", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e0e47227a436bec96d36a7b5c2651011ad00bce39bba0eeb7bf08eea66471138df2d74305a1454c250a380a303904a610c5d4b5e29f8c99e57858a856b3b4a02", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66ce3ff171412bbce9183624d8523d6b7ebd7888e29f4a16f98d40d6b3c660b0193445c6c82ce81a572f5b43c190cf8faeb5aba3c30a375ac4580a2ad2346a1e"} 10:09:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:09:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:09:36 INFO - Contents: 10:09:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8ee97a56600c65883cf4d4b99d244932d0f2fb2cf3a79c51e7c5e9c26823d936910047e073d80099dac0531b3fcbb34342243b047606ed321b5cca0d766c1d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fab471036928f4683c73761b6f9878b3dcf01946a1f704506996df5949ca06d5ef75680c39cb9feef5348bbe3dbb27ae8aea87111c7f9becadec51e574120e95", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e0e47227a436bec96d36a7b5c2651011ad00bce39bba0eeb7bf08eea66471138df2d74305a1454c250a380a303904a610c5d4b5e29f8c99e57858a856b3b4a02", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66ce3ff171412bbce9183624d8523d6b7ebd7888e29f4a16f98d40d6b3c660b0193445c6c82ce81a572f5b43c190cf8faeb5aba3c30a375ac4580a2ad2346a1e"} 10:09:36 INFO - Running post-run listener: copy_logs_to_upload_dir 10:09:36 INFO - Copying logs to upload dir... 10:09:36 INFO - mkdir: /builds/slave/test/build/upload/logs 10:09:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.406696 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-07-31 10:09:36.764915) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-31 10:09:36.768529) ========= 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=3836458cccd887f2d2de3cf1000001de-1501519625.521125-1167683589 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/d8ee97a56600c65883cf4d4b99d244932d0f2fb2cf3a79c51e7c5e9c26823d936910047e073d80099dac0531b3fcbb34342243b047606ed321b5cca0d766c1d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fab471036928f4683c73761b6f9878b3dcf01946a1f704506996df5949ca06d5ef75680c39cb9feef5348bbe3dbb27ae8aea87111c7f9becadec51e574120e95", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e0e47227a436bec96d36a7b5c2651011ad00bce39bba0eeb7bf08eea66471138df2d74305a1454c250a380a303904a610c5d4b5e29f8c99e57858a856b3b4a02", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66ce3ff171412bbce9183624d8523d6b7ebd7888e29f4a16f98d40d6b3c660b0193445c6c82ce81a572f5b43c190cf8faeb5aba3c30a375ac4580a2ad2346a1e"} build_url:https://queue.taskcluster.net/v1/task/GJIFbv4yTaKDTYEmSbl0jw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011285 build_url: 'https://queue.taskcluster.net/v1/task/GJIFbv4yTaKDTYEmSbl0jw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8ee97a56600c65883cf4d4b99d244932d0f2fb2cf3a79c51e7c5e9c26823d936910047e073d80099dac0531b3fcbb34342243b047606ed321b5cca0d766c1d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fab471036928f4683c73761b6f9878b3dcf01946a1f704506996df5949ca06d5ef75680c39cb9feef5348bbe3dbb27ae8aea87111c7f9becadec51e574120e95", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e0e47227a436bec96d36a7b5c2651011ad00bce39bba0eeb7bf08eea66471138df2d74305a1454c250a380a303904a610c5d4b5e29f8c99e57858a856b3b4a02", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66ce3ff171412bbce9183624d8523d6b7ebd7888e29f4a16f98d40d6b3c660b0193445c6c82ce81a572f5b43c190cf8faeb5aba3c30a375ac4580a2ad2346a1e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-31 10:09:36.792580) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 10:09:36.792884) ========= 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=3836458cccd887f2d2de3cf1000001de-1501519625.521125-1167683589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004449 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 10:09:36.876107) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-31 10:09:36.876482) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-31 10:09:36.876773) ========= ========= Total master_lag: 0.17 =========