builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-085 starttime: 1502321491.08 results: success (0) revision: a4a448ba7f187069fce916ee234a06cbb0d06f80 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-09 16:31:31.084121) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-09 16:31:31.084556) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-09 16:31:31.084856) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-09 16:31:31.114284) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 16:31:31.114552) ========= 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=5c37b704b588aaa989324530000001d0-1502318132.175676-260754789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-09 16:31:31-- 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% 39.8M=0s 2017-08-09 16:31:31 (39.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.152476 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 16:31:31.294662) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 16:31:31.294980) ========= 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=5c37b704b588aaa989324530000001d0-1502318132.175676-260754789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015423 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 16:31:31.345573) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 16:31:31.348930) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a4a448ba7f187069fce916ee234a06cbb0d06f80 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev a4a448ba7f187069fce916ee234a06cbb0d06f80 --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=5c37b704b588aaa989324530000001d0-1502318132.175676-260754789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-09 16:31:31,956 truncating revision to first 12 chars 2017-08-09 16:31:31,956 Setting DEBUG logging. 2017-08-09 16:31:31,956 attempt 1/10 2017-08-09 16:31:31,957 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a4a448ba7f18?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-09 16:31:32,394 unpacking tar archive at: mozilla-central-a4a448ba7f18/testing/mozharness/ program finished with exit code 0 elapsedTime=0.740633 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 16:31:32.105341) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-09 16:31:32.105662) ========= script_repo_revision: a4a448ba7f187069fce916ee234a06cbb0d06f80 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-09 16:31:32.106076) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-09 16:31:32.106352) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-09 16:31:32.115652) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-09 16:31:32.115973) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5c37b704b588aaa989324530000001d0-1502318132.175676-260754789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:31:32 INFO - MultiFileLogger online at 20170809 16:31:32 in /builds/slave/test 16:31:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:31:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:31:32 INFO - {'append_to_log': False, 16:31:32 INFO - 'base_work_dir': '/builds/slave/test', 16:31:32 INFO - 'blob_upload_branch': 'Firefox', 16:31:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:31:32 INFO - 'branch': 'Firefox', 16:31:32 INFO - 'buildbot_json_path': 'buildprops.json', 16:31:32 INFO - 'code_coverage': False, 16:31:32 INFO - 'config_files': ('talos/linux_config.py',), 16:31:32 INFO - 'default_actions': ('clobber', 16:31:32 INFO - 'read-buildbot-config', 16:31:32 INFO - 'download-and-extract', 16:31:32 INFO - 'populate-webroot', 16:31:32 INFO - 'create-virtualenv', 16:31:32 INFO - 'install', 16:31:32 INFO - 'setup-mitmproxy', 16:31:32 INFO - 'run-tests'), 16:31:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:31:32 INFO - 'disable_ccov_upload': False, 16:31:32 INFO - 'download_minidump_stackwalk': True, 16:31:32 INFO - 'download_symbols': 'ondemand', 16:31:32 INFO - 'enable_stylo': False, 16:31:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:31:32 INFO - 'tooltool.py': '/tools/tooltool.py', 16:31:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:31:32 INFO - '/tools/misc-python/virtualenv.py')}, 16:31:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:31:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:31:32 INFO - 'gecko_profile': False, 16:31:32 INFO - 'gecko_profile_interval': 0, 16:31:32 INFO - 'installer_path': 'installer.exe', 16:31:32 INFO - 'log_level': 'info', 16:31:32 INFO - 'log_name': 'talos', 16:31:32 INFO - 'log_to_console': True, 16:31:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:31:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:31:32 INFO - 'opt_config_files': (), 16:31:32 INFO - 'pip_index': False, 16:31:32 INFO - 'suite': 'dromaeojs-e10s', 16:31:32 INFO - 'system_bits': '32', 16:31:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:31:32 INFO - 'title': 'talos-linux64-ix-085', 16:31:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:31:32 INFO - 'use_talos_json': True, 16:31:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:31:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:31:32 INFO - 'work_dir': 'build'} 16:31:32 INFO - [mozharness: 2017-08-09 23:31:32.835020Z] Running clobber step. 16:31:32 INFO - Running pre-action listener: _resource_record_pre_action 16:31:32 INFO - Running main action method: clobber 16:31:32 INFO - rmtree: /builds/slave/test/build 16:31:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:31:34 INFO - Running post-action listener: _resource_record_post_action 16:31:34 INFO - [mozharness: 2017-08-09 23:31:34.381724Z] Finished clobber step (success) 16:31:34 INFO - [mozharness: 2017-08-09 23:31:34.381827Z] Running read-buildbot-config step. 16:31:34 INFO - Running pre-action listener: _resource_record_pre_action 16:31:34 INFO - Running main action method: read_buildbot_config 16:31:34 INFO - Using buildbot properties: 16:31:34 INFO - { 16:31:34 INFO - "project": "", 16:31:34 INFO - "product": "firefox", 16:31:34 INFO - "who": "ryanvm@gmail.com", 16:31:34 INFO - "installer_path": "public/build/target.tar.bz2", 16:31:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 16:31:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:31:34 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 16:31:34 INFO - "stage_platform": "linux64-stylosequential", 16:31:34 INFO - "basedir": "/builds/slave/test", 16:31:34 INFO - "buildnumber": 141, 16:31:34 INFO - "platform": "ubuntu64_hw_styloseq", 16:31:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:31:34 INFO - "slavebuilddir": "test", 16:31:34 INFO - "taskId": "PefKYYrBSc2LIBcx0dospA", 16:31:34 INFO - "branch": "mozilla-central", 16:31:34 INFO - "script_repo_revision": "production", 16:31:34 INFO - "revision": "a4a448ba7f187069fce916ee234a06cbb0d06f80", 16:31:34 INFO - "slavename": "talos-linux64-ix-085", 16:31:34 INFO - "repo_path": "mozilla-central" 16:31:34 INFO - } 16:31:34 INFO - Finding installer, test and symbols from parent task. 16:31:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PefKYYrBSc2LIBcx0dospA'}, attempt #1 16:31:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PefKYYrBSc2LIBcx0dospA'}, attempt #1 16:31:35 INFO - Task dependencies: W3D-FPkqR6iRZ6ceKXKElw 16:31:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw'}, attempt #1 16:31:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.tar.bz2 16:31:35 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.test_packages.json 16:31:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.crashreporter-symbols.zip 16:31:35 INFO - Running post-action listener: _resource_record_post_action 16:31:35 INFO - [mozharness: 2017-08-09 23:31:35.724405Z] Finished read-buildbot-config step (success) 16:31:35 INFO - [mozharness: 2017-08-09 23:31:35.724626Z] Running download-and-extract step. 16:31:35 INFO - Running pre-action listener: _resource_record_pre_action 16:31:35 INFO - Running main action method: download_and_extract 16:31:35 INFO - mkdir: /builds/slave/test/build/tests 16:31:35 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')]} 16:31:35 INFO - trying https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.test_packages.json 16:31:35 INFO - Downloading https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:31:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:31:36 INFO - Downloaded 989 bytes. 16:31:36 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:31:36 INFO - Using the following test package requirements: 16:31:36 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:31:36 INFO - u'common': [u'target.common.tests.zip'], 16:31:36 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:31:36 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:31:36 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:31:36 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:31:36 INFO - u'mozbase': [u'target.common.tests.zip'], 16:31:36 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:31:36 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:31:36 INFO - u'web-platform': [u'target.common.tests.zip', 16:31:36 INFO - u'target.web-platform.tests.tar.gz'], 16:31:36 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:31:36 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:31:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.common.tests.zip 16:31:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:31:36 INFO - Fetch https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.common.tests.zip into memory 16:31:37 INFO - Content-Length response header: 54284101 16:31:37 INFO - Bytes received: 54284101 16:31:48 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:31:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.common.tests.zip 16:31:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:31:48 INFO - Fetch https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.common.tests.zip into memory 16:31:49 INFO - Content-Length response header: 54284101 16:31:49 INFO - Bytes received: 54284101 16:32:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.talos.tests.zip 16:32:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:32:01 INFO - Fetch https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.talos.tests.zip into memory 16:32:02 INFO - Content-Length response header: 14496008 16:32:02 INFO - Bytes received: 14496008 16:32:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:02 INFO - trying https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.tar.bz2 16:32:02 INFO - Downloading https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:32:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:32:03 INFO - Downloaded 61801086 bytes. 16:32:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.tar.bz2 16:32:03 INFO - mkdir: /builds/slave/test/properties 16:32:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:32:03 INFO - Writing to file /builds/slave/test/properties/build_url 16:32:03 INFO - Contents: 16:32:03 INFO - build_url:https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.tar.bz2 16:32:03 INFO - Running post-action listener: _resource_record_post_action 16:32:03 INFO - Running post-action listener: set_extra_try_arguments 16:32:03 INFO - [mozharness: 2017-08-09 23:32:03.541556Z] Finished download-and-extract step (success) 16:32:03 INFO - [mozharness: 2017-08-09 23:32:03.541676Z] Running populate-webroot step. 16:32:03 INFO - Running pre-action listener: _resource_record_pre_action 16:32:03 INFO - Running main action method: populate_webroot 16:32:03 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:32:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:32:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:32:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:32:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:32:03 INFO - 'tests': ['damp', 'tps']}, 16:32:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:32:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:32:03 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:32:03 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:32:03 INFO - 'other-e10s': {'tests': ['a11yr', 16:32:03 INFO - 'ts_paint', 16:32:03 INFO - 'tpaint', 16:32:03 INFO - 'sessionrestore', 16:32:03 INFO - 'sessionrestore_many_windows', 16:32:03 INFO - 'sessionrestore_no_auto_restore', 16:32:03 INFO - 'tabpaint']}, 16:32:03 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 16:32:03 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 16:32:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:32:03 INFO - 'tsvgr_opacity', 16:32:03 INFO - 'tart', 16:32:03 INFO - 'tscrollx', 16:32:03 INFO - 'tsvg_static']}, 16:32:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:32:03 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:32:03 INFO - 'talos_options': ['--mitmproxy', 16:32:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:32:03 INFO - '--firstNonBlankPaint'], 16:32:03 INFO - 'tests': ['tp6_google', 16:32:03 INFO - 'tp6_youtube', 16:32:03 INFO - 'tp6_amazon', 16:32:03 INFO - 'tp6_facebook']}, 16:32:03 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:32:03 INFO - 'talos_options': ['--stylo', 16:32:03 INFO - '--mitmproxy', 16:32:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:32:03 INFO - '--firstNonBlankPaint'], 16:32:03 INFO - 'tests': ['tp6_google', 16:32:03 INFO - 'tp6_youtube', 16:32:03 INFO - 'tp6_amazon', 16:32:03 INFO - 'tp6_facebook']}, 16:32:03 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:32:03 INFO - 'talos_options': ['--stylo', 16:32:03 INFO - '--stylo-threads=1', 16:32:03 INFO - '--mitmproxy', 16:32:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:32:03 INFO - '--firstNonBlankPaint'], 16:32:03 INFO - 'tests': ['tp6_google', 16:32:03 INFO - 'tp6_youtube', 16:32:03 INFO - 'tp6_amazon', 16:32:03 INFO - 'tp6_facebook']}, 16:32:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:32:03 INFO - 'talos_options': ['--xperf_path', 16:32:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:32:03 INFO - 'tests': ['tp5n']}}} 16:32:03 INFO - Running post-action listener: _resource_record_post_action 16:32:03 INFO - [mozharness: 2017-08-09 23:32:03.550128Z] Finished populate-webroot step (success) 16:32:03 INFO - [mozharness: 2017-08-09 23:32:03.550219Z] Running create-virtualenv step. 16:32:03 INFO - Running pre-action listener: _resource_record_pre_action 16:32:03 INFO - Running main action method: create_virtualenv 16:32:03 INFO - Creating virtualenv /builds/slave/test/build/venv 16:32:03 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 16:32:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:32:03 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:32:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:32:03 INFO - Using real prefix '/usr' 16:32:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:32:04 INFO - Installing distribute.............................................................................................................................................................................................done. 16:32:06 INFO - Installing pip.................done. 16:32:06 INFO - Return code: 0 16:32:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:32:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:32:06 INFO - Reading from file tmpfile_stdout 16:32:06 INFO - Output received: 16:32:06 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) 16:32:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:06 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 0x1f931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2302700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ff8a0>, '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 0x23007a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2300c30>, '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': '5c37b704b588aaa989324530000001d0-1502318132.175676-260754789', '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 16:32:06 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 16:32:06 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 16:32:06 INFO - Using env: {'DISPLAY': ':0', 16:32:06 INFO - 'HOME': '/home/cltbld', 16:32:06 INFO - 'LANG': 'en_US.UTF-8', 16:32:06 INFO - 'LANGUAGE': 'en_US:en', 16:32:06 INFO - 'LOGNAME': 'cltbld', 16:32:06 INFO - 'MAIL': '/var/mail/cltbld', 16:32:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:06 INFO - 'MOZ_NO_REMOTE': '1', 16:32:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:06 INFO - 'NO_EM_RESTART': '1', 16:32:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:06 INFO - 'PWD': '/builds/slave/test', 16:32:06 INFO - 'SHELL': '/bin/bash', 16:32:06 INFO - 'SHLVL': '1', 16:32:06 INFO - 'TERM': 'linux', 16:32:06 INFO - 'TMOUT': '86400', 16:32:06 INFO - 'USER': 'cltbld', 16:32:06 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1502318132.175676-260754789', 16:32:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:06 INFO - '_': '/tools/buildbot/bin/python'} 16:32:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:06 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 16:32:06 INFO - Cleaning up... 16:32:06 INFO - Return code: 0 16:32:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:06 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 0x1f931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2302700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ff8a0>, '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 0x23007a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2300c30>, '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': '5c37b704b588aaa989324530000001d0-1502318132.175676-260754789', '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 16:32:06 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 16:32:06 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 16:32:06 INFO - Using env: {'DISPLAY': ':0', 16:32:06 INFO - 'HOME': '/home/cltbld', 16:32:06 INFO - 'LANG': 'en_US.UTF-8', 16:32:06 INFO - 'LANGUAGE': 'en_US:en', 16:32:06 INFO - 'LOGNAME': 'cltbld', 16:32:06 INFO - 'MAIL': '/var/mail/cltbld', 16:32:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:06 INFO - 'MOZ_NO_REMOTE': '1', 16:32:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:06 INFO - 'NO_EM_RESTART': '1', 16:32:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:06 INFO - 'PWD': '/builds/slave/test', 16:32:06 INFO - 'SHELL': '/bin/bash', 16:32:06 INFO - 'SHLVL': '1', 16:32:06 INFO - 'TERM': 'linux', 16:32:06 INFO - 'TMOUT': '86400', 16:32:06 INFO - 'USER': 'cltbld', 16:32:06 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1502318132.175676-260754789', 16:32:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:06 INFO - '_': '/tools/buildbot/bin/python'} 16:32:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:06 INFO - Downloading/unpacking psutil>=3.1.1 16:32:06 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 16:32:06 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 16:32:06 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 16:32:06 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 16:32:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:32:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:32:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:32:07 INFO - Installing collected packages: psutil 16:32:07 INFO - Running setup.py install for psutil 16:32:08 INFO - building 'psutil._psutil_linux' extension 16:32:08 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 16:32:08 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 16:32:08 INFO - building 'psutil._psutil_posix' extension 16:32:08 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 16:32:08 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 16:32:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:32:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:32:08 INFO - Successfully installed psutil 16:32:08 INFO - Cleaning up... 16:32:08 INFO - Return code: 0 16:32:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:32:08 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')]} 16:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:08 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')]} 16:32:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:08 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 0x1f931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2302700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ff8a0>, '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 0x23007a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2300c30>, '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': '5c37b704b588aaa989324530000001d0-1502318132.175676-260754789', '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 16:32:08 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 16:32:08 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 16:32:08 INFO - Using env: {'DISPLAY': ':0', 16:32:08 INFO - 'HOME': '/home/cltbld', 16:32:08 INFO - 'LANG': 'en_US.UTF-8', 16:32:08 INFO - 'LANGUAGE': 'en_US:en', 16:32:08 INFO - 'LOGNAME': 'cltbld', 16:32:08 INFO - 'MAIL': '/var/mail/cltbld', 16:32:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:08 INFO - 'MOZ_NO_REMOTE': '1', 16:32:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:08 INFO - 'NO_EM_RESTART': '1', 16:32:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:08 INFO - 'PWD': '/builds/slave/test', 16:32:08 INFO - 'SHELL': '/bin/bash', 16:32:08 INFO - 'SHLVL': '1', 16:32:08 INFO - 'TERM': 'linux', 16:32:08 INFO - 'TMOUT': '86400', 16:32:08 INFO - 'USER': 'cltbld', 16:32:08 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1502318132.175676-260754789', 16:32:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:08 INFO - '_': '/tools/buildbot/bin/python'} 16:32:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:32:08 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 16:32:08 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 16:32:08 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 16:32:08 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 16:32:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:32:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:32:09 INFO - Installing collected packages: mozsystemmonitor 16:32:09 INFO - Running setup.py install for mozsystemmonitor 16:32:09 INFO - Successfully installed mozsystemmonitor 16:32:09 INFO - Cleaning up... 16:32:10 INFO - Return code: 0 16:32:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:32: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')]} 16:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32: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')]} 16:32:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1f931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2302700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ff8a0>, '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 0x23007a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2300c30>, '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': '5c37b704b588aaa989324530000001d0-1502318132.175676-260754789', '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 16:32:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:32:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:32:10 INFO - Using env: {'DISPLAY': ':0', 16:32:10 INFO - 'HOME': '/home/cltbld', 16:32:10 INFO - 'LANG': 'en_US.UTF-8', 16:32:10 INFO - 'LANGUAGE': 'en_US:en', 16:32:10 INFO - 'LOGNAME': 'cltbld', 16:32:10 INFO - 'MAIL': '/var/mail/cltbld', 16:32:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:10 INFO - 'MOZ_NO_REMOTE': '1', 16:32:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:10 INFO - 'NO_EM_RESTART': '1', 16:32:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:10 INFO - 'PWD': '/builds/slave/test', 16:32:10 INFO - 'SHELL': '/bin/bash', 16:32:10 INFO - 'SHLVL': '1', 16:32:10 INFO - 'TERM': 'linux', 16:32:10 INFO - 'TMOUT': '86400', 16:32:10 INFO - 'USER': 'cltbld', 16:32:10 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1502318132.175676-260754789', 16:32:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:10 INFO - '_': '/tools/buildbot/bin/python'} 16:32:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:10 INFO - Downloading/unpacking jsonschema==2.5.1 16:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:32:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:32:11 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 16:32:11 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 16:32:11 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 16:32:11 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 16:32:11 INFO - Downloading functools32-3.2.3-2.tar.gz 16:32:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:32:11 INFO - warning: no files found matching '*.txt' 16:32:11 INFO - no previously-included directories found matching 'build' 16:32:11 INFO - no previously-included directories found matching 'dist' 16:32:11 INFO - no previously-included directories found matching '.git*' 16:32:11 INFO - Installing collected packages: jsonschema, functools32 16:32:11 INFO - Running setup.py install for functools32 16:32:11 INFO - warning: no files found matching '*.txt' 16:32:11 INFO - no previously-included directories found matching 'build' 16:32:11 INFO - no previously-included directories found matching 'dist' 16:32:11 INFO - no previously-included directories found matching '.git*' 16:32:11 INFO - Successfully installed jsonschema functools32 16:32:11 INFO - Cleaning up... 16:32:11 INFO - Return code: 0 16:32:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:32:11 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')]} 16:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:11 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')]} 16:32:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:11 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 0x1f931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2302700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ff8a0>, '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 0x23007a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2300c30>, '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': '5c37b704b588aaa989324530000001d0-1502318132.175676-260754789', '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 16:32:11 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 16:32:11 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 16:32:11 INFO - Using env: {'DISPLAY': ':0', 16:32:11 INFO - 'HOME': '/home/cltbld', 16:32:11 INFO - 'LANG': 'en_US.UTF-8', 16:32:11 INFO - 'LANGUAGE': 'en_US:en', 16:32:11 INFO - 'LOGNAME': 'cltbld', 16:32:11 INFO - 'MAIL': '/var/mail/cltbld', 16:32:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:11 INFO - 'MOZ_NO_REMOTE': '1', 16:32:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:11 INFO - 'NO_EM_RESTART': '1', 16:32:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:11 INFO - 'PWD': '/builds/slave/test', 16:32:11 INFO - 'SHELL': '/bin/bash', 16:32:11 INFO - 'SHLVL': '1', 16:32:11 INFO - 'TERM': 'linux', 16:32:11 INFO - 'TMOUT': '86400', 16:32:11 INFO - 'USER': 'cltbld', 16:32:11 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1502318132.175676-260754789', 16:32:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:11 INFO - '_': '/tools/buildbot/bin/python'} 16:32:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:32:12 INFO - Cleaning up... 16:32:12 INFO - Return code: 0 16:32:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:32:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1f931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2302700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ff8a0>, '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 0x23007a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2300c30>, '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': '5c37b704b588aaa989324530000001d0-1502318132.175676-260754789', '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 16:32:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:32:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:32:12 INFO - Using env: {'DISPLAY': ':0', 16:32:12 INFO - 'HOME': '/home/cltbld', 16:32:12 INFO - 'LANG': 'en_US.UTF-8', 16:32:12 INFO - 'LANGUAGE': 'en_US:en', 16:32:12 INFO - 'LOGNAME': 'cltbld', 16:32:12 INFO - 'MAIL': '/var/mail/cltbld', 16:32:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:12 INFO - 'MOZ_NO_REMOTE': '1', 16:32:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:12 INFO - 'NO_EM_RESTART': '1', 16:32:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:12 INFO - 'PWD': '/builds/slave/test', 16:32:12 INFO - 'SHELL': '/bin/bash', 16:32:12 INFO - 'SHLVL': '1', 16:32:12 INFO - 'TERM': 'linux', 16:32:12 INFO - 'TMOUT': '86400', 16:32:12 INFO - 'USER': 'cltbld', 16:32:12 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1502318132.175676-260754789', 16:32:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:12 INFO - '_': '/tools/buildbot/bin/python'} 16:32:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:12 INFO - Downloading/unpacking blobuploader==1.2.4 16:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:13 INFO - Downloading blobuploader-1.2.4.tar.gz 16:32:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:32:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:32:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:13 INFO - Downloading docopt-0.6.1.tar.gz 16:32:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:32:14 INFO - Installing collected packages: blobuploader, requests, docopt 16:32:14 INFO - Running setup.py install for blobuploader 16:32:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:32:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:32:14 INFO - Running setup.py install for requests 16:32:14 INFO - Running setup.py install for docopt 16:32:14 INFO - Successfully installed blobuploader requests docopt 16:32:14 INFO - Cleaning up... 16:32:14 INFO - Return code: 0 16:32:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:32:14 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')]} 16:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:14 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')]} 16:32:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:14 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 0x1f931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2302700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ff8a0>, '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 0x23007a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2300c30>, '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': '5c37b704b588aaa989324530000001d0-1502318132.175676-260754789', '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 16:32:14 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 16:32:14 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 16:32:14 INFO - Using env: {'DISPLAY': ':0', 16:32:14 INFO - 'HOME': '/home/cltbld', 16:32:14 INFO - 'LANG': 'en_US.UTF-8', 16:32:14 INFO - 'LANGUAGE': 'en_US:en', 16:32:14 INFO - 'LOGNAME': 'cltbld', 16:32:14 INFO - 'MAIL': '/var/mail/cltbld', 16:32:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:14 INFO - 'MOZ_NO_REMOTE': '1', 16:32:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:14 INFO - 'NO_EM_RESTART': '1', 16:32:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:14 INFO - 'PWD': '/builds/slave/test', 16:32:14 INFO - 'SHELL': '/bin/bash', 16:32:14 INFO - 'SHLVL': '1', 16:32:14 INFO - 'TERM': 'linux', 16:32:14 INFO - 'TMOUT': '86400', 16:32:14 INFO - 'USER': 'cltbld', 16:32:14 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1502318132.175676-260754789', 16:32:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:14 INFO - '_': '/tools/buildbot/bin/python'} 16:32:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:32:14 INFO - Running setup.py (path:/tmp/pip-fGf8dG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:32:14 INFO - Running setup.py (path:/tmp/pip-sLzAyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:32:15 INFO - Running setup.py (path:/tmp/pip-yff5Ro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:32:15 INFO - Running setup.py (path:/tmp/pip-7VgwvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:32:15 INFO - Running setup.py (path:/tmp/pip-t3rlEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:32:15 INFO - Running setup.py (path:/tmp/pip-vSOvWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:32:15 INFO - Running setup.py (path:/tmp/pip-anqjoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:32:15 INFO - Running setup.py (path:/tmp/pip-GtkU9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:32:15 INFO - Running setup.py (path:/tmp/pip-wx5gHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:32:15 INFO - Running setup.py (path:/tmp/pip-rD4PkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:32:15 INFO - Running setup.py (path:/tmp/pip-3lfTUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:32:15 INFO - Running setup.py (path:/tmp/pip-JXVOeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:32:15 INFO - Running setup.py (path:/tmp/pip-jcfou_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:32:15 INFO - Running setup.py (path:/tmp/pip-JrXCmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:15 INFO - Running setup.py (path:/tmp/pip-bipMrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:32:15 INFO - Running setup.py (path:/tmp/pip-thqPA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:32:16 INFO - Running setup.py (path:/tmp/pip-1QswPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:32:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:32:16 INFO - Running setup.py install for manifestparser 16:32:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:32:16 INFO - Running setup.py install for mozcrash 16:32:16 INFO - Running setup.py install for mozdebug 16:32:16 INFO - Running setup.py install for mozdevice 16:32:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:32:16 INFO - Running setup.py install for mozfile 16:32:16 INFO - Running setup.py install for mozhttpd 16:32:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:32:16 INFO - Running setup.py install for mozinfo 16:32:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:32:16 INFO - Running setup.py install for mozInstall 16:32:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:32:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:32:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:32:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:32:16 INFO - Running setup.py install for mozleak 16:32:16 INFO - Running setup.py install for mozlog 16:32:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:32:17 INFO - Running setup.py install for moznetwork 16:32:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:32:17 INFO - Running setup.py install for mozprocess 16:32:17 INFO - Running setup.py install for mozprofile 16:32:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:32:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:32:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:32:17 INFO - Running setup.py install for mozrunner 16:32:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:32:17 INFO - Running setup.py install for mozscreenshot 16:32:17 INFO - Running setup.py install for moztest 16:32:17 INFO - Running setup.py install for mozversion 16:32:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:32:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:32:17 INFO - Cleaning up... 16:32:17 INFO - Return code: 0 16:32:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:32:17 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')]} 16:32:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:17 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')]} 16:32:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:17 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 0x1f931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2302700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ff8a0>, '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 0x23007a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2300c30>, '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': '5c37b704b588aaa989324530000001d0-1502318132.175676-260754789', '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 16:32:17 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 16:32:17 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 16:32:17 INFO - Using env: {'DISPLAY': ':0', 16:32:17 INFO - 'HOME': '/home/cltbld', 16:32:17 INFO - 'LANG': 'en_US.UTF-8', 16:32:17 INFO - 'LANGUAGE': 'en_US:en', 16:32:17 INFO - 'LOGNAME': 'cltbld', 16:32:17 INFO - 'MAIL': '/var/mail/cltbld', 16:32:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:17 INFO - 'MOZ_NO_REMOTE': '1', 16:32:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:17 INFO - 'NO_EM_RESTART': '1', 16:32:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:17 INFO - 'PWD': '/builds/slave/test', 16:32:17 INFO - 'SHELL': '/bin/bash', 16:32:17 INFO - 'SHLVL': '1', 16:32:17 INFO - 'TERM': 'linux', 16:32:17 INFO - 'TMOUT': '86400', 16:32:17 INFO - 'USER': 'cltbld', 16:32:17 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1502318132.175676-260754789', 16:32:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:17 INFO - '_': '/tools/buildbot/bin/python'} 16:32:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:32:18 INFO - Running setup.py (path:/tmp/pip-1eZaxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:32:18 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)) 16:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:32:18 INFO - Running setup.py (path:/tmp/pip-Ai8cAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:32:18 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)) 16:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:32:18 INFO - Running setup.py (path:/tmp/pip-6ETpQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:32:18 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)) 16:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:32:18 INFO - Running setup.py (path:/tmp/pip-chs5dO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:32:18 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)) 16:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:32:18 INFO - Running setup.py (path:/tmp/pip-tg_lVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:32:18 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)) 16:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:32:18 INFO - Running setup.py (path:/tmp/pip-reOQx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:32:18 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)) 16:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:32:18 INFO - Running setup.py (path:/tmp/pip-Sy0BwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:32:18 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)) 16:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:32:18 INFO - Running setup.py (path:/tmp/pip-k8QVqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:32:18 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)) 16:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:32:18 INFO - Running setup.py (path:/tmp/pip-DWGUU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:32:18 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)) 16:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:32:18 INFO - Running setup.py (path:/tmp/pip-gtoQlt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:32:18 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)) 16:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:32:18 INFO - Running setup.py (path:/tmp/pip-KQ4O34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:32:18 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)) 16:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:32:18 INFO - Running setup.py (path:/tmp/pip-CgI87Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:32:18 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)) 16:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:32:18 INFO - Running setup.py (path:/tmp/pip-D5keVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:32:19 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)) 16:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:32:19 INFO - Running setup.py (path:/tmp/pip-AZcp4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:32:19 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)) 16:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:19 INFO - Running setup.py (path:/tmp/pip-uObaz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:19 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)) 16:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:32:19 INFO - Running setup.py (path:/tmp/pip-ca1kEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:32:19 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)) 16:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:32:19 INFO - Running setup.py (path:/tmp/pip-qGKtYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:32:19 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)) 16:32:19 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)) 16:32:19 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)) 16:32:19 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)) 16:32:19 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)) 16:32:19 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)) 16:32:19 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)) 16:32:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:32:19 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 16:32:19 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 16:32:19 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 16:32:19 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 16:32:20 INFO - Downloading blessings-1.6.tar.gz 16:32:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:32:20 INFO - Installing collected packages: blessings 16:32:20 INFO - Running setup.py install for blessings 16:32:20 INFO - Successfully installed blessings 16:32:20 INFO - Cleaning up... 16:32:20 INFO - Return code: 0 16:32:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:32:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:32:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:32:20 INFO - Reading from file tmpfile_stdout 16:32:20 INFO - Current package versions: 16:32:20 INFO - argparse == 1.2.1 16:32:20 INFO - blessings == 1.6 16:32:20 INFO - blobuploader == 1.2.4 16:32:20 INFO - docopt == 0.6.1 16:32:20 INFO - functools32 == 3.2.3-2 16:32:20 INFO - jsonschema == 2.5.1 16:32:20 INFO - manifestparser == 1.1 16:32:20 INFO - mozInstall == 1.13 16:32:20 INFO - mozcrash == 1.0 16:32:20 INFO - mozdebug == 0.1 16:32:20 INFO - mozdevice == 0.51 16:32:20 INFO - mozfile == 1.2 16:32:20 INFO - mozhttpd == 0.7 16:32:20 INFO - mozinfo == 0.10 16:32:20 INFO - mozleak == 0.1 16:32:20 INFO - mozlog == 3.5 16:32:20 INFO - moznetwork == 0.27 16:32:20 INFO - mozprocess == 0.25 16:32:20 INFO - mozprofile == 0.28 16:32:20 INFO - mozrunner == 6.13 16:32:20 INFO - mozscreenshot == 0.1 16:32:20 INFO - mozsystemmonitor == 0.3 16:32:20 INFO - moztest == 0.8 16:32:20 INFO - mozversion == 1.4 16:32:20 INFO - psutil == 3.1.1 16:32:20 INFO - requests == 1.2.3 16:32:20 INFO - wsgiref == 0.1.2 16:32:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:32:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:20 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 0x1f931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2302700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ff8a0>, '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 0x23007a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2300c30>, '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': '5c37b704b588aaa989324530000001d0-1502318132.175676-260754789', '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 16:32:20 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 16:32:20 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 16:32:20 INFO - Using env: {'DISPLAY': ':0', 16:32:20 INFO - 'HOME': '/home/cltbld', 16:32:20 INFO - 'LANG': 'en_US.UTF-8', 16:32:20 INFO - 'LANGUAGE': 'en_US:en', 16:32:20 INFO - 'LOGNAME': 'cltbld', 16:32:20 INFO - 'MAIL': '/var/mail/cltbld', 16:32:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:20 INFO - 'MOZ_NO_REMOTE': '1', 16:32:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:20 INFO - 'NO_EM_RESTART': '1', 16:32:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:20 INFO - 'PWD': '/builds/slave/test', 16:32:20 INFO - 'SHELL': '/bin/bash', 16:32:20 INFO - 'SHLVL': '1', 16:32:20 INFO - 'TERM': 'linux', 16:32:20 INFO - 'TMOUT': '86400', 16:32:20 INFO - 'USER': 'cltbld', 16:32:20 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1502318132.175676-260754789', 16:32:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:20 INFO - '_': '/tools/buildbot/bin/python'} 16:32:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:21 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)) 16:32:21 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)) 16:32:21 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)) 16:32:21 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)) 16:32:21 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)) 16:32:21 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)) 16:32:21 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)) 16:32:21 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)) 16:32:21 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)) 16:32:21 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:32:21 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 16:32:21 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 16:32:21 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 16:32:21 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 16:32:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:32:22 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)) 16:32:22 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)) 16:32:22 INFO - Installing collected packages: simplejson 16:32:22 INFO - Running setup.py install for simplejson 16:32:22 INFO - building 'simplejson._speedups' extension 16:32:22 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 16:32:23 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 16:32:23 INFO - Successfully installed simplejson 16:32:23 INFO - Cleaning up... 16:32:23 INFO - Return code: 0 16:32:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:32:23 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')]} 16:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:23 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')]} 16:32:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:23 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 0x1f931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2302700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ff8a0>, '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 0x23007a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2300c30>, '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': '5c37b704b588aaa989324530000001d0-1502318132.175676-260754789', '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 16:32:23 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 16:32:23 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 16:32:23 INFO - Using env: {'DISPLAY': ':0', 16:32:23 INFO - 'HOME': '/home/cltbld', 16:32:23 INFO - 'LANG': 'en_US.UTF-8', 16:32:23 INFO - 'LANGUAGE': 'en_US:en', 16:32:23 INFO - 'LOGNAME': 'cltbld', 16:32:23 INFO - 'MAIL': '/var/mail/cltbld', 16:32:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:23 INFO - 'MOZ_NO_REMOTE': '1', 16:32:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:23 INFO - 'NO_EM_RESTART': '1', 16:32:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:23 INFO - 'PWD': '/builds/slave/test', 16:32:23 INFO - 'SHELL': '/bin/bash', 16:32:23 INFO - 'SHLVL': '1', 16:32:23 INFO - 'TERM': 'linux', 16:32:23 INFO - 'TMOUT': '86400', 16:32:23 INFO - 'USER': 'cltbld', 16:32:23 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1502318132.175676-260754789', 16:32:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:23 INFO - '_': '/tools/buildbot/bin/python'} 16:32:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:32:23 INFO - Cleaning up... 16:32:23 INFO - Return code: 0 16:32:23 INFO - Running post-action listener: _resource_record_post_action 16:32:23 INFO - Running post-action listener: _start_resource_monitoring 16:32:23 INFO - Starting resource monitoring. 16:32:23 INFO - [mozharness: 2017-08-09 23:32:23.559532Z] Finished create-virtualenv step (success) 16:32:23 INFO - [mozharness: 2017-08-09 23:32:23.560044Z] Running install step. 16:32:23 INFO - Running pre-action listener: _resource_record_pre_action 16:32:23 INFO - Running main action method: install 16:32:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:32:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:32:23 INFO - Reading from file tmpfile_stdout 16:32:23 INFO - Detecting whether we're running mozinstall >=1.0... 16:32:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:32:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:32:23 INFO - Reading from file tmpfile_stdout 16:32:23 INFO - Output received: 16:32:23 INFO - Usage: mozinstall [options] installer 16:32:23 INFO - Options: 16:32:23 INFO - -h, --help show this help message and exit 16:32:23 INFO - -d DEST, --destination=DEST 16:32:23 INFO - Directory to install application into. [default: 16:32:23 INFO - "/builds/slave/test"] 16:32:23 INFO - --app=APP Application being installed. [default: firefox] 16:32:23 INFO - mkdir: /builds/slave/test/build/application 16:32:23 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'] 16:32:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:32:41 INFO - Reading from file tmpfile_stdout 16:32:41 INFO - Output received: 16:32:41 INFO - /builds/slave/test/build/application/firefox/firefox 16:32:41 INFO - Running post-action listener: _resource_record_post_action 16:32:41 INFO - [mozharness: 2017-08-09 23:32:41.853730Z] Finished install step (success) 16:32:41 INFO - [mozharness: 2017-08-09 23:32:41.853990Z] Running setup-mitmproxy step. 16:32:41 INFO - Running pre-action listener: _resource_record_pre_action 16:32:41 INFO - Running main action method: setup_mitmproxy 16:32:41 INFO - Skipping: mitmproxy is not required 16:32:41 INFO - Running post-action listener: _resource_record_post_action 16:32:41 INFO - [mozharness: 2017-08-09 23:32:41.855146Z] Finished setup-mitmproxy step (success) 16:32:41 INFO - [mozharness: 2017-08-09 23:32:41.855369Z] Running run-tests step. 16:32:41 INFO - Running pre-action listener: _resource_record_pre_action 16:32:41 INFO - Running pre-action listener: _set_gcov_prefix 16:32:41 INFO - Running main action method: run_tests 16:32:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:32:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:32:41 INFO - Python 2.7.3 16:32:41 INFO - Return code: 0 16:32:41 INFO - grabbing minidump binary from tooltool 16:32:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:41 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 0x22ff8a0>, '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 0x23007a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2300c30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:32:41 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 16:32:41 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 16:32:41 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 16:32:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:32:41 INFO - Return code: 0 16:32:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:32:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:32:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:32:41 INFO - ENV: RUST_BACKTRACE is now full 16:32:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:32:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:32:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-085', '--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 16:32:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-085 --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 16:32:41 INFO - Using env: {'DISPLAY': ':0', 16:32:41 INFO - 'HOME': '/home/cltbld', 16:32:41 INFO - 'LANG': 'en_US.UTF-8', 16:32:41 INFO - 'LANGUAGE': 'en_US:en', 16:32:41 INFO - 'LOGNAME': 'cltbld', 16:32:41 INFO - 'MAIL': '/var/mail/cltbld', 16:32:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:32:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:32:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:41 INFO - 'MOZ_NO_REMOTE': '1', 16:32:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:32:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:41 INFO - 'NO_EM_RESTART': '1', 16:32:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:41 INFO - 'PWD': '/builds/slave/test', 16:32:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:32:41 INFO - 'RUST_BACKTRACE': 'full', 16:32:41 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:32:41 INFO - 'SHELL': '/bin/bash', 16:32:41 INFO - 'SHLVL': '1', 16:32:41 INFO - 'STYLO_FORCE_ENABLED': '1', 16:32:41 INFO - 'TERM': 'linux', 16:32:41 INFO - 'TMOUT': '86400', 16:32:41 INFO - 'USER': 'cltbld', 16:32:41 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1502318132.175676-260754789', 16:32:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:41 INFO - '_': '/tools/buildbot/bin/python'} 16:32:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-085', '--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 16:32:42 INFO - mozversion application_buildid: 20170809224807 16:32:42 INFO - mozversion application_changeset: a4a448ba7f187069fce916ee234a06cbb0d06f80 16:32:42 INFO - mozversion application_display_name: Nightly 16:32:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:32:42 INFO - mozversion application_name: Firefox 16:32:42 INFO - mozversion application_remotingname: firefox 16:32:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:32:42 INFO - mozversion application_vendor: Mozilla 16:32:42 INFO - mozversion application_version: 57.0a1 16:32:42 INFO - mozversion platform_buildid: 20170809224807 16:32:42 INFO - mozversion platform_changeset: a4a448ba7f187069fce916ee234a06cbb0d06f80 16:32:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:32:42 INFO - mozversion platform_version: 57.0a1 16:32:42 INFO - using testdate: 1502321562 16:32:42 INFO - actual date: 1502321562 16:32:42 INFO - starting webserver on 'localhost:42684' 16:32:42 INFO - SUITE-START | Running 2 tests 16:32:42 INFO - TEST-START | dromaeo_css 16:32:42 INFO - Initialising browser for dromaeo_css test... 16:32:42 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42684/getInfo.html -profile /tmp/tmpGZSITY/profile 16:32:42 INFO - TEST-INFO | started process 31525 (/builds/slave/test/build/application/firefox/firefox http://localhost:42684/getInfo.html) 16:32:48 INFO - TEST-INFO | 31525: exit 0 16:32:48 INFO - Browser initialized. 16:32:48 INFO - Running cycle 1/1 for dromaeo_css test... 16:32:48 INFO - TEST-INFO | started process 31754 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGZSITY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:32:49 INFO - PID 31754 | 16:32:49 INFO - PID 31754 | (/builds/slave/test/build/application/firefox/firefox:31808): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:32:49 INFO - PID 31754 | 16:32:59 INFO - PID 31754 | RSS: Main: 170696704 16:32:59 INFO - PID 31754 | 16:35:59 INFO - PID 31754 | Cycle 1(1): loaded http://localhost:42684/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42684/tests/dromaeo/cssquery-ext.html) 16:36:01 INFO - PID 31754 | RSS: Main: 174903296 16:36:01 INFO - PID 31754 | 16:39:03 INFO - PID 31754 | Cycle 1(1): loaded http://localhost:42684/tests/dromaeo/cssquery-ext.html (next: http://localhost:42684/tests/dromaeo/cssquery-jquery.html) 16:39:03 INFO - PID 31754 | RSS: Main: 172978176 16:39:03 INFO - PID 31754 | 16:42:05 INFO - PID 31754 | Cycle 1(1): loaded http://localhost:42684/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42684/tests/dromaeo/cssquery-mootools.html) 16:42:06 INFO - PID 31754 | RSS: Main: 174718976 16:42:06 INFO - PID 31754 | 16:45:07 INFO - PID 31754 | Cycle 1(1): loaded http://localhost:42684/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42684/tests/dromaeo/cssquery-prototype.html) 16:45:08 INFO - PID 31754 | RSS: Main: 173154304 16:45:08 INFO - PID 31754 | 16:48:12 INFO - PID 31754 | Cycle 1(1): loaded http://localhost:42684/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42684/tests/dromaeo/cssquery-yui.html) 16:48:12 INFO - PID 31754 | RSS: Main: 176685056 16:48:12 INFO - PID 31754 | 16:51:14 INFO - PID 31754 | Cycle 1(1): loaded http://localhost:42684/tests/dromaeo/cssquery-yui.html (next: http://localhost:42684/tests/dromaeo/cssquery-dojo.html) 16:51:14 INFO - PID 31754 | RSS: Main: 177078272 16:51:14 INFO - PID 31754 | 16:51:14 INFO - PID 31754 | __start_tp_report 16:51:14 INFO - PID 31754 | _x_x_mozilla_page_load 16:51:14 INFO - PID 31754 | _x_x_mozilla_page_load_details 16:51:14 INFO - PID 31754 | |i|pagename|runs| 16:51:14 INFO - PID 31754 | |0;dojo.html;3146.63813661429;3169.9683003169966;3182.18854192181;3183.1564635371615;3208.262099717065;6222.284437289713;6319.399657032586;6326.778562750304;6373.61758294502;6431.807045788622;6163.969180154093;6199.225096862892;6202.286737025243;6206.7827626033095;6331.050342448635;5743.885122297552;5745.052066409037;5754.482096611304;5770.134479828017;5802.796902108427;5797.1594118852745;5803.477687008169;5804.187413762077;5804.448577385142;5806.622569532967;5748.051571490699;5844.064949608063;5852.063669812831;5885.117232415129;5900.29196496421;5705.74324155414;5780.72823978724;5782.306123265193;5811.302643682743;5831.679257640828;5565.916511252334;5694.088945768657;5714.314282286111;5736.512396446307;5768.019436695729;6230.43926046658;6250.562460627758;6261.530385221126;6268.561200715952;6273.780417685359;6709.899351509731;6722.697478613474;6727.596344219362;6800.183977922681;6807.285235050347;6699.363560461748;6777.390034896834;6785.084013658142;6888.104546408985;6917.9654101729675;6307.27466341372;6311.873762524724;6316.968415157895;6317.241930968221;6320.146780184708;6942.271061538567;6967.756128535579;6980.267071957473;6985.3713165815325;7025.894611580728;6445.967770161119;6515.413612774778;6528.640924749185;6531.379518945692;6535.346465353522;6589;6612.504062195355;6626.171728533934;6633.1045308882685;6637.203535575762;6522.184726909137;6576.704048317837;6625.734970601122;6641.966790166019;6651.501137414713;6515.641639709862;6602.537822352485;6614.404703576702;6652.368025037614;6751.156105486814;5382.407935127133;5407.405185429599;5413.188021796762;5418.91871621926;5443.346798384219;4632.397788287569;4645.5354464553275;4692.389989301369;4706.388169538007;4732;5905.852353691106;5947.316058653224;5959.851003724942;5967.791127310524;5973.133895585116;6693.832654183587;6788.422984046411;6799.932000680029;6812.250652428229;6860.451163906875;5859.2090067841145;5871.32479764824;5873.618214816023;5885.823425297248;5894.469497745224;5895.35151133375;5912.970435147883;5914.704264786744;5926.555508336892;5932.139839723216;6354.936450635527;6521.445677117498;6554.868902622016;6606.768763093269;6616.040674102228;6616.90074648871;6765.729370825112;6767.1879374475375;6789.1852977643;6833.794986150423;6442.291347951628;6459.61242325462;6472.35276472349;6548.214214294125;6650.135482387259;6631.1048008520165;6639.601623902581;6666.566673166229;6704.83237919056;6719.462443004646;6780.288069752605;6815.693293801692;6866.965665171642;6871;6877;6536.575122617015;6537.5096867736065;6554.901676474761;6646.0695502628705;6674.733010679518;6390.360963903572;6551.705173267119;6580.5064620152725;6585.5719378242175;6594.868102638016;6474.546781725234;6482.124913136855;6510.544261901621;6521.184851893513;6530.020496925499;6530.640814755044;6541.574797638138;6568.507361947777;6594.472442204708;6612.933870661424;6378.362163783585;6390.105385245976;6392.52056095804;6412.6793660317735;6468.450181734605 16:51:14 INFO - PID 31754 | |1;ext.html;789.329070290253;828.4283844147534;862.9007664118626;874.2437791310518;884.7080463447063;39424.80287598562;40354;40473.7976310118;40585.79707101468;40593.391099133536;37983;38136.80931595345;38228;38326;38354;6890.104286442755;6950.513464057518;6951.131108611424;6953.652317384136;7029.648517574126;6930.826729331757;6996.090508233922;7016.052832867574;7037.507374483763;7038.225795162528;6989.965050174767;7541.208173141823;7838.059432868035;7873.763787086368;7874.763757087268;7814.843703125934;7847.64685589147;7879.0151231096115;7880.724174653859;7882.487638303521;7568.356689681329;7659.272369124924;7779.805504862424;7783.299503044696;7795.961020194863;38120;38376.42435363472;38419.61580384188;38494.80752596247;38549.229015419536;3541.9114522136897;3649.85400583979;3657.963420365789;3658.140337020798;3663.120850995742;30971.38057238865;31182.688173118204;31213.687863121533;31241.53137702936;31242.218944526343;5083.059633967728;5106.719130447824;5108.565771909392;5116.130257856136;5136.357955255593;233530;235450;237229;237451;237797;49061.75469122631;49518.50481495211;49528;49548.50451495511;49786.75106624516;50605;50791.492085079415;50939.49060509347;51052.48947510552;51093;14375.28123593816;14517.927410362881;14586.270686465634;14596.854031459761;14597.708045839025;11668.766624667629;11713.414329283502;11736.119791015708;11765.176437649454;11792.056635469142;13760.587182384545;13776.862231377758;13854.307284635728;13883.652908677364;14047;5374.758135883816;5492.890142197134;5557.916631250535;5675.943240567624;5694.629849059798;1002.7292630989738;1013.5185786751382;1030.922680798943;1032.4631191780381;1042.7393151712072;23025.539489210456;23039.193628222933;23042.884785575963;23175.072997080264;23187.7681223189;1092.7650555130685;1113.5935383584933;1115.369816053927;1118.5134466507095;1126.2172789911097;12273.079519036108;12358.938205308916;12387.265782790417;12456.377181140906;12529.248245105322;236593;237419;237968;238151;238979;50307.24539131916;50926.74536627293;54749;56176;56569.43430565724;1440.2654646130338;1468.7356275870231;1478.6303424143964;1489.9031562948373;1494.3648949196547;26774.732252677222;27114;27375.86312068427;27624.585631215145;27653.308667282676;35249.64750352566;35512.11219719424;35648.821755891055;35698.46452303165;35724.28551428905;228288;228410;228503;229391;229875;34622.82688586541;34811.477827832095;34918;34943;35045;41580.58419415767;43381.34927976146;43460.56539434565;43476.13047738964;43589.56410435982;32097.518537221495;32236.35527289488;32441.675583243865;32454.83772581122;32584.185395365304;31142;31648.525272120474;31773.61697872715;31823.840880795447;31937.840310798296;34484;34583.13542161466;34772.82613587017;34807.651923480444;34814.65185348114;30959.535606966365;31297.687023129478;33356.332873342886;34101.317973640886;34156.48765268473;23883.880580596986;24523.01907923663;24764.876175619007;24836.130735424173;25011.624825627994 16:51:14 INFO - PID 31754 | |2;jquery.html;579.3511267380535;586.9413058694131;603.5171862509992;606.5632744424015;607.2561112637018;22615.095396184133;22724.77275227247;23526.058957641697;23532.76467235327;23533.64699529506;26112.869435652796;28354.716452835466;28398.29004274894;28401.147965561013;28435.146945591667;7056.294370562941;7260.52806567574;7263.418926485895;7266.745663901765;7276.527025743309;6760.222574403932;7029.507934444591;7049.718011279542;7086.043384143126;7088.291170882896;7083.256258092878;7085.504014718972;7099.609521476316;7106.289371062904;7120.50156489046;7017.82455438613;7038.964805175967;7072.717091316341;7080.929190708079;7083.291670832953;6885.070515480396;6934.930650693479;6948.722051117949;6959;6971.6862741176765;30839;31231.219219519695;31254.687453125633;32756.508652370234;32767.344653106804;1999.1703443071108;2053.5584849257334;2059.083707750052;2063.2675400233;2065.8037486438766;20196;20765.688514672293;21140.3657890262;21177.89411052935;21195.576088478298;2565.1663209456815;2639.155470249521;2670.839749615029;2672.2918426616766;2672.812903096784;142227;149533;153368;153920;154153;20257.898710506353;21660.675089873665;21740.456488587595;21892.781072189075;23299.18452854142;45023.549764501935;45124.09751804946;45196.09607807891;45197.32204016943;45392.54607453883;10880.891191088147;11038.337699738042;11067.225294229327;11247.100231981422;11311.886881131248;9105.453672779655;9135.132162444557;9264.490453025148;9294.395864268801;9366.531673416439;9188.95405522968;11400.429978501043;11633.825492617618;11729.530818767324;11970.640880773592;3693.741438099361;3735.6637902588354;4014.698897582693;4153.356229784388;4242.939265183704;947.7204224753714;989.5101924547395;997.5710444508786;999.1906555689915;999.2855108597388;19455.90272048631;19458.124384402738;19890.50273743139;20119.899400502905;20189.49526261855;1023.5036007536339;1043.2436483549518;1049.6850944716555;1055.5408397347178;1058.7194393485731;10778.299410538446;11134.387608681438;11151.944240278746;11501.712457188638;13471.797923031163;563678;568584;576298;577242;585562;120198;124073.13890291653;124657;126690;127131.36434317769;1243.3099629705418;1254.9372531373394;1294.1393973008032;1303.4460354349553;1313.343328335832;20576.58846823085;20830.479238019172;20894;21105.155793768077;21428.678569821153;56211.71894140503;56331;56931.71534142303;57512.836793976734;58994.70502647459;69471.65264173647;69771;70174.29825701678;71008;71236;12634.620961371174;14461.78307325412;14950.850491494946;15428.460003899809;15615.609609759393;23473.76526234716;23852.642210367205;23853;23995.16016939399;24291.514169716862;18661.253549858397;18816.15327310247;19093.427197184108;19112;19148.808511914704;16898.493045208663;16931.57671058184;17117.74323385125;17327.133643318037;17379.652406951536;18955.431337059912;19143.90428047851;19174;19210.903945480743;19371.225150993803;14952.850471495145;14953.401863925756;14959.626009349853;14964.326605302569;15049.247537623294;18672.184652601973;18858.717119243498;19057.428277151706;19110.617787643892;19121.043947802274 16:51:14 INFO - PID 31754 | |3;mootools.html;1384.3355189509036;1411.915285082895;1423.1674470434796;1437.4465830655195;1442.848500907404;13925.23411212383;13932.860671393282;14524.419023239057;14528.3462244199;14538.781918271234;14328.498502552413;14687.265636718175;14690.485832995848;14699.265036748173;14706.04410713303;2702.121810411619;2767.5433553463654;2771.196353057621;2774.7918906082023;2776.6112744215825;2623.160588611645;2800.747932686058;2804.6634403871562;2806.172179207139;2808.4102338508937;2741.917742467729;2758.9310267243277;2769.9723002769915;2784.0116758550625;2784.136917555554;2697.6223328733995;2702.3514356554383;2709.9322516937236;2758.3655759175504;2780.6802217745017;2617.3718307606036;2655.7875369970548;2663.5338815707173;2673.5454972654697;2673.919782406531;13692.52076177329;13784.793228101587;13865.168089914638;13890.93054534731;13909.234992075431;7710.151883292833;7949.682012719484;7974.401919855976;8002.119766825645;8013.2387423194705;5228.398734145584;5368.194770784414;5447.346318441772;5541.501264886179;5549.278593782782;1752.7809023872016;1774.574102215459;1779.4839496545985;1811.03109836237;1819.5087326421792;21005.36983890486;21509.032093555983;21549.353519394444;21552.784472155392;21557.78442215589;6844.828879277959;6845.691943862538;6932.896006559906;6952.374286314155;6962.721491140399;17379.65240695179;17407.3037078518;17410;17457;17511.912440437718;7675.078990521173;7996.480228785111;7998.680052797939;8006.719764808204;8020.879686804703;7040.2607726189035;7124.145102587722;7145.92854071463;7152;7200.351968322771;5347.572194224453;5541.750621222055;5620.5503559715125;5658.207850900877;5658.434156584309;1718.3470281293028;1789.391606853676;1794.5154808201712;1811.6376724654858;1815.373696074852;863.0937515608712;893.2318206342541;906.5849313841634;912.0924679943498;914.9634014639473;7193.352598266181;7218.278172182845;7243.275672432715;7277.526960747535;7308.37878780299;702.3292755418563;702.9437644988388;717.1430140981477;730.868443680132;741.3513175971025;4872.171730805771;4997.625178111656;5076.771545280471;5105.387353517602;5282.128448805904;18257.360992365204;18542.165602547917;18969.051547422572;18997;19006;18427.447176584457;18889.52776180579;19168.233270669018;19226.134823932956;19253;10132.34139780912;10369.533370998322;10421.166306695446;10435.217358698128;10583.259171857895;7756;7914.5646989413835;7929.841403171788;7932.722354717557;7943.126256111938;16302.918485407497;16367.181640918145;16453.012819230884;16503.587410314838;16780.832191677928;16698.58253543671;16756;16821.495355139366;16845.326186952876;16918.915405423388;11181.776364472827;11251.212415130862;11270.098392128446;11346.716332091764;11367.261128026652;12675.93662031684;12693.8095928563;12916.418761155583;12931.965442764367;12949.676258093623;10510.842337364793;10711.8928810714;10792.406417647106;10869.130469562575;10961.45192740344;10068.69793906184;10191.796164076824;10282.280240383101;10414.062734353642;10628.468576571295;9347.439153650803;9413.764655883657;9447.196988256075;9472.28957828152;9511.524423778921;7133.8929916050265;7235.493515453868;7249.093863267091;7280.67236974348;7287.562746235243;6758.459323254227;6761.188657360952;6841.110655614738;6851.725930962705;6927.861442771015 16:51:14 INFO - PID 31754 | |4;prototype.html;495.9280904268881;505.4137200847018;524.1613418530351;531.9893602127955;533.029885608193;6204.379562043799;6215.9906860075225;6238.812835614939;6262.561620686553;6270.686465676721;5933.376995415473;5969.343372229051;6082.939170608292;6093.299270583884;6108.267007959051;5104.66819656723;5150.201718733583;5156.407013193493;5186.7147306898105;5214.765335559909;5051.3180720602795;5106.259592359106;5142.254373115896;5204.791808327681;5213.765380557884;5110.437851836295;5112.974435127838;5122.6158038147105;5177.534021938025;5215.530602245797;5122.487751224848;5166.870828229286;5173.8189163379475;5178.119719647669;5191.610629202806;4783.067301876135;4808.3989501312335;4834.58905992991;4834.6374021948495;4838.322634831126;6146.385361463863;6161.291451483092;6176.197094377747;6186.969065154691;6203.379662033805;5935.676021428014;5982.341942386334;6043.063325184604;6084.8134613750335;6090.96954515229;6571.539992200548;6605;6623.3045530219115;6704.865902681919;6710.127683401127;5322.2282768998275;5327.573794096463;5330.627870597586;5347.572194224453;5365.704886231256;6875.828104297382;6894.207166175854;6950.339717726808;6998.895016574756;7010.090812312884;5453.454654534515;5457.070908945553;5474.890502190014;5526.58550608706;5545.528630066409;5594.972025139929;5612.298462692163;5624.465675760796;5627.634203776742;5639.802606908738;5895.557833162444;6001.989333573302;6005.459508644243;6076.392360763976;6077.908831367533;6567.901481477782;6650.401463868178;6667.566608170453;6674.699638516181;6684.16447944007;1820.3173809821317;1833.9174737136861;1886.4623582278984;1940.3014914630721;1947.4936516505811;1424.978625320621;1438.503716217903;1449.289847974506;1450.6373406648338;1463.8023866778062;5678.858028549237;5694.804091140907;5713.714314284269;5718.799842005593;5800.796972106041;6587.604743715392;6591;6601.844677181474;6617;6752.257251702309;5823.650580965155;5836.474717275466;5849.385814489502;5854.356020837705;5859.941400586024;3540.3096396202495;3615.493830863681;3627.927441451156;3641.344557979589;3655.3785856404475;6522.21733391996;6591.83520411984;6608.867822643617;6612.404883560406;6626.403623673892;6871.6564171791215;6878.3465570770695;6947.3747362737595;6966.909927021975;6971.407430368374;6522.119513865568;6526.967365163238;6560.311167327457;6574.539782215199;6592.9340706593275;6629.668516574248;6716.126903502513;6734.629595372302;6783.287754785873;6789.830254243683;6642.206604216738;6651.135352404156;6677.599344039373;6720.966395167993;6725.260221375743;6372.299047104722;6554.442872355903;6563.737450502117;6569.178852643419;6578.80263592093;5006.474320196473;5017.874553136201;5018.164736923626;5035.59715222774;5053.11570475158;6461.61230326182;6642.169728783902;6773.356531129535;6798.830029249309;6818.215905170969;6210.192674952227;6447.70985305653;6506.934930650822;6515.804525864231;6538.967305163444;6392.20097487814;6434.453071488976;6467.223933128054;6469.353064693493;6469.77355792545;6384.936150638434;6390.201224846895;6401.903971440339;6436.163298771317;6437.935620643733;6241.3134555197985;6467.935320646921;6481.4722258320235;6487.935120648922;6573.408393244631;6280.1207830902795;6308.012975912573;6327.203677793287;6375.203099612549;6463.547551671526 16:51:14 INFO - PID 31754 | |5;yui.html;912.7672443526901;913.6619450803199;924.7919218175907;929.9023602521733;936.0499093420179;18964.62070758584;20014.49963750907;20034.99999999998;20067.698984515246;22298.88850555749;21597.67603485945;22151.224707135254;22170.778292217114;22344;22377;983.9852402213954;998.4159266828914;1000.4447531619948;1002.3284399452348;1002.8194924913513;1063.9946800265989;1075.3118004477142;1078.2937176149635;1078.358376765823;1079.681493959284;1013.9556257055208;1115.2193464574789;1116.101538261699;1120.8710998235185;1127.8421021057059;1105.6904066861212;1111.7387413957713;1120.843081968525;1121.5794077221042;1121.7588218533015;794.7854079398588;799.0690845165375;800.1958032177624;801.967921283148;802.8835818806241;18853.151608177526;18924;19809.603807923904;19820.702689459526;20024.79975200244;21429.89285053565;21656.675149872764;22077.116915323368;22086.668699969512;22385.888070559544;16466.341346346133;16679.6664066718;16839.494815155565;16896.239669214916;16903.915480422642;3618.7828730276005;3649.7445178837493;3650.926981460356;3652.3425783358985;3655.214128962286;128176.99999999907;128373.35813320873;129878;130649.6935030647;131811;16667.583310417336;16910.323587056628;17179.82820171807;17224.138793060298;17308;30717.23206919845;31588;31708.682913171033;31722;31839.204019899687;7732.342750866239;8056.315213206826;8513.36149788756;8880.333974951904;9114.13415725505;4197.286461301586;4283.935740963888;4289.978550107292;4293.0769884474985;4299.204647140289;5281.815136470205;5285.180796976475;5310;5368.758405871745;5420.322459692538;1064.6752740414247;1069.652362982034;1082.924195306321;1085.5060947269133;1094.2012330998416;691.374306252842;696.1055044268091;700.9579425234502;710;712.7398499547628;11970.40147992597;12155.149139560146;12339.62981110568;12664.366781661065;13095.541656041993;686.8248596607833;693.2443636436309;693.4833549005922;709.021550260637;710.076900029959;5700.543956483471;5917.52659787216;5960.850978725566;6011.849703757353;6082.482988945901;107855.46072269745;110828;112456;117963.41018294853;118336.40831795786;94896;97435;99172;100874;101935.49032254939;87194;88141.55929220314;88575.55712221526;90054.54972725094;91997.08002919886;11707.88292117068;11870.940645296718;11911.880881191077;12099.939500302442;12556.43496042662;38404;38438.807805960794;39057.80471097626;39369.212615746954;40030;69068;72732.63633681797;73217.6339118301;74731;75367.62316188384;18819.71770423472;19027.429177124708;19044.523886902385;19145.904270478557;19276.518087047934;21647.567048659253;21728.130874765466;21999.23002694898;22025.779742202372;22101.115955361605;18428.447146585622;18796.248150073843;18927.621447571248;18942;19810.40568782939;19241.90379048096;19637.70543441821;19878.50303742418;20060.297889573794;20070.49823754418;19139.712904306725;19148.04259786977;19420.611587767882;19557.60884782325;20097;13937.930310348384;14043.859561404255;14221.786673199704;14381.28093595337;14514.274286285432;14229.786553201917;14512.419503220175;14909;15074.849251507345;15103.32035058447 16:51:14 INFO - PID 31754 | __end_tp_report 16:51:14 INFO - PID 31754 | __start_cc_report 16:51:14 INFO - PID 31754 | _x_x_mozilla_cycle_collect,369 16:51:14 INFO - PID 31754 | __end_cc_report 16:51:14 INFO - PID 31754 | __startTimestamp1502322674905__endTimestamp 16:51:14 INFO - PID 31754 | 16:51:14 INFO - PID 31754 | ------- Summary: start ------- 16:51:14 INFO - PID 31754 | Number of tests: 6 16:51:14 INFO - PID 31754 | 16:51:14 INFO - PID 31754 | [#0] dojo.html Cycles:165 Average:6201.86 Median:6445.97 stddev:725.60 (11.3%) stddev-sans-first:687.11 16:51:14 INFO - PID 31754 | Values: 3146.6 3170.0 3182.2 3183.2 3208.3 6222.3 6319.4 6326.8 6373.6 6431.8 6164.0 6199.2 6202.3 6206.8 6331.1 5743.9 5745.1 5754.5 5770.1 5802.8 5797.2 5803.5 5804.2 5804.4 5806.6 5748.1 5844.1 5852.1 5885.1 5900.3 5705.7 5780.7 5782.3 5811.3 5831.7 5565.9 5694.1 5714.3 5736.5 5768.0 6230.4 6250.6 6261.5 6268.6 6273.8 6709.9 6722.7 6727.6 6800.2 6807.3 6699.4 6777.4 6785.1 6888.1 6918.0 6307.3 6311.9 6317.0 6317.2 6320.1 6942.3 6967.8 6980.3 6985.4 7025.9 6446.0 6515.4 6528.6 6531.4 6535.3 6589.0 6612.5 6626.2 6633.1 6637.2 6522.2 6576.7 6625.7 6642.0 6651.5 6515.6 6602.5 6614.4 6652.4 6751.2 5382.4 5407.4 5413.2 5418.9 5443.3 4632.4 4645.5 4692.4 4706.4 4732.0 5905.9 5947.3 5959.9 5967.8 5973.1 6693.8 6788.4 6799.9 6812.3 6860.5 5859.2 5871.3 5873.6 5885.8 5894.5 5895.4 5913.0 5914.7 5926.6 5932.1 6354.9 6521.4 6554.9 6606.8 6616.0 6616.9 6765.7 6767.2 6789.2 6833.8 6442.3 6459.6 6472.4 6548.2 6650.1 6631.1 6639.6 6666.6 6704.8 6719.5 6780.3 6815.7 6867.0 6871.0 6877.0 6536.6 6537.5 6554.9 6646.1 6674.7 6390.4 6551.7 6580.5 6585.6 6594.9 6474.5 6482.1 6510.5 6521.2 6530.0 6530.6 6541.6 6568.5 6594.5 6612.9 6378.4 6390.1 6392.5 6412.7 6468.5 16:51:14 INFO - PID 31754 | 16:51:14 INFO - PID 31754 | [#1] ext.html Cycles:180 Average:39824.58 Median:34813.06 stddev:60895.82 (174.9%) stddev-sans-first:60996.11 16:51:14 INFO - PID 31754 | Values: 789.3 828.4 862.9 874.2 884.7 39424.8 40354.0 40473.8 40585.8 40593.4 37983.0 38136.8 38228.0 38326.0 38354.0 6890.1 6950.5 6951.1 6953.7 7029.6 6930.8 6996.1 7016.1 7037.5 7038.2 6990.0 7541.2 7838.1 7873.8 7874.8 7814.8 7847.6 7879.0 7880.7 7882.5 7568.4 7659.3 7779.8 7783.3 7796.0 38120.0 38376.4 38419.6 38494.8 38549.2 3541.9 3649.9 3658.0 3658.1 3663.1 30971.4 31182.7 31213.7 31241.5 31242.2 5083.1 5106.7 5108.6 5116.1 5136.4 233530.0 235450.0 237229.0 237451.0 237797.0 49061.8 49518.5 49528.0 49548.5 49786.8 50605.0 50791.5 50939.5 51052.5 51093.0 14375.3 14517.9 14586.3 14596.9 14597.7 11668.8 11713.4 11736.1 11765.2 11792.1 13760.6 13776.9 13854.3 13883.7 14047.0 5374.8 5492.9 5557.9 5675.9 5694.6 1002.7 1013.5 1030.9 1032.5 1042.7 23025.5 23039.2 23042.9 23175.1 23187.8 1092.8 1113.6 1115.4 1118.5 1126.2 12273.1 12358.9 12387.3 12456.4 12529.2 236593.0 237419.0 237968.0 238151.0 238979.0 50307.2 50926.7 54749.0 56176.0 56569.4 1440.3 1468.7 1478.6 1489.9 1494.4 26774.7 27114.0 27375.9 27624.6 27653.3 35249.6 35512.1 35648.8 35698.5 35724.3 228288.0 228410.0 228503.0 229391.0 229875.0 34622.8 34811.5 34918.0 34943.0 35045.0 41580.6 43381.3 43460.6 43476.1 43589.6 32097.5 32236.4 32441.7 32454.8 32584.2 31142.0 31648.5 31773.6 31823.8 31937.8 34484.0 34583.1 34772.8 34807.7 34814.7 30959.5 31297.7 33356.3 34101.3 34156.5 23883.9 24523.0 24764.9 24836.1 25011.6 16:51:14 INFO - PID 31754 | 16:51:14 INFO - PID 31754 | [#2] jquery.html Cycles:180 Average:39091.14 Median:23386.47 stddev:96088.67 (410.9%) stddev-sans-first:96314.71 16:51:14 INFO - PID 31754 | Values: 579.4 586.9 603.5 606.6 607.3 22615.1 22724.8 23526.1 23532.8 23533.6 26112.9 28354.7 28398.3 28401.1 28435.1 7056.3 7260.5 7263.4 7266.7 7276.5 6760.2 7029.5 7049.7 7086.0 7088.3 7083.3 7085.5 7099.6 7106.3 7120.5 7017.8 7039.0 7072.7 7080.9 7083.3 6885.1 6934.9 6948.7 6959.0 6971.7 30839.0 31231.2 31254.7 32756.5 32767.3 1999.2 2053.6 2059.1 2063.3 2065.8 20196.0 20765.7 21140.4 21177.9 21195.6 2565.2 2639.2 2670.8 2672.3 2672.8 142227.0 149533.0 153368.0 153920.0 154153.0 20257.9 21660.7 21740.5 21892.8 23299.2 45023.5 45124.1 45196.1 45197.3 45392.5 10880.9 11038.3 11067.2 11247.1 11311.9 9105.5 9135.1 9264.5 9294.4 9366.5 9189.0 11400.4 11633.8 11729.5 11970.6 3693.7 3735.7 4014.7 4153.4 4242.9 947.7 989.5 997.6 999.2 999.3 19455.9 19458.1 19890.5 20119.9 20189.5 1023.5 1043.2 1049.7 1055.5 1058.7 10778.3 11134.4 11151.9 11501.7 13471.8 563678.0 568584.0 576298.0 577242.0 585562.0 120198.0 124073.1 124657.0 126690.0 127131.4 1243.3 1254.9 1294.1 1303.4 1313.3 20576.6 20830.5 20894.0 21105.2 21428.7 56211.7 56331.0 56931.7 57512.8 58994.7 69471.7 69771.0 70174.3 71008.0 71236.0 12634.6 14461.8 14950.9 15428.5 15615.6 23473.8 23852.6 23853.0 23995.2 24291.5 18661.3 18816.2 19093.4 19112.0 19148.8 16898.5 16931.6 17117.7 17327.1 17379.7 18955.4 19143.9 19174.0 19210.9 19371.2 14952.9 14953.4 14959.6 14964.3 15049.2 18672.2 18858.7 19057.4 19110.6 19121.0 16:51:14 INFO - PID 31754 | 16:51:14 INFO - PID 31754 | [#3] mootools.html Cycles:180 Average:8698.47 Median:2685.77 stddev:5787.23 (215.5%) stddev-sans-first:5777.36 16:51:14 INFO - PID 31754 | Values: 1384.3 1411.9 1423.2 1437.4 1442.8 13925.2 13932.9 14524.4 14528.3 14538.8 14328.5 14687.3 14690.5 14699.3 14706.0 2702.1 2767.5 2771.2 2774.8 2776.6 2623.2 2800.7 2804.7 2806.2 2808.4 2741.9 2758.9 2770.0 2784.0 2784.1 2697.6 2702.4 2709.9 2758.4 2780.7 2617.4 2655.8 2663.5 2673.5 2673.9 13692.5 13784.8 13865.2 13890.9 13909.2 7710.2 7949.7 7974.4 8002.1 8013.2 5228.4 5368.2 5447.3 5541.5 5549.3 1752.8 1774.6 1779.5 1811.0 1819.5 21005.4 21509.0 21549.4 21552.8 21557.8 6844.8 6845.7 6932.9 6952.4 6962.7 17379.7 17407.3 17410.0 17457.0 17511.9 7675.1 7996.5 7998.7 8006.7 8020.9 7040.3 7124.1 7145.9 7152.0 7200.4 5347.6 5541.8 5620.6 5658.2 5658.4 1718.3 1789.4 1794.5 1811.6 1815.4 863.1 893.2 906.6 912.1 915.0 7193.4 7218.3 7243.3 7277.5 7308.4 702.3 702.9 717.1 730.9 741.4 4872.2 4997.6 5076.8 5105.4 5282.1 18257.4 18542.2 18969.1 18997.0 19006.0 18427.4 18889.5 19168.2 19226.1 19253.0 10132.3 10369.5 10421.2 10435.2 10583.3 7756.0 7914.6 7929.8 7932.7 7943.1 16302.9 16367.2 16453.0 16503.6 16780.8 16698.6 16756.0 16821.5 16845.3 16918.9 11181.8 11251.2 11270.1 11346.7 11367.3 12675.9 12693.8 12916.4 12932.0 12949.7 10510.8 10711.9 10792.4 10869.1 10961.5 10068.7 10191.8 10282.3 10414.1 10628.5 9347.4 9413.8 9447.2 9472.3 9511.5 7133.9 7235.5 7249.1 7280.7 7287.6 6758.5 6761.2 6841.1 6851.7 6927.9 16:51:14 INFO - PID 31754 | 16:51:14 INFO - PID 31754 | [#4] prototype.html Cycles:180 Average:5614.53 Median:6153.84 stddev:1501.36 (24.4%) stddev-sans-first:1455.58 16:51:14 INFO - PID 31754 | Values: 495.9 505.4 524.2 532.0 533.0 6204.4 6216.0 6238.8 6262.6 6270.7 5933.4 5969.3 6082.9 6093.3 6108.3 5104.7 5150.2 5156.4 5186.7 5214.8 5051.3 5106.3 5142.3 5204.8 5213.8 5110.4 5113.0 5122.6 5177.5 5215.5 5122.5 5166.9 5173.8 5178.1 5191.6 4783.1 4808.4 4834.6 4834.6 4838.3 6146.4 6161.3 6176.2 6187.0 6203.4 5935.7 5982.3 6043.1 6084.8 6091.0 6571.5 6605.0 6623.3 6704.9 6710.1 5322.2 5327.6 5330.6 5347.6 5365.7 6875.8 6894.2 6950.3 6998.9 7010.1 5453.5 5457.1 5474.9 5526.6 5545.5 5595.0 5612.3 5624.5 5627.6 5639.8 5895.6 6002.0 6005.5 6076.4 6077.9 6567.9 6650.4 6667.6 6674.7 6684.2 1820.3 1833.9 1886.5 1940.3 1947.5 1425.0 1438.5 1449.3 1450.6 1463.8 5678.9 5694.8 5713.7 5718.8 5800.8 6587.6 6591.0 6601.8 6617.0 6752.3 5823.7 5836.5 5849.4 5854.4 5859.9 3540.3 3615.5 3627.9 3641.3 3655.4 6522.2 6591.8 6608.9 6612.4 6626.4 6871.7 6878.3 6947.4 6966.9 6971.4 6522.1 6527.0 6560.3 6574.5 6592.9 6629.7 6716.1 6734.6 6783.3 6789.8 6642.2 6651.1 6677.6 6721.0 6725.3 6372.3 6554.4 6563.7 6569.2 6578.8 5006.5 5017.9 5018.2 5035.6 5053.1 6461.6 6642.2 6773.4 6798.8 6818.2 6210.2 6447.7 6506.9 6515.8 6539.0 6392.2 6434.5 6467.2 6469.4 6469.8 6384.9 6390.2 6401.9 6436.2 6437.9 6241.3 6467.9 6481.5 6487.9 6573.4 6280.1 6308.0 6327.2 6375.2 6463.5 16:51:14 INFO - PID 31754 | 16:51:14 INFO - PID 31754 | [#5] yui.html Cycles:180 Average:24481.76 Median:20064.00 stddev:32990.09 (164.4%) stddev-sans-first:33035.17 16:51:14 INFO - PID 31754 | Values: 912.8 913.7 924.8 929.9 936.0 18964.6 20014.5 20035.0 20067.7 22298.9 21597.7 22151.2 22170.8 22344.0 22377.0 984.0 998.4 1000.4 1002.3 1002.8 1064.0 1075.3 1078.3 1078.4 1079.7 1014.0 1115.2 1116.1 1120.9 1127.8 1105.7 1111.7 1120.8 1121.6 1121.8 794.8 799.1 800.2 802.0 802.9 18853.2 18924.0 19809.6 19820.7 20024.8 21429.9 21656.7 22077.1 22086.7 22385.9 16466.3 16679.7 16839.5 16896.2 16903.9 3618.8 3649.7 3650.9 3652.3 3655.2 128177.0 128373.4 129878.0 130649.7 131811.0 16667.6 16910.3 17179.8 17224.1 17308.0 30717.2 31588.0 31708.7 31722.0 31839.2 7732.3 8056.3 8513.4 8880.3 9114.1 4197.3 4283.9 4290.0 4293.1 4299.2 5281.8 5285.2 5310.0 5368.8 5420.3 1064.7 1069.7 1082.9 1085.5 1094.2 691.4 696.1 701.0 710.0 712.7 11970.4 12155.1 12339.6 12664.4 13095.5 686.8 693.2 693.5 709.0 710.1 5700.5 5917.5 5960.9 6011.8 6082.5 107855.5 110828.0 112456.0 117963.4 118336.4 94896.0 97435.0 99172.0 100874.0 101935.5 87194.0 88141.6 88575.6 90054.5 91997.1 11707.9 11870.9 11911.9 12099.9 12556.4 38404.0 38438.8 39057.8 39369.2 40030.0 69068.0 72732.6 73217.6 74731.0 75367.6 18819.7 19027.4 19044.5 19145.9 19276.5 21647.6 21728.1 21999.2 22025.8 22101.1 18428.4 18796.2 18927.6 18942.0 19810.4 19241.9 19637.7 19878.5 20060.3 20070.5 19139.7 19148.0 19420.6 19557.6 20097.0 13937.9 14043.9 14221.8 14381.3 14514.3 14229.8 14512.4 14909.0 15074.8 15103.3 16:51:14 INFO - PID 31754 | -------- Summary: end -------- 16:51:14 INFO - PID 31754 | 16:51:15 INFO - TEST-INFO | 31754: exit 0 16:51:15 INFO - TEST-OK | dromaeo_css | took 1113430ms 16:51:15 INFO - TEST-START | kraken 16:51:15 INFO - Initialising browser for kraken test... 16:51:15 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42684/getInfo.html -profile /tmp/tmpBQBLZO/profile 16:51:15 INFO - TEST-INFO | started process 32131 (/builds/slave/test/build/application/firefox/firefox http://localhost:42684/getInfo.html) 16:51:21 INFO - TEST-INFO | 32131: exit 0 16:51:21 INFO - Browser initialized. 16:51:21 INFO - Running cycle 1/1 for kraken test... 16:51:21 INFO - TEST-INFO | started process 32361 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBQBLZO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:51:22 INFO - PID 32361 | 16:51:22 INFO - PID 32361 | (/builds/slave/test/build/application/firefox/firefox:32415): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:51:22 INFO - PID 32361 | 16:51:32 INFO - PID 32361 | RSS: Main: 170987520 16:51:32 INFO - PID 32361 | 16:51:35 INFO - PID 32361 | Cycle 1(1): loaded http://localhost:42684/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42684/tests/kraken/driver.html?testName=audio-beat-detection) 16:51:36 INFO - PID 32361 | RSS: Main: 175194112 16:51:36 INFO - PID 32361 | 16:51:39 INFO - PID 32361 | Cycle 1(1): loaded http://localhost:42684/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42684/tests/kraken/driver.html?testName=audio-dft) 16:51:39 INFO - PID 32361 | RSS: Main: 175882240 16:51:39 INFO - PID 32361 | 16:51:42 INFO - PID 32361 | Cycle 1(1): loaded http://localhost:42684/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42684/tests/kraken/driver.html?testName=audio-fft) 16:51:43 INFO - PID 32361 | RSS: Main: 171024384 16:51:43 INFO - PID 32361 | 16:51:45 INFO - PID 32361 | Cycle 1(1): loaded http://localhost:42684/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42684/tests/kraken/driver.html?testName=audio-oscillator) 16:51:46 INFO - PID 32361 | RSS: Main: 171524096 16:51:46 INFO - PID 32361 | 16:51:48 INFO - PID 32361 | Cycle 1(1): loaded http://localhost:42684/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42684/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:51:49 INFO - PID 32361 | RSS: Main: 171618304 16:51:49 INFO - PID 32361 | 16:51:52 INFO - PID 32361 | Cycle 1(1): loaded http://localhost:42684/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42684/tests/kraken/driver.html?testName=imaging-darkroom) 16:51:52 INFO - PID 32361 | RSS: Main: 174325760 16:51:52 INFO - PID 32361 | 16:51:56 INFO - PID 32361 | Cycle 1(1): loaded http://localhost:42684/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42684/tests/kraken/driver.html?testName=imaging-desaturate) 16:51:56 INFO - PID 32361 | RSS: Main: 173985792 16:51:56 INFO - PID 32361 | 16:51:59 INFO - PID 32361 | Cycle 1(1): loaded http://localhost:42684/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42684/tests/kraken/driver.html?testName=json-parse-financial) 16:52:00 INFO - PID 32361 | RSS: Main: 174530560 16:52:00 INFO - PID 32361 | 16:52:02 INFO - PID 32361 | Cycle 1(1): loaded http://localhost:42684/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42684/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:52:02 INFO - PID 32361 | RSS: Main: 174374912 16:52:02 INFO - PID 32361 | 16:52:04 INFO - PID 32361 | Cycle 1(1): loaded http://localhost:42684/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42684/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:52:05 INFO - PID 32361 | RSS: Main: 174718976 16:52:05 INFO - PID 32361 | 16:52:07 INFO - PID 32361 | Cycle 1(1): loaded http://localhost:42684/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42684/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:52:08 INFO - PID 32361 | RSS: Main: 174456832 16:52:08 INFO - PID 32361 | 16:52:11 INFO - PID 32361 | Cycle 1(1): loaded http://localhost:42684/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42684/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:52:11 INFO - PID 32361 | RSS: Main: 174972928 16:52:11 INFO - PID 32361 | 16:52:14 INFO - PID 32361 | Cycle 1(1): loaded http://localhost:42684/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42684/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:52:15 INFO - PID 32361 | RSS: Main: 175239168 16:52:15 INFO - PID 32361 | 16:52:17 INFO - PID 32361 | Cycle 1(1): loaded http://localhost:42684/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42684/tests/kraken/driver.html?testName=ai-astar) 16:52:17 INFO - PID 32361 | RSS: Main: 176672768 16:52:17 INFO - PID 32361 | 16:52:17 INFO - PID 32361 | __start_tp_report 16:52:17 INFO - PID 32361 | _x_x_mozilla_page_load 16:52:17 INFO - PID 32361 | _x_x_mozilla_page_load_details 16:52:17 INFO - PID 32361 | |i|pagename|runs| 16:52:17 INFO - PID 32361 | |0;ai-astar;98;111;101;108;107;110;118;97;110;115 16:52:17 INFO - PID 32361 | |1;audio-beat-detection;150;121;145;188;117;151;143;119;185;120 16:52:17 INFO - PID 32361 | |2;audio-dft;164;163;166;162;163;161;164;166;166;162 16:52:17 INFO - PID 32361 | |3;audio-fft;75;75;75;170;74;73;74;78;156;75 16:52:17 INFO - PID 32361 | |4;audio-oscillator;79;79;130;79;78;82;122;79;80;127 16:52:17 INFO - PID 32361 | |5;imaging-gaussian-blur;114;125;118;114;114;113;114;114;116;114 16:52:17 INFO - PID 32361 | |6;imaging-darkroom;151;153;153;150;150;155;153;152;152;151 16:52:17 INFO - PID 32361 | |7;imaging-desaturate;94;94;98;99;94;94;95;98;94;93 16:52:17 INFO - PID 32361 | |8;json-parse-financial;56;55;58;55;57;56;55;54;54;59 16:52:17 INFO - PID 32361 | |9;json-stringify-tinderbox;54;54;54;57;58;54;60;53;62;64 16:52:17 INFO - PID 32361 | |10;stanford-crypto-aes;89;80;78;87;81;93;81;95;98;80 16:52:17 INFO - PID 32361 | |11;stanford-crypto-ccm;133;133;131;133;133;133;127;127;130;170 16:52:17 INFO - PID 32361 | |12;stanford-crypto-pbkdf2;178;177;178;177;193;177;173;171;173;170 16:52:17 INFO - PID 32361 | |13;stanford-crypto-sha256-iterative;74;66;68;71;72;66;64;77;68;65 16:52:17 INFO - PID 32361 | __end_tp_report 16:52:17 INFO - PID 32361 | __start_cc_report 16:52:17 INFO - PID 32361 | _x_x_mozilla_cycle_collect,940 16:52:17 INFO - PID 32361 | __end_cc_report 16:52:17 INFO - PID 32361 | __startTimestamp1502322737651__endTimestamp 16:52:17 INFO - PID 32361 | 16:52:17 INFO - PID 32361 | ------- Summary: start ------- 16:52:17 INFO - PID 32361 | Number of tests: 14 16:52:17 INFO - PID 32361 | 16:52:17 INFO - PID 32361 | [#0] ai-astar Cycles:10 Average:107.50 Median:113.00 stddev:6.95 (6.1%) stddev-sans-first:6.46 16:52:17 INFO - PID 32361 | Values: 98.0 111.0 101.0 108.0 107.0 110.0 118.0 97.0 110.0 115.0 16:52:17 INFO - PID 32361 | 16:52:17 INFO - PID 32361 | [#1] audio-beat-detection Cycles:10 Average:143.90 Median:147.50 stddev:26.17 (17.7%) stddev-sans-first:27.66 16:52:17 INFO - PID 32361 | Values: 150.0 121.0 145.0 188.0 117.0 151.0 143.0 119.0 185.0 120.0 16:52:17 INFO - PID 32361 | 16:52:17 INFO - PID 32361 | [#2] audio-dft Cycles:10 Average:163.70 Median:164.00 stddev:1.83 (1.1%) stddev-sans-first:1.94 16:52:17 INFO - PID 32361 | Values: 164.0 163.0 166.0 162.0 163.0 161.0 164.0 166.0 166.0 162.0 16:52:17 INFO - PID 32361 | 16:52:17 INFO - PID 32361 | [#3] audio-fft Cycles:10 Average:92.50 Median:75.00 stddev:37.33 (49.8%) stddev-sans-first:39.05 16:52:17 INFO - PID 32361 | Values: 75.0 75.0 75.0 170.0 74.0 73.0 74.0 78.0 156.0 75.0 16:52:17 INFO - PID 32361 | 16:52:17 INFO - PID 32361 | [#4] audio-oscillator Cycles:10 Average:93.50 Median:79.00 stddev:22.76 (28.8%) stddev-sans-first:23.53 16:52:17 INFO - PID 32361 | Values: 79.0 79.0 130.0 79.0 78.0 82.0 122.0 79.0 80.0 127.0 16:52:17 INFO - PID 32361 | 16:52:17 INFO - PID 32361 | [#5] imaging-gaussian-blur Cycles:10 Average:115.60 Median:114.00 stddev:3.60 (3.2%) stddev-sans-first:3.77 16:52:17 INFO - PID 32361 | Values: 114.0 125.0 118.0 114.0 114.0 113.0 114.0 114.0 116.0 114.0 16:52:17 INFO - PID 32361 | 16:52:17 INFO - PID 32361 | [#6] imaging-darkroom Cycles:10 Average:152.00 Median:152.50 stddev:1.56 (1.0%) stddev-sans-first:1.62 16:52:17 INFO - PID 32361 | Values: 151.0 153.0 153.0 150.0 150.0 155.0 153.0 152.0 152.0 151.0 16:52:17 INFO - PID 32361 | 16:52:17 INFO - PID 32361 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:94.50 stddev:2.16 (2.3%) stddev-sans-first:2.24 16:52:17 INFO - PID 32361 | Values: 94.0 94.0 98.0 99.0 94.0 94.0 95.0 98.0 94.0 93.0 16:52:17 INFO - PID 32361 | 16:52:17 INFO - PID 32361 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:56.00 stddev:1.66 (3.0%) stddev-sans-first:1.76 16:52:17 INFO - PID 32361 | Values: 56.0 55.0 58.0 55.0 57.0 56.0 55.0 54.0 54.0 59.0 16:52:17 INFO - PID 32361 | 16:52:17 INFO - PID 32361 | [#9] json-stringify-tinderbox Cycles:10 Average:57.00 Median:57.50 stddev:3.89 (6.8%) stddev-sans-first:3.97 16:52:17 INFO - PID 32361 | Values: 54.0 54.0 54.0 57.0 58.0 54.0 60.0 53.0 62.0 64.0 16:52:17 INFO - PID 32361 | 16:52:17 INFO - PID 32361 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:88.00 stddev:7.22 (8.2%) stddev-sans-first:7.59 16:52:17 INFO - PID 32361 | Values: 89.0 80.0 78.0 87.0 81.0 93.0 81.0 95.0 98.0 80.0 16:52:17 INFO - PID 32361 | 16:52:17 INFO - PID 32361 | [#11] stanford-crypto-ccm Cycles:10 Average:135.00 Median:133.00 stddev:12.53 (9.4%) stddev-sans-first:13.27 16:52:17 INFO - PID 32361 | Values: 133.0 133.0 131.0 133.0 133.0 133.0 127.0 127.0 130.0 170.0 16:52:17 INFO - PID 32361 | 16:52:17 INFO - PID 32361 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.70 Median:177.00 stddev:6.45 (3.6%) stddev-sans-first:6.82 16:52:17 INFO - PID 32361 | Values: 178.0 177.0 178.0 177.0 193.0 177.0 173.0 171.0 173.0 170.0 16:52:17 INFO - PID 32361 | 16:52:17 INFO - PID 32361 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.50 stddev:4.25 (6.1%) stddev-sans-first:4.13 16:52:17 INFO - PID 32361 | Values: 74.0 66.0 68.0 71.0 72.0 66.0 64.0 77.0 68.0 65.0 16:52:17 INFO - PID 32361 | -------- Summary: end -------- 16:52:17 INFO - PID 32361 | 16:52:18 INFO - PID 32361 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:52:18 INFO - TEST-INFO | 32361: exit 0 16:52:18 INFO - TEST-OK | kraken | took 62762ms 16:52:18 INFO - SUITE-END | took 1176s 16:52:18 INFO - Completed test suite (00:19:36) 16:52:18 INFO - javascript benchmark 16:52:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8706.2963681625, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3146.63813661429, 3169.9683003169966, 3182.18854192181, 3183.1564635371615, 3208.262099717065, 6222.284437289713, 6319.399657032586, 6326.778562750304, 6373.61758294502, 6431.807045788622, 6163.969180154093, 6199.225096862892, 6202.286737025243, 6206.7827626033095, 6331.050342448635, 5743.885122297552, 5745.052066409037, 5754.482096611304, 5770.134479828017, 5802.796902108427, 5797.1594118852745, 5803.477687008169, 5804.187413762077, 5804.448577385142, 5806.622569532967, 5748.051571490699, 5844.064949608063, 5852.063669812831, 5885.117232415129, 5900.29196496421, 5705.74324155414, 5780.72823978724, 5782.306123265193, 5811.302643682743, 5831.679257640828, 5565.916511252334, 5694.088945768657, 5714.314282286111, 5736.512396446307, 5768.019436695729, 6230.43926046658, 6250.562460627758, 6261.530385221126, 6268.561200715952, 6273.780417685359, 6709.899351509731, 6722.697478613474, 6727.596344219362, 6800.183977922681, 6807.285235050347, 6699.363560461748, 6777.390034896834, 6785.084013658142, 6888.104546408985, 6917.9654101729675, 6307.27466341372, 6311.873762524724, 6316.968415157895, 6317.241930968221, 6320.146780184708, 6942.271061538567, 6967.756128535579, 6980.267071957473, 6985.3713165815325, 7025.894611580728, 6445.967770161119, 6515.413612774778, 6528.640924749185, 6531.379518945692, 6535.346465353522, 6589.0, 6612.504062195355, 6626.171728533934, 6633.1045308882685, 6637.203535575762, 6522.184726909137, 6576.704048317837, 6625.734970601122, 6641.966790166019, 6651.501137414713, 6515.641639709862, 6602.537822352485, 6614.404703576702, 6652.368025037614, 6751.156105486814, 5382.407935127133, 5407.405185429599, 5413.188021796762, 5418.91871621926, 5443.346798384219, 4632.397788287569, 4645.5354464553275, 4692.389989301369, 4706.388169538007, 4732.0, 5905.852353691106, 5947.316058653224, 5959.851003724942, 5967.791127310524, 5973.133895585116, 6693.832654183587, 6788.422984046411, 6799.932000680029, 6812.250652428229, 6860.451163906875, 5859.2090067841145, 5871.32479764824, 5873.618214816023, 5885.823425297248, 5894.469497745224, 5895.35151133375, 5912.970435147883, 5914.704264786744, 5926.555508336892, 5932.139839723216, 6354.936450635527, 6521.445677117498, 6554.868902622016, 6606.768763093269, 6616.040674102228, 6616.90074648871, 6765.729370825112, 6767.1879374475375, 6789.1852977643, 6833.794986150423, 6442.291347951628, 6459.61242325462, 6472.35276472349, 6548.214214294125, 6650.135482387259, 6631.1048008520165, 6639.601623902581, 6666.566673166229, 6704.83237919056, 6719.462443004646, 6780.288069752605, 6815.693293801692, 6866.965665171642, 6871.0, 6877.0, 6536.575122617015, 6537.5096867736065, 6554.901676474761, 6646.0695502628705, 6674.733010679518, 6390.360963903572, 6551.705173267119, 6580.5064620152725, 6585.5719378242175, 6594.868102638016, 6474.546781725234, 6482.124913136855, 6510.544261901621, 6521.184851893513, 6530.020496925499, 6530.640814755044, 6541.574797638138, 6568.507361947777, 6594.472442204708, 6612.933870661424, 6378.362163783585, 6390.105385245976, 6392.52056095804, 6412.6793660317735, 6468.450181734605], "value": 6147.538840591307, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [789.329070290253, 828.4283844147534, 862.9007664118626, 874.2437791310518, 884.7080463447063, 39424.80287598562, 40354.0, 40473.7976310118, 40585.79707101468, 40593.391099133536, 37983.0, 38136.80931595345, 38228.0, 38326.0, 38354.0, 6890.104286442755, 6950.513464057518, 6951.131108611424, 6953.652317384136, 7029.648517574126, 6930.826729331757, 6996.090508233922, 7016.052832867574, 7037.507374483763, 7038.225795162528, 6989.965050174767, 7541.208173141823, 7838.059432868035, 7873.763787086368, 7874.763757087268, 7814.843703125934, 7847.64685589147, 7879.0151231096115, 7880.724174653859, 7882.487638303521, 7568.356689681329, 7659.272369124924, 7779.805504862424, 7783.299503044696, 7795.961020194863, 38120.0, 38376.42435363472, 38419.61580384188, 38494.80752596247, 38549.229015419536, 3541.9114522136897, 3649.85400583979, 3657.963420365789, 3658.140337020798, 3663.120850995742, 30971.38057238865, 31182.688173118204, 31213.687863121533, 31241.53137702936, 31242.218944526343, 5083.059633967728, 5106.719130447824, 5108.565771909392, 5116.130257856136, 5136.357955255593, 233530.0, 235450.0, 237229.0, 237451.0, 237797.0, 49061.75469122631, 49518.50481495211, 49528.0, 49548.50451495511, 49786.75106624516, 50605.0, 50791.492085079415, 50939.49060509347, 51052.48947510552, 51093.0, 14375.28123593816, 14517.927410362881, 14586.270686465634, 14596.854031459761, 14597.708045839025, 11668.766624667629, 11713.414329283502, 11736.119791015708, 11765.176437649454, 11792.056635469142, 13760.587182384545, 13776.862231377758, 13854.307284635728, 13883.652908677364, 14047.0, 5374.758135883816, 5492.890142197134, 5557.916631250535, 5675.943240567624, 5694.629849059798, 1002.7292630989738, 1013.5185786751382, 1030.922680798943, 1032.4631191780381, 1042.7393151712072, 23025.539489210456, 23039.193628222933, 23042.884785575963, 23175.072997080264, 23187.7681223189, 1092.7650555130685, 1113.5935383584933, 1115.369816053927, 1118.5134466507095, 1126.2172789911097, 12273.079519036108, 12358.938205308916, 12387.265782790417, 12456.377181140906, 12529.248245105322, 236593.0, 237419.0, 237968.0, 238151.0, 238979.0, 50307.24539131916, 50926.74536627293, 54749.0, 56176.0, 56569.43430565724, 1440.2654646130338, 1468.7356275870231, 1478.6303424143964, 1489.9031562948373, 1494.3648949196547, 26774.732252677222, 27114.0, 27375.86312068427, 27624.585631215145, 27653.308667282676, 35249.64750352566, 35512.11219719424, 35648.821755891055, 35698.46452303165, 35724.28551428905, 228288.0, 228410.0, 228503.0, 229391.0, 229875.0, 34622.82688586541, 34811.477827832095, 34918.0, 34943.0, 35045.0, 41580.58419415767, 43381.34927976146, 43460.56539434565, 43476.13047738964, 43589.56410435982, 32097.518537221495, 32236.35527289488, 32441.675583243865, 32454.83772581122, 32584.185395365304, 31142.0, 31648.525272120474, 31773.61697872715, 31823.840880795447, 31937.840310798296, 34484.0, 34583.13542161466, 34772.82613587017, 34807.651923480444, 34814.65185348114, 30959.535606966365, 31297.687023129478, 33356.332873342886, 34101.317973640886, 34156.48765268473, 23883.880580596986, 24523.01907923663, 24764.876175619007, 24836.130735424173, 25011.624825627994], "value": 17201.97090927473, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.3511267380535, 586.9413058694131, 603.5171862509992, 606.5632744424015, 607.2561112637018, 22615.095396184133, 22724.77275227247, 23526.058957641697, 23532.76467235327, 23533.64699529506, 26112.869435652796, 28354.716452835466, 28398.29004274894, 28401.147965561013, 28435.146945591667, 7056.294370562941, 7260.52806567574, 7263.418926485895, 7266.745663901765, 7276.527025743309, 6760.222574403932, 7029.507934444591, 7049.718011279542, 7086.043384143126, 7088.291170882896, 7083.256258092878, 7085.504014718972, 7099.609521476316, 7106.289371062904, 7120.50156489046, 7017.82455438613, 7038.964805175967, 7072.717091316341, 7080.929190708079, 7083.291670832953, 6885.070515480396, 6934.930650693479, 6948.722051117949, 6959.0, 6971.6862741176765, 30839.0, 31231.219219519695, 31254.687453125633, 32756.508652370234, 32767.344653106804, 1999.1703443071108, 2053.5584849257334, 2059.083707750052, 2063.2675400233, 2065.8037486438766, 20196.0, 20765.688514672293, 21140.3657890262, 21177.89411052935, 21195.576088478298, 2565.1663209456815, 2639.155470249521, 2670.839749615029, 2672.2918426616766, 2672.812903096784, 142227.0, 149533.0, 153368.0, 153920.0, 154153.0, 20257.898710506353, 21660.675089873665, 21740.456488587595, 21892.781072189075, 23299.18452854142, 45023.549764501935, 45124.09751804946, 45196.09607807891, 45197.32204016943, 45392.54607453883, 10880.891191088147, 11038.337699738042, 11067.225294229327, 11247.100231981422, 11311.886881131248, 9105.453672779655, 9135.132162444557, 9264.490453025148, 9294.395864268801, 9366.531673416439, 9188.95405522968, 11400.429978501043, 11633.825492617618, 11729.530818767324, 11970.640880773592, 3693.741438099361, 3735.6637902588354, 4014.698897582693, 4153.356229784388, 4242.939265183704, 947.7204224753714, 989.5101924547395, 997.5710444508786, 999.1906555689915, 999.2855108597388, 19455.90272048631, 19458.124384402738, 19890.50273743139, 20119.899400502905, 20189.49526261855, 1023.5036007536339, 1043.2436483549518, 1049.6850944716555, 1055.5408397347178, 1058.7194393485731, 10778.299410538446, 11134.387608681438, 11151.944240278746, 11501.712457188638, 13471.797923031163, 563678.0, 568584.0, 576298.0, 577242.0, 585562.0, 120198.0, 124073.13890291653, 124657.0, 126690.0, 127131.36434317769, 1243.3099629705418, 1254.9372531373394, 1294.1393973008032, 1303.4460354349553, 1313.343328335832, 20576.58846823085, 20830.479238019172, 20894.0, 21105.155793768077, 21428.678569821153, 56211.71894140503, 56331.0, 56931.71534142303, 57512.836793976734, 58994.70502647459, 69471.65264173647, 69771.0, 70174.29825701678, 71008.0, 71236.0, 12634.620961371174, 14461.78307325412, 14950.850491494946, 15428.460003899809, 15615.609609759393, 23473.76526234716, 23852.642210367205, 23853.0, 23995.16016939399, 24291.514169716862, 18661.253549858397, 18816.15327310247, 19093.427197184108, 19112.0, 19148.808511914704, 16898.493045208663, 16931.57671058184, 17117.74323385125, 17327.133643318037, 17379.652406951536, 18955.431337059912, 19143.90428047851, 19174.0, 19210.903945480743, 19371.225150993803, 14952.850471495145, 14953.401863925756, 14959.626009349853, 14964.326605302569, 15049.247537623294, 18672.184652601973, 18858.717119243498, 19057.428277151706, 19110.617787643892, 19121.043947802274], "value": 13144.085453033253, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1384.3355189509036, 1411.915285082895, 1423.1674470434796, 1437.4465830655195, 1442.848500907404, 13925.23411212383, 13932.860671393282, 14524.419023239057, 14528.3462244199, 14538.781918271234, 14328.498502552413, 14687.265636718175, 14690.485832995848, 14699.265036748173, 14706.04410713303, 2702.121810411619, 2767.5433553463654, 2771.196353057621, 2774.7918906082023, 2776.6112744215825, 2623.160588611645, 2800.747932686058, 2804.6634403871562, 2806.172179207139, 2808.4102338508937, 2741.917742467729, 2758.9310267243277, 2769.9723002769915, 2784.0116758550625, 2784.136917555554, 2697.6223328733995, 2702.3514356554383, 2709.9322516937236, 2758.3655759175504, 2780.6802217745017, 2617.3718307606036, 2655.7875369970548, 2663.5338815707173, 2673.5454972654697, 2673.919782406531, 13692.52076177329, 13784.793228101587, 13865.168089914638, 13890.93054534731, 13909.234992075431, 7710.151883292833, 7949.682012719484, 7974.401919855976, 8002.119766825645, 8013.2387423194705, 5228.398734145584, 5368.194770784414, 5447.346318441772, 5541.501264886179, 5549.278593782782, 1752.7809023872016, 1774.574102215459, 1779.4839496545985, 1811.03109836237, 1819.5087326421792, 21005.36983890486, 21509.032093555983, 21549.353519394444, 21552.784472155392, 21557.78442215589, 6844.828879277959, 6845.691943862538, 6932.896006559906, 6952.374286314155, 6962.721491140399, 17379.65240695179, 17407.3037078518, 17410.0, 17457.0, 17511.912440437718, 7675.078990521173, 7996.480228785111, 7998.680052797939, 8006.719764808204, 8020.879686804703, 7040.2607726189035, 7124.145102587722, 7145.92854071463, 7152.0, 7200.351968322771, 5347.572194224453, 5541.750621222055, 5620.5503559715125, 5658.207850900877, 5658.434156584309, 1718.3470281293028, 1789.391606853676, 1794.5154808201712, 1811.6376724654858, 1815.373696074852, 863.0937515608712, 893.2318206342541, 906.5849313841634, 912.0924679943498, 914.9634014639473, 7193.352598266181, 7218.278172182845, 7243.275672432715, 7277.526960747535, 7308.37878780299, 702.3292755418563, 702.9437644988388, 717.1430140981477, 730.868443680132, 741.3513175971025, 4872.171730805771, 4997.625178111656, 5076.771545280471, 5105.387353517602, 5282.128448805904, 18257.360992365204, 18542.165602547917, 18969.051547422572, 18997.0, 19006.0, 18427.447176584457, 18889.52776180579, 19168.233270669018, 19226.134823932956, 19253.0, 10132.34139780912, 10369.533370998322, 10421.166306695446, 10435.217358698128, 10583.259171857895, 7756.0, 7914.5646989413835, 7929.841403171788, 7932.722354717557, 7943.126256111938, 16302.918485407497, 16367.181640918145, 16453.012819230884, 16503.587410314838, 16780.832191677928, 16698.58253543671, 16756.0, 16821.495355139366, 16845.326186952876, 16918.915405423388, 11181.776364472827, 11251.212415130862, 11270.098392128446, 11346.716332091764, 11367.261128026652, 12675.93662031684, 12693.8095928563, 12916.418761155583, 12931.965442764367, 12949.676258093623, 10510.842337364793, 10711.8928810714, 10792.406417647106, 10869.130469562575, 10961.45192740344, 10068.69793906184, 10191.796164076824, 10282.280240383101, 10414.062734353642, 10628.468576571295, 9347.439153650803, 9413.764655883657, 9447.196988256075, 9472.28957828152, 9511.524423778921, 7133.8929916050265, 7235.493515453868, 7249.093863267091, 7280.67236974348, 7287.562746235243, 6758.459323254227, 6761.188657360952, 6841.110655614738, 6851.725930962705, 6927.861442771015], "value": 6393.536635024992, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.9280904268881, 505.4137200847018, 524.1613418530351, 531.9893602127955, 533.029885608193, 6204.379562043799, 6215.9906860075225, 6238.812835614939, 6262.561620686553, 6270.686465676721, 5933.376995415473, 5969.343372229051, 6082.939170608292, 6093.299270583884, 6108.267007959051, 5104.66819656723, 5150.201718733583, 5156.407013193493, 5186.7147306898105, 5214.765335559909, 5051.3180720602795, 5106.259592359106, 5142.254373115896, 5204.791808327681, 5213.765380557884, 5110.437851836295, 5112.974435127838, 5122.6158038147105, 5177.534021938025, 5215.530602245797, 5122.487751224848, 5166.870828229286, 5173.8189163379475, 5178.119719647669, 5191.610629202806, 4783.067301876135, 4808.3989501312335, 4834.58905992991, 4834.6374021948495, 4838.322634831126, 6146.385361463863, 6161.291451483092, 6176.197094377747, 6186.969065154691, 6203.379662033805, 5935.676021428014, 5982.341942386334, 6043.063325184604, 6084.8134613750335, 6090.96954515229, 6571.539992200548, 6605.0, 6623.3045530219115, 6704.865902681919, 6710.127683401127, 5322.2282768998275, 5327.573794096463, 5330.627870597586, 5347.572194224453, 5365.704886231256, 6875.828104297382, 6894.207166175854, 6950.339717726808, 6998.895016574756, 7010.090812312884, 5453.454654534515, 5457.070908945553, 5474.890502190014, 5526.58550608706, 5545.528630066409, 5594.972025139929, 5612.298462692163, 5624.465675760796, 5627.634203776742, 5639.802606908738, 5895.557833162444, 6001.989333573302, 6005.459508644243, 6076.392360763976, 6077.908831367533, 6567.901481477782, 6650.401463868178, 6667.566608170453, 6674.699638516181, 6684.16447944007, 1820.3173809821317, 1833.9174737136861, 1886.4623582278984, 1940.3014914630721, 1947.4936516505811, 1424.978625320621, 1438.503716217903, 1449.289847974506, 1450.6373406648338, 1463.8023866778062, 5678.858028549237, 5694.804091140907, 5713.714314284269, 5718.799842005593, 5800.796972106041, 6587.604743715392, 6591.0, 6601.844677181474, 6617.0, 6752.257251702309, 5823.650580965155, 5836.474717275466, 5849.385814489502, 5854.356020837705, 5859.941400586024, 3540.3096396202495, 3615.493830863681, 3627.927441451156, 3641.344557979589, 3655.3785856404475, 6522.21733391996, 6591.83520411984, 6608.867822643617, 6612.404883560406, 6626.403623673892, 6871.6564171791215, 6878.3465570770695, 6947.3747362737595, 6966.909927021975, 6971.407430368374, 6522.119513865568, 6526.967365163238, 6560.311167327457, 6574.539782215199, 6592.9340706593275, 6629.668516574248, 6716.126903502513, 6734.629595372302, 6783.287754785873, 6789.830254243683, 6642.206604216738, 6651.135352404156, 6677.599344039373, 6720.966395167993, 6725.260221375743, 6372.299047104722, 6554.442872355903, 6563.737450502117, 6569.178852643419, 6578.80263592093, 5006.474320196473, 5017.874553136201, 5018.164736923626, 5035.59715222774, 5053.11570475158, 6461.61230326182, 6642.169728783902, 6773.356531129535, 6798.830029249309, 6818.215905170969, 6210.192674952227, 6447.70985305653, 6506.934930650822, 6515.804525864231, 6538.967305163444, 6392.20097487814, 6434.453071488976, 6467.223933128054, 6469.353064693493, 6469.77355792545, 6384.936150638434, 6390.201224846895, 6401.903971440339, 6436.163298771317, 6437.935620643733, 6241.3134555197985, 6467.935320646921, 6481.4722258320235, 6487.935120648922, 6573.408393244631, 6280.1207830902795, 6308.012975912573, 6327.203677793287, 6375.203099612549, 6463.547551671526], "value": 5183.049395755837, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [912.7672443526901, 913.6619450803199, 924.7919218175907, 929.9023602521733, 936.0499093420179, 18964.62070758584, 20014.49963750907, 20034.99999999998, 20067.698984515246, 22298.88850555749, 21597.67603485945, 22151.224707135254, 22170.778292217114, 22344.0, 22377.0, 983.9852402213954, 998.4159266828914, 1000.4447531619948, 1002.3284399452348, 1002.8194924913513, 1063.9946800265989, 1075.3118004477142, 1078.2937176149635, 1078.358376765823, 1079.681493959284, 1013.9556257055208, 1115.2193464574789, 1116.101538261699, 1120.8710998235185, 1127.8421021057059, 1105.6904066861212, 1111.7387413957713, 1120.843081968525, 1121.5794077221042, 1121.7588218533015, 794.7854079398588, 799.0690845165375, 800.1958032177624, 801.967921283148, 802.8835818806241, 18853.151608177526, 18924.0, 19809.603807923904, 19820.702689459526, 20024.79975200244, 21429.89285053565, 21656.675149872764, 22077.116915323368, 22086.668699969512, 22385.888070559544, 16466.341346346133, 16679.6664066718, 16839.494815155565, 16896.239669214916, 16903.915480422642, 3618.7828730276005, 3649.7445178837493, 3650.926981460356, 3652.3425783358985, 3655.214128962286, 128176.99999999907, 128373.35813320873, 129878.0, 130649.6935030647, 131811.0, 16667.583310417336, 16910.323587056628, 17179.82820171807, 17224.138793060298, 17308.0, 30717.23206919845, 31588.0, 31708.682913171033, 31722.0, 31839.204019899687, 7732.342750866239, 8056.315213206826, 8513.36149788756, 8880.333974951904, 9114.13415725505, 4197.286461301586, 4283.935740963888, 4289.978550107292, 4293.0769884474985, 4299.204647140289, 5281.815136470205, 5285.180796976475, 5310.0, 5368.758405871745, 5420.322459692538, 1064.6752740414247, 1069.652362982034, 1082.924195306321, 1085.5060947269133, 1094.2012330998416, 691.374306252842, 696.1055044268091, 700.9579425234502, 710.0, 712.7398499547628, 11970.40147992597, 12155.149139560146, 12339.62981110568, 12664.366781661065, 13095.541656041993, 686.8248596607833, 693.2443636436309, 693.4833549005922, 709.021550260637, 710.076900029959, 5700.543956483471, 5917.52659787216, 5960.850978725566, 6011.849703757353, 6082.482988945901, 107855.46072269745, 110828.0, 112456.0, 117963.41018294853, 118336.40831795786, 94896.0, 97435.0, 99172.0, 100874.0, 101935.49032254939, 87194.0, 88141.55929220314, 88575.55712221526, 90054.54972725094, 91997.08002919886, 11707.88292117068, 11870.940645296718, 11911.880881191077, 12099.939500302442, 12556.43496042662, 38404.0, 38438.807805960794, 39057.80471097626, 39369.212615746954, 40030.0, 69068.0, 72732.63633681797, 73217.6339118301, 74731.0, 75367.62316188384, 18819.71770423472, 19027.429177124708, 19044.523886902385, 19145.904270478557, 19276.518087047934, 21647.567048659253, 21728.130874765466, 21999.23002694898, 22025.779742202372, 22101.115955361605, 18428.447146585622, 18796.248150073843, 18927.621447571248, 18942.0, 19810.40568782939, 19241.90379048096, 19637.70543441821, 19878.50303742418, 20060.297889573794, 20070.49823754418, 19139.712904306725, 19148.04259786977, 19420.611587767882, 19557.60884782325, 20097.0, 13937.930310348384, 14043.859561404255, 14221.786673199704, 14381.28093595337, 14514.274286285432, 14229.786553201917, 14512.419503220175, 14909.0, 15074.849251507345, 15103.32035058447], "value": 9454.466489405573, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1543.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 111.0, 101.0, 108.0, 107.0, 110.0, 118.0, 97.0, 110.0, 115.0], "value": 107.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 121.0, 145.0, 188.0, 117.0, 151.0, 143.0, 119.0, 185.0, 120.0], "value": 143.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 166.0, 162.0, 163.0, 161.0, 164.0, 166.0, 166.0, 162.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 170.0, 74.0, 73.0, 74.0, 78.0, 156.0, 75.0], "value": 92.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 130.0, 79.0, 78.0, 82.0, 122.0, 79.0, 80.0, 127.0], "value": 93.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 125.0, 118.0, 114.0, 114.0, 113.0, 114.0, 114.0, 116.0, 114.0], "value": 115.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 153.0, 153.0, 150.0, 150.0, 155.0, 153.0, 152.0, 152.0, 151.0], "value": 152.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 98.0, 99.0, 94.0, 94.0, 95.0, 98.0, 94.0, 93.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 58.0, 55.0, 57.0, 56.0, 55.0, 54.0, 54.0, 59.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 57.0, 58.0, 54.0, 60.0, 53.0, 62.0, 64.0], "value": 57.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 80.0, 78.0, 87.0, 81.0, 93.0, 81.0, 95.0, 98.0, 80.0], "value": 86.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 133.0, 131.0, 133.0, 133.0, 133.0, 127.0, 127.0, 130.0, 170.0], "value": 135.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 177.0, 178.0, 177.0, 193.0, 177.0, 173.0, 171.0, 173.0, 170.0], "value": 176.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 66.0, 68.0, 71.0, 72.0, 66.0, 64.0, 77.0, 68.0, 65.0], "value": 69.1, "unit": "score"}]}]} 16:52:18 INFO - Return code: 0 16:52:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:52:18 INFO - # TBPL SUCCESS # 16:52:18 INFO - Running post-action listener: _package_coverage_data 16:52:18 INFO - Running post-action listener: _resource_record_post_action 16:52:18 INFO - [mozharness: 2017-08-09 23:52:18.940233Z] Finished run-tests step (success) 16:52:18 INFO - Running post-run listener: _resource_record_post_run 16:52:19 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 433008640; Read time: 12; Write time: 516548 16:52:19 INFO - TinderboxPrint: CPU usage
13.2% 16:52:19 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 16:52:19 INFO - TinderboxPrint: I/O write bytes / time
433,008,640 / 516,548 16:52:19 INFO - TinderboxPrint: CPU idle
8,268.1 (86.8%) 16:52:19 INFO - TinderboxPrint: CPU user
1,206.4 (12.7%) 16:52:19 INFO - TinderboxPrint: Swap in / out
0 / 0 16:52:19 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 106508288; Read time: 0; Write time: 165876 16:52:19 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:52:19 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 325378048; Read time: 0; Write time: 350648 16:52:19 INFO - Running post-run listener: _upload_blobber_files 16:52:19 INFO - Blob upload gear active. 16:52:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:52:19 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 16:52:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:52:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:52:19 INFO - (blobuploader) - INFO - Open directory for files ... 16:52:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:52:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:52:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:52:20 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:52:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:52:20 INFO - (blobuploader) - INFO - Done attempting. 16:52:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:52:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:52:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:52:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:52:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:52:27 INFO - (blobuploader) - INFO - Done attempting. 16:52:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:52:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:52:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:52:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:52:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:52:28 INFO - (blobuploader) - INFO - Done attempting. 16:52:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:52:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:52:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:52:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:52:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:52:29 INFO - (blobuploader) - INFO - Done attempting. 16:52:29 INFO - (blobuploader) - INFO - Iteration through files over. 16:52:29 INFO - Return code: 0 16:52:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:52:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:52:29 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6df70ea5635026bf8b866de2b416ef3b29e78f1b6430dd34881bd5ff42c200286a9425ac4f78036ed4c64e37833a77dd644d0c1ce0cf3ae39a91c32ff4cff511", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bbcd054d1ee123eca2b915bef23fb881569d4077040bc14461d0c66cc608015f33ba5eb0608db11a5749363d3dcbf33ff25c880d13cb596dfb716e1655c6abe0", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2b36685815d3d0f0825d1017c48faa9bc39fb9cca7d58726e67643b7b436f82dee0e1481ff3e08c2adeaa4ec026c537fb32adb2f2812b054d2de28c18dc3e8e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33a6387b83e69221247239203440ccfb3bac410eb5f29eddf9bc5175c3b615a4897df3e3354471a47815ef0d66013b34b74bea52c369527327740d94aaad5c29"} 16:52:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:52:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:52:29 INFO - Contents: 16:52:29 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6df70ea5635026bf8b866de2b416ef3b29e78f1b6430dd34881bd5ff42c200286a9425ac4f78036ed4c64e37833a77dd644d0c1ce0cf3ae39a91c32ff4cff511", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bbcd054d1ee123eca2b915bef23fb881569d4077040bc14461d0c66cc608015f33ba5eb0608db11a5749363d3dcbf33ff25c880d13cb596dfb716e1655c6abe0", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2b36685815d3d0f0825d1017c48faa9bc39fb9cca7d58726e67643b7b436f82dee0e1481ff3e08c2adeaa4ec026c537fb32adb2f2812b054d2de28c18dc3e8e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33a6387b83e69221247239203440ccfb3bac410eb5f29eddf9bc5175c3b615a4897df3e3354471a47815ef0d66013b34b74bea52c369527327740d94aaad5c29"} 16:52:29 INFO - Running post-run listener: copy_logs_to_upload_dir 16:52:29 INFO - Copying logs to upload dir... 16:52:29 INFO - mkdir: /builds/slave/test/build/upload/logs 16:52:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.522245 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-09 16:52:28.681825) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-09 16:52:28.688463) ========= 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=5c37b704b588aaa989324530000001d0-1502318132.175676-260754789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6df70ea5635026bf8b866de2b416ef3b29e78f1b6430dd34881bd5ff42c200286a9425ac4f78036ed4c64e37833a77dd644d0c1ce0cf3ae39a91c32ff4cff511", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bbcd054d1ee123eca2b915bef23fb881569d4077040bc14461d0c66cc608015f33ba5eb0608db11a5749363d3dcbf33ff25c880d13cb596dfb716e1655c6abe0", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2b36685815d3d0f0825d1017c48faa9bc39fb9cca7d58726e67643b7b436f82dee0e1481ff3e08c2adeaa4ec026c537fb32adb2f2812b054d2de28c18dc3e8e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33a6387b83e69221247239203440ccfb3bac410eb5f29eddf9bc5175c3b615a4897df3e3354471a47815ef0d66013b34b74bea52c369527327740d94aaad5c29"} build_url:https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011242 build_url: 'https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6df70ea5635026bf8b866de2b416ef3b29e78f1b6430dd34881bd5ff42c200286a9425ac4f78036ed4c64e37833a77dd644d0c1ce0cf3ae39a91c32ff4cff511", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bbcd054d1ee123eca2b915bef23fb881569d4077040bc14461d0c66cc608015f33ba5eb0608db11a5749363d3dcbf33ff25c880d13cb596dfb716e1655c6abe0", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2b36685815d3d0f0825d1017c48faa9bc39fb9cca7d58726e67643b7b436f82dee0e1481ff3e08c2adeaa4ec026c537fb32adb2f2812b054d2de28c18dc3e8e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33a6387b83e69221247239203440ccfb3bac410eb5f29eddf9bc5175c3b615a4897df3e3354471a47815ef0d66013b34b74bea52c369527327740d94aaad5c29"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-09 16:52:28.720327) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 16:52:28.720693) ========= 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=5c37b704b588aaa989324530000001d0-1502318132.175676-260754789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004441 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 16:52:28.805299) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-09 16:52:28.805701) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-09 16:52:28.806085) ========= ========= Total master_lag: 0.22 =========