builder: cedar_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-023 starttime: 1501508456.02 results: success (0) revision: 795b4eb792c928d5221a9dc9c6d505b49454d4cc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-31 06:40:56.016784) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-31 06:40:56.017191) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-31 06:40:56.017773) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-31 06:40:56.050860) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 06:40:56.051120) ========= 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=6d15e502d8e29d5d2676d664000001c3-1501508409.165673-1389218230 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-31 06:40:56-- 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% 24.0M=0s 2017-07-31 06:40:56 (24.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.112476 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 06:40:56.196506) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 06:40:56.198821) ========= 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=6d15e502d8e29d5d2676d664000001c3-1501508409.165673-1389218230 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020275 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 06:40:56.255807) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-07-31 06:40:56.256144) ========= bash -c 'python archiver_client.py mozharness --repo projects/cedar --rev 795b4eb792c928d5221a9dc9c6d505b49454d4cc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo projects/cedar --rev 795b4eb792c928d5221a9dc9c6d505b49454d4cc --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=6d15e502d8e29d5d2676d664000001c3-1501508409.165673-1389218230 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-31 06:40:56,443 truncating revision to first 12 chars 2017-07-31 06:40:56,443 Setting DEBUG logging. 2017-07-31 06:40:56,443 attempt 1/10 2017-07-31 06:40:56,443 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/cedar/795b4eb792c9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-31 06:40:57,395 attempt 1/10 2017-07-31 06:40:57,968 current task status: no status available at this point. state: STARTED 2017-07-31 06:40:57,969 sleeping for 9.00s (attempt 1/10) 2017-07-31 06:41:06,978 attempt 2/10 2017-07-31 06:41:07,307 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-07-31 06:41:07,521 unpacking tar archive at: cedar-795b4eb792c9/testing/mozharness/ program finished with exit code 0 elapsedTime=11.395885 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-07-31 06:41:07.670984) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-31 06:41:07.671325) ========= script_repo_revision: 795b4eb792c928d5221a9dc9c6d505b49454d4cc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-31 06:41:07.671716) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-31 06:41:07.672024) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-31 06:41:07.680933) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-07-31 06:41:07.681240) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Cedar --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 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', 'Cedar', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Cedar'] 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=6d15e502d8e29d5d2676d664000001c3-1501508409.165673-1389218230 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:41:07 INFO - MultiFileLogger online at 20170731 06:41:07 in /builds/slave/test 06:41:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Cedar --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 06:41:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:41:07 INFO - {'append_to_log': False, 06:41:07 INFO - 'base_work_dir': '/builds/slave/test', 06:41:07 INFO - 'blob_upload_branch': 'Cedar', 06:41:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:41:07 INFO - 'branch': 'Cedar', 06:41:07 INFO - 'buildbot_json_path': 'buildprops.json', 06:41:07 INFO - 'code_coverage': False, 06:41:07 INFO - 'config_files': ('talos/linux_config.py',), 06:41:07 INFO - 'default_actions': ('clobber', 06:41:07 INFO - 'read-buildbot-config', 06:41:07 INFO - 'download-and-extract', 06:41:07 INFO - 'populate-webroot', 06:41:07 INFO - 'create-virtualenv', 06:41:07 INFO - 'install', 06:41:07 INFO - 'setup-mitmproxy', 06:41:07 INFO - 'run-tests'), 06:41:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:41:07 INFO - 'disable_ccov_upload': False, 06:41:07 INFO - 'download_minidump_stackwalk': True, 06:41:07 INFO - 'download_symbols': 'ondemand', 06:41:07 INFO - 'enable_stylo': False, 06:41:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:41:07 INFO - 'tooltool.py': '/tools/tooltool.py', 06:41:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:41:07 INFO - '/tools/misc-python/virtualenv.py')}, 06:41:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:41:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:41:07 INFO - 'gecko_profile': False, 06:41:07 INFO - 'gecko_profile_interval': 0, 06:41:07 INFO - 'installer_path': 'installer.exe', 06:41:07 INFO - 'log_level': 'info', 06:41:07 INFO - 'log_name': 'talos', 06:41:07 INFO - 'log_to_console': True, 06:41:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:41:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:41:07 INFO - 'opt_config_files': (), 06:41:07 INFO - 'pip_index': False, 06:41:07 INFO - 'suite': 'dromaeojs-e10s', 06:41:07 INFO - 'system_bits': '32', 06:41:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:41:07 INFO - 'title': 'talos-linux64-ix-023', 06:41:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:41:07 INFO - 'use_talos_json': True, 06:41:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:41:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:41:07 INFO - 'work_dir': 'build'} 06:41:07 INFO - [mozharness: 2017-07-31 13:41:07.969799Z] Running clobber step. 06:41:07 INFO - Running pre-action listener: _resource_record_pre_action 06:41:07 INFO - Running main action method: clobber 06:41:07 INFO - rmtree: /builds/slave/test/build 06:41:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:41:09 INFO - Running post-action listener: _resource_record_post_action 06:41:09 INFO - [mozharness: 2017-07-31 13:41:09.526826Z] Finished clobber step (success) 06:41:09 INFO - [mozharness: 2017-07-31 13:41:09.526928Z] Running read-buildbot-config step. 06:41:09 INFO - Running pre-action listener: _resource_record_pre_action 06:41:09 INFO - Running main action method: read_buildbot_config 06:41:09 INFO - Using buildbot properties: 06:41:09 INFO - { 06:41:09 INFO - "project": "", 06:41:09 INFO - "product": "firefox", 06:41:09 INFO - "who": "mconley@mozilla.com", 06:41:09 INFO - "installer_path": "public/build/target.tar.bz2", 06:41:09 INFO - "builddir": "cedar_ubuntu64_hw_test-dromaeojs-e10s", 06:41:09 INFO - "repository": "https://hg.mozilla.org/projects/cedar", 06:41:09 INFO - "buildername": "Ubuntu HW 12.04 x64 cedar talos dromaeojs-e10s", 06:41:09 INFO - "stage_platform": "linux64", 06:41:09 INFO - "basedir": "/builds/slave/test", 06:41:09 INFO - "buildnumber": 2, 06:41:09 INFO - "platform": "ubuntu64_hw", 06:41:09 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:41:09 INFO - "slavebuilddir": "test", 06:41:09 INFO - "taskId": "LJzLScJaSMerMBsbiuh7fw", 06:41:09 INFO - "branch": "cedar", 06:41:09 INFO - "script_repo_revision": "default", 06:41:09 INFO - "revision": "795b4eb792c928d5221a9dc9c6d505b49454d4cc", 06:41:09 INFO - "slavename": "talos-linux64-ix-023", 06:41:09 INFO - "repo_path": "projects/cedar" 06:41:09 INFO - } 06:41:09 INFO - Finding installer, test and symbols from parent task. 06:41:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LJzLScJaSMerMBsbiuh7fw'}, attempt #1 06:41:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LJzLScJaSMerMBsbiuh7fw'}, attempt #1 06:41:10 INFO - Task dependencies: IOZBrifhSf2vs-92s6FmwQ 06:41:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IOZBrifhSf2vs-92s6FmwQ'}, attempt #1 06:41:10 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/IOZBrifhSf2vs-92s6FmwQ/artifacts/public/build/target.tar.bz2 06:41:10 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/IOZBrifhSf2vs-92s6FmwQ/artifacts/public/build/target.test_packages.json 06:41:10 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/IOZBrifhSf2vs-92s6FmwQ/artifacts/public/build/target.crashreporter-symbols.zip 06:41:10 INFO - Running post-action listener: _resource_record_post_action 06:41:10 INFO - [mozharness: 2017-07-31 13:41:10.897328Z] Finished read-buildbot-config step (success) 06:41:10 INFO - [mozharness: 2017-07-31 13:41:10.897549Z] Running download-and-extract step. 06:41:10 INFO - Running pre-action listener: _resource_record_pre_action 06:41:10 INFO - Running main action method: download_and_extract 06:41:10 INFO - mkdir: /builds/slave/test/build/tests 06:41: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')]} 06:41:10 INFO - trying https://queue.taskcluster.net/v1/task/IOZBrifhSf2vs-92s6FmwQ/artifacts/public/build/target.test_packages.json 06:41:10 INFO - Downloading https://queue.taskcluster.net/v1/task/IOZBrifhSf2vs-92s6FmwQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:41:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IOZBrifhSf2vs-92s6FmwQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:41:11 INFO - Downloaded 989 bytes. 06:41:11 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:41:11 INFO - Using the following test package requirements: 06:41:11 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 06:41:11 INFO - u'common': [u'target.common.tests.zip'], 06:41:11 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:41:11 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:41:11 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:41:11 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:41:11 INFO - u'mozbase': [u'target.common.tests.zip'], 06:41:11 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:41:11 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:41:11 INFO - u'web-platform': [u'target.common.tests.zip', 06:41:11 INFO - u'target.web-platform.tests.tar.gz'], 06:41:11 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:41:11 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:41:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IOZBrifhSf2vs-92s6FmwQ/artifacts/public/build/target.common.tests.zip 06:41:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IOZBrifhSf2vs-92s6FmwQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:41:11 INFO - Fetch https://queue.taskcluster.net/v1/task/IOZBrifhSf2vs-92s6FmwQ/artifacts/public/build/target.common.tests.zip into memory 06:41:12 INFO - Content-Length response header: 72389929 06:41:12 INFO - Bytes received: 72389929 06:41:23 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:41:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IOZBrifhSf2vs-92s6FmwQ/artifacts/public/build/target.common.tests.zip 06:41:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IOZBrifhSf2vs-92s6FmwQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:41:23 INFO - Fetch https://queue.taskcluster.net/v1/task/IOZBrifhSf2vs-92s6FmwQ/artifacts/public/build/target.common.tests.zip into memory 06:41:24 INFO - Content-Length response header: 72389929 06:41:24 INFO - Bytes received: 72389929 06:41:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IOZBrifhSf2vs-92s6FmwQ/artifacts/public/build/target.talos.tests.zip 06:41:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IOZBrifhSf2vs-92s6FmwQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:41:37 INFO - Fetch https://queue.taskcluster.net/v1/task/IOZBrifhSf2vs-92s6FmwQ/artifacts/public/build/target.talos.tests.zip into memory 06:41:38 INFO - Content-Length response header: 14496686 06:41:38 INFO - Bytes received: 14496686 06:41:38 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')]} 06:41:38 INFO - trying https://queue.taskcluster.net/v1/task/IOZBrifhSf2vs-92s6FmwQ/artifacts/public/build/target.tar.bz2 06:41:38 INFO - Downloading https://queue.taskcluster.net/v1/task/IOZBrifhSf2vs-92s6FmwQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:41:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IOZBrifhSf2vs-92s6FmwQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:41:40 INFO - Downloaded 62241928 bytes. 06:41:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IOZBrifhSf2vs-92s6FmwQ/artifacts/public/build/target.tar.bz2 06:41:40 INFO - mkdir: /builds/slave/test/properties 06:41:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:41:40 INFO - Writing to file /builds/slave/test/properties/build_url 06:41:40 INFO - Contents: 06:41:40 INFO - build_url:https://queue.taskcluster.net/v1/task/IOZBrifhSf2vs-92s6FmwQ/artifacts/public/build/target.tar.bz2 06:41:40 INFO - Running post-action listener: _resource_record_post_action 06:41:40 INFO - Running post-action listener: set_extra_try_arguments 06:41:40 INFO - [mozharness: 2017-07-31 13:41:40.310200Z] Finished download-and-extract step (success) 06:41:40 INFO - [mozharness: 2017-07-31 13:41:40.310298Z] Running populate-webroot step. 06:41:40 INFO - Running pre-action listener: _resource_record_pre_action 06:41:40 INFO - Running main action method: populate_webroot 06:41:40 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:41:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:41:40 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:41:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:41:40 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:41:40 INFO - 'tests': ['damp', 'tps']}, 06:41:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:41:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 06:41:40 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 06:41:40 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 06:41:40 INFO - 'other-e10s': {'tests': ['a11yr', 06:41:40 INFO - 'ts_paint', 06:41:40 INFO - 'tpaint', 06:41:40 INFO - 'sessionrestore', 06:41:40 INFO - 'sessionrestore_many_windows', 06:41:40 INFO - 'sessionrestore_no_auto_restore', 06:41:40 INFO - 'tabpaint']}, 06:41:40 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 06:41:40 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 06:41:40 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 06:41:40 INFO - 'talos_options': ['--mitmproxy', 06:41:40 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 06:41:40 INFO - '--firstNonBlankPaint'], 06:41:40 INFO - 'tests': ['quantum_pageload_google', 06:41:40 INFO - 'quantum_pageload_youtube', 06:41:40 INFO - 'quantum_pageload_amazon', 06:41:40 INFO - 'quantum_pageload_facebook']}, 06:41:40 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 06:41:40 INFO - 'talos_options': ['--stylo', 06:41:40 INFO - '--mitmproxy', 06:41:40 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 06:41:40 INFO - '--firstNonBlankPaint'], 06:41:40 INFO - 'tests': ['quantum_pageload_google', 06:41:40 INFO - 'quantum_pageload_youtube', 06:41:40 INFO - 'quantum_pageload_amazon', 06:41:40 INFO - 'quantum_pageload_facebook']}, 06:41:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:41:40 INFO - 'tsvgr_opacity', 06:41:40 INFO - 'tart', 06:41:40 INFO - 'tscrollx', 06:41:40 INFO - 'cart', 06:41:40 INFO - 'tsvg_static']}, 06:41:40 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:41:40 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 06:41:40 INFO - 'talos_options': ['--stylo', 06:41:40 INFO - '--stylo-threads=1', 06:41:40 INFO - '--mitmproxy', 06:41:40 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 06:41:40 INFO - '--firstNonBlankPaint'], 06:41:40 INFO - 'tests': ['tp6_google', 06:41:40 INFO - 'tp6_youtube', 06:41:40 INFO - 'tp6_amazon', 06:41:40 INFO - 'tp6_facebook']}, 06:41:40 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:41:40 INFO - 'talos_options': ['--xperf_path', 06:41:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:41:40 INFO - 'tests': ['tp5n']}}} 06:41:40 INFO - Running post-action listener: _resource_record_post_action 06:41:40 INFO - [mozharness: 2017-07-31 13:41:40.318952Z] Finished populate-webroot step (success) 06:41:40 INFO - [mozharness: 2017-07-31 13:41:40.319043Z] Running create-virtualenv step. 06:41:40 INFO - Running pre-action listener: _resource_record_pre_action 06:41:40 INFO - Running main action method: create_virtualenv 06:41:40 INFO - Creating virtualenv /builds/slave/test/build/venv 06:41:40 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 06:41:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:41:40 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 06:41:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:41:40 INFO - Using real prefix '/usr' 06:41:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:41:40 INFO - Installing distribute.............................................................................................................................................................................................done. 06:41:42 INFO - Installing pip.................done. 06:41:42 INFO - Return code: 0 06:41:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:41:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:41:43 INFO - Reading from file tmpfile_stdout 06:41:43 INFO - Output received: 06:41:43 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) 06:41:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:41:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:43 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 0xb941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd60a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf03d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf00eb0>, '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 0xf01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf02240>, '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': '6d15e502d8e29d5d2676d664000001c3-1501508409.165673-1389218230', '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 06:41:43 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 06:41:43 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 06:41:43 INFO - Using env: {'DISPLAY': ':0', 06:41:43 INFO - 'HOME': '/home/cltbld', 06:41:43 INFO - 'LANG': 'en_US.UTF-8', 06:41:43 INFO - 'LANGUAGE': 'en_US:en', 06:41:43 INFO - 'LOGNAME': 'cltbld', 06:41:43 INFO - 'MAIL': '/var/mail/cltbld', 06:41:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:43 INFO - 'MOZ_NO_REMOTE': '1', 06:41:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:43 INFO - 'NO_EM_RESTART': '1', 06:41:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:43 INFO - 'PWD': '/builds/slave/test', 06:41:43 INFO - 'SHELL': '/bin/bash', 06:41:43 INFO - 'SHLVL': '1', 06:41:43 INFO - 'TERM': 'linux', 06:41:43 INFO - 'TMOUT': '86400', 06:41:43 INFO - 'USER': 'cltbld', 06:41:43 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1501508409.165673-1389218230', 06:41:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:43 INFO - '_': '/tools/buildbot/bin/python'} 06:41:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:43 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 06:41:43 INFO - Cleaning up... 06:41:43 INFO - Return code: 0 06:41:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:41:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:43 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 0xb941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd60a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf03d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf00eb0>, '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 0xf01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf02240>, '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': '6d15e502d8e29d5d2676d664000001c3-1501508409.165673-1389218230', '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 06:41:43 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 06:41:43 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 06:41:43 INFO - Using env: {'DISPLAY': ':0', 06:41:43 INFO - 'HOME': '/home/cltbld', 06:41:43 INFO - 'LANG': 'en_US.UTF-8', 06:41:43 INFO - 'LANGUAGE': 'en_US:en', 06:41:43 INFO - 'LOGNAME': 'cltbld', 06:41:43 INFO - 'MAIL': '/var/mail/cltbld', 06:41:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:43 INFO - 'MOZ_NO_REMOTE': '1', 06:41:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:43 INFO - 'NO_EM_RESTART': '1', 06:41:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:43 INFO - 'PWD': '/builds/slave/test', 06:41:43 INFO - 'SHELL': '/bin/bash', 06:41:43 INFO - 'SHLVL': '1', 06:41:43 INFO - 'TERM': 'linux', 06:41:43 INFO - 'TMOUT': '86400', 06:41:43 INFO - 'USER': 'cltbld', 06:41:43 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1501508409.165673-1389218230', 06:41:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:43 INFO - '_': '/tools/buildbot/bin/python'} 06:41:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:43 INFO - Downloading/unpacking psutil>=3.1.1 06:41:43 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 06:41:43 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 06:41:43 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 06:41:43 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 06:41:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:41:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:41:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:41:44 INFO - Installing collected packages: psutil 06:41:44 INFO - Running setup.py install for psutil 06:41:44 INFO - building 'psutil._psutil_linux' extension 06:41:44 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 06:41:44 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 06:41:44 INFO - building 'psutil._psutil_posix' extension 06:41:44 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 06:41:45 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 06:41:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:41:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:41:45 INFO - Successfully installed psutil 06:41:45 INFO - Cleaning up... 06:41:45 INFO - Return code: 0 06:41:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:41: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')]} 06:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41: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')]} 06:41:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd60a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf03d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf00eb0>, '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 0xf01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf02240>, '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': '6d15e502d8e29d5d2676d664000001c3-1501508409.165673-1389218230', '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 06:41:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:41:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:41:45 INFO - Using env: {'DISPLAY': ':0', 06:41:45 INFO - 'HOME': '/home/cltbld', 06:41:45 INFO - 'LANG': 'en_US.UTF-8', 06:41:45 INFO - 'LANGUAGE': 'en_US:en', 06:41:45 INFO - 'LOGNAME': 'cltbld', 06:41:45 INFO - 'MAIL': '/var/mail/cltbld', 06:41:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:45 INFO - 'MOZ_NO_REMOTE': '1', 06:41:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:45 INFO - 'NO_EM_RESTART': '1', 06:41:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:45 INFO - 'PWD': '/builds/slave/test', 06:41:45 INFO - 'SHELL': '/bin/bash', 06:41:45 INFO - 'SHLVL': '1', 06:41:45 INFO - 'TERM': 'linux', 06:41:45 INFO - 'TMOUT': '86400', 06:41:45 INFO - 'USER': 'cltbld', 06:41:45 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1501508409.165673-1389218230', 06:41:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:45 INFO - '_': '/tools/buildbot/bin/python'} 06:41:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:41:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:41:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:41:46 INFO - Installing collected packages: mozsystemmonitor 06:41:46 INFO - Running setup.py install for mozsystemmonitor 06:41:46 INFO - Successfully installed mozsystemmonitor 06:41:46 INFO - Cleaning up... 06:41:46 INFO - Return code: 0 06:41:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:41:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xb941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd60a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf03d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf00eb0>, '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 0xf01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf02240>, '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': '6d15e502d8e29d5d2676d664000001c3-1501508409.165673-1389218230', '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 06:41:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:41:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:41:46 INFO - Using env: {'DISPLAY': ':0', 06:41:46 INFO - 'HOME': '/home/cltbld', 06:41:46 INFO - 'LANG': 'en_US.UTF-8', 06:41:46 INFO - 'LANGUAGE': 'en_US:en', 06:41:46 INFO - 'LOGNAME': 'cltbld', 06:41:46 INFO - 'MAIL': '/var/mail/cltbld', 06:41:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:46 INFO - 'MOZ_NO_REMOTE': '1', 06:41:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:46 INFO - 'NO_EM_RESTART': '1', 06:41:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:46 INFO - 'PWD': '/builds/slave/test', 06:41:46 INFO - 'SHELL': '/bin/bash', 06:41:46 INFO - 'SHLVL': '1', 06:41:46 INFO - 'TERM': 'linux', 06:41:46 INFO - 'TMOUT': '86400', 06:41:46 INFO - 'USER': 'cltbld', 06:41:46 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1501508409.165673-1389218230', 06:41:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:46 INFO - '_': '/tools/buildbot/bin/python'} 06:41:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:46 INFO - Downloading/unpacking jsonschema==2.5.1 06:41:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:41:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:41:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:48 INFO - Downloading functools32-3.2.3-2.tar.gz 06:41:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:41:48 INFO - warning: no files found matching '*.txt' 06:41:48 INFO - no previously-included directories found matching 'build' 06:41:48 INFO - no previously-included directories found matching 'dist' 06:41:48 INFO - no previously-included directories found matching '.git*' 06:41:48 INFO - Installing collected packages: jsonschema, functools32 06:41:48 INFO - Running setup.py install for functools32 06:41:48 INFO - warning: no files found matching '*.txt' 06:41:48 INFO - no previously-included directories found matching 'build' 06:41:48 INFO - no previously-included directories found matching 'dist' 06:41:48 INFO - no previously-included directories found matching '.git*' 06:41:48 INFO - Successfully installed jsonschema functools32 06:41:48 INFO - Cleaning up... 06:41:48 INFO - Return code: 0 06:41:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:41:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xb941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd60a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf03d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf00eb0>, '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 0xf01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf02240>, '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': '6d15e502d8e29d5d2676d664000001c3-1501508409.165673-1389218230', '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 06:41:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:41:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:41:48 INFO - Using env: {'DISPLAY': ':0', 06:41:48 INFO - 'HOME': '/home/cltbld', 06:41:48 INFO - 'LANG': 'en_US.UTF-8', 06:41:48 INFO - 'LANGUAGE': 'en_US:en', 06:41:48 INFO - 'LOGNAME': 'cltbld', 06:41:48 INFO - 'MAIL': '/var/mail/cltbld', 06:41:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:48 INFO - 'MOZ_NO_REMOTE': '1', 06:41:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:48 INFO - 'NO_EM_RESTART': '1', 06:41:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:48 INFO - 'PWD': '/builds/slave/test', 06:41:48 INFO - 'SHELL': '/bin/bash', 06:41:48 INFO - 'SHLVL': '1', 06:41:48 INFO - 'TERM': 'linux', 06:41:48 INFO - 'TMOUT': '86400', 06:41:48 INFO - 'USER': 'cltbld', 06:41:48 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1501508409.165673-1389218230', 06:41:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:48 INFO - '_': '/tools/buildbot/bin/python'} 06:41:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:41:48 INFO - Cleaning up... 06:41:48 INFO - Return code: 0 06:41:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:41:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xb941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd60a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf03d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf00eb0>, '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 0xf01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf02240>, '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': '6d15e502d8e29d5d2676d664000001c3-1501508409.165673-1389218230', '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 06:41:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:41:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:41:48 INFO - Using env: {'DISPLAY': ':0', 06:41:48 INFO - 'HOME': '/home/cltbld', 06:41:48 INFO - 'LANG': 'en_US.UTF-8', 06:41:48 INFO - 'LANGUAGE': 'en_US:en', 06:41:48 INFO - 'LOGNAME': 'cltbld', 06:41:48 INFO - 'MAIL': '/var/mail/cltbld', 06:41:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:48 INFO - 'MOZ_NO_REMOTE': '1', 06:41:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:48 INFO - 'NO_EM_RESTART': '1', 06:41:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:48 INFO - 'PWD': '/builds/slave/test', 06:41:48 INFO - 'SHELL': '/bin/bash', 06:41:48 INFO - 'SHLVL': '1', 06:41:48 INFO - 'TERM': 'linux', 06:41:48 INFO - 'TMOUT': '86400', 06:41:48 INFO - 'USER': 'cltbld', 06:41:48 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1501508409.165673-1389218230', 06:41:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:48 INFO - '_': '/tools/buildbot/bin/python'} 06:41:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:48 INFO - Downloading/unpacking blobuploader==1.2.4 06:41:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:49 INFO - Downloading blobuploader-1.2.4.tar.gz 06:41:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:41:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:41:49 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 06:41:49 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 06:41:49 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 06:41:49 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 06:41:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:41:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:41:50 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 06:41:50 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 06:41:50 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 06:41:50 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 06:41:50 INFO - Downloading docopt-0.6.1.tar.gz 06:41:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:41:50 INFO - Installing collected packages: blobuploader, requests, docopt 06:41:50 INFO - Running setup.py install for blobuploader 06:41:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:41:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:41:50 INFO - Running setup.py install for requests 06:41:50 INFO - Running setup.py install for docopt 06:41:51 INFO - Successfully installed blobuploader requests docopt 06:41:51 INFO - Cleaning up... 06:41:51 INFO - Return code: 0 06:41:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:41:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:51 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 0xb941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd60a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf03d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf00eb0>, '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 0xf01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf02240>, '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': '6d15e502d8e29d5d2676d664000001c3-1501508409.165673-1389218230', '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 06:41:51 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 06:41:51 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 06:41:51 INFO - Using env: {'DISPLAY': ':0', 06:41:51 INFO - 'HOME': '/home/cltbld', 06:41:51 INFO - 'LANG': 'en_US.UTF-8', 06:41:51 INFO - 'LANGUAGE': 'en_US:en', 06:41:51 INFO - 'LOGNAME': 'cltbld', 06:41:51 INFO - 'MAIL': '/var/mail/cltbld', 06:41:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:51 INFO - 'MOZ_NO_REMOTE': '1', 06:41:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:51 INFO - 'NO_EM_RESTART': '1', 06:41:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:51 INFO - 'PWD': '/builds/slave/test', 06:41:51 INFO - 'SHELL': '/bin/bash', 06:41:51 INFO - 'SHLVL': '1', 06:41:51 INFO - 'TERM': 'linux', 06:41:51 INFO - 'TMOUT': '86400', 06:41:51 INFO - 'USER': 'cltbld', 06:41:51 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1501508409.165673-1389218230', 06:41:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:51 INFO - '_': '/tools/buildbot/bin/python'} 06:41:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:41:51 INFO - Running setup.py (path:/tmp/pip-Xbl_O_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:41:51 INFO - Running setup.py (path:/tmp/pip-DHAP9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:41:51 INFO - Running setup.py (path:/tmp/pip-_I2iDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:41:51 INFO - Running setup.py (path:/tmp/pip-Xdy4VW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:41:51 INFO - Running setup.py (path:/tmp/pip-_Zn80A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:41:51 INFO - Running setup.py (path:/tmp/pip-UYjKF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:41:51 INFO - Running setup.py (path:/tmp/pip-RgFRtM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:41:51 INFO - Running setup.py (path:/tmp/pip-vqPlTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:41:51 INFO - Running setup.py (path:/tmp/pip-1hyfQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:41:51 INFO - Running setup.py (path:/tmp/pip-yTtEJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:41:52 INFO - Running setup.py (path:/tmp/pip-tv5mYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:41:52 INFO - Running setup.py (path:/tmp/pip-6Ivr2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:41:52 INFO - Running setup.py (path:/tmp/pip-8MB5tY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:41:52 INFO - Running setup.py (path:/tmp/pip-E2f0Ko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:41:52 INFO - Running setup.py (path:/tmp/pip-q7Lh8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:41:52 INFO - Running setup.py (path:/tmp/pip-UBabJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:41:52 INFO - Running setup.py (path:/tmp/pip-czKX8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:41:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:41:52 INFO - Running setup.py install for manifestparser 06:41:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:41:52 INFO - Running setup.py install for mozcrash 06:41:52 INFO - Running setup.py install for mozdebug 06:41:52 INFO - Running setup.py install for mozdevice 06:41:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:41:52 INFO - Running setup.py install for mozfile 06:41:53 INFO - Running setup.py install for mozhttpd 06:41:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:41:53 INFO - Running setup.py install for mozinfo 06:41:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:41:53 INFO - Running setup.py install for mozInstall 06:41:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:41:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:41:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:41:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:41:53 INFO - Running setup.py install for mozleak 06:41:53 INFO - Running setup.py install for mozlog 06:41:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:41:53 INFO - Running setup.py install for moznetwork 06:41:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:41:53 INFO - Running setup.py install for mozprocess 06:41:53 INFO - Running setup.py install for mozprofile 06:41:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:41:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:41:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:41:53 INFO - Running setup.py install for mozrunner 06:41:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:41:53 INFO - Running setup.py install for mozscreenshot 06:41:54 INFO - Running setup.py install for moztest 06:41:54 INFO - Running setup.py install for mozversion 06:41:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:41:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:41:54 INFO - Cleaning up... 06:41:54 INFO - Return code: 0 06:41:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:41:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:54 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 0xb941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd60a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf03d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf00eb0>, '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 0xf01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf02240>, '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': '6d15e502d8e29d5d2676d664000001c3-1501508409.165673-1389218230', '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 06:41:54 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 06:41:54 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 06:41:54 INFO - Using env: {'DISPLAY': ':0', 06:41:54 INFO - 'HOME': '/home/cltbld', 06:41:54 INFO - 'LANG': 'en_US.UTF-8', 06:41:54 INFO - 'LANGUAGE': 'en_US:en', 06:41:54 INFO - 'LOGNAME': 'cltbld', 06:41:54 INFO - 'MAIL': '/var/mail/cltbld', 06:41:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:54 INFO - 'MOZ_NO_REMOTE': '1', 06:41:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:54 INFO - 'NO_EM_RESTART': '1', 06:41:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:54 INFO - 'PWD': '/builds/slave/test', 06:41:54 INFO - 'SHELL': '/bin/bash', 06:41:54 INFO - 'SHLVL': '1', 06:41:54 INFO - 'TERM': 'linux', 06:41:54 INFO - 'TMOUT': '86400', 06:41:54 INFO - 'USER': 'cltbld', 06:41:54 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1501508409.165673-1389218230', 06:41:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:54 INFO - '_': '/tools/buildbot/bin/python'} 06:41:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:41:54 INFO - Running setup.py (path:/tmp/pip-LRGOc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:41:54 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)) 06:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:41:54 INFO - Running setup.py (path:/tmp/pip-HVmQUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:41:54 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)) 06:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:41:54 INFO - Running setup.py (path:/tmp/pip-4r4gIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:41:54 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)) 06:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:41:54 INFO - Running setup.py (path:/tmp/pip-ZcLmcm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:41:54 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)) 06:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:41:54 INFO - Running setup.py (path:/tmp/pip-Uxfe3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:41:54 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)) 06:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:41:54 INFO - Running setup.py (path:/tmp/pip-hxPvoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:41:54 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)) 06:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:41:54 INFO - Running setup.py (path:/tmp/pip-Nm3Gqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:41:55 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)) 06:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:41:55 INFO - Running setup.py (path:/tmp/pip-HV6E_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:41:55 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)) 06:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:41:55 INFO - Running setup.py (path:/tmp/pip-hPiYjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:41:55 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)) 06:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:41:55 INFO - Running setup.py (path:/tmp/pip-TK3D2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:41:55 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)) 06:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:41:55 INFO - Running setup.py (path:/tmp/pip-GiGTrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:41:55 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)) 06:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:41:55 INFO - Running setup.py (path:/tmp/pip-rhJ7tr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:41:55 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)) 06:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:41:55 INFO - Running setup.py (path:/tmp/pip-fLGrpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:41:55 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)) 06:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:41:55 INFO - Running setup.py (path:/tmp/pip-h7cwgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:41:55 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)) 06:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:41:55 INFO - Running setup.py (path:/tmp/pip-l8F2Hw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:41:55 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)) 06:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:41:55 INFO - Running setup.py (path:/tmp/pip-g4a6mQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:41:55 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)) 06:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:41:55 INFO - Running setup.py (path:/tmp/pip-PLUm2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:41:55 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)) 06:41:55 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)) 06:41:55 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)) 06:41:55 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)) 06:41:55 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)) 06:41:55 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)) 06:41:55 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)) 06:41:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:56 INFO - Downloading blessings-1.6.tar.gz 06:41:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:41:56 INFO - Installing collected packages: blessings 06:41:56 INFO - Running setup.py install for blessings 06:41:57 INFO - Successfully installed blessings 06:41:57 INFO - Cleaning up... 06:41:57 INFO - Return code: 0 06:41:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:41:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:41:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:41:57 INFO - Reading from file tmpfile_stdout 06:41:57 INFO - Current package versions: 06:41:57 INFO - argparse == 1.2.1 06:41:57 INFO - blessings == 1.6 06:41:57 INFO - blobuploader == 1.2.4 06:41:57 INFO - docopt == 0.6.1 06:41:57 INFO - functools32 == 3.2.3-2 06:41:57 INFO - jsonschema == 2.5.1 06:41:57 INFO - manifestparser == 1.1 06:41:57 INFO - mozInstall == 1.13 06:41:57 INFO - mozcrash == 1.0 06:41:57 INFO - mozdebug == 0.1 06:41:57 INFO - mozdevice == 0.51 06:41:57 INFO - mozfile == 1.2 06:41:57 INFO - mozhttpd == 0.7 06:41:57 INFO - mozinfo == 0.10 06:41:57 INFO - mozleak == 0.1 06:41:57 INFO - mozlog == 3.5 06:41:57 INFO - moznetwork == 0.27 06:41:57 INFO - mozprocess == 0.25 06:41:57 INFO - mozprofile == 0.28 06:41:57 INFO - mozrunner == 6.13 06:41:57 INFO - mozscreenshot == 0.1 06:41:57 INFO - mozsystemmonitor == 0.3 06:41:57 INFO - moztest == 0.8 06:41:57 INFO - mozversion == 1.4 06:41:57 INFO - psutil == 3.1.1 06:41:57 INFO - requests == 1.2.3 06:41:57 INFO - wsgiref == 0.1.2 06:41:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:41:57 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')]} 06:41:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:57 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')]} 06:41:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:57 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 0xb941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd60a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf03d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf00eb0>, '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 0xf01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf02240>, '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': '6d15e502d8e29d5d2676d664000001c3-1501508409.165673-1389218230', '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 06:41:57 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 06:41:57 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 06:41:57 INFO - Using env: {'DISPLAY': ':0', 06:41:57 INFO - 'HOME': '/home/cltbld', 06:41:57 INFO - 'LANG': 'en_US.UTF-8', 06:41:57 INFO - 'LANGUAGE': 'en_US:en', 06:41:57 INFO - 'LOGNAME': 'cltbld', 06:41:57 INFO - 'MAIL': '/var/mail/cltbld', 06:41:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:57 INFO - 'MOZ_NO_REMOTE': '1', 06:41:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:57 INFO - 'NO_EM_RESTART': '1', 06:41:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:57 INFO - 'PWD': '/builds/slave/test', 06:41:57 INFO - 'SHELL': '/bin/bash', 06:41:57 INFO - 'SHLVL': '1', 06:41:57 INFO - 'TERM': 'linux', 06:41:57 INFO - 'TMOUT': '86400', 06:41:57 INFO - 'USER': 'cltbld', 06:41:57 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1501508409.165673-1389218230', 06:41:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:57 INFO - '_': '/tools/buildbot/bin/python'} 06:41:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:57 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)) 06:41:57 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)) 06:41:57 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)) 06:41:57 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)) 06:41:57 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)) 06:41:57 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)) 06:41:57 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)) 06:41:57 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)) 06:41:57 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)) 06:41:57 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 06:41:57 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 06:41:57 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 06:41:57 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 06:41:57 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 06:41:58 INFO - Downloading marionette_driver-1.4.0.tar.gz 06:41:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 06:41:58 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 06:41:58 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 06:41:58 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 06:41:58 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 06:41:58 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 06:41:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 06:41:58 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)) 06:41:58 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)) 06:41:58 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)) 06:41:58 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)) 06:41:58 INFO - Installing collected packages: marionette-driver, simplejson 06:41:58 INFO - Running setup.py install for marionette-driver 06:41:59 INFO - Running setup.py install for simplejson 06:41:59 INFO - building 'simplejson._speedups' extension 06:41:59 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 06:41:59 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 06:42:00 INFO - Successfully installed marionette-driver simplejson 06:42:00 INFO - Cleaning up... 06:42:00 INFO - Return code: 0 06:42:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:42:00 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')]} 06:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42:00 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')]} 06:42:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42:00 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 0xb941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd60a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf03d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf00eb0>, '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 0xf01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf02240>, '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': '6d15e502d8e29d5d2676d664000001c3-1501508409.165673-1389218230', '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 06:42:00 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 06:42:00 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 06:42:00 INFO - Using env: {'DISPLAY': ':0', 06:42:00 INFO - 'HOME': '/home/cltbld', 06:42:00 INFO - 'LANG': 'en_US.UTF-8', 06:42:00 INFO - 'LANGUAGE': 'en_US:en', 06:42:00 INFO - 'LOGNAME': 'cltbld', 06:42:00 INFO - 'MAIL': '/var/mail/cltbld', 06:42:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:00 INFO - 'MOZ_NO_REMOTE': '1', 06:42:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:00 INFO - 'NO_EM_RESTART': '1', 06:42:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:00 INFO - 'PWD': '/builds/slave/test', 06:42:00 INFO - 'SHELL': '/bin/bash', 06:42:00 INFO - 'SHLVL': '1', 06:42:00 INFO - 'TERM': 'linux', 06:42:00 INFO - 'TMOUT': '86400', 06:42:00 INFO - 'USER': 'cltbld', 06:42:00 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1501508409.165673-1389218230', 06:42:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:00 INFO - '_': '/tools/buildbot/bin/python'} 06:42:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:42:00 INFO - Cleaning up... 06:42:00 INFO - Return code: 0 06:42:00 INFO - Running post-action listener: _resource_record_post_action 06:42:00 INFO - Running post-action listener: _start_resource_monitoring 06:42:00 INFO - Starting resource monitoring. 06:42:00 INFO - [mozharness: 2017-07-31 13:42:00.346309Z] Finished create-virtualenv step (success) 06:42:00 INFO - [mozharness: 2017-07-31 13:42:00.346777Z] Running install step. 06:42:00 INFO - Running pre-action listener: _resource_record_pre_action 06:42:00 INFO - Running main action method: install 06:42:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:42:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:42:00 INFO - Reading from file tmpfile_stdout 06:42:00 INFO - Detecting whether we're running mozinstall >=1.0... 06:42:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:42:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:42:00 INFO - Reading from file tmpfile_stdout 06:42:00 INFO - Output received: 06:42:00 INFO - Usage: mozinstall [options] installer 06:42:00 INFO - Options: 06:42:00 INFO - -h, --help show this help message and exit 06:42:00 INFO - -d DEST, --destination=DEST 06:42:00 INFO - Directory to install application into. [default: 06:42:00 INFO - "/builds/slave/test"] 06:42:00 INFO - --app=APP Application being installed. [default: firefox] 06:42:00 INFO - mkdir: /builds/slave/test/build/application 06:42:00 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'] 06:42:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:42:18 INFO - Reading from file tmpfile_stdout 06:42:18 INFO - Output received: 06:42:18 INFO - /builds/slave/test/build/application/firefox/firefox 06:42:18 INFO - Running post-action listener: _resource_record_post_action 06:42:18 INFO - [mozharness: 2017-07-31 13:42:18.720537Z] Finished install step (success) 06:42:18 INFO - [mozharness: 2017-07-31 13:42:18.720687Z] Running setup-mitmproxy step. 06:42:18 INFO - Running pre-action listener: _resource_record_pre_action 06:42:18 INFO - Running main action method: setup_mitmproxy 06:42:18 INFO - Skipping: mitmproxy is not required 06:42:18 INFO - Running post-action listener: _resource_record_post_action 06:42:18 INFO - [mozharness: 2017-07-31 13:42:18.721846Z] Finished setup-mitmproxy step (success) 06:42:18 INFO - [mozharness: 2017-07-31 13:42:18.722067Z] Running run-tests step. 06:42:18 INFO - Running pre-action listener: _resource_record_pre_action 06:42:18 INFO - Running pre-action listener: _set_gcov_prefix 06:42:18 INFO - Running main action method: run_tests 06:42:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:42:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:42:18 INFO - Python 2.7.3 06:42:18 INFO - Return code: 0 06:42:18 INFO - grabbing minidump binary from tooltool 06:42: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')]} 06:42:18 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 0xf00eb0>, '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 0xf01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf02240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:42:18 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 06:42:18 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 06:42:18 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 06:42:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:42:18 INFO - Return code: 0 06:42:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:42:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:42:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:42:18 INFO - ENV: RUST_BACKTRACE is now 1 06:42:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:42:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:42:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IOZBrifhSf2vs-92s6FmwQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 06:42:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Cedar --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IOZBrifhSf2vs-92s6FmwQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 06:42:18 INFO - Using env: {'DISPLAY': ':0', 06:42:18 INFO - 'HOME': '/home/cltbld', 06:42:18 INFO - 'LANG': 'en_US.UTF-8', 06:42:18 INFO - 'LANGUAGE': 'en_US:en', 06:42:18 INFO - 'LOGNAME': 'cltbld', 06:42:18 INFO - 'MAIL': '/var/mail/cltbld', 06:42:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:42:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:42:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:18 INFO - 'MOZ_NO_REMOTE': '1', 06:42:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:42:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:18 INFO - 'NO_EM_RESTART': '1', 06:42:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:18 INFO - 'PWD': '/builds/slave/test', 06:42:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:42:18 INFO - 'RUST_BACKTRACE': '1', 06:42:18 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 06:42:18 INFO - 'SHELL': '/bin/bash', 06:42:18 INFO - 'SHLVL': '1', 06:42:18 INFO - 'TERM': 'linux', 06:42:18 INFO - 'TMOUT': '86400', 06:42:18 INFO - 'USER': 'cltbld', 06:42:18 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1501508409.165673-1389218230', 06:42:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:18 INFO - '_': '/tools/buildbot/bin/python'} 06:42:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IOZBrifhSf2vs-92s6FmwQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 06:42:19 INFO - mozversion application_buildid: 20170731124427 06:42:19 INFO - mozversion application_changeset: 795b4eb792c928d5221a9dc9c6d505b49454d4cc 06:42:19 INFO - mozversion application_display_name: Nightly 06:42:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:42:19 INFO - mozversion application_name: Firefox 06:42:19 INFO - mozversion application_remotingname: firefox 06:42:19 INFO - mozversion application_repository: https://hg.mozilla.org/projects/cedar 06:42:19 INFO - mozversion application_vendor: Mozilla 06:42:19 INFO - mozversion application_version: 56.0a1 06:42:19 INFO - mozversion platform_buildid: 20170731124427 06:42:19 INFO - mozversion platform_changeset: 795b4eb792c928d5221a9dc9c6d505b49454d4cc 06:42:19 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/cedar 06:42:19 INFO - mozversion platform_version: 56.0a1 06:42:19 INFO - using testdate: 1501508539 06:42:19 INFO - actual date: 1501508539 06:42:19 INFO - starting webserver on 'localhost:38257' 06:42:19 INFO - SUITE-START | Running 2 tests 06:42:19 INFO - TEST-START | dromaeo_css 06:42:19 INFO - Initialising browser for dromaeo_css test... 06:42:19 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38257/getInfo.html -profile /tmp/tmpVGGxAi/profile 06:42:19 INFO - TEST-INFO | started process 29589 (/builds/slave/test/build/application/firefox/firefox http://localhost:38257/getInfo.html) 06:42:24 INFO - TEST-INFO | 29589: exit 0 06:42:24 INFO - Browser initialized. 06:42:24 INFO - Running cycle 1/1 for dromaeo_css test... 06:42:24 INFO - TEST-INFO | started process 29800 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVGGxAi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 06:42:25 INFO - PID 29800 | 06:42:25 INFO - PID 29800 | (/builds/slave/test/build/application/firefox/firefox:29848): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 06:42:25 INFO - PID 29800 | 06:42:36 INFO - PID 29800 | RSS: Main: 171204608 06:42:36 INFO - PID 29800 | 06:45:36 INFO - PID 29800 | Cycle 1(1): loaded http://localhost:38257/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38257/tests/dromaeo/cssquery-ext.html) 06:45:37 INFO - PID 29800 | RSS: Main: 173584384 06:45:37 INFO - PID 29800 | 06:48:39 INFO - PID 29800 | Cycle 1(1): loaded http://localhost:38257/tests/dromaeo/cssquery-ext.html (next: http://localhost:38257/tests/dromaeo/cssquery-jquery.html) 06:48:39 INFO - PID 29800 | RSS: Main: 171311104 06:48:39 INFO - PID 29800 | 06:51:41 INFO - PID 29800 | Cycle 1(1): loaded http://localhost:38257/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38257/tests/dromaeo/cssquery-mootools.html) 06:51:42 INFO - PID 29800 | RSS: Main: 173301760 06:51:42 INFO - PID 29800 | 06:54:43 INFO - PID 29800 | Cycle 1(1): loaded http://localhost:38257/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38257/tests/dromaeo/cssquery-prototype.html) 06:54:44 INFO - PID 29800 | RSS: Main: 170946560 06:54:44 INFO - PID 29800 | 06:57:48 INFO - PID 29800 | Cycle 1(1): loaded http://localhost:38257/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38257/tests/dromaeo/cssquery-yui.html) 06:57:49 INFO - PID 29800 | RSS: Main: 175288320 06:57:49 INFO - PID 29800 | 07:00:50 INFO - PID 29800 | Cycle 1(1): loaded http://localhost:38257/tests/dromaeo/cssquery-yui.html (next: http://localhost:38257/tests/dromaeo/cssquery-dojo.html) 07:00:51 INFO - PID 29800 | RSS: Main: 175788032 07:00:51 INFO - PID 29800 | 07:00:51 INFO - PID 29800 | __start_tp_report 07:00:51 INFO - PID 29800 | _x_x_mozilla_page_load 07:00:51 INFO - PID 29800 | _x_x_mozilla_page_load_details 07:00:51 INFO - PID 29800 | |i|pagename|runs| 07:00:51 INFO - PID 29800 | |0;dojo.html;3124.156477751009;3139.1053549738326;3144.072498612909;3184.1402821238266;3185.6655051219614;6088.086786981949;6264.561480696353;6288.779892703757;6289.182406287187;6300.149479820223;6103.7253323600435;6219.346968568292;6246.750129994806;6249.875002499959;6273.874522509547;5682.119271512922;5687.658740475575;5694.544436445074;5726.656400615955;5727.455891690282;5709.371969083398;5715.599908006441;5716.628419152763;5720.399358067405;5720.79977200798;5663.207150998864;5693.28833895763;5694.288213973254;5696.572757043217;5702.572307076965;5688.2605261315975;5695.202671625976;5696.743646535895;5696.743646535916;5715.628484148517;5592.804251851166;5663.830085097454;5719.656820590778;5734.168545560912;5767.33675627304;6018.337982821886;6029.698515074273;6089.147519347295;6146;6188.752449902044;6607.3392660734025;6628.370304821035;6638.701258443381;6645.235797883257;6646.966765166191;5722.62802917809;6612.477379928182;6701.497387695942;6706.161729783777;6731.495137864631;6195.938040619536;6204.782832600882;6257.655828929407;6275.843103922392;6282.591631543935;6691.431228345547;6877.65611719412;6878.65606719662;6916.757913473004;6974.128233970754;6530.836729081716;6533.869322613521;6540.2805691373915;6548.574342667712;6561.1142495763415;6586.5389422739945;6597.340265973365;6681.164854393201;6692.899606505906;6695.966520167368;6627.900581491282;6637.4026337628875;6637.435817955431;6641.103451034049;6683.598984060972;6639.701213445406;6643.5017373697165;6728.259891411941;6736.932630673728;6749.0888730020815;5314.794360340416;5340.225667278223;5380.085385484477;5388.003219404422;5388.137897936312;4586.289125185602;4608.331791890224;4628.560286772751;4646.186917289461;4650.116477869194;5689.715514224355;5743.885122297531;5781.797637082682;5785.623934444247;5792.420757924174;6696.933030669728;6707.027481015323;6710.328967103348;6719;6724.630145342053;5727.3699893011735;5804.622699524517;5814.127880817827;5818.040023396177;5837.29952405714;5756.25168728071;5816.76732930678;5832.416758324219;5843.444872737083;5898.439648233411;6336.461400780893;6341.143945567289;6348.714307856158;6399;6403.135576697179;6492.610443373413;6563.7702680405955;6570.737170513126;6581.6709164542535;6596.67016649156;6341.682915854097;6346.952752795737;6350.7142178603;6354.586951848115;6356.555041147075;6431.5819471734185;6542.34576542361;6565.080888675685;6624.337566243337;6656.900146497903;6689.899651505134;6703.899441508479;6735.191776986793;6817.420519255918;6822.488313376417;6362.872742545031;6443.355664433519;6462.0306953955405;6537.607743535403;6541.953287473982;6453.774117905851;6453.903191452226;6465.870682586416;6468.353164683494;6473.935260647521;6398.200224971879;6414.454771344488;6429.324920883427;6448;6449.258335291502;6471.158749362553;6475.061116138228;6514.869702606016;6547;6581.835454113685;6263.404976527223;6299.149614801943;6382.5532212744665;6389.137466442156;6393.232812062396 07:00:51 INFO - PID 29800 | |1;ext.html;818.4720855048494;873.2097451806115;879.9032106468292;897.8653202019698;1175.9470823812928;41566;42600;42608.786956065254;42650.786746066224;42760.78619606901;42146.36780448296;42248.577514224846;42496.57503424965;42506.36240456396;42595.787021064854;7717.228277172294;7927.326177274938;7929.563873986928;7931.563763992978;7941;7788.6884524618945;7885.763427097197;7898.052233731932;7900.288973992339;7901.920980790204;7801.96099019507;7865;7868.724594639189;7878.369730421581;7896.486728362638;7794.493357931745;7818.765437036898;7829.099653539859;7839.96080019602;7841.68633254672;7690.807729806799;7775.1447340792465;7776.922230777676;7802.882956755653;7809.453338266324;38438.61561384378;38637.8408647741;38746;38757.22485550273;38778;3538.716902647782;3540.132667496454;3568.1793187567005;3571.23218508022;3573.9642603573893;31280.37439251225;31480.842595787104;31532.684673153206;31737.20656983594;31815.20461988446;4245.957540424587;4387.3857659927635;4418.955810441887;4457.509673935864;4460.687751857371;174655;177138;178148;178448;178730.10634946742;47657.76171119192;47806.760966195645;47946.5205347949;47976.52023479721;48017.27974080392;49712;49723.50276497189;49759;49778.751106244235;49822.50177498251;12873.776991185823;13110.278934658494;14096.224707640973;16072.116033618264;16380.754288685679;13511.594652160451;13535.05254632186;13542.05205635596;13548.322583870768;13572;13826.170429774245;13846.861531384759;14017.229052402216;14097.577072687836;14213.715725685428;5638;5751.511121554631;5780;5799.88400231993;5885.352611212763;958.4919992404037;965.9082387173207;997.152420442618;1019.23557332001;1024.8257796174669;21965.560688786136;21987.34037978863;22221.44446388821;22284.108635654393;22483.775162248494;1058.090042563395;1085.6275143961623;1102.8014957307762;1119.6417146513038;1121.870984836738;11692.47383867728;11754;11859.762804743857;11929.164958452999;12015.639530814089;211154;212103;212791;212941;213091;50889.49110508848;51287;51330.48669513257;51515.48484515107;51598.48401516012;1437.1233547535994;1481.1705444951078;1483.480781726387;1494.805675262209;1519.3163076615347;21696.457588560414;21738.239161629266;21778.237761678265;21785.128594856662;21830.89084554567;36117;36296.27407451783;36308.81845590755;36363.636363636026;36383.81808090943;185754;188503;194316;195531;195804;32009.199770005936;32290.35419291648;32682.673173268915;35100.12249693778;35256.823715881255;46294.30558541692;46408.071838563716;46637;46646.30030549612;46835.53164468312;26221;27532.32785448584;27711;28178.85910570434;28393.148205553865;26948.32629184286;27127;28084;28462.85768571144;29415.411691766472;38361;38364.80817595894;38429.231415370974;38748.41877371785;38876.22247554977;31612.525812113297;33525.83237083799;34163.829180853936;34416.139596510286;34714.82642586771;24299.878500607385;24312.635310470003;24341;24602.876985614956;24933 07:00:51 INFO - PID 29800 | |2;jquery.html;574.7270046727803;575.8243735660625;576.0926540698401;586.2788769813129;587.800147949697;22273.665895011567;22730;23352.766472335272;23364.182253621104;23385.532289354247;25991.09031183909;26032.349191270227;26219;26235.475290494178;26450.20649380517;6524.836879078037;6684.966575167117;6686.398224159825;6692.330766923317;6693.564918280321;6047.485963693091;6560.048792925023;6577.144971153743;6635.071090047397;6650.966745166267;6517.315681853408;6528.08606795049;6531.281559028503;6556.93443065568;6557.606543607375;6555.803325900254;6561.147050883403;6563.245226798931;6566.343365663443;6566.934330656704;6082.543809214282;6093.268807743055;6096.878062438771;6119.44924956756;6127.11156882254;29327.560086598718;29687.25781855449;29777;29986.70013299861;30296.24259393511;1864.869459137861;1918.9232430702755;1921;1922.7596550431197;1926.8651194416395;18466.35367762122;18945.81054189454;18980.14589343483;19052.90473547637;19149.04254787269;2265.161890100657;2302.5970455170445;2324.825638077134;2340.4382948092334;2403.495265994143;134375;138549;138640;138865;138909.3054534731;13782.448702052006;14626.780598291034;14788.926055369655;15338.923305383401;15615.297311621005;23588.882055589613;23672.88163559171;23679.52640947206;23797;23812.16657417017;10315.742106447398;10320.638777642747;10337.224708146769;10375.740606484747;10410.895891040993;9596.184324332371;9648.565814538362;9688.951555242178;9829.45937973404;9893.802123957481;8899.377043607015;8917.719494642608;9055.864162037575;9142.542872856331;9222.262219022463;2688.4085501189707;2742.3829638331613;2782.944341113207;2785.7632101271215;2808.2698498390155;902.7562558109274;939.3330735177964;951.3816019587324;953.4755884263627;982.5824024789435;19249.32627358036;19442.70835937462;19473.415797526097;19689.11398987049;19942.401727948185;993.1359717046216;995.5171741705267;1003.6437064841876;1019.1591936652292;1035.6219979707503;10495.580176792842;10544.683659490227;10566.947165264279;10780.353178809297;11018.228723989243;496441;501757;525268;531217;537130;123981.38009310076;127329;128434;129564;129965;1178.2459226095307;1191.5055252070467;1211.4185191108318;1217.6164508179895;1217.6712287682276;16374.918125409296;20827.06278217514;21887.781122188575;22056.669149962443;22226.110955561595;58815.41184588099;59289.11066333922;59483.405165947785;59653.70173149106;61079.69460152671;66217;66588.33411665821;66769.33230667826;67145.99281010691;68279.3172068273;12514.561990330294;15085.868559858274;15220.847791521943;15291.388344466543;15451.304691288695;17459.738103928197;19288.90355548213;24406.51186976215;24706.50586988286;24708.752912470645;17487.300507980046;17750.20124094393;17911.462656120337;17929.01390423539;17996.460106196835;14149.292535372984;14630.341634626255;15821.841781582038;15856.60358491047;16153.59616009609;18852.811471885107;19084.95032773211;19339.323123691167;19975.300864469675;20149.39551813448;14716.55850324492;14744.48394306237;14793.556193314218;14883.255837208313;14912.85087149158;17676.823231767517;18682.906585466986;19125.139368728163;19168.233270669018;19176.232950682373 07:00:51 INFO - PID 29800 | |3;mootools.html;1324.8675132486749;1367.432515506065;1389.5414513210637;1393.5679939218837;1395.7976093466455;13581.728365432698;14146.221957792317;14149.504767333132;14150.716985660281;14156.929215353908;13880.30598470075;14711.48509802157;14720.190389528598;14723.04300220485;14736.778948315758;2456.9631455528183;2517.169334119736;2524.8232623716253;2526.759957804006;2531.6076008218756;2509.8619575923317;2619.371350875795;2648.0996461203185;2674.9598756018677;2689.556223223166;2542.6821647294087;2608.21753473958;2626.7373262673773;2676.4513274778624;2680.865956702167;2610.947781044378;2615.2415799418145;2626.107123577983;2626.4372698244515;2626.500964816679;2571.7171111177754;2572.8165044079747;2580.6129080637866;2582.625519299691;2606.2572166932523;13638.93180534101;13717.245551494663;13774.242416667079;13788.379522921392;13794.586162415144;7240.891386629205;7519.13529944058;7539.623018849035;7543.2079631638435;7552.169261381244;4830.492798256203;4836.41962964443;4907.11671899058;5025.472325405816;5042.3949126104735;1701.9744703829454;1713.4088739384893;1713.4088739385018;1725.413359457778;1754.2281396185638;21870.562588748297;22179.223727169472;22254.332370028762;22271.331860044225;22272.554548909095;6263.467605253513;6338.619682819046;6369.20384951881;6476.902846457307;6724.529282950147;15548.222588870738;15563.766543501857;15583.844161558465;15615.219239038002;15636.296366663528;7150.821229469201;7272.163701174327;7307.89038164428;7321.487495875344;7327.523710958771;5374.5700343972385;6156.969215153896;6667.166604174478;6877.449804015667;6892.689828957709;5372.167314066326;5509;5559.360673522516;5577.498025177753;5777.075667893201;1713.468824664358;1725.4564812084154;1734.09826890019;1737.1661602430904;1770.4334612924;825.9215374539409;846.5259454705384;850.6852464588142;861.8362511122866;881.8589025755977;6511.15355003856;6704.66476676174;6862.279460656659;6927.168739751262;6949.513534052669;944.0795224655906;980.9068138526828;985.7979114281555;986.4870267461024;986.6891929042472;4654.138984287918;4964.950350496449;5020.799168033238;5297.629165958346;5428.104362780097;18135.36526221576;19222.135003924857;19242.326518571783;19248.61502769965;19292.517687057934;18901.81098189028;18966.620667586572;19286.61426771485;19361.806381936283;19400.611987760167;10499.580016799242;10720.839187412195;11050.834237486444;11087.05760010392;11099.611513596985;7517.887231691419;7807.960960195162;8034.116247212919;8133.959330203311;8292.37807164453;15990.120543370227;16308.021518708916;16930.830691692925;17030.744538832176;17355;16880.662386751952;17222.31110755606;17286;17366.565835854206;17601.20794564222;11297.322160670386;11368.317900925971;11417.543298267976;11484.19610627248;11491.195616306779;12816.615501534969;12877.420516076612;12999.610011699664;13063.542776002794;13176.736465270833;8928.598213080557;9220.285024995488;9232.261419086592;9290.767730806514;9407.670731524364;9598.760030999281;9691.5154242289;9825.4104753715;9847.507624618596;9940.751481213027;8659.913400865911;8825.470471771714;8856.557172141496;8880.689175878813;8887.97788254359;6042.939570604413;6261.279952805486;6569.4744420447205;6569.967150164219;6576.572522786004;6416.615003099829;6550.803475895731;6798.7620433286575;6992.475564332797;7000.544964577286 07:00:51 INFO - PID 29800 | |4;prototype.html;493.54986479098017;504.76081220603425;521.6739537788882;522.7804322184681;527.8996990571791;6163.38366163384;6209.534284928626;6250.28121765997;6291.24505059393;6331.1769469968895;5899.941000589993;6047.516198704104;6133.27069454092;6159.384061593838;6204.875902481947;4905.141600219965;4955.851324460254;4967;4984.451710311862;5018.799248030084;4905.645290260677;4918.311436398907;4944.826931057396;4961.603071754251;4982.17794063979;4683.414573178353;4889.828855990041;4896.143174944388;4900.803967841282;4913.508649135076;4930.408350997867;4933.45731969483;4937.23472861707;4971.950280497203;5032.899342013139;4414.690971631987;4424.734515929054;4467.195904737146;4483.327500874862;4491.393661855673;6054.96972515139;6124.510039196898;6172.135900973867;6182.289036760785;6202.472789812871;5711.914321285184;5751.504608801742;5770.336411312669;5785.218995435646;5841.707914604295;6566.212054553484;6614.900776488356;6620.735170593171;6658.966705166492;6668.399844014062;4828.52729917375;4877.146499362598;4891.902161956741;4902.093112774148;4922.581580565657;6915.723371065152;6962.721491140399;6998.75504357345;7018.017477553147;7032.789016329519;5014.473480284518;5015.749212539358;5060.569851562658;5070.163423035158;5099.260607211933;5058.620603454756;5115.923261151086;5132.692038477703;5148.588112950955;5153.665955735871;5710.143478478179;5712.7714891403875;5726.169705392778;5742.885142297131;5755.453231942959;6527.967360163168;6659.469401627351;6679.699413526403;6722.226943901416;6760.594364338155;1666.475060355984;1700.9843335647297;1710.3757128648203;1747.842694157532;1763.6296377760557;1210.903127749778;1218.2325135164967;1225.546547777328;1230.354064116346;1250.593557093948;5743.712814359265;5752.188060760847;5774.133879918046;5781.797637082682;5787.5080618147085;6590.439812615886;6668.533202675863;6691.397774200345;6731.629760363129;6751;5763.884722305615;5767.192593036978;5768.644368573382;5770.480656740913;5895.616784908967;3579.8926032218556;3604.585472670624;3621.167131559703;3627.220147668211;3657.908552286214;6550.148480697479;6585.835354116185;6606.4565142420515;6609.272979972199;6616.007598860209;7018.649067546602;7019.578245505292;7040.6479676016;7060.5410648308725;7063.834467312939;6510.641914694737;6552.541322107502;6597.571157874723;6601.834954126185;6621.33786621334;6716.294789047275;6716.83207919806;6809.38715515606;6813.591184528944;6828.283030281749;6715.56348837324;6752.797416077526;6806.319368063154;6846.726130954706;6848.623325717133;6589.17635295588;6615.81678046234;6626.734930602915;6648.368405001517;6661.600303981777;4853.635977301646;4859.659823812299;4874.512548745097;4976.402831660224;4993.126202914548;6688.063671085954;6731.697073631601;6753.425958793361;6767.458603311822;6825.317468253135;6494;6524.869502609827;6530.771423000172;6547.134066790942;6656.73373065072;6395.680215989275;6458.67706614658;6559.540832141704;6568.088720151902;6609.702563384755;6162;6209.96895015522;6389.297177310399;6389.808305750835;6470.35296470368;6468.611883287018;6521.804315885087;6536.738530458919;6580.144581204413;6588.143541339595;6288.811335659938;6315.494760419064;6333.8733225336155;6345.209366928125;6378.138951241523 07:00:51 INFO - PID 29800 | |5;yui.html;890.6036813617939;912.6805618033693;917.5137177296033;926.3422969691519;938.1041105744015;18335;19281.517962050955;19295.710564341527;19297.517562060955;19311.227550897966;17485.7377139343;17640.647187056253;17674.823251767477;19017.904910475427;21990.560188796255;1019.6329321444274;1039.6517166749147;1039.7556574205055;1039.807635587415;1040.0223789637716;1036.906678398944;1043.1446214104437;1043.9164866810675;1044.9373037617768;1045.1847558904067;995.3828626251734;1030.8402197659375;1081.232325049216;1081.8323159910226;1082.2099867097024;1062.2776511971856;1064.1380481809758;1066.077842666096;1068.369661899479;1068.8236440987266;779.5985067690087;779.7582749347721;780.3055280800093;781.8514482248412;782.2255966593088;17930.91034544832;18324.358647447276;18411.63176736471;18425.447236582924;20116.994150292427;20110.095045722977;20118.396448106432;20788.896055519777;20803;20958.685619715718;16661.91669041659;16745.16274186286;16804.83195168057;16944.49166525006;16945.152742362956;3562.4656301554714;3599.31612993533;3609.4405367168133;3610.5847827499647;3611.7652352596997;115368.4231578845;117370.41314793371;118062.40968795274;118741;120495;15647.608809779618;16298.348066077224;16440.342386304652;16458.09480478585;16465.83534164667;29327.266818329714;31435.685643143734;31518.842405787826;31675.366492670477;31861.840690796398;8647.610857511427;8686.869696954423;8699.304055675531;8706.564671766386;8785.956070219609;4143.295639741251;4200.4539409876525;4214.515330736943;4221.02916329246;4229.111886503807;4713.8350157745;4810.494898035726;4870.756462176877;5536.944630553723;5859.707014649251;1009.4599389326675;1038.159091136182;1056.102313033915;1056.5404049238605;1062.5590379992216;641.6150309814168;663.6217356107069;681.3935597318391;684.3924647094585;693.3932808792307;11423.885761142283;12701.428435720414;12778.488860445477;12858.228506289652;12991.415386307639;673.2997682410337;691.3225039461356;699.6431819771851;700.6566782276648;703.9049728286718;5261.789528418821;5493.258410114663;5572.916406253909;6058.969705151534;6363.172787537591;92956.53521732484;94687.52656236812;96938.51530742302;97055.0294497046;100772;84403;86243.13756862476;88038;88068.55965720258;89782.10217897868;69233.65383173153;75195.62402187954;77607.22392776112;80071.59964200141;80270.59864700756;11850.881491184979;12326.630201093982;12689.936550317188;12845.229286242855;12930.159539629894;35440;35890.44503594596;36118.41319154025;36215;38059.809700951315;64559.354406455335;64694.35305646883;66597.66701166463;68350;72421.27578724145;18276.268949242414;18396.172172252547;19091.427257182306;19218.327358542385;19323.420297390538;20199.59600808005;20777;20836.166553337698;21192.894035529724;21382;18468.44594662162;19160.808391915903;19436.70844937299;19818.801811981695;19989;17802.5549361267;19504.512387190432;19630.705539417206;19637.70543441821;19701;18172;18813.341533046278;19065.61868762589;19180.80819191846;19429.319973800848;11972.940135299268;13075.411606477921;13100.410481528164;13111;13420.597382078553;14375.496857609933;14577.416903323749;14715.108595366759;15041.774373384627;15439.150846703538 07:00:51 INFO - PID 29800 | __end_tp_report 07:00:51 INFO - PID 29800 | __start_cc_report 07:00:51 INFO - PID 29800 | _x_x_mozilla_cycle_collect,360 07:00:51 INFO - PID 29800 | __end_cc_report 07:00:51 INFO - PID 29800 | __startTimestamp1501509651143__endTimestamp 07:00:51 INFO - PID 29800 | 07:00:51 INFO - PID 29800 | ------- Summary: start ------- 07:00:51 INFO - PID 29800 | Number of tests: 6 07:00:51 INFO - PID 29800 | 07:00:51 INFO - PID 29800 | [#0] dojo.html Cycles:165 Average:6118.24 Median:6348.71 stddev:717.55 (11.3%) stddev-sans-first:680.23 07:00:51 INFO - PID 29800 | Values: 3124.2 3139.1 3144.1 3184.1 3185.7 6088.1 6264.6 6288.8 6289.2 6300.1 6103.7 6219.3 6246.8 6249.9 6273.9 5682.1 5687.7 5694.5 5726.7 5727.5 5709.4 5715.6 5716.6 5720.4 5720.8 5663.2 5693.3 5694.3 5696.6 5702.6 5688.3 5695.2 5696.7 5696.7 5715.6 5592.8 5663.8 5719.7 5734.2 5767.3 6018.3 6029.7 6089.1 6146.0 6188.8 6607.3 6628.4 6638.7 6645.2 6647.0 5722.6 6612.5 6701.5 6706.2 6731.5 6195.9 6204.8 6257.7 6275.8 6282.6 6691.4 6877.7 6878.7 6916.8 6974.1 6530.8 6533.9 6540.3 6548.6 6561.1 6586.5 6597.3 6681.2 6692.9 6696.0 6627.9 6637.4 6637.4 6641.1 6683.6 6639.7 6643.5 6728.3 6736.9 6749.1 5314.8 5340.2 5380.1 5388.0 5388.1 4586.3 4608.3 4628.6 4646.2 4650.1 5689.7 5743.9 5781.8 5785.6 5792.4 6696.9 6707.0 6710.3 6719.0 6724.6 5727.4 5804.6 5814.1 5818.0 5837.3 5756.3 5816.8 5832.4 5843.4 5898.4 6336.5 6341.1 6348.7 6399.0 6403.1 6492.6 6563.8 6570.7 6581.7 6596.7 6341.7 6347.0 6350.7 6354.6 6356.6 6431.6 6542.3 6565.1 6624.3 6656.9 6689.9 6703.9 6735.2 6817.4 6822.5 6362.9 6443.4 6462.0 6537.6 6542.0 6453.8 6453.9 6465.9 6468.4 6473.9 6398.2 6414.5 6429.3 6448.0 6449.3 6471.2 6475.1 6514.9 6547.0 6581.8 6263.4 6299.1 6382.6 6389.1 6393.2 07:00:51 INFO - PID 29800 | 07:00:51 INFO - PID 29800 | [#1] ext.html Cycles:180 Average:36384.60 Median:3569.71 stddev:50352.65 (1410.6%) stddev-sans-first:50423.08 07:00:51 INFO - PID 29800 | Values: 818.5 873.2 879.9 897.9 1175.9 41566.0 42600.0 42608.8 42650.8 42760.8 42146.4 42248.6 42496.6 42506.4 42595.8 7717.2 7927.3 7929.6 7931.6 7941.0 7788.7 7885.8 7898.1 7900.3 7901.9 7802.0 7865.0 7868.7 7878.4 7896.5 7794.5 7818.8 7829.1 7840.0 7841.7 7690.8 7775.1 7776.9 7802.9 7809.5 38438.6 38637.8 38746.0 38757.2 38778.0 3538.7 3540.1 3568.2 3571.2 3574.0 31280.4 31480.8 31532.7 31737.2 31815.2 4246.0 4387.4 4419.0 4457.5 4460.7 174655.0 177138.0 178148.0 178448.0 178730.1 47657.8 47806.8 47946.5 47976.5 48017.3 49712.0 49723.5 49759.0 49778.8 49822.5 12873.8 13110.3 14096.2 16072.1 16380.8 13511.6 13535.1 13542.1 13548.3 13572.0 13826.2 13846.9 14017.2 14097.6 14213.7 5638.0 5751.5 5780.0 5799.9 5885.4 958.5 965.9 997.2 1019.2 1024.8 21965.6 21987.3 22221.4 22284.1 22483.8 1058.1 1085.6 1102.8 1119.6 1121.9 11692.5 11754.0 11859.8 11929.2 12015.6 211154.0 212103.0 212791.0 212941.0 213091.0 50889.5 51287.0 51330.5 51515.5 51598.5 1437.1 1481.2 1483.5 1494.8 1519.3 21696.5 21738.2 21778.2 21785.1 21830.9 36117.0 36296.3 36308.8 36363.6 36383.8 185754.0 188503.0 194316.0 195531.0 195804.0 32009.2 32290.4 32682.7 35100.1 35256.8 46294.3 46408.1 46637.0 46646.3 46835.5 26221.0 27532.3 27711.0 28178.9 28393.1 26948.3 27127.0 28084.0 28462.9 29415.4 38361.0 38364.8 38429.2 38748.4 38876.2 31612.5 33525.8 34163.8 34416.1 34714.8 24299.9 24312.6 24341.0 24602.9 24933.0 07:00:51 INFO - PID 29800 | 07:00:51 INFO - PID 29800 | [#2] jquery.html Cycles:180 Average:35927.52 Median:23358.47 stddev:87295.91 (373.7%) stddev-sans-first:87500.44 07:00:51 INFO - PID 29800 | Values: 574.7 575.8 576.1 586.3 587.8 22273.7 22730.0 23352.8 23364.2 23385.5 25991.1 26032.3 26219.0 26235.5 26450.2 6524.8 6685.0 6686.4 6692.3 6693.6 6047.5 6560.0 6577.1 6635.1 6651.0 6517.3 6528.1 6531.3 6556.9 6557.6 6555.8 6561.1 6563.2 6566.3 6566.9 6082.5 6093.3 6096.9 6119.4 6127.1 29327.6 29687.3 29777.0 29986.7 30296.2 1864.9 1918.9 1921.0 1922.8 1926.9 18466.4 18945.8 18980.1 19052.9 19149.0 2265.2 2302.6 2324.8 2340.4 2403.5 134375.0 138549.0 138640.0 138865.0 138909.3 13782.4 14626.8 14788.9 15338.9 15615.3 23588.9 23672.9 23679.5 23797.0 23812.2 10315.7 10320.6 10337.2 10375.7 10410.9 9596.2 9648.6 9689.0 9829.5 9893.8 8899.4 8917.7 9055.9 9142.5 9222.3 2688.4 2742.4 2782.9 2785.8 2808.3 902.8 939.3 951.4 953.5 982.6 19249.3 19442.7 19473.4 19689.1 19942.4 993.1 995.5 1003.6 1019.2 1035.6 10495.6 10544.7 10566.9 10780.4 11018.2 496441.0 501757.0 525268.0 531217.0 537130.0 123981.4 127329.0 128434.0 129564.0 129965.0 1178.2 1191.5 1211.4 1217.6 1217.7 16374.9 20827.1 21887.8 22056.7 22226.1 58815.4 59289.1 59483.4 59653.7 61079.7 66217.0 66588.3 66769.3 67146.0 68279.3 12514.6 15085.9 15220.8 15291.4 15451.3 17459.7 19288.9 24406.5 24706.5 24708.8 17487.3 17750.2 17911.5 17929.0 17996.5 14149.3 14630.3 15821.8 15856.6 16153.6 18852.8 19085.0 19339.3 19975.3 20149.4 14716.6 14744.5 14793.6 14883.3 14912.9 17676.8 18682.9 19125.1 19168.2 19176.2 07:00:51 INFO - PID 29800 | 07:00:51 INFO - PID 29800 | [#3] mootools.html Cycles:180 Average:8502.47 Median:2622.74 stddev:5853.41 (223.2%) stddev-sans-first:5844.98 07:00:51 INFO - PID 29800 | Values: 1324.9 1367.4 1389.5 1393.6 1395.8 13581.7 14146.2 14149.5 14150.7 14156.9 13880.3 14711.5 14720.2 14723.0 14736.8 2457.0 2517.2 2524.8 2526.8 2531.6 2509.9 2619.4 2648.1 2675.0 2689.6 2542.7 2608.2 2626.7 2676.5 2680.9 2610.9 2615.2 2626.1 2626.4 2626.5 2571.7 2572.8 2580.6 2582.6 2606.3 13638.9 13717.2 13774.2 13788.4 13794.6 7240.9 7519.1 7539.6 7543.2 7552.2 4830.5 4836.4 4907.1 5025.5 5042.4 1702.0 1713.4 1713.4 1725.4 1754.2 21870.6 22179.2 22254.3 22271.3 22272.6 6263.5 6338.6 6369.2 6476.9 6724.5 15548.2 15563.8 15583.8 15615.2 15636.3 7150.8 7272.2 7307.9 7321.5 7327.5 5374.6 6157.0 6667.2 6877.4 6892.7 5372.2 5509.0 5559.4 5577.5 5777.1 1713.5 1725.5 1734.1 1737.2 1770.4 825.9 846.5 850.7 861.8 881.9 6511.2 6704.7 6862.3 6927.2 6949.5 944.1 980.9 985.8 986.5 986.7 4654.1 4965.0 5020.8 5297.6 5428.1 18135.4 19222.1 19242.3 19248.6 19292.5 18901.8 18966.6 19286.6 19361.8 19400.6 10499.6 10720.8 11050.8 11087.1 11099.6 7517.9 7808.0 8034.1 8134.0 8292.4 15990.1 16308.0 16930.8 17030.7 17355.0 16880.7 17222.3 17286.0 17366.6 17601.2 11297.3 11368.3 11417.5 11484.2 11491.2 12816.6 12877.4 12999.6 13063.5 13176.7 8928.6 9220.3 9232.3 9290.8 9407.7 9598.8 9691.5 9825.4 9847.5 9940.8 8659.9 8825.5 8856.6 8880.7 8888.0 6042.9 6261.3 6569.5 6570.0 6576.6 6416.6 6550.8 6798.8 6992.5 7000.5 07:00:51 INFO - PID 29800 | 07:00:51 INFO - PID 29800 | [#4] prototype.html Cycles:180 Average:5532.62 Median:6160.69 stddev:1566.12 (25.4%) stddev-sans-first:1524.16 07:00:51 INFO - PID 29800 | Values: 493.5 504.8 521.7 522.8 527.9 6163.4 6209.5 6250.3 6291.2 6331.2 5899.9 6047.5 6133.3 6159.4 6204.9 4905.1 4955.9 4967.0 4984.5 5018.8 4905.6 4918.3 4944.8 4961.6 4982.2 4683.4 4889.8 4896.1 4900.8 4913.5 4930.4 4933.5 4937.2 4972.0 5032.9 4414.7 4424.7 4467.2 4483.3 4491.4 6055.0 6124.5 6172.1 6182.3 6202.5 5711.9 5751.5 5770.3 5785.2 5841.7 6566.2 6614.9 6620.7 6659.0 6668.4 4828.5 4877.1 4891.9 4902.1 4922.6 6915.7 6962.7 6998.8 7018.0 7032.8 5014.5 5015.7 5060.6 5070.2 5099.3 5058.6 5115.9 5132.7 5148.6 5153.7 5710.1 5712.8 5726.2 5742.9 5755.5 6528.0 6659.5 6679.7 6722.2 6760.6 1666.5 1701.0 1710.4 1747.8 1763.6 1210.9 1218.2 1225.5 1230.4 1250.6 5743.7 5752.2 5774.1 5781.8 5787.5 6590.4 6668.5 6691.4 6731.6 6751.0 5763.9 5767.2 5768.6 5770.5 5895.6 3579.9 3604.6 3621.2 3627.2 3657.9 6550.1 6585.8 6606.5 6609.3 6616.0 7018.6 7019.6 7040.6 7060.5 7063.8 6510.6 6552.5 6597.6 6601.8 6621.3 6716.3 6716.8 6809.4 6813.6 6828.3 6715.6 6752.8 6806.3 6846.7 6848.6 6589.2 6615.8 6626.7 6648.4 6661.6 4853.6 4859.7 4874.5 4976.4 4993.1 6688.1 6731.7 6753.4 6767.5 6825.3 6494.0 6524.9 6530.8 6547.1 6656.7 6395.7 6458.7 6559.5 6568.1 6609.7 6162.0 6210.0 6389.3 6389.8 6470.4 6468.6 6521.8 6536.7 6580.1 6588.1 6288.8 6315.5 6333.9 6345.2 6378.1 07:00:51 INFO - PID 29800 | 07:00:51 INFO - PID 29800 | [#5] yui.html Cycles:180 Average:22475.53 Median:19759.90 stddev:29043.12 (147.0%) stddev-sans-first:29079.37 07:00:51 INFO - PID 29800 | Values: 890.6 912.7 917.5 926.3 938.1 18335.0 19281.5 19295.7 19297.5 19311.2 17485.7 17640.6 17674.8 19017.9 21990.6 1019.6 1039.7 1039.8 1039.8 1040.0 1036.9 1043.1 1043.9 1044.9 1045.2 995.4 1030.8 1081.2 1081.8 1082.2 1062.3 1064.1 1066.1 1068.4 1068.8 779.6 779.8 780.3 781.9 782.2 17930.9 18324.4 18411.6 18425.4 20117.0 20110.1 20118.4 20788.9 20803.0 20958.7 16661.9 16745.2 16804.8 16944.5 16945.2 3562.5 3599.3 3609.4 3610.6 3611.8 115368.4 117370.4 118062.4 118741.0 120495.0 15647.6 16298.3 16440.3 16458.1 16465.8 29327.3 31435.7 31518.8 31675.4 31861.8 8647.6 8686.9 8699.3 8706.6 8786.0 4143.3 4200.5 4214.5 4221.0 4229.1 4713.8 4810.5 4870.8 5536.9 5859.7 1009.5 1038.2 1056.1 1056.5 1062.6 641.6 663.6 681.4 684.4 693.4 11423.9 12701.4 12778.5 12858.2 12991.4 673.3 691.3 699.6 700.7 703.9 5261.8 5493.3 5572.9 6059.0 6363.2 92956.5 94687.5 96938.5 97055.0 100772.0 84403.0 86243.1 88038.0 88068.6 89782.1 69233.7 75195.6 77607.2 80071.6 80270.6 11850.9 12326.6 12689.9 12845.2 12930.2 35440.0 35890.4 36118.4 36215.0 38059.8 64559.4 64694.4 66597.7 68350.0 72421.3 18276.3 18396.2 19091.4 19218.3 19323.4 20199.6 20777.0 20836.2 21192.9 21382.0 18468.4 19160.8 19436.7 19818.8 19989.0 17802.6 19504.5 19630.7 19637.7 19701.0 18172.0 18813.3 19065.6 19180.8 19429.3 11972.9 13075.4 13100.4 13111.0 13420.6 14375.5 14577.4 14715.1 15041.8 15439.2 07:00:51 INFO - PID 29800 | -------- Summary: end -------- 07:00:51 INFO - PID 29800 | 07:00:51 INFO - TEST-INFO | 29800: exit 0 07:00:51 INFO - TEST-OK | dromaeo_css | took 1112763ms 07:00:51 INFO - TEST-START | kraken 07:00:51 INFO - Initialising browser for kraken test... 07:00:51 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38257/getInfo.html -profile /tmp/tmpr0ZEjJ/profile 07:00:51 INFO - TEST-INFO | started process 30164 (/builds/slave/test/build/application/firefox/firefox http://localhost:38257/getInfo.html) 07:00:57 INFO - TEST-INFO | 30164: exit 0 07:00:57 INFO - Browser initialized. 07:00:57 INFO - Running cycle 1/1 for kraken test... 07:00:57 INFO - TEST-INFO | started process 30373 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr0ZEjJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:00:58 INFO - PID 30373 | 07:00:58 INFO - PID 30373 | (/builds/slave/test/build/application/firefox/firefox:30422): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:00:58 INFO - PID 30373 | 07:01:08 INFO - PID 30373 | RSS: Main: 171773952 07:01:08 INFO - PID 30373 | 07:01:11 INFO - PID 30373 | Cycle 1(1): loaded http://localhost:38257/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38257/tests/kraken/driver.html?testName=audio-beat-detection) 07:01:12 INFO - PID 30373 | RSS: Main: 177496064 07:01:12 INFO - PID 30373 | 07:01:15 INFO - PID 30373 | Cycle 1(1): loaded http://localhost:38257/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38257/tests/kraken/driver.html?testName=audio-dft) 07:01:15 INFO - PID 30373 | RSS: Main: 177823744 07:01:15 INFO - PID 30373 | 07:01:18 INFO - PID 30373 | Cycle 1(1): loaded http://localhost:38257/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38257/tests/kraken/driver.html?testName=audio-fft) 07:01:19 INFO - PID 30373 | RSS: Main: 171241472 07:01:19 INFO - PID 30373 | 07:01:21 INFO - PID 30373 | Cycle 1(1): loaded http://localhost:38257/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38257/tests/kraken/driver.html?testName=audio-oscillator) 07:01:22 INFO - PID 30373 | RSS: Main: 172322816 07:01:22 INFO - PID 30373 | 07:01:24 INFO - PID 30373 | Cycle 1(1): loaded http://localhost:38257/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38257/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:01:24 INFO - PID 30373 | RSS: Main: 172761088 07:01:24 INFO - PID 30373 | 07:01:28 INFO - PID 30373 | Cycle 1(1): loaded http://localhost:38257/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38257/tests/kraken/driver.html?testName=imaging-darkroom) 07:01:28 INFO - PID 30373 | RSS: Main: 175329280 07:01:28 INFO - PID 30373 | 07:01:32 INFO - PID 30373 | Cycle 1(1): loaded http://localhost:38257/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38257/tests/kraken/driver.html?testName=imaging-desaturate) 07:01:32 INFO - PID 30373 | RSS: Main: 175468544 07:01:32 INFO - PID 30373 | 07:01:35 INFO - PID 30373 | Cycle 1(1): loaded http://localhost:38257/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38257/tests/kraken/driver.html?testName=json-parse-financial) 07:01:36 INFO - PID 30373 | RSS: Main: 175808512 07:01:36 INFO - PID 30373 | 07:01:37 INFO - PID 30373 | Cycle 1(1): loaded http://localhost:38257/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38257/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:01:38 INFO - PID 30373 | RSS: Main: 175845376 07:01:38 INFO - PID 30373 | 07:01:40 INFO - PID 30373 | Cycle 1(1): loaded http://localhost:38257/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38257/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:01:40 INFO - PID 30373 | RSS: Main: 173170688 07:01:40 INFO - PID 30373 | 07:01:43 INFO - PID 30373 | Cycle 1(1): loaded http://localhost:38257/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38257/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:01:43 INFO - PID 30373 | RSS: Main: 172736512 07:01:43 INFO - PID 30373 | 07:01:46 INFO - PID 30373 | Cycle 1(1): loaded http://localhost:38257/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38257/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:01:47 INFO - PID 30373 | RSS: Main: 173162496 07:01:47 INFO - PID 30373 | 07:01:50 INFO - PID 30373 | Cycle 1(1): loaded http://localhost:38257/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38257/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:01:50 INFO - PID 30373 | RSS: Main: 173510656 07:01:50 INFO - PID 30373 | 07:01:52 INFO - PID 30373 | Cycle 1(1): loaded http://localhost:38257/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38257/tests/kraken/driver.html?testName=ai-astar) 07:01:53 INFO - PID 30373 | RSS: Main: 174964736 07:01:53 INFO - PID 30373 | 07:01:53 INFO - PID 30373 | __start_tp_report 07:01:53 INFO - PID 30373 | _x_x_mozilla_page_load 07:01:53 INFO - PID 30373 | _x_x_mozilla_page_load_details 07:01:53 INFO - PID 30373 | |i|pagename|runs| 07:01:53 INFO - PID 30373 | |0;ai-astar;99;120;104;110;110;110;109;101;109;108 07:01:53 INFO - PID 30373 | |1;audio-beat-detection;156;122;143;181;123;146;145;130;175;121 07:01:53 INFO - PID 30373 | |2;audio-dft;164;163;164;165;165;164;169;168;164;165 07:01:53 INFO - PID 30373 | |3;audio-fft;74;75;75;180;75;76;77;78;161;76 07:01:53 INFO - PID 30373 | |4;audio-oscillator;80;79;152;78;78;79;129;81;80;130 07:01:53 INFO - PID 30373 | |5;imaging-gaussian-blur;114;115;115;114;114;115;114;114;114;116 07:01:53 INFO - PID 30373 | |6;imaging-darkroom;151;151;152;151;151;151;150;152;150;151 07:01:53 INFO - PID 30373 | |7;imaging-desaturate;95;95;94;96;95;94;95;94;94;94 07:01:53 INFO - PID 30373 | |8;json-parse-financial;56;57;56;56;55;57;57;55;56;56 07:01:53 INFO - PID 30373 | |9;json-stringify-tinderbox;54;54;54;55;54;54;55;55;55;54 07:01:53 INFO - PID 30373 | |10;stanford-crypto-aes;81;80;89;80;80;81;99;81;90;81 07:01:53 INFO - PID 30373 | |11;stanford-crypto-ccm;130;139;126;135;147;128;144;127;130;172 07:01:53 INFO - PID 30373 | |12;stanford-crypto-pbkdf2;182;187;196;184;178;190;179;176;180;177 07:01:53 INFO - PID 30373 | |13;stanford-crypto-sha256-iterative;68;67;71;68;66;71;71;68;69;69 07:01:53 INFO - PID 30373 | __end_tp_report 07:01:53 INFO - PID 30373 | __start_cc_report 07:01:53 INFO - PID 30373 | _x_x_mozilla_cycle_collect,994 07:01:53 INFO - PID 30373 | __end_cc_report 07:01:53 INFO - PID 30373 | __startTimestamp1501509713036__endTimestamp 07:01:53 INFO - PID 30373 | 07:01:53 INFO - PID 30373 | ------- Summary: start ------- 07:01:53 INFO - PID 30373 | Number of tests: 14 07:01:53 INFO - PID 30373 | 07:01:53 INFO - PID 30373 | [#0] ai-astar Cycles:10 Average:108.00 Median:110.00 stddev:5.81 (5.3%) stddev-sans-first:5.17 07:01:53 INFO - PID 30373 | Values: 99.0 120.0 104.0 110.0 110.0 110.0 109.0 101.0 109.0 108.0 07:01:53 INFO - PID 30373 | 07:01:53 INFO - PID 30373 | [#1] audio-beat-detection Cycles:10 Average:144.20 Median:145.50 stddev:21.42 (14.7%) stddev-sans-first:22.29 07:01:53 INFO - PID 30373 | Values: 156.0 122.0 143.0 181.0 123.0 146.0 145.0 130.0 175.0 121.0 07:01:53 INFO - PID 30373 | 07:01:53 INFO - PID 30373 | [#2] audio-dft Cycles:10 Average:165.10 Median:165.00 stddev:1.91 (1.2%) stddev-sans-first:1.99 07:01:53 INFO - PID 30373 | Values: 164.0 163.0 164.0 165.0 165.0 164.0 169.0 168.0 164.0 165.0 07:01:53 INFO - PID 30373 | 07:01:53 INFO - PID 30373 | [#3] audio-fft Cycles:10 Average:94.70 Median:75.50 stddev:40.22 (53.3%) stddev-sans-first:41.95 07:01:53 INFO - PID 30373 | Values: 74.0 75.0 75.0 180.0 75.0 76.0 77.0 78.0 161.0 76.0 07:01:53 INFO - PID 30373 | 07:01:53 INFO - PID 30373 | [#4] audio-oscillator Cycles:10 Average:96.60 Median:79.00 stddev:28.56 (36.2%) stddev-sans-first:29.65 07:01:53 INFO - PID 30373 | Values: 80.0 79.0 152.0 78.0 78.0 79.0 129.0 81.0 80.0 130.0 07:01:53 INFO - PID 30373 | 07:01:53 INFO - PID 30373 | [#5] imaging-gaussian-blur Cycles:10 Average:114.50 Median:114.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 07:01:53 INFO - PID 30373 | Values: 114.0 115.0 115.0 114.0 114.0 115.0 114.0 114.0 114.0 116.0 07:01:53 INFO - PID 30373 | 07:01:53 INFO - PID 30373 | [#6] imaging-darkroom Cycles:10 Average:151.00 Median:151.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 07:01:53 INFO - PID 30373 | Values: 151.0 151.0 152.0 151.0 151.0 151.0 150.0 152.0 150.0 151.0 07:01:53 INFO - PID 30373 | 07:01:53 INFO - PID 30373 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 07:01:53 INFO - PID 30373 | Values: 95.0 95.0 94.0 96.0 95.0 94.0 95.0 94.0 94.0 94.0 07:01:53 INFO - PID 30373 | 07:01:53 INFO - PID 30373 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.00 stddev:0.74 (1.3%) stddev-sans-first:0.78 07:01:53 INFO - PID 30373 | Values: 56.0 57.0 56.0 56.0 55.0 57.0 57.0 55.0 56.0 56.0 07:01:53 INFO - PID 30373 | 07:01:53 INFO - PID 30373 | [#9] json-stringify-tinderbox Cycles:10 Average:54.40 Median:54.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 07:01:53 INFO - PID 30373 | Values: 54.0 54.0 54.0 55.0 54.0 54.0 55.0 55.0 55.0 54.0 07:01:53 INFO - PID 30373 | 07:01:53 INFO - PID 30373 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:81.00 stddev:6.41 (7.9%) stddev-sans-first:6.69 07:01:53 INFO - PID 30373 | Values: 81.0 80.0 89.0 80.0 80.0 81.0 99.0 81.0 90.0 81.0 07:01:53 INFO - PID 30373 | 07:01:53 INFO - PID 30373 | [#11] stanford-crypto-ccm Cycles:10 Average:137.80 Median:137.00 stddev:14.05 (10.3%) stddev-sans-first:14.61 07:01:53 INFO - PID 30373 | Values: 130.0 139.0 126.0 135.0 147.0 128.0 144.0 127.0 130.0 172.0 07:01:53 INFO - PID 30373 | 07:01:53 INFO - PID 30373 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.90 Median:183.00 stddev:6.42 (3.5%) stddev-sans-first:6.80 07:01:53 INFO - PID 30373 | Values: 182.0 187.0 196.0 184.0 178.0 190.0 179.0 176.0 180.0 177.0 07:01:53 INFO - PID 30373 | 07:01:53 INFO - PID 30373 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:1.75 (2.5%) stddev-sans-first:1.83 07:01:53 INFO - PID 30373 | Values: 68.0 67.0 71.0 68.0 66.0 71.0 71.0 68.0 69.0 69.0 07:01:53 INFO - PID 30373 | -------- Summary: end -------- 07:01:53 INFO - PID 30373 | 07:01:53 INFO - PID 30373 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 07:01:53 INFO - TEST-INFO | 30373: exit 0 07:01:53 INFO - TEST-OK | kraken | took 61953ms 07:01:53 INFO - SUITE-END | took 1174s 07:01:54 INFO - Completed test suite (00:19:35) 07:01:54 INFO - javascript benchmark 07:01:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8410.105383006725, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3124.156477751009, 3139.1053549738326, 3144.072498612909, 3184.1402821238266, 3185.6655051219614, 6088.086786981949, 6264.561480696353, 6288.779892703757, 6289.182406287187, 6300.149479820223, 6103.7253323600435, 6219.346968568292, 6246.750129994806, 6249.875002499959, 6273.874522509547, 5682.119271512922, 5687.658740475575, 5694.544436445074, 5726.656400615955, 5727.455891690282, 5709.371969083398, 5715.599908006441, 5716.628419152763, 5720.399358067405, 5720.79977200798, 5663.207150998864, 5693.28833895763, 5694.288213973254, 5696.572757043217, 5702.572307076965, 5688.2605261315975, 5695.202671625976, 5696.743646535895, 5696.743646535916, 5715.628484148517, 5592.804251851166, 5663.830085097454, 5719.656820590778, 5734.168545560912, 5767.33675627304, 6018.337982821886, 6029.698515074273, 6089.147519347295, 6146.0, 6188.752449902044, 6607.3392660734025, 6628.370304821035, 6638.701258443381, 6645.235797883257, 6646.966765166191, 5722.62802917809, 6612.477379928182, 6701.497387695942, 6706.161729783777, 6731.495137864631, 6195.938040619536, 6204.782832600882, 6257.655828929407, 6275.843103922392, 6282.591631543935, 6691.431228345547, 6877.65611719412, 6878.65606719662, 6916.757913473004, 6974.128233970754, 6530.836729081716, 6533.869322613521, 6540.2805691373915, 6548.574342667712, 6561.1142495763415, 6586.5389422739945, 6597.340265973365, 6681.164854393201, 6692.899606505906, 6695.966520167368, 6627.900581491282, 6637.4026337628875, 6637.435817955431, 6641.103451034049, 6683.598984060972, 6639.701213445406, 6643.5017373697165, 6728.259891411941, 6736.932630673728, 6749.0888730020815, 5314.794360340416, 5340.225667278223, 5380.085385484477, 5388.003219404422, 5388.137897936312, 4586.289125185602, 4608.331791890224, 4628.560286772751, 4646.186917289461, 4650.116477869194, 5689.715514224355, 5743.885122297531, 5781.797637082682, 5785.623934444247, 5792.420757924174, 6696.933030669728, 6707.027481015323, 6710.328967103348, 6719.0, 6724.630145342053, 5727.3699893011735, 5804.622699524517, 5814.127880817827, 5818.040023396177, 5837.29952405714, 5756.25168728071, 5816.76732930678, 5832.416758324219, 5843.444872737083, 5898.439648233411, 6336.461400780893, 6341.143945567289, 6348.714307856158, 6399.0, 6403.135576697179, 6492.610443373413, 6563.7702680405955, 6570.737170513126, 6581.6709164542535, 6596.67016649156, 6341.682915854097, 6346.952752795737, 6350.7142178603, 6354.586951848115, 6356.555041147075, 6431.5819471734185, 6542.34576542361, 6565.080888675685, 6624.337566243337, 6656.900146497903, 6689.899651505134, 6703.899441508479, 6735.191776986793, 6817.420519255918, 6822.488313376417, 6362.872742545031, 6443.355664433519, 6462.0306953955405, 6537.607743535403, 6541.953287473982, 6453.774117905851, 6453.903191452226, 6465.870682586416, 6468.353164683494, 6473.935260647521, 6398.200224971879, 6414.454771344488, 6429.324920883427, 6448.0, 6449.258335291502, 6471.158749362553, 6475.061116138228, 6514.869702606016, 6547.0, 6581.835454113685, 6263.404976527223, 6299.149614801943, 6382.5532212744665, 6389.137466442156, 6393.232812062396], "value": 6065.095964456616, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [818.4720855048494, 873.2097451806115, 879.9032106468292, 897.8653202019698, 1175.9470823812928, 41566.0, 42600.0, 42608.786956065254, 42650.786746066224, 42760.78619606901, 42146.36780448296, 42248.577514224846, 42496.57503424965, 42506.36240456396, 42595.787021064854, 7717.228277172294, 7927.326177274938, 7929.563873986928, 7931.563763992978, 7941.0, 7788.6884524618945, 7885.763427097197, 7898.052233731932, 7900.288973992339, 7901.920980790204, 7801.96099019507, 7865.0, 7868.724594639189, 7878.369730421581, 7896.486728362638, 7794.493357931745, 7818.765437036898, 7829.099653539859, 7839.96080019602, 7841.68633254672, 7690.807729806799, 7775.1447340792465, 7776.922230777676, 7802.882956755653, 7809.453338266324, 38438.61561384378, 38637.8408647741, 38746.0, 38757.22485550273, 38778.0, 3538.716902647782, 3540.132667496454, 3568.1793187567005, 3571.23218508022, 3573.9642603573893, 31280.37439251225, 31480.842595787104, 31532.684673153206, 31737.20656983594, 31815.20461988446, 4245.957540424587, 4387.3857659927635, 4418.955810441887, 4457.509673935864, 4460.687751857371, 174655.0, 177138.0, 178148.0, 178448.0, 178730.10634946742, 47657.76171119192, 47806.760966195645, 47946.5205347949, 47976.52023479721, 48017.27974080392, 49712.0, 49723.50276497189, 49759.0, 49778.751106244235, 49822.50177498251, 12873.776991185823, 13110.278934658494, 14096.224707640973, 16072.116033618264, 16380.754288685679, 13511.594652160451, 13535.05254632186, 13542.05205635596, 13548.322583870768, 13572.0, 13826.170429774245, 13846.861531384759, 14017.229052402216, 14097.577072687836, 14213.715725685428, 5638.0, 5751.511121554631, 5780.0, 5799.88400231993, 5885.352611212763, 958.4919992404037, 965.9082387173207, 997.152420442618, 1019.23557332001, 1024.8257796174669, 21965.560688786136, 21987.34037978863, 22221.44446388821, 22284.108635654393, 22483.775162248494, 1058.090042563395, 1085.6275143961623, 1102.8014957307762, 1119.6417146513038, 1121.870984836738, 11692.47383867728, 11754.0, 11859.762804743857, 11929.164958452999, 12015.639530814089, 211154.0, 212103.0, 212791.0, 212941.0, 213091.0, 50889.49110508848, 51287.0, 51330.48669513257, 51515.48484515107, 51598.48401516012, 1437.1233547535994, 1481.1705444951078, 1483.480781726387, 1494.805675262209, 1519.3163076615347, 21696.457588560414, 21738.239161629266, 21778.237761678265, 21785.128594856662, 21830.89084554567, 36117.0, 36296.27407451783, 36308.81845590755, 36363.636363636026, 36383.81808090943, 185754.0, 188503.0, 194316.0, 195531.0, 195804.0, 32009.199770005936, 32290.35419291648, 32682.673173268915, 35100.12249693778, 35256.823715881255, 46294.30558541692, 46408.071838563716, 46637.0, 46646.30030549612, 46835.53164468312, 26221.0, 27532.32785448584, 27711.0, 28178.85910570434, 28393.148205553865, 26948.32629184286, 27127.0, 28084.0, 28462.85768571144, 29415.411691766472, 38361.0, 38364.80817595894, 38429.231415370974, 38748.41877371785, 38876.22247554977, 31612.525812113297, 33525.83237083799, 34163.829180853936, 34416.139596510286, 34714.82642586771, 24299.878500607385, 24312.635310470003, 24341.0, 24602.876985614956, 24933.0], "value": 16934.191191619695, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.7270046727803, 575.8243735660625, 576.0926540698401, 586.2788769813129, 587.800147949697, 22273.665895011567, 22730.0, 23352.766472335272, 23364.182253621104, 23385.532289354247, 25991.09031183909, 26032.349191270227, 26219.0, 26235.475290494178, 26450.20649380517, 6524.836879078037, 6684.966575167117, 6686.398224159825, 6692.330766923317, 6693.564918280321, 6047.485963693091, 6560.048792925023, 6577.144971153743, 6635.071090047397, 6650.966745166267, 6517.315681853408, 6528.08606795049, 6531.281559028503, 6556.93443065568, 6557.606543607375, 6555.803325900254, 6561.147050883403, 6563.245226798931, 6566.343365663443, 6566.934330656704, 6082.543809214282, 6093.268807743055, 6096.878062438771, 6119.44924956756, 6127.11156882254, 29327.560086598718, 29687.25781855449, 29777.0, 29986.70013299861, 30296.24259393511, 1864.869459137861, 1918.9232430702755, 1921.0, 1922.7596550431197, 1926.8651194416395, 18466.35367762122, 18945.81054189454, 18980.14589343483, 19052.90473547637, 19149.04254787269, 2265.161890100657, 2302.5970455170445, 2324.825638077134, 2340.4382948092334, 2403.495265994143, 134375.0, 138549.0, 138640.0, 138865.0, 138909.3054534731, 13782.448702052006, 14626.780598291034, 14788.926055369655, 15338.923305383401, 15615.297311621005, 23588.882055589613, 23672.88163559171, 23679.52640947206, 23797.0, 23812.16657417017, 10315.742106447398, 10320.638777642747, 10337.224708146769, 10375.740606484747, 10410.895891040993, 9596.184324332371, 9648.565814538362, 9688.951555242178, 9829.45937973404, 9893.802123957481, 8899.377043607015, 8917.719494642608, 9055.864162037575, 9142.542872856331, 9222.262219022463, 2688.4085501189707, 2742.3829638331613, 2782.944341113207, 2785.7632101271215, 2808.2698498390155, 902.7562558109274, 939.3330735177964, 951.3816019587324, 953.4755884263627, 982.5824024789435, 19249.32627358036, 19442.70835937462, 19473.415797526097, 19689.11398987049, 19942.401727948185, 993.1359717046216, 995.5171741705267, 1003.6437064841876, 1019.1591936652292, 1035.6219979707503, 10495.580176792842, 10544.683659490227, 10566.947165264279, 10780.353178809297, 11018.228723989243, 496441.0, 501757.0, 525268.0, 531217.0, 537130.0, 123981.38009310076, 127329.0, 128434.0, 129564.0, 129965.0, 1178.2459226095307, 1191.5055252070467, 1211.4185191108318, 1217.6164508179895, 1217.6712287682276, 16374.918125409296, 20827.06278217514, 21887.781122188575, 22056.669149962443, 22226.110955561595, 58815.41184588099, 59289.11066333922, 59483.405165947785, 59653.70173149106, 61079.69460152671, 66217.0, 66588.33411665821, 66769.33230667826, 67145.99281010691, 68279.3172068273, 12514.561990330294, 15085.868559858274, 15220.847791521943, 15291.388344466543, 15451.304691288695, 17459.738103928197, 19288.90355548213, 24406.51186976215, 24706.50586988286, 24708.752912470645, 17487.300507980046, 17750.20124094393, 17911.462656120337, 17929.01390423539, 17996.460106196835, 14149.292535372984, 14630.341634626255, 15821.841781582038, 15856.60358491047, 16153.59616009609, 18852.811471885107, 19084.95032773211, 19339.323123691167, 19975.300864469675, 20149.39551813448, 14716.55850324492, 14744.48394306237, 14793.556193314218, 14883.255837208313, 14912.85087149158, 17676.823231767517, 18682.906585466986, 19125.139368728163, 19168.233270669018, 19176.232950682373], "value": 12027.617313912446, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1324.8675132486749, 1367.432515506065, 1389.5414513210637, 1393.5679939218837, 1395.7976093466455, 13581.728365432698, 14146.221957792317, 14149.504767333132, 14150.716985660281, 14156.929215353908, 13880.30598470075, 14711.48509802157, 14720.190389528598, 14723.04300220485, 14736.778948315758, 2456.9631455528183, 2517.169334119736, 2524.8232623716253, 2526.759957804006, 2531.6076008218756, 2509.8619575923317, 2619.371350875795, 2648.0996461203185, 2674.9598756018677, 2689.556223223166, 2542.6821647294087, 2608.21753473958, 2626.7373262673773, 2676.4513274778624, 2680.865956702167, 2610.947781044378, 2615.2415799418145, 2626.107123577983, 2626.4372698244515, 2626.500964816679, 2571.7171111177754, 2572.8165044079747, 2580.6129080637866, 2582.625519299691, 2606.2572166932523, 13638.93180534101, 13717.245551494663, 13774.242416667079, 13788.379522921392, 13794.586162415144, 7240.891386629205, 7519.13529944058, 7539.623018849035, 7543.2079631638435, 7552.169261381244, 4830.492798256203, 4836.41962964443, 4907.11671899058, 5025.472325405816, 5042.3949126104735, 1701.9744703829454, 1713.4088739384893, 1713.4088739385018, 1725.413359457778, 1754.2281396185638, 21870.562588748297, 22179.223727169472, 22254.332370028762, 22271.331860044225, 22272.554548909095, 6263.467605253513, 6338.619682819046, 6369.20384951881, 6476.902846457307, 6724.529282950147, 15548.222588870738, 15563.766543501857, 15583.844161558465, 15615.219239038002, 15636.296366663528, 7150.821229469201, 7272.163701174327, 7307.89038164428, 7321.487495875344, 7327.523710958771, 5374.5700343972385, 6156.969215153896, 6667.166604174478, 6877.449804015667, 6892.689828957709, 5372.167314066326, 5509.0, 5559.360673522516, 5577.498025177753, 5777.075667893201, 1713.468824664358, 1725.4564812084154, 1734.09826890019, 1737.1661602430904, 1770.4334612924, 825.9215374539409, 846.5259454705384, 850.6852464588142, 861.8362511122866, 881.8589025755977, 6511.15355003856, 6704.66476676174, 6862.279460656659, 6927.168739751262, 6949.513534052669, 944.0795224655906, 980.9068138526828, 985.7979114281555, 986.4870267461024, 986.6891929042472, 4654.138984287918, 4964.950350496449, 5020.799168033238, 5297.629165958346, 5428.104362780097, 18135.36526221576, 19222.135003924857, 19242.326518571783, 19248.61502769965, 19292.517687057934, 18901.81098189028, 18966.620667586572, 19286.61426771485, 19361.806381936283, 19400.611987760167, 10499.580016799242, 10720.839187412195, 11050.834237486444, 11087.05760010392, 11099.611513596985, 7517.887231691419, 7807.960960195162, 8034.116247212919, 8133.959330203311, 8292.37807164453, 15990.120543370227, 16308.021518708916, 16930.830691692925, 17030.744538832176, 17355.0, 16880.662386751952, 17222.31110755606, 17286.0, 17366.565835854206, 17601.20794564222, 11297.322160670386, 11368.317900925971, 11417.543298267976, 11484.19610627248, 11491.195616306779, 12816.615501534969, 12877.420516076612, 12999.610011699664, 13063.542776002794, 13176.736465270833, 8928.598213080557, 9220.285024995488, 9232.261419086592, 9290.767730806514, 9407.670731524364, 9598.760030999281, 9691.5154242289, 9825.4104753715, 9847.507624618596, 9940.751481213027, 8659.913400865911, 8825.470471771714, 8856.557172141496, 8880.689175878813, 8887.97788254359, 6042.939570604413, 6261.279952805486, 6569.4744420447205, 6569.967150164219, 6576.572522786004, 6416.615003099829, 6550.803475895731, 6798.7620433286575, 6992.475564332797, 7000.544964577286], "value": 6223.558291873809, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [493.54986479098017, 504.76081220603425, 521.6739537788882, 522.7804322184681, 527.8996990571791, 6163.38366163384, 6209.534284928626, 6250.28121765997, 6291.24505059393, 6331.1769469968895, 5899.941000589993, 6047.516198704104, 6133.27069454092, 6159.384061593838, 6204.875902481947, 4905.141600219965, 4955.851324460254, 4967.0, 4984.451710311862, 5018.799248030084, 4905.645290260677, 4918.311436398907, 4944.826931057396, 4961.603071754251, 4982.17794063979, 4683.414573178353, 4889.828855990041, 4896.143174944388, 4900.803967841282, 4913.508649135076, 4930.408350997867, 4933.45731969483, 4937.23472861707, 4971.950280497203, 5032.899342013139, 4414.690971631987, 4424.734515929054, 4467.195904737146, 4483.327500874862, 4491.393661855673, 6054.96972515139, 6124.510039196898, 6172.135900973867, 6182.289036760785, 6202.472789812871, 5711.914321285184, 5751.504608801742, 5770.336411312669, 5785.218995435646, 5841.707914604295, 6566.212054553484, 6614.900776488356, 6620.735170593171, 6658.966705166492, 6668.399844014062, 4828.52729917375, 4877.146499362598, 4891.902161956741, 4902.093112774148, 4922.581580565657, 6915.723371065152, 6962.721491140399, 6998.75504357345, 7018.017477553147, 7032.789016329519, 5014.473480284518, 5015.749212539358, 5060.569851562658, 5070.163423035158, 5099.260607211933, 5058.620603454756, 5115.923261151086, 5132.692038477703, 5148.588112950955, 5153.665955735871, 5710.143478478179, 5712.7714891403875, 5726.169705392778, 5742.885142297131, 5755.453231942959, 6527.967360163168, 6659.469401627351, 6679.699413526403, 6722.226943901416, 6760.594364338155, 1666.475060355984, 1700.9843335647297, 1710.3757128648203, 1747.842694157532, 1763.6296377760557, 1210.903127749778, 1218.2325135164967, 1225.546547777328, 1230.354064116346, 1250.593557093948, 5743.712814359265, 5752.188060760847, 5774.133879918046, 5781.797637082682, 5787.5080618147085, 6590.439812615886, 6668.533202675863, 6691.397774200345, 6731.629760363129, 6751.0, 5763.884722305615, 5767.192593036978, 5768.644368573382, 5770.480656740913, 5895.616784908967, 3579.8926032218556, 3604.585472670624, 3621.167131559703, 3627.220147668211, 3657.908552286214, 6550.148480697479, 6585.835354116185, 6606.4565142420515, 6609.272979972199, 6616.007598860209, 7018.649067546602, 7019.578245505292, 7040.6479676016, 7060.5410648308725, 7063.834467312939, 6510.641914694737, 6552.541322107502, 6597.571157874723, 6601.834954126185, 6621.33786621334, 6716.294789047275, 6716.83207919806, 6809.38715515606, 6813.591184528944, 6828.283030281749, 6715.56348837324, 6752.797416077526, 6806.319368063154, 6846.726130954706, 6848.623325717133, 6589.17635295588, 6615.81678046234, 6626.734930602915, 6648.368405001517, 6661.600303981777, 4853.635977301646, 4859.659823812299, 4874.512548745097, 4976.402831660224, 4993.126202914548, 6688.063671085954, 6731.697073631601, 6753.425958793361, 6767.458603311822, 6825.317468253135, 6494.0, 6524.869502609827, 6530.771423000172, 6547.134066790942, 6656.73373065072, 6395.680215989275, 6458.67706614658, 6559.540832141704, 6568.088720151902, 6609.702563384755, 6162.0, 6209.96895015522, 6389.297177310399, 6389.808305750835, 6470.35296470368, 6468.611883287018, 6521.804315885087, 6536.738530458919, 6580.144581204413, 6588.143541339595, 6288.811335659938, 6315.494760419064, 6333.8733225336155, 6345.209366928125, 6378.138951241523], "value": 5070.757818410307, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [890.6036813617939, 912.6805618033693, 917.5137177296033, 926.3422969691519, 938.1041105744015, 18335.0, 19281.517962050955, 19295.710564341527, 19297.517562060955, 19311.227550897966, 17485.7377139343, 17640.647187056253, 17674.823251767477, 19017.904910475427, 21990.560188796255, 1019.6329321444274, 1039.6517166749147, 1039.7556574205055, 1039.807635587415, 1040.0223789637716, 1036.906678398944, 1043.1446214104437, 1043.9164866810675, 1044.9373037617768, 1045.1847558904067, 995.3828626251734, 1030.8402197659375, 1081.232325049216, 1081.8323159910226, 1082.2099867097024, 1062.2776511971856, 1064.1380481809758, 1066.077842666096, 1068.369661899479, 1068.8236440987266, 779.5985067690087, 779.7582749347721, 780.3055280800093, 781.8514482248412, 782.2255966593088, 17930.91034544832, 18324.358647447276, 18411.63176736471, 18425.447236582924, 20116.994150292427, 20110.095045722977, 20118.396448106432, 20788.896055519777, 20803.0, 20958.685619715718, 16661.91669041659, 16745.16274186286, 16804.83195168057, 16944.49166525006, 16945.152742362956, 3562.4656301554714, 3599.31612993533, 3609.4405367168133, 3610.5847827499647, 3611.7652352596997, 115368.4231578845, 117370.41314793371, 118062.40968795274, 118741.0, 120495.0, 15647.608809779618, 16298.348066077224, 16440.342386304652, 16458.09480478585, 16465.83534164667, 29327.266818329714, 31435.685643143734, 31518.842405787826, 31675.366492670477, 31861.840690796398, 8647.610857511427, 8686.869696954423, 8699.304055675531, 8706.564671766386, 8785.956070219609, 4143.295639741251, 4200.4539409876525, 4214.515330736943, 4221.02916329246, 4229.111886503807, 4713.8350157745, 4810.494898035726, 4870.756462176877, 5536.944630553723, 5859.707014649251, 1009.4599389326675, 1038.159091136182, 1056.102313033915, 1056.5404049238605, 1062.5590379992216, 641.6150309814168, 663.6217356107069, 681.3935597318391, 684.3924647094585, 693.3932808792307, 11423.885761142283, 12701.428435720414, 12778.488860445477, 12858.228506289652, 12991.415386307639, 673.2997682410337, 691.3225039461356, 699.6431819771851, 700.6566782276648, 703.9049728286718, 5261.789528418821, 5493.258410114663, 5572.916406253909, 6058.969705151534, 6363.172787537591, 92956.53521732484, 94687.52656236812, 96938.51530742302, 97055.0294497046, 100772.0, 84403.0, 86243.13756862476, 88038.0, 88068.55965720258, 89782.10217897868, 69233.65383173153, 75195.62402187954, 77607.22392776112, 80071.59964200141, 80270.59864700756, 11850.881491184979, 12326.630201093982, 12689.936550317188, 12845.229286242855, 12930.159539629894, 35440.0, 35890.44503594596, 36118.41319154025, 36215.0, 38059.809700951315, 64559.354406455335, 64694.35305646883, 66597.66701166463, 68350.0, 72421.27578724145, 18276.268949242414, 18396.172172252547, 19091.427257182306, 19218.327358542385, 19323.420297390538, 20199.59600808005, 20777.0, 20836.166553337698, 21192.894035529724, 21382.0, 18468.44594662162, 19160.808391915903, 19436.70844937299, 19818.801811981695, 19989.0, 17802.5549361267, 19504.512387190432, 19630.705539417206, 19637.70543441821, 19701.0, 18172.0, 18813.341533046278, 19065.61868762589, 19180.80819191846, 19429.319973800848, 11972.940135299268, 13075.411606477921, 13100.410481528164, 13111.0, 13420.597382078553, 14375.496857609933, 14577.416903323749, 14715.108595366759, 15041.774373384627, 15439.150846703538], "value": 9075.874093978467, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1552.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 120.0, 104.0, 110.0, 110.0, 110.0, 109.0, 101.0, 109.0, 108.0], "value": 108.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 122.0, 143.0, 181.0, 123.0, 146.0, 145.0, 130.0, 175.0, 121.0], "value": 144.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 164.0, 165.0, 165.0, 164.0, 169.0, 168.0, 164.0, 165.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 180.0, 75.0, 76.0, 77.0, 78.0, 161.0, 76.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 152.0, 78.0, 78.0, 79.0, 129.0, 81.0, 80.0, 130.0], "value": 96.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 114.0, 114.0, 115.0, 114.0, 114.0, 114.0, 116.0], "value": 114.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 152.0, 151.0, 151.0, 151.0, 150.0, 152.0, 150.0, 151.0], "value": 151.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 96.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 56.0, 56.0, 55.0, 57.0, 57.0, 55.0, 56.0, 56.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 55.0, 54.0, 54.0, 55.0, 55.0, 55.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 89.0, 80.0, 80.0, 81.0, 99.0, 81.0, 90.0, 81.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 139.0, 126.0, 135.0, 147.0, 128.0, 144.0, 127.0, 130.0, 172.0], "value": 137.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 187.0, 196.0, 184.0, 178.0, 190.0, 179.0, 176.0, 180.0, 177.0], "value": 182.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 71.0, 68.0, 66.0, 71.0, 71.0, 68.0, 69.0, 69.0], "value": 68.8, "unit": "score"}]}]} 07:01:54 INFO - Return code: 0 07:01:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:01:54 INFO - # TBPL SUCCESS # 07:01:54 INFO - Running post-action listener: _package_coverage_data 07:01:54 INFO - Running post-action listener: _resource_record_post_action 07:01:54 INFO - [mozharness: 2017-07-31 14:01:54.301249Z] Finished run-tests step (success) 07:01:54 INFO - Running post-run listener: _resource_record_post_run 07:01:54 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 16384; Write bytes: 436797440; Read time: 320; Write time: 329940 07:01:54 INFO - TinderboxPrint: CPU usage
13.1% 07:01:54 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 320 07:01:54 INFO - TinderboxPrint: I/O write bytes / time
436,797,440 / 329,940 07:01:54 INFO - TinderboxPrint: CPU idle
8,263.0 (86.9%) 07:01:54 INFO - TinderboxPrint: CPU user
1,201.6 (12.6%) 07:01:54 INFO - TinderboxPrint: Swap in / out
0 / 0 07:01:54 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 112959488; Read time: 32; Write time: 90080 07:01:54 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 07:01:54 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 8192; Write bytes: 322269184; Read time: 276; Write time: 239792 07:01:54 INFO - Running post-run listener: _upload_blobber_files 07:01:54 INFO - Blob upload gear active. 07:01:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:01:54 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 07:01:54 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', 'Cedar', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:01:54 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 Cedar -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:01:55 INFO - (blobuploader) - INFO - Open directory for files ... 07:01:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:01:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:01:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:01:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:01:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:01:56 INFO - (blobuploader) - INFO - Done attempting. 07:01:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:01:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:01:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:01:57 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:01:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:01:57 INFO - (blobuploader) - INFO - Done attempting. 07:01:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:01:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:01:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:01:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:01:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:01:57 INFO - (blobuploader) - INFO - Done attempting. 07:01:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:01:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:01:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:02:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:02:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:02:00 INFO - (blobuploader) - INFO - Done attempting. 07:02:00 INFO - (blobuploader) - INFO - Iteration through files over. 07:02:00 INFO - Return code: 0 07:02:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:02:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:02:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/efe78423442470c4e39b2f48c8161918d6b76b666377a349cdefbfafed4e2f5c3bf5c2338e34d79e3574d3b4e166982360466037c5715e08b34ed1e3de430843", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/e3b2f2362daea9063e2a3f7e7384c6e85f9013ba620af75dd9e261a90f09536bb6975038b01cee352ba779a65822a62b7f5e0f4a634e54dda92774250137dba2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/98efd2117580e872f5e3b2d67dab4a5328a3c03fa2e4e6933fddf1c571666a255acd75c27a6bfd1420d9aca5d4db502b9fcc46fa2c113166a05df297cea1557c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/731be2bb4f078afdc8dcc2e73e19c9fa46b8854a402fc94e4376a65a4317f1f3ad408e29af001c92acef00a3ea397b1100af799c8bc1a89b499077d7fdc48c75"} 07:02:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:02:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:02:00 INFO - Contents: 07:02:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/efe78423442470c4e39b2f48c8161918d6b76b666377a349cdefbfafed4e2f5c3bf5c2338e34d79e3574d3b4e166982360466037c5715e08b34ed1e3de430843", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/e3b2f2362daea9063e2a3f7e7384c6e85f9013ba620af75dd9e261a90f09536bb6975038b01cee352ba779a65822a62b7f5e0f4a634e54dda92774250137dba2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/98efd2117580e872f5e3b2d67dab4a5328a3c03fa2e4e6933fddf1c571666a255acd75c27a6bfd1420d9aca5d4db502b9fcc46fa2c113166a05df297cea1557c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/731be2bb4f078afdc8dcc2e73e19c9fa46b8854a402fc94e4376a65a4317f1f3ad408e29af001c92acef00a3ea397b1100af799c8bc1a89b499077d7fdc48c75"} 07:02:00 INFO - Running post-run listener: copy_logs_to_upload_dir 07:02:00 INFO - Copying logs to upload dir... 07:02:00 INFO - mkdir: /builds/slave/test/build/upload/logs 07:02:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.974546 ========= master_lag: -0.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-07-31 07:02:00.557195) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-31 07:02:00.561292) ========= 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=6d15e502d8e29d5d2676d664000001c3-1501508409.165673-1389218230 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/Cedar/sha512/efe78423442470c4e39b2f48c8161918d6b76b666377a349cdefbfafed4e2f5c3bf5c2338e34d79e3574d3b4e166982360466037c5715e08b34ed1e3de430843", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/e3b2f2362daea9063e2a3f7e7384c6e85f9013ba620af75dd9e261a90f09536bb6975038b01cee352ba779a65822a62b7f5e0f4a634e54dda92774250137dba2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/98efd2117580e872f5e3b2d67dab4a5328a3c03fa2e4e6933fddf1c571666a255acd75c27a6bfd1420d9aca5d4db502b9fcc46fa2c113166a05df297cea1557c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/731be2bb4f078afdc8dcc2e73e19c9fa46b8854a402fc94e4376a65a4317f1f3ad408e29af001c92acef00a3ea397b1100af799c8bc1a89b499077d7fdc48c75"} build_url:https://queue.taskcluster.net/v1/task/IOZBrifhSf2vs-92s6FmwQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011245 build_url: 'https://queue.taskcluster.net/v1/task/IOZBrifhSf2vs-92s6FmwQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/efe78423442470c4e39b2f48c8161918d6b76b666377a349cdefbfafed4e2f5c3bf5c2338e34d79e3574d3b4e166982360466037c5715e08b34ed1e3de430843", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/e3b2f2362daea9063e2a3f7e7384c6e85f9013ba620af75dd9e261a90f09536bb6975038b01cee352ba779a65822a62b7f5e0f4a634e54dda92774250137dba2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/98efd2117580e872f5e3b2d67dab4a5328a3c03fa2e4e6933fddf1c571666a255acd75c27a6bfd1420d9aca5d4db502b9fcc46fa2c113166a05df297cea1557c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/731be2bb4f078afdc8dcc2e73e19c9fa46b8854a402fc94e4376a65a4317f1f3ad408e29af001c92acef00a3ea397b1100af799c8bc1a89b499077d7fdc48c75"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-31 07:02:00.592216) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 07:02:00.592586) ========= 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=6d15e502d8e29d5d2676d664000001c3-1501508409.165673-1389218230 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004392 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 07:02:00.672348) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-31 07:02:00.672662) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-31 07:02:00.672958) ========= ========= Total master_lag: 0.09 =========