builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-010 starttime: 1502417466.42 results: success (0) revision: bb88ccb10454a78b8fa4a7d6c45bdf6fc47de3cd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-10 19:11:06.422520) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-10 19:11:06.422948) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-10 19:11:06.423227) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-10 19:11:06.439316) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-10 19:11:06.439575) ========= 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=eca2ab57546de7b41f256b19000001ef-1502417289.658245-582301924 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-10 19:11:06-- 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% 42.4M=0s 2017-08-10 19:11:06 (42.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.078979 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-10 19:11:06.609793) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-10 19:11:06.610127) ========= 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=eca2ab57546de7b41f256b19000001ef-1502417289.658245-582301924 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015356 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-10 19:11:06.640460) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-10 19:11:06.640755) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bb88ccb10454a78b8fa4a7d6c45bdf6fc47de3cd --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 bb88ccb10454a78b8fa4a7d6c45bdf6fc47de3cd --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=eca2ab57546de7b41f256b19000001ef-1502417289.658245-582301924 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-10 19:11:07,136 truncating revision to first 12 chars 2017-08-10 19:11:07,136 Setting DEBUG logging. 2017-08-10 19:11:07,136 attempt 1/10 2017-08-10 19:11:07,136 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bb88ccb10454?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-10 19:11:07,564 unpacking tar archive at: mozilla-central-bb88ccb10454/testing/mozharness/ program finished with exit code 0 elapsedTime=0.741999 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-10 19:11:07.397463) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-10 19:11:07.397765) ========= script_repo_revision: bb88ccb10454a78b8fa4a7d6c45bdf6fc47de3cd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-10 19:11:07.398154) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-10 19:11:07.398419) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-10 19:11:07.410807) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-08-10 19:11:07.411105) ========= /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=eca2ab57546de7b41f256b19000001ef-1502417289.658245-582301924 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:11:07 INFO - MultiFileLogger online at 20170810 19:11:07 in /builds/slave/test 19:11:08 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 19:11:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:11:08 INFO - {'append_to_log': False, 19:11:08 INFO - 'base_work_dir': '/builds/slave/test', 19:11:08 INFO - 'blob_upload_branch': 'Firefox', 19:11:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:11:08 INFO - 'branch': 'Firefox', 19:11:08 INFO - 'buildbot_json_path': 'buildprops.json', 19:11:08 INFO - 'code_coverage': False, 19:11:08 INFO - 'config_files': ('talos/linux_config.py',), 19:11:08 INFO - 'default_actions': ('clobber', 19:11:08 INFO - 'read-buildbot-config', 19:11:08 INFO - 'download-and-extract', 19:11:08 INFO - 'populate-webroot', 19:11:08 INFO - 'create-virtualenv', 19:11:08 INFO - 'install', 19:11:08 INFO - 'setup-mitmproxy', 19:11:08 INFO - 'run-tests'), 19:11:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:11:08 INFO - 'disable_ccov_upload': False, 19:11:08 INFO - 'download_minidump_stackwalk': True, 19:11:08 INFO - 'download_symbols': 'ondemand', 19:11:08 INFO - 'enable_stylo': False, 19:11:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:11:08 INFO - 'tooltool.py': '/tools/tooltool.py', 19:11:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:11:08 INFO - '/tools/misc-python/virtualenv.py')}, 19:11:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:11:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:11:08 INFO - 'gecko_profile': False, 19:11:08 INFO - 'gecko_profile_interval': 0, 19:11:08 INFO - 'installer_path': 'installer.exe', 19:11:08 INFO - 'log_level': 'info', 19:11:08 INFO - 'log_name': 'talos', 19:11:08 INFO - 'log_to_console': True, 19:11:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:11:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:11:08 INFO - 'opt_config_files': (), 19:11:08 INFO - 'pip_index': False, 19:11:08 INFO - 'suite': 'dromaeojs-e10s', 19:11:08 INFO - 'system_bits': '32', 19:11:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:11:08 INFO - 'title': 'talos-linux64-ix-010', 19:11:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:11:08 INFO - 'use_talos_json': True, 19:11:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:11:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:11:08 INFO - 'work_dir': 'build'} 19:11:08 INFO - [mozharness: 2017-08-11 02:11:08.009336Z] Running clobber step. 19:11:08 INFO - Running pre-action listener: _resource_record_pre_action 19:11:08 INFO - Running main action method: clobber 19:11:08 INFO - rmtree: /builds/slave/test/build 19:11:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:11:09 INFO - Running post-action listener: _resource_record_post_action 19:11:09 INFO - [mozharness: 2017-08-11 02:11:09.036324Z] Finished clobber step (success) 19:11:09 INFO - [mozharness: 2017-08-11 02:11:09.036427Z] Running read-buildbot-config step. 19:11:09 INFO - Running pre-action listener: _resource_record_pre_action 19:11:09 INFO - Running main action method: read_buildbot_config 19:11:09 INFO - Using buildbot properties: 19:11:09 INFO - { 19:11:09 INFO - "project": "", 19:11:09 INFO - "product": "firefox", 19:11:09 INFO - "who": "ffxbld@noreply.mozilla.org", 19:11:09 INFO - "installer_path": "public/build/target.tar.bz2", 19:11:09 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 19:11:09 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 19:11:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 19:11:09 INFO - "stage_platform": "linux64-pgo", 19:11:09 INFO - "basedir": "/builds/slave/test", 19:11:09 INFO - "buildnumber": 105, 19:11:09 INFO - "platform": "ubuntu64_hw", 19:11:09 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:11:09 INFO - "slavebuilddir": "test", 19:11:09 INFO - "taskId": "NjyUIoUoRAy3DhB0AnnjxQ", 19:11:09 INFO - "branch": "mozilla-central", 19:11:09 INFO - "script_repo_revision": "production", 19:11:09 INFO - "revision": "bb88ccb10454a78b8fa4a7d6c45bdf6fc47de3cd", 19:11:09 INFO - "slavename": "talos-linux64-ix-010", 19:11:09 INFO - "repo_path": "mozilla-central" 19:11:09 INFO - } 19:11:09 INFO - Finding installer, test and symbols from parent task. 19:11:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NjyUIoUoRAy3DhB0AnnjxQ'}, attempt #1 19:11:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NjyUIoUoRAy3DhB0AnnjxQ'}, attempt #1 19:11:09 INFO - Task dependencies: MdTQ30e8RrmpX7d1b_CT_g 19:11:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MdTQ30e8RrmpX7d1b_CT_g'}, attempt #1 19:11:10 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/MdTQ30e8RrmpX7d1b_CT_g/artifacts/public/build/target.tar.bz2 19:11:10 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/MdTQ30e8RrmpX7d1b_CT_g/artifacts/public/build/target.test_packages.json 19:11:10 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/MdTQ30e8RrmpX7d1b_CT_g/artifacts/public/build/target.crashreporter-symbols.zip 19:11:10 INFO - Running post-action listener: _resource_record_post_action 19:11:10 INFO - [mozharness: 2017-08-11 02:11:10.419169Z] Finished read-buildbot-config step (success) 19:11:10 INFO - [mozharness: 2017-08-11 02:11:10.419389Z] Running download-and-extract step. 19:11:10 INFO - Running pre-action listener: _resource_record_pre_action 19:11:10 INFO - Running main action method: download_and_extract 19:11:10 INFO - mkdir: /builds/slave/test/build/tests 19:11: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')]} 19:11:10 INFO - trying https://queue.taskcluster.net/v1/task/MdTQ30e8RrmpX7d1b_CT_g/artifacts/public/build/target.test_packages.json 19:11:10 INFO - Downloading https://queue.taskcluster.net/v1/task/MdTQ30e8RrmpX7d1b_CT_g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 19:11:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MdTQ30e8RrmpX7d1b_CT_g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 19:11:10 INFO - Downloaded 989 bytes. 19:11:10 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 19:11:10 INFO - Using the following test package requirements: 19:11:10 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 19:11:10 INFO - u'common': [u'target.common.tests.zip'], 19:11:10 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 19:11:10 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 19:11:10 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 19:11:10 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 19:11:10 INFO - u'mozbase': [u'target.common.tests.zip'], 19:11:10 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 19:11:10 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 19:11:10 INFO - u'web-platform': [u'target.common.tests.zip', 19:11:10 INFO - u'target.web-platform.tests.tar.gz'], 19:11:10 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 19:11:10 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 19:11:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MdTQ30e8RrmpX7d1b_CT_g/artifacts/public/build/target.common.tests.zip 19:11:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MdTQ30e8RrmpX7d1b_CT_g/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:11:10 INFO - Fetch https://queue.taskcluster.net/v1/task/MdTQ30e8RrmpX7d1b_CT_g/artifacts/public/build/target.common.tests.zip into memory 19:11:12 INFO - Content-Length response header: 54956602 19:11:12 INFO - Bytes received: 54956602 19:11:23 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 19:11:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MdTQ30e8RrmpX7d1b_CT_g/artifacts/public/build/target.common.tests.zip 19:11:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MdTQ30e8RrmpX7d1b_CT_g/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:11:23 INFO - Fetch https://queue.taskcluster.net/v1/task/MdTQ30e8RrmpX7d1b_CT_g/artifacts/public/build/target.common.tests.zip into memory 19:11:24 INFO - Content-Length response header: 54956602 19:11:24 INFO - Bytes received: 54956602 19:11:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MdTQ30e8RrmpX7d1b_CT_g/artifacts/public/build/target.talos.tests.zip 19:11:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MdTQ30e8RrmpX7d1b_CT_g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 19:11:36 INFO - Fetch https://queue.taskcluster.net/v1/task/MdTQ30e8RrmpX7d1b_CT_g/artifacts/public/build/target.talos.tests.zip into memory 19:11:37 INFO - Content-Length response header: 14496008 19:11:37 INFO - Bytes received: 14496008 19:11:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:11:37 INFO - trying https://queue.taskcluster.net/v1/task/MdTQ30e8RrmpX7d1b_CT_g/artifacts/public/build/target.tar.bz2 19:11:37 INFO - Downloading https://queue.taskcluster.net/v1/task/MdTQ30e8RrmpX7d1b_CT_g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 19:11:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MdTQ30e8RrmpX7d1b_CT_g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 19:11:38 INFO - Downloaded 62733184 bytes. 19:11:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MdTQ30e8RrmpX7d1b_CT_g/artifacts/public/build/target.tar.bz2 19:11:38 INFO - mkdir: /builds/slave/test/properties 19:11:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:11:38 INFO - Writing to file /builds/slave/test/properties/build_url 19:11:38 INFO - Contents: 19:11:38 INFO - build_url:https://queue.taskcluster.net/v1/task/MdTQ30e8RrmpX7d1b_CT_g/artifacts/public/build/target.tar.bz2 19:11:38 INFO - Running post-action listener: _resource_record_post_action 19:11:38 INFO - Running post-action listener: set_extra_try_arguments 19:11:38 INFO - [mozharness: 2017-08-11 02:11:38.455898Z] Finished download-and-extract step (success) 19:11:38 INFO - [mozharness: 2017-08-11 02:11:38.455996Z] Running populate-webroot step. 19:11:38 INFO - Running pre-action listener: _resource_record_pre_action 19:11:38 INFO - Running main action method: populate_webroot 19:11:38 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:11:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:11:38 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:11:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:11:38 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:11:38 INFO - 'tests': ['damp', 'tps']}, 19:11:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:11:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 19:11:38 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 19:11:38 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 19:11:38 INFO - 'other-e10s': {'tests': ['a11yr', 19:11:38 INFO - 'ts_paint', 19:11:38 INFO - 'tpaint', 19:11:38 INFO - 'sessionrestore', 19:11:38 INFO - 'sessionrestore_many_windows', 19:11:38 INFO - 'sessionrestore_no_auto_restore', 19:11:38 INFO - 'tabpaint']}, 19:11:38 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 19:11:38 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 19:11:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:11:38 INFO - 'tsvgr_opacity', 19:11:38 INFO - 'tart', 19:11:38 INFO - 'tscrollx', 19:11:38 INFO - 'tsvg_static']}, 19:11:38 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:11:38 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:11:38 INFO - 'talos_options': ['--mitmproxy', 19:11:38 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:11:38 INFO - '--firstNonBlankPaint'], 19:11:38 INFO - 'tests': ['tp6_google', 19:11:38 INFO - 'tp6_youtube', 19:11:38 INFO - 'tp6_amazon', 19:11:38 INFO - 'tp6_facebook']}, 19:11:38 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:11:38 INFO - 'talos_options': ['--stylo', 19:11:38 INFO - '--mitmproxy', 19:11:38 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:11:38 INFO - '--firstNonBlankPaint'], 19:11:38 INFO - 'tests': ['tp6_google', 19:11:38 INFO - 'tp6_youtube', 19:11:38 INFO - 'tp6_amazon', 19:11:38 INFO - 'tp6_facebook']}, 19:11:38 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:11:38 INFO - 'talos_options': ['--stylo', 19:11:38 INFO - '--stylo-threads=1', 19:11:38 INFO - '--mitmproxy', 19:11:38 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:11:38 INFO - '--firstNonBlankPaint'], 19:11:38 INFO - 'tests': ['tp6_google', 19:11:38 INFO - 'tp6_youtube', 19:11:38 INFO - 'tp6_amazon', 19:11:38 INFO - 'tp6_facebook']}, 19:11:38 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:11:38 INFO - 'talos_options': ['--xperf_path', 19:11:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:11:38 INFO - 'tests': ['tp5n']}}} 19:11:38 INFO - Running post-action listener: _resource_record_post_action 19:11:38 INFO - [mozharness: 2017-08-11 02:11:38.464392Z] Finished populate-webroot step (success) 19:11:38 INFO - [mozharness: 2017-08-11 02:11:38.464482Z] Running create-virtualenv step. 19:11:38 INFO - Running pre-action listener: _resource_record_pre_action 19:11:38 INFO - Running main action method: create_virtualenv 19:11:38 INFO - Creating virtualenv /builds/slave/test/build/venv 19:11:38 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 19:11:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:11:38 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 19:11:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:11:38 INFO - Using real prefix '/usr' 19:11:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:11:39 INFO - Installing distribute.............................................................................................................................................................................................done. 19:11:41 INFO - Installing pip.................done. 19:11:41 INFO - Return code: 0 19:11:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:11:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:11:41 INFO - Reading from file tmpfile_stdout 19:11:41 INFO - Output received: 19:11:41 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) 19:11:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:11: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')]} 19:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11: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')]} 19:11:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:41 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 0x1b2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9ab20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9df00>, '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 0x1e98ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e99050>, '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': 'eca2ab57546de7b41f256b19000001ef-1502417289.658245-582301924', '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 19:11:41 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 19:11:41 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 19:11:41 INFO - Using env: {'DISPLAY': ':0', 19:11:41 INFO - 'HOME': '/home/cltbld', 19:11:41 INFO - 'LANG': 'en_US.UTF-8', 19:11:41 INFO - 'LANGUAGE': 'en_US:en', 19:11:41 INFO - 'LOGNAME': 'cltbld', 19:11:41 INFO - 'MAIL': '/var/mail/cltbld', 19:11:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:41 INFO - 'MOZ_NO_REMOTE': '1', 19:11:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:41 INFO - 'NO_EM_RESTART': '1', 19:11:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:41 INFO - 'PWD': '/builds/slave/test', 19:11:41 INFO - 'SHELL': '/bin/bash', 19:11:41 INFO - 'SHLVL': '1', 19:11:41 INFO - 'TERM': 'linux', 19:11:41 INFO - 'TMOUT': '86400', 19:11:41 INFO - 'USER': 'cltbld', 19:11:41 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1502417289.658245-582301924', 19:11:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:41 INFO - '_': '/tools/buildbot/bin/python'} 19:11:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:41 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 19:11:41 INFO - Cleaning up... 19:11:41 INFO - Return code: 0 19:11:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:11: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')]} 19:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11: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')]} 19:11:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:41 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 0x1b2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9ab20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9df00>, '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 0x1e98ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e99050>, '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': 'eca2ab57546de7b41f256b19000001ef-1502417289.658245-582301924', '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 19:11:41 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 19:11:41 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 19:11:41 INFO - Using env: {'DISPLAY': ':0', 19:11:41 INFO - 'HOME': '/home/cltbld', 19:11:41 INFO - 'LANG': 'en_US.UTF-8', 19:11:41 INFO - 'LANGUAGE': 'en_US:en', 19:11:41 INFO - 'LOGNAME': 'cltbld', 19:11:41 INFO - 'MAIL': '/var/mail/cltbld', 19:11:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:41 INFO - 'MOZ_NO_REMOTE': '1', 19:11:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:41 INFO - 'NO_EM_RESTART': '1', 19:11:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:41 INFO - 'PWD': '/builds/slave/test', 19:11:41 INFO - 'SHELL': '/bin/bash', 19:11:41 INFO - 'SHLVL': '1', 19:11:41 INFO - 'TERM': 'linux', 19:11:41 INFO - 'TMOUT': '86400', 19:11:41 INFO - 'USER': 'cltbld', 19:11:41 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1502417289.658245-582301924', 19:11:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:41 INFO - '_': '/tools/buildbot/bin/python'} 19:11:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:41 INFO - Downloading/unpacking psutil>=3.1.1 19:11:41 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 19:11:41 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 19:11:41 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 19:11:41 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 19:11:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:11:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:11:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:11:42 INFO - Installing collected packages: psutil 19:11:42 INFO - Running setup.py install for psutil 19:11:42 INFO - building 'psutil._psutil_linux' extension 19:11:42 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 19:11:43 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 19:11:43 INFO - building 'psutil._psutil_posix' extension 19:11:43 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 19:11:43 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 19:11:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:11:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:11:43 INFO - Successfully installed psutil 19:11:43 INFO - Cleaning up... 19:11:43 INFO - Return code: 0 19:11:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:11:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:11:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9ab20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9df00>, '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 0x1e98ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e99050>, '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': 'eca2ab57546de7b41f256b19000001ef-1502417289.658245-582301924', '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 19:11:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:11:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:11:43 INFO - Using env: {'DISPLAY': ':0', 19:11:43 INFO - 'HOME': '/home/cltbld', 19:11:43 INFO - 'LANG': 'en_US.UTF-8', 19:11:43 INFO - 'LANGUAGE': 'en_US:en', 19:11:43 INFO - 'LOGNAME': 'cltbld', 19:11:43 INFO - 'MAIL': '/var/mail/cltbld', 19:11:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:43 INFO - 'MOZ_NO_REMOTE': '1', 19:11:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:43 INFO - 'NO_EM_RESTART': '1', 19:11:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:43 INFO - 'PWD': '/builds/slave/test', 19:11:43 INFO - 'SHELL': '/bin/bash', 19:11:43 INFO - 'SHLVL': '1', 19:11:43 INFO - 'TERM': 'linux', 19:11:43 INFO - 'TMOUT': '86400', 19:11:43 INFO - 'USER': 'cltbld', 19:11:43 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1502417289.658245-582301924', 19:11:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:43 INFO - '_': '/tools/buildbot/bin/python'} 19:11:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:11:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:11:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:11:44 INFO - Installing collected packages: mozsystemmonitor 19:11:44 INFO - Running setup.py install for mozsystemmonitor 19:11:44 INFO - Successfully installed mozsystemmonitor 19:11:44 INFO - Cleaning up... 19:11:44 INFO - Return code: 0 19:11:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:11:44 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')]} 19:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:44 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')]} 19:11:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:44 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 0x1b2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9ab20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9df00>, '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 0x1e98ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e99050>, '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': 'eca2ab57546de7b41f256b19000001ef-1502417289.658245-582301924', '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 19:11:44 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 19:11:44 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 19:11:44 INFO - Using env: {'DISPLAY': ':0', 19:11:44 INFO - 'HOME': '/home/cltbld', 19:11:44 INFO - 'LANG': 'en_US.UTF-8', 19:11:44 INFO - 'LANGUAGE': 'en_US:en', 19:11:44 INFO - 'LOGNAME': 'cltbld', 19:11:44 INFO - 'MAIL': '/var/mail/cltbld', 19:11:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:44 INFO - 'MOZ_NO_REMOTE': '1', 19:11:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:44 INFO - 'NO_EM_RESTART': '1', 19:11:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:44 INFO - 'PWD': '/builds/slave/test', 19:11:44 INFO - 'SHELL': '/bin/bash', 19:11:44 INFO - 'SHLVL': '1', 19:11:44 INFO - 'TERM': 'linux', 19:11:44 INFO - 'TMOUT': '86400', 19:11:44 INFO - 'USER': 'cltbld', 19:11:44 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1502417289.658245-582301924', 19:11:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:44 INFO - '_': '/tools/buildbot/bin/python'} 19:11:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:45 INFO - Downloading/unpacking jsonschema==2.5.1 19:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:11:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:46 INFO - Downloading functools32-3.2.3-2.tar.gz 19:11:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:11:46 INFO - warning: no files found matching '*.txt' 19:11:46 INFO - no previously-included directories found matching 'build' 19:11:46 INFO - no previously-included directories found matching 'dist' 19:11:46 INFO - no previously-included directories found matching '.git*' 19:11:46 INFO - Installing collected packages: jsonschema, functools32 19:11:46 INFO - Running setup.py install for functools32 19:11:46 INFO - warning: no files found matching '*.txt' 19:11:46 INFO - no previously-included directories found matching 'build' 19:11:46 INFO - no previously-included directories found matching 'dist' 19:11:46 INFO - no previously-included directories found matching '.git*' 19:11:46 INFO - Successfully installed jsonschema functools32 19:11:46 INFO - Cleaning up... 19:11:46 INFO - Return code: 0 19:11:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:11:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:11:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1b2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9ab20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9df00>, '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 0x1e98ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e99050>, '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': 'eca2ab57546de7b41f256b19000001ef-1502417289.658245-582301924', '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 19:11:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:11:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:11:46 INFO - Using env: {'DISPLAY': ':0', 19:11:46 INFO - 'HOME': '/home/cltbld', 19:11:46 INFO - 'LANG': 'en_US.UTF-8', 19:11:46 INFO - 'LANGUAGE': 'en_US:en', 19:11:46 INFO - 'LOGNAME': 'cltbld', 19:11:46 INFO - 'MAIL': '/var/mail/cltbld', 19:11:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:46 INFO - 'MOZ_NO_REMOTE': '1', 19:11:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:46 INFO - 'NO_EM_RESTART': '1', 19:11:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:46 INFO - 'PWD': '/builds/slave/test', 19:11:46 INFO - 'SHELL': '/bin/bash', 19:11:46 INFO - 'SHLVL': '1', 19:11:46 INFO - 'TERM': 'linux', 19:11:46 INFO - 'TMOUT': '86400', 19:11:46 INFO - 'USER': 'cltbld', 19:11:46 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1502417289.658245-582301924', 19:11:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:46 INFO - '_': '/tools/buildbot/bin/python'} 19:11:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:11:46 INFO - Cleaning up... 19:11:46 INFO - Return code: 0 19:11:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:11:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:11:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1b2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9ab20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9df00>, '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 0x1e98ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e99050>, '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': 'eca2ab57546de7b41f256b19000001ef-1502417289.658245-582301924', '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 19:11:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:11:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:11:46 INFO - Using env: {'DISPLAY': ':0', 19:11:46 INFO - 'HOME': '/home/cltbld', 19:11:46 INFO - 'LANG': 'en_US.UTF-8', 19:11:46 INFO - 'LANGUAGE': 'en_US:en', 19:11:46 INFO - 'LOGNAME': 'cltbld', 19:11:46 INFO - 'MAIL': '/var/mail/cltbld', 19:11:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:46 INFO - 'MOZ_NO_REMOTE': '1', 19:11:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:46 INFO - 'NO_EM_RESTART': '1', 19:11:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:46 INFO - 'PWD': '/builds/slave/test', 19:11:46 INFO - 'SHELL': '/bin/bash', 19:11:46 INFO - 'SHLVL': '1', 19:11:46 INFO - 'TERM': 'linux', 19:11:46 INFO - 'TMOUT': '86400', 19:11:46 INFO - 'USER': 'cltbld', 19:11:46 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1502417289.658245-582301924', 19:11:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:46 INFO - '_': '/tools/buildbot/bin/python'} 19:11:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:47 INFO - Downloading/unpacking blobuploader==1.2.4 19:11:47 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 19:11:47 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 19:11:47 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 19:11:47 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 19:11:48 INFO - Downloading blobuploader-1.2.4.tar.gz 19:11:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:11:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:11:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:48 INFO - Downloading docopt-0.6.1.tar.gz 19:11:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:11:48 INFO - Installing collected packages: blobuploader, requests, docopt 19:11:48 INFO - Running setup.py install for blobuploader 19:11:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:11:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:11:48 INFO - Running setup.py install for requests 19:11:49 INFO - Running setup.py install for docopt 19:11:49 INFO - Successfully installed blobuploader requests docopt 19:11:49 INFO - Cleaning up... 19:11:49 INFO - Return code: 0 19:11:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:11:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:11:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:49 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 0x1b2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9ab20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9df00>, '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 0x1e98ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e99050>, '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': 'eca2ab57546de7b41f256b19000001ef-1502417289.658245-582301924', '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 19:11:49 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 19:11:49 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 19:11:49 INFO - Using env: {'DISPLAY': ':0', 19:11:49 INFO - 'HOME': '/home/cltbld', 19:11:49 INFO - 'LANG': 'en_US.UTF-8', 19:11:49 INFO - 'LANGUAGE': 'en_US:en', 19:11:49 INFO - 'LOGNAME': 'cltbld', 19:11:49 INFO - 'MAIL': '/var/mail/cltbld', 19:11:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:49 INFO - 'MOZ_NO_REMOTE': '1', 19:11:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:49 INFO - 'NO_EM_RESTART': '1', 19:11:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:49 INFO - 'PWD': '/builds/slave/test', 19:11:49 INFO - 'SHELL': '/bin/bash', 19:11:49 INFO - 'SHLVL': '1', 19:11:49 INFO - 'TERM': 'linux', 19:11:49 INFO - 'TMOUT': '86400', 19:11:49 INFO - 'USER': 'cltbld', 19:11:49 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1502417289.658245-582301924', 19:11:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:49 INFO - '_': '/tools/buildbot/bin/python'} 19:11:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:11:49 INFO - Running setup.py (path:/tmp/pip-OBS04v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:11:49 INFO - Running setup.py (path:/tmp/pip-AkPjXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:11:49 INFO - Running setup.py (path:/tmp/pip-qo8GvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:11:49 INFO - Running setup.py (path:/tmp/pip-HaBalw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:11:49 INFO - Running setup.py (path:/tmp/pip-y2G5nz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:11:49 INFO - Running setup.py (path:/tmp/pip-lszYYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:11:49 INFO - Running setup.py (path:/tmp/pip-9Q_e7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:11:50 INFO - Running setup.py (path:/tmp/pip-skMBS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:11:50 INFO - Running setup.py (path:/tmp/pip-n9QBdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:11:50 INFO - Running setup.py (path:/tmp/pip-MaVq5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:11:50 INFO - Running setup.py (path:/tmp/pip-fZdxR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:11:50 INFO - Running setup.py (path:/tmp/pip-sTUyHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:11:50 INFO - Running setup.py (path:/tmp/pip-ZNqnFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:11:50 INFO - Running setup.py (path:/tmp/pip-hTEm4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:50 INFO - Running setup.py (path:/tmp/pip-0hPWV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:11:50 INFO - Running setup.py (path:/tmp/pip-gXRAZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:11:50 INFO - Running setup.py (path:/tmp/pip-xJh8uI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:11:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:11:50 INFO - Running setup.py install for manifestparser 19:11:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:11:50 INFO - Running setup.py install for mozcrash 19:11:50 INFO - Running setup.py install for mozdebug 19:11:51 INFO - Running setup.py install for mozdevice 19:11:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:11:51 INFO - Running setup.py install for mozfile 19:11:51 INFO - Running setup.py install for mozhttpd 19:11:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:11:51 INFO - Running setup.py install for mozinfo 19:11:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:11:51 INFO - Running setup.py install for mozInstall 19:11:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:11:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:11:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:11:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:11:51 INFO - Running setup.py install for mozleak 19:11:51 INFO - Running setup.py install for mozlog 19:11:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:11:51 INFO - Running setup.py install for moznetwork 19:11:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:11:51 INFO - Running setup.py install for mozprocess 19:11:51 INFO - Running setup.py install for mozprofile 19:11:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:11:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:11:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:11:52 INFO - Running setup.py install for mozrunner 19:11:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:11:52 INFO - Running setup.py install for mozscreenshot 19:11:52 INFO - Running setup.py install for moztest 19:11:52 INFO - Running setup.py install for mozversion 19:11:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:11:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:11:52 INFO - Cleaning up... 19:11:52 INFO - Return code: 0 19:11:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:11:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:11:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:52 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 0x1b2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9ab20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9df00>, '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 0x1e98ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e99050>, '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': 'eca2ab57546de7b41f256b19000001ef-1502417289.658245-582301924', '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 19:11:52 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 19:11:52 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 19:11:52 INFO - Using env: {'DISPLAY': ':0', 19:11:52 INFO - 'HOME': '/home/cltbld', 19:11:52 INFO - 'LANG': 'en_US.UTF-8', 19:11:52 INFO - 'LANGUAGE': 'en_US:en', 19:11:52 INFO - 'LOGNAME': 'cltbld', 19:11:52 INFO - 'MAIL': '/var/mail/cltbld', 19:11:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:52 INFO - 'MOZ_NO_REMOTE': '1', 19:11:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:52 INFO - 'NO_EM_RESTART': '1', 19:11:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:52 INFO - 'PWD': '/builds/slave/test', 19:11:52 INFO - 'SHELL': '/bin/bash', 19:11:52 INFO - 'SHLVL': '1', 19:11:52 INFO - 'TERM': 'linux', 19:11:52 INFO - 'TMOUT': '86400', 19:11:52 INFO - 'USER': 'cltbld', 19:11:52 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1502417289.658245-582301924', 19:11:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:52 INFO - '_': '/tools/buildbot/bin/python'} 19:11:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:11:52 INFO - Running setup.py (path:/tmp/pip-3QiGtE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:11:52 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)) 19:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:11:52 INFO - Running setup.py (path:/tmp/pip-yW5oLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:11:52 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)) 19:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:11:52 INFO - Running setup.py (path:/tmp/pip-bYvJ4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:11:52 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)) 19:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:11:52 INFO - Running setup.py (path:/tmp/pip-uHhaQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:11:53 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)) 19:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:11:53 INFO - Running setup.py (path:/tmp/pip-KuwAIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:11:53 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)) 19:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:11:53 INFO - Running setup.py (path:/tmp/pip-cj3ZVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:11:53 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)) 19:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:11:53 INFO - Running setup.py (path:/tmp/pip-4yPkxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:11:53 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)) 19:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:11:53 INFO - Running setup.py (path:/tmp/pip-ltmP6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:11:53 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)) 19:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:11:53 INFO - Running setup.py (path:/tmp/pip-5IvWpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:11:53 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)) 19:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:11:53 INFO - Running setup.py (path:/tmp/pip-O5t5Qs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:11:53 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)) 19:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:11:53 INFO - Running setup.py (path:/tmp/pip-Rlcsuu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:11:53 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)) 19:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:11:53 INFO - Running setup.py (path:/tmp/pip-tebf5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:11:53 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)) 19:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:11:53 INFO - Running setup.py (path:/tmp/pip-R3FOFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:11:53 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)) 19:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:11:53 INFO - Running setup.py (path:/tmp/pip-YWL5Ul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:11:53 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)) 19:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:53 INFO - Running setup.py (path:/tmp/pip-wPPJVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:53 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)) 19:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:11:53 INFO - Running setup.py (path:/tmp/pip-su50Qd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:11:53 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)) 19:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:11:53 INFO - Running setup.py (path:/tmp/pip-rJQ21G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:11:53 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)) 19:11:53 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)) 19:11:53 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)) 19:11:53 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)) 19:11:53 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)) 19:11:53 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)) 19:11:53 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)) 19:11:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:11:53 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 19:11:53 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 19:11:53 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 19:11:53 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 19:11:55 INFO - Downloading blessings-1.6.tar.gz 19:11:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:11:55 INFO - Installing collected packages: blessings 19:11:55 INFO - Running setup.py install for blessings 19:11:55 INFO - Successfully installed blessings 19:11:55 INFO - Cleaning up... 19:11:55 INFO - Return code: 0 19:11:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:11:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:11:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:11:55 INFO - Reading from file tmpfile_stdout 19:11:55 INFO - Current package versions: 19:11:55 INFO - argparse == 1.2.1 19:11:55 INFO - blessings == 1.6 19:11:55 INFO - blobuploader == 1.2.4 19:11:55 INFO - docopt == 0.6.1 19:11:55 INFO - functools32 == 3.2.3-2 19:11:55 INFO - jsonschema == 2.5.1 19:11:55 INFO - manifestparser == 1.1 19:11:55 INFO - mozInstall == 1.13 19:11:55 INFO - mozcrash == 1.0 19:11:55 INFO - mozdebug == 0.1 19:11:55 INFO - mozdevice == 0.51 19:11:55 INFO - mozfile == 1.2 19:11:55 INFO - mozhttpd == 0.7 19:11:55 INFO - mozinfo == 0.10 19:11:55 INFO - mozleak == 0.1 19:11:55 INFO - mozlog == 3.5 19:11:55 INFO - moznetwork == 0.27 19:11:55 INFO - mozprocess == 0.25 19:11:55 INFO - mozprofile == 0.28 19:11:55 INFO - mozrunner == 6.13 19:11:55 INFO - mozscreenshot == 0.1 19:11:55 INFO - mozsystemmonitor == 0.3 19:11:55 INFO - moztest == 0.8 19:11:55 INFO - mozversion == 1.4 19:11:55 INFO - psutil == 3.1.1 19:11:55 INFO - requests == 1.2.3 19:11:55 INFO - wsgiref == 0.1.2 19:11:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:11:55 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')]} 19:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:55 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')]} 19:11:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:55 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 0x1b2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9ab20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9df00>, '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 0x1e98ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e99050>, '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': 'eca2ab57546de7b41f256b19000001ef-1502417289.658245-582301924', '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 19:11:55 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 19:11:55 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 19:11:55 INFO - Using env: {'DISPLAY': ':0', 19:11:55 INFO - 'HOME': '/home/cltbld', 19:11:55 INFO - 'LANG': 'en_US.UTF-8', 19:11:55 INFO - 'LANGUAGE': 'en_US:en', 19:11:55 INFO - 'LOGNAME': 'cltbld', 19:11:55 INFO - 'MAIL': '/var/mail/cltbld', 19:11:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:55 INFO - 'MOZ_NO_REMOTE': '1', 19:11:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:55 INFO - 'NO_EM_RESTART': '1', 19:11:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:55 INFO - 'PWD': '/builds/slave/test', 19:11:55 INFO - 'SHELL': '/bin/bash', 19:11:55 INFO - 'SHLVL': '1', 19:11:55 INFO - 'TERM': 'linux', 19:11:55 INFO - 'TMOUT': '86400', 19:11:55 INFO - 'USER': 'cltbld', 19:11:55 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1502417289.658245-582301924', 19:11:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:55 INFO - '_': '/tools/buildbot/bin/python'} 19:11:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:55 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)) 19:11:55 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)) 19:11:55 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)) 19:11:55 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)) 19:11:55 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)) 19:11:55 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)) 19:11:55 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)) 19:11:55 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)) 19:11:55 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)) 19:11:55 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 19:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 19:11:56 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)) 19:11:56 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)) 19:11:56 INFO - Installing collected packages: simplejson 19:11:56 INFO - Running setup.py install for simplejson 19:11:57 INFO - building 'simplejson._speedups' extension 19:11:57 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 19:11:57 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 19:11:57 INFO - Successfully installed simplejson 19:11:57 INFO - Cleaning up... 19:11:57 INFO - Return code: 0 19:11:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:11:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:57 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 0x1b2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9ab20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9df00>, '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 0x1e98ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e99050>, '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': 'eca2ab57546de7b41f256b19000001ef-1502417289.658245-582301924', '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 19:11:57 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 19:11:57 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 19:11:57 INFO - Using env: {'DISPLAY': ':0', 19:11:57 INFO - 'HOME': '/home/cltbld', 19:11:57 INFO - 'LANG': 'en_US.UTF-8', 19:11:58 INFO - 'LANGUAGE': 'en_US:en', 19:11:58 INFO - 'LOGNAME': 'cltbld', 19:11:58 INFO - 'MAIL': '/var/mail/cltbld', 19:11:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:58 INFO - 'MOZ_NO_REMOTE': '1', 19:11:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:58 INFO - 'NO_EM_RESTART': '1', 19:11:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:58 INFO - 'PWD': '/builds/slave/test', 19:11:58 INFO - 'SHELL': '/bin/bash', 19:11:58 INFO - 'SHLVL': '1', 19:11:58 INFO - 'TERM': 'linux', 19:11:58 INFO - 'TMOUT': '86400', 19:11:58 INFO - 'USER': 'cltbld', 19:11:58 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1502417289.658245-582301924', 19:11:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:58 INFO - '_': '/tools/buildbot/bin/python'} 19:11:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:11:58 INFO - Cleaning up... 19:11:58 INFO - Return code: 0 19:11:58 INFO - Running post-action listener: _resource_record_post_action 19:11:58 INFO - Running post-action listener: _start_resource_monitoring 19:11:58 INFO - Starting resource monitoring. 19:11:58 INFO - [mozharness: 2017-08-11 02:11:58.263144Z] Finished create-virtualenv step (success) 19:11:58 INFO - [mozharness: 2017-08-11 02:11:58.263669Z] Running install step. 19:11:58 INFO - Running pre-action listener: _resource_record_pre_action 19:11:58 INFO - Running main action method: install 19:11:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:11:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:11:58 INFO - Reading from file tmpfile_stdout 19:11:58 INFO - Detecting whether we're running mozinstall >=1.0... 19:11:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:11:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:11:58 INFO - Reading from file tmpfile_stdout 19:11:58 INFO - Output received: 19:11:58 INFO - Usage: mozinstall [options] installer 19:11:58 INFO - Options: 19:11:58 INFO - -h, --help show this help message and exit 19:11:58 INFO - -d DEST, --destination=DEST 19:11:58 INFO - Directory to install application into. [default: 19:11:58 INFO - "/builds/slave/test"] 19:11:58 INFO - --app=APP Application being installed. [default: firefox] 19:11:58 INFO - mkdir: /builds/slave/test/build/application 19:11:58 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'] 19:11:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 19:12:16 INFO - Reading from file tmpfile_stdout 19:12:16 INFO - Output received: 19:12:16 INFO - /builds/slave/test/build/application/firefox/firefox 19:12:16 INFO - Running post-action listener: _resource_record_post_action 19:12:16 INFO - [mozharness: 2017-08-11 02:12:16.811607Z] Finished install step (success) 19:12:16 INFO - [mozharness: 2017-08-11 02:12:16.811889Z] Running setup-mitmproxy step. 19:12:16 INFO - Running pre-action listener: _resource_record_pre_action 19:12:16 INFO - Running main action method: setup_mitmproxy 19:12:16 INFO - Skipping: mitmproxy is not required 19:12:16 INFO - Running post-action listener: _resource_record_post_action 19:12:16 INFO - [mozharness: 2017-08-11 02:12:16.813020Z] Finished setup-mitmproxy step (success) 19:12:16 INFO - [mozharness: 2017-08-11 02:12:16.813303Z] Running run-tests step. 19:12:16 INFO - Running pre-action listener: _resource_record_pre_action 19:12:16 INFO - Running pre-action listener: _set_gcov_prefix 19:12:16 INFO - Running main action method: run_tests 19:12:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:12:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:12:16 INFO - Python 2.7.3 19:12:16 INFO - Return code: 0 19:12:16 INFO - grabbing minidump binary from tooltool 19:12:16 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')]} 19:12:16 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 0x1e9df00>, '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 0x1e98ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e99050>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:12:16 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 19:12:16 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 19:12:16 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 19:12:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:12:16 INFO - Return code: 0 19:12:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:12:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:12:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:12:16 INFO - ENV: RUST_BACKTRACE is now full 19:12:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:12:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:12:16 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/MdTQ30e8RrmpX7d1b_CT_g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 19:12:16 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/MdTQ30e8RrmpX7d1b_CT_g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 19:12:16 INFO - Using env: {'DISPLAY': ':0', 19:12:16 INFO - 'HOME': '/home/cltbld', 19:12:16 INFO - 'LANG': 'en_US.UTF-8', 19:12:16 INFO - 'LANGUAGE': 'en_US:en', 19:12:16 INFO - 'LOGNAME': 'cltbld', 19:12:16 INFO - 'MAIL': '/var/mail/cltbld', 19:12:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:12:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:12:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:16 INFO - 'MOZ_NO_REMOTE': '1', 19:12:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:12:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:16 INFO - 'NO_EM_RESTART': '1', 19:12:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:16 INFO - 'PWD': '/builds/slave/test', 19:12:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:12:16 INFO - 'RUST_BACKTRACE': 'full', 19:12:16 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 19:12:16 INFO - 'SHELL': '/bin/bash', 19:12:16 INFO - 'SHLVL': '1', 19:12:16 INFO - 'TERM': 'linux', 19:12:16 INFO - 'TMOUT': '86400', 19:12:16 INFO - 'USER': 'cltbld', 19:12:16 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1502417289.658245-582301924', 19:12:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:16 INFO - '_': '/tools/buildbot/bin/python'} 19:12:16 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/MdTQ30e8RrmpX7d1b_CT_g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 19:12:17 INFO - mozversion application_buildid: 20170811005950 19:12:17 INFO - mozversion application_changeset: bb88ccb10454a78b8fa4a7d6c45bdf6fc47de3cd 19:12:17 INFO - mozversion application_display_name: Nightly 19:12:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:12:17 INFO - mozversion application_name: Firefox 19:12:17 INFO - mozversion application_remotingname: firefox 19:12:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:12:17 INFO - mozversion application_vendor: Mozilla 19:12:17 INFO - mozversion application_version: 57.0a1 19:12:17 INFO - mozversion platform_buildid: 20170811005950 19:12:17 INFO - mozversion platform_changeset: bb88ccb10454a78b8fa4a7d6c45bdf6fc47de3cd 19:12:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:12:17 INFO - mozversion platform_version: 57.0a1 19:12:17 INFO - using testdate: 1502417537 19:12:17 INFO - actual date: 1502417537 19:12:17 INFO - starting webserver on 'localhost:53135' 19:12:17 INFO - SUITE-START | Running 2 tests 19:12:17 INFO - TEST-START | dromaeo_css 19:12:17 INFO - Initialising browser for dromaeo_css test... 19:12:17 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53135/getInfo.html -profile /tmp/tmpxzZugL/profile 19:12:17 INFO - TEST-INFO | started process 24706 (/builds/slave/test/build/application/firefox/firefox http://localhost:53135/getInfo.html) 19:12:24 INFO - TEST-INFO | 24706: exit 0 19:12:24 INFO - Browser initialized. 19:12:24 INFO - Running cycle 1/1 for dromaeo_css test... 19:12:24 INFO - TEST-INFO | started process 24921 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxzZugL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:12:25 INFO - PID 24921 | 19:12:25 INFO - PID 24921 | (/builds/slave/test/build/application/firefox/firefox:24970): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 19:12:25 INFO - PID 24921 | 19:12:35 INFO - PID 24921 | RSS: Main: 158621696 19:12:35 INFO - PID 24921 | 19:15:33 INFO - PID 24921 | Cycle 1(1): loaded http://localhost:53135/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53135/tests/dromaeo/cssquery-ext.html) 19:15:35 INFO - PID 24921 | RSS: Main: 166322176 19:15:35 INFO - PID 24921 | 19:18:36 INFO - PID 24921 | Cycle 1(1): loaded http://localhost:53135/tests/dromaeo/cssquery-ext.html (next: http://localhost:53135/tests/dromaeo/cssquery-jquery.html) 19:18:37 INFO - PID 24921 | RSS: Main: 163459072 19:18:37 INFO - PID 24921 | 19:21:39 INFO - PID 24921 | Cycle 1(1): loaded http://localhost:53135/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53135/tests/dromaeo/cssquery-mootools.html) 19:21:39 INFO - PID 24921 | RSS: Main: 165797888 19:21:39 INFO - PID 24921 | 19:24:41 INFO - PID 24921 | Cycle 1(1): loaded http://localhost:53135/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53135/tests/dromaeo/cssquery-prototype.html) 19:24:41 INFO - PID 24921 | RSS: Main: 164634624 19:24:41 INFO - PID 24921 | 19:27:45 INFO - PID 24921 | Cycle 1(1): loaded http://localhost:53135/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53135/tests/dromaeo/cssquery-yui.html) 19:27:45 INFO - PID 24921 | RSS: Main: 167849984 19:27:45 INFO - PID 24921 | 19:30:47 INFO - PID 24921 | Cycle 1(1): loaded http://localhost:53135/tests/dromaeo/cssquery-yui.html (next: http://localhost:53135/tests/dromaeo/cssquery-dojo.html) 19:30:47 INFO - PID 24921 | RSS: Main: 168476672 19:30:47 INFO - PID 24921 | 19:30:47 INFO - PID 24921 | __start_tp_report 19:30:47 INFO - PID 24921 | _x_x_mozilla_page_load 19:30:47 INFO - PID 24921 | _x_x_mozilla_page_load_details 19:30:47 INFO - PID 24921 | |i|pagename|runs| 19:30:47 INFO - PID 24921 | |0;dojo.html;3519.70082542984;3540.168060505781;3564.1802385451347;3569.3396721606487;3582.3909935310994;6110.69446527673;6165;6286.119943207955;6293.496520278378;6352.618842869425;6109.877802443949;6285.748570057203;6293.181886354779;6297.748090076403;6312.495000399968;5495.203195536645;5504.697241651697;5509.063459211943;5514.779408823642;5542.667439953616;5519.586031047667;5521.3926468088475;5522.6686398816;5541.168824676291;5551.2228288039705;5516.14499752537;5566.137248726453;5595.664260144384;5602.0196465618355;5607.495325420711;5363.839084827461;5474.945250547523;5534.944650553523;5602.747876345554;5614.214010038598;5451.373092094381;5510.504054635102;5511.3937466878615;5512.91730624041;5513.917291240635;6153.292371377304;6164;6209.068639704035;6244.188255526752;6253.656048917308;6775.356341147583;6783.796486105425;6856.931430685729;6878.037074809531;6878.830598798217;6760.357766012221;6819.897701534481;6820.658967051677;6831.146106736658;6923.342282483156;6233.937660623381;6244.406781355764;6251.78118765841;6265.310815810257;6276.246850377938;6998.160220773438;6998.790036298919;7002.089728335386;7016.158061032606;7084.362407383257;6651.86696266072;6671.466282697373;6745.865082698417;6747.797566073025;6748.4938629602975;6719.899201511981;6854.451643868479;6862.142232220973;6894.931050689529;6939.340762627542;6718.529702920847;6731.2932142125355;6758.560693554903;6769.8646027079185;6777.2545020047755;6815.556988795713;6816.284290149463;6820.522563420612;6826.761063362758;6833.829154271183;4879.731614761222;4913.950860491349;4923.8276660316715;4928.778204980785;4948.950510494849;4330.696851220448;4394.472663280363;4396.516383197845;4400.713953593006;4403.955960440355;6197.876042479215;6321.778737744157;6368.172137622079;6370.8088757337355;6401.615903045832;6818.454523638097;6822.692978815965;6823.420009299265;6825.69284382194;6919.827004324932;6362.6500542469685;6364.204474440695;6439.742410303629;6444.355564443612;6468.514861385415;5426.782928682808;5457.181422786534;5505.229267902497;5517.889642207214;5533.03171944908;7000.299970002959;7125.002499650053;7142.4286057115305;7149.428045756327;7158;6747.865042699021;6799.490038247251;6820.761273355607;6822.590644561342;6827.7610283641825;7122.928770712227;7150.249223831631;7155.964220178866;7161.104861892263;7163.4269258460245;6662.267150613332;6679.398854103154;6683.43190828785;6683.498737594797;6710.16122984627;5976.223090998143;6831.555948863308;6851.280615535297;6922.896156557555;6945.617991010543;6610.140681711347;6611.790878754171;6627.1716035495565;6710.396064354231;6712.026756120433;6496.285408604956;6538.607683539003;6569.605823650596;6574.04676321921;6662.933370666231;6595.571287866273;6610.70251838678;6618.933810661832;6647.803395388876;6649;6661;6662.333766623299;6698.933010669831;6737.629430381376;6748.6963086660235;6375.075614036032;6425.742970281136;6434.967825160844;6436.485081193587;6531.281559028408 19:30:47 INFO - PID 24921 | |1;ext.html;874.8093990694764;899.4917871402657;933.9346245762796;951.8477043673014;952.6332362040621;40909.79545102278;41110;41883.79058104709;41976.79011604945;41980.37029444553;38887.61112388875;39377;39432.60567394325;39450.80274598623;39494.60505394945;6747.257801641816;6867.107276054131;6868.519203655746;6884.552504087218;6890.862182756342;6758.864822703543;6833;6835.496190838033;6839;6840.828979275509;6808.114945057136;6815.625140617289;7258.383037441798;7456.254374562554;7481.8877716834295;7349.118105827281;7379.3727533159745;7415.3326200642205;7442;7471.402287816962;7160.892586611205;7285.7814265572115;7334.413246940232;7339.155997060353;7351.154617219035;39446.80276598627;39589;39708.20583588341;39813.60186398157;39825.40261896074;3350.480675495278;3390.6778856008887;3399.2521645238007;3403.6085850127306;3405.4210784166503;30884.53673194904;30977.380452390826;30998;31010.534841977387;31027.069187924397;5031.622628302855;5044.344235249431;5060.1903695408555;5060.620453465968;5071.847844564669;216088;218502;219242;219387;220251;49360.25959610609;49589.50410495849;49600.50399495959;49773;49978;51754;52045;52458.73770631122;52504.212436813476;52521.737391312796;16402.425915092914;16737.748933766004;16772.41296554639;16793.58016049584;16869.831301686827;13709.725805483835;13773.104748191336;13780.724385512234;13782;13796.103253288504;14864.108153510824;14922.776158357634;14953.775693364609;15006.474773382879;15157.469488568067;5916.378780228014;5919.112133180058;5953.779475207572;6028.517718582503;6074.787382441594;1058.4601853054996;1097.7934351952474;1098.9120870330355;1103.9668809935715;1111.4276147783899;24204.51590968206;24593.508129837304;24794.380140496633;24812.627810582857;24918.12786552462;1194.9902332529;1207.3540655749307;1210.7033776724759;1211.4366819429008;1220.5911019808286;13205.93397033028;13297.867021329663;13318.467261309634;13362.198268103944;13397.732045359038;276380;277984;278161;278288;278977;54529.1820622691;55343.446565534636;55751.163732544046;58414.41585584175;58750.412495875345;1444.7038357136762;1505.8795296376263;1506.864382205585;1511.909285442855;1517.6433538118533;28370.858145709964;28677.569836452054;29350.706492934798;29397.265068372606;29544.55683164711;37739;37871.81064094662;37909.431358529095;37919.43120853134;37960.81019594995;222548;222696;223851;224365;224513;32232;32327;32619.836900815342;32872.671273286964;33147.66852331446;42267;42395;42573.57426425696;42695.5730442704;42796.358054629825;31870.840645796623;31880;32035.83982080168;32605.18487037843;32771.672283276865;32716.83641581777;34390.14024649404;34491.655083448844;34576.82711586426;34703.65296347105;39403;39453.605463944994;39957.2008559833;40018.599814001485;40170.59829401786;32976.34047319088;33470.832645836614;33666.49500257547;33693;34014.319713606084;25758.484830302914;26219.4756104873;26232.73767262303;26379.60430593581;26488.602670960336 19:30:47 INFO - PID 24921 | |2;jquery.html;555.4667519181588;563.2565014181281;571.6391303914831;576.75487917635;581.3546962871212;22431.214907478243;23243;23332.65001024986;23348.41628959277;23355.299341019752;25462;27796.444071118567;27922.441551169017;27962.30094247645;27970.440591188162;6285.874282514347;6416.069669897862;6421.8715625687455;6423.582467139644;6424.421802037816;5700.942990570104;6239.407256310643;6263.780767673133;6313.273973493038;6320.399562041599;6234.8441288967915;6246.281677607065;6246.906296405557;6247.250329960389;6247.937520624781;6231.906521402183;6244.094606282109;6245.250569931637;6247.9062814057825;6248.1564988726395;5775.335836378787;5824.126381042835;5825.796097136622;5838.795642152504;5840.386759390245;30604;31507.21231969196;31935.4532320876;32184.19539511531;32674.83662581672;2220.4004918671867;2268.7844654757937;2269.8524595901213;2272.0570963050313;2272.2955883676113;20029.399118026482;20557.383278501668;20608.58782824335;20618.793812061987;20618.896905515376;2405.230326295586;2466.938326541833;2513.899444022237;2514.559952008391;2520.5463016656995;157805;159834;160851;161092;161201;15196.924015379853;15450.304736286895;15518;15814.36742530309;15955.361785528448;22583.661245081337;22640.207592734176;22740.886295568416;22835;22867;10719.142468602493;10721.785564288826;10800;10823.35059896393;10864.511097000654;10158.644447444303;10162.949185254027;10183;10278.22913281507;10307.587696492206;9227.400218985744;9480.241580673668;9571.33000689945;9800.509974501389;10026.799464010825;2746.6429364182527;2761.1716485054403;2765.4054378308356;2807.3402750353653;2815.296175956011;1026.7484466305802;1059.3167407022427;1060.2578195263347;1060.3266925502362;1064.5688496159069;22320.330390088322;22520.662190067163;22927.770722292564;23293.88353058224;23422.18022369243;1031.6079889642037;1123.2642619084513;1135.6025391113044;1143.6683361825144;1149.4712432281244;12101.636950891487;12404.81392779109;12487.562935297221;12540.623781286577;12597.370131493572;580294;591385;593772;595500;599508;137917;142633;144841;145486.27256863858;146116.26941865223;1298.8181654568368;1307.7972914198315;1332.8267325247655;1339.1830983100301;1358.280111540885;23079.423014424774;23465.06139754391;23467.295981120595;23634;23747;68315;69150;69309.99999999798;69344.6532767333;71916;88620.5568972151;89406.55296723475;89412.5529372349;89724;89823;13348.265845378597;13812.309384530934;14916.179610121548;15450.9227453862;15479.84520154784;24344.391390215387;24755.381115472257;24858.751412485643;24915.37711557153;25520.872395637904;20237.291694790612;20239.392818215478;21253.01804604854;21508.784912151303;21713.674294885273;18042;18279.086045697928;18759.437216883514;19406.611867762847;19584.51038723986;21930.342089737333;22029.339119826433;22058.33824985253;22069.11723531041;22158.77841221567;15481.148536830582;15610.531684049496;15709.607259818597;15759.527214183134;15818.367265309258;20786.1685532577;20837.79162208419;20923.58152836965;21057.262995795074;21076.578468430853 19:30:47 INFO - PID 24921 | |3;mootools.html;1456.3446449097905;1523.824760152582;1526.1682383101208;1527.2974431761388;1538.7768773527846;15165.317560709767;15816.525504234862;15842.76235856463;15843.445479408223;15855.365785368585;15187.240637968085;15261.6947661047;15327.770083448757;15344.846551534481;15361.385544578203;2691.8115731898774;2723.3872378714827;2723.496153211652;2728.372474330905;2743.903963361283;2627.106783693544;2737.7262273772562;2740.986295068522;2741.2050505353423;2742.506348857205;2455.1897873701723;2757.820741651786;2758.3517873299757;2759.1446651538085;2760.144355249869;2688.6639170103736;2717.619533265354;2739;2757.655293088354;2793.622860913781;2744.8490333031677;2829.9717002829916;2832.8017038807293;2834.4331133773326;2840.6733225679104;15290.541283761506;15390;15391.769123463157;15405.22973851303;15416.3833446662;8137.186281371815;8439.915600843975;8448.619812108469;8462.57687115648;8468;5084.084864724348;5205.063088644042;5303.787848486056;5322.33470816148;5336.546393556552;1953.345629214215;1953.4042117154263;1963.6170946665407;1964.5972575621963;2010.859239853211;26639.600405993926;26810.731892681215;27095.593566096326;27121.728782712118;27142.185734428;7140.107486564179;7149.749758758522;7239.529430586995;7292;7295.52579082358;18288.90855545714;18295.72556411655;18387.448376548724;18422.539436514195;18445.631087378446;8088.231617996281;8244.917550824535;8249.546274954935;8285.171482851787;8302.169783021649;7582.052243469567;7590;7776;7809.492382995087;7828.452008359474;5653.660780353192;5814.534837213013;5882.058870580687;5899.439553242435;5901.852453688606;1756.7891852977468;1788.9069788347665;1829.9634007319778;1831.3041044403042;1835.476889086604;888.7955770172767;901.2024358442825;908.1871724806393;919.8022425178618;928.5682157796657;7157.785266442015;7244.855102897913;7263.128424588977;7348;7393.223711510214;745.4036770583511;757.6893473675766;760.1676164599754;761.8819083042138;771.1132197972377;4620.792064357112;4766.451858036301;4768.284757286435;4770.356001939763;5289.127293996447;21301;21755.238566650092;22579.887100564392;22612;22690.886545567497;21486.140554377962;22341.776582234295;22574.887125564266;22677.43306417353;22694.886525567596;12084.093692973061;12337.876621233852;12358.62924112278;12436.316002619762;12494.250344979511;8150.4294699370475;8503.319734421355;8509.191626795444;8802.811650254009;8936.28509719234;19414.51463713362;19580.412587622395;19655.901720491307;19786.90106549458;20186.192552297744;20057.699134512703;20140.496487587927;20237.392878213675;20321.89839050795;20423.897880510503;11922.344271065174;11966.22219555726;11978.64064078079;12073.69815754578;12084.214526055779;13936.094153879965;13994.860051399355;14131.434742610181;14137.787933181216;14152.575422737335;11604.245724027911;11670.124740644655;11671.241369311307;11776.88223117792;11789.646310610695;10754.892451075702;10828.945855270988;10862.619808306672;10878.891211087788;11068.391238481961;9002.50486223264;9121.589528471102;9138.771530711785;9138.954305228432;9156.6795162169;7064.470164737768;7082.4688148390105;7112.644367781487;7152.892706609301;7165.534240274365;7206.495545311778;7235.204127546071;7267.273272672691;7340.669669864976;7349.30181632744 19:30:47 INFO - PID 24921 | |4;prototype.html;500.2895887839269;505.1437812907124;535.5287347134522;536.2813829468512;540.7944980907255;5953.345132035478;6047.762327938658;6083.543734219929;6092.847678808026;6132.754689812407;5782.971085144579;5925.674087925162;5973.372795856438;5987.40125987401;6005.687810193074;4707.976460117703;4750.667453278272;4765.356676848615;4773.451053128882;4786.425628924534;4681.438227412716;4733.90532189356;4743.264793956942;4747.8575642730775;4748.928766068511;4699.812007519712;4707.6233901287815;4732.6748510416965;4738.928916066262;4752.310914917335;4671;4714.599259062984;4731.266653668669;4753.287006948951;4771.665983381147;4238.19474299882;4261.74429534229;4289.849855255083;4291.35629655551;4308.80610372534;5848.210491583624;5864.677442740647;5884.205632239678;5918.201042859245;5918.615290006136;5585.972070139624;5629.268195134648;5655.943440565624;5666.376698563155;5708.631907174746;6348.809535713936;6361.522885783538;6374.9800031994655;6382.266039405435;6421.389967953037;4767.4994125617;4801.903961920777;4844.2733589961435;4866.537678920497;4869.951300486985;6730.158730158731;6802.020817821581;6803.897941530881;6844.623545704984;6859.416949559293;4913.87715307113;4933.112039832793;4967.552920237196;4984.975075124601;4995.8001679932395;4989.307912144986;4996.825111121166;5024.171011783088;5048.72232027242;5058.266551350033;5600.411956744483;5657.745401456944;5684.289463817023;5709;5748.971255143698;6156.938430615726;6500.447461965786;6504.1869766279215;6509.218893732783;6522.152120224436;1696.3214714114206;1697.7691173898825;1724.430937790526;1743.616404391032;1765.496833402474;1211.19455562052;1235.9926659772257;1237.3936770982334;1257.9245245285313;1271.7965125579863;5976.760929562855;6056.454919057306;6064.181335519736;6087.69561521931;6095.939040609537;6389.137466442064;6571.737130514726;6665.100211471389;6666.699998500079;6677.465802735769;6138.508919286446;6143.96928015357;6193.225846769154;6194.38056194377;6209.223847019122;3478.913027174341;3520.4191308434333;3525.347810655037;3530.5763308402643;3562.0738607962116;6969;6989.89515157273;6997.230304666483;7005.0893383859775;7017.228104908456;6719.916825783925;6761.222459417131;6764.898526522106;6794.320567943166;6809.93190068093;6972.163340399185;6980.93019069813;7014.123234595778;7074.610896400542;7081.752138675225;6623.437007854386;6696.631685257357;6737.193485680575;6760.93239067603;6808.9659551701925;6513.54405191632;6555.672216389257;6567.44176744982;6625.966870165618;6630.602163870183;6917.515773895779;6964.408025317702;6972.302769722987;6988.40598549129;7071.338235514753;4980.228064649985;4990.3762029746285;4993.925091123709;4997.475265097112;5009.574186194214;6506.219253689587;6657.866842663217;6676.165479315086;6693.631850248283;6702.631355275506;6246.064979063342;6409.743610255724;6424.614523128627;6451.967740161269;6542.705578248895;6385.402510192654;6399.712012959521;6405.647689376942;6445.903311450238;6489.156409666713;6347.873042539216;6454.5159113065765;6459.386358295955;6483.059956306403;6504.414602685781;6306.65313407767;6350.396712312323;6416.326285740117;6456.320626939767;6538.738450461929;6250.312465628686;6270.592411493239;6313.779017734358;6350.206224221973;6369.649669268235 19:30:47 INFO - PID 24921 | |5;yui.html;912.4251721415508;936.4989730494185;939.1829108675454;942.8020115775687;943.4952300519224;18231.635367292645;19198.712019319704;19261.325853595128;19285.22859085635;19291.13189906456;17511.649767004652;18226.817731822677;20250;20367.28714494993;20493.48766280844;1057.1595581512697;1074.3875990685312;1080.2438293194755;1083.5340803454512;1087.24979763963;1034.9896501034968;1069.4011353641947;1071.6784964510655;1074.9946250268738;1094.2996482251365;1138.8918052784973;1150.1603829204685;1151.5336288803048;1153.2561497833892;1154.1171004181808;1124.6850881753123;1130.3161587239765;1132.2979752553429;1139.3562637110049;1139.4587570903836;823.6622984576295;836.4103307168492;838.0488145954386;840.8402403543307;845.0662018469626;19264;19276.90361548183;19345.51636209092;19778.60442791136;20248.696269555967;22049.33851984443;22132.114715411364;22253.109875604958;22491;22546.323610291718;16364;16545.090020048894;16726.16369181536;16855;17088.57278568033;3689.575698794646;3705.7035437164964;3706.4810926470313;3706.499622550975;3707.2029513654425;145418.27290863477;146228;146760;147873;150581;17076.914615426842;17080.316787328367;17311.913440432716;17323.133843307784;17399.913000434917;32099.839500802347;32305.35389292248;32566.34867302688;32645.51031734526;32845.17887052843;9217.493037882981;9376.531173441437;9394.436333819993;9411.717648470556;9427.19868811145;4150.377443383456;4205.158968206371;4205.17998990194;4206.915861682749;4232.894177645583;5636.013697602903;5728.484436400744;5802.332731735904;5830.475257226785;5848.88302233953;1049.1711547877244;1078.5254488025244;1094.7919895219882;1097.3251450358132;1099.0767755085767;721.3111478537984;727.5162017258464;733.9669714862844;742.8180095876437;755.6788364944877;12457.0034397248;12539.811902821282;12661.430235639418;13326.466941322238;13575.253361065039;682.8804959132232;690.6270613868455;692.2177938928978;702.7329614746363;705.4462247135974;5968.731407086691;6007.699615019232;6020.578559500793;6049.122877182784;6077;138242;138938.3053084728;139540;143631;145965;121387.39306303412;122102;122744.38627806804;123015;125315;105371.4731426338;106418;106676;107909.46045269724;108148.4592577032;11625.825612615648;11715.589954351557;11855.52577896909;11892.702682433008;11978;50010.24984625161;50973.49026509687;51561.9999999985;51661;51992.220116699034;63952.68023659852;64514.35485645084;64561.67719161562;64740.676296618214;67539.66230168818;15944.681106378039;16000.119993400474;16147.111908844656;16217.67564648724;16334.591635209215;16800.831991679926;18155.727664084785;18166.5458363542;18177.81822181761;18181.818181818013;16168.110753908648;16519.504414867573;16541.338346466007;16676;16726.414575489798;15690.76463853066;15835.683286333979;15886.52340429789;15959.281832317805;16026.919865400598;15953.760693589373;16147.919260403623;16226.67546649084;16245.187740612686;16344.591385215464;12647.936760316139;12746.808797867854;12774.680632983878;12824.102312838386;12921.483140674643;12907.612771616867;12931.935340323238;12932.547360842325;13021.609351719464;13092.476300947856 19:30:47 INFO - PID 24921 | __end_tp_report 19:30:47 INFO - PID 24921 | __start_cc_report 19:30:47 INFO - PID 24921 | _x_x_mozilla_cycle_collect,342 19:30:47 INFO - PID 24921 | __end_cc_report 19:30:47 INFO - PID 24921 | __startTimestamp1502418647515__endTimestamp 19:30:47 INFO - PID 24921 | 19:30:47 INFO - PID 24921 | ------- Summary: start ------- 19:30:47 INFO - PID 24921 | Number of tests: 6 19:30:47 INFO - PID 24921 | 19:30:47 INFO - PID 24921 | [#0] dojo.html Cycles:165 Average:6236.75 Median:6538.61 stddev:811.90 (12.4%) stddev-sans-first:785.91 19:30:47 INFO - PID 24921 | Values: 3519.7 3540.2 3564.2 3569.3 3582.4 6110.7 6165.0 6286.1 6293.5 6352.6 6109.9 6285.7 6293.2 6297.7 6312.5 5495.2 5504.7 5509.1 5514.8 5542.7 5519.6 5521.4 5522.7 5541.2 5551.2 5516.1 5566.1 5595.7 5602.0 5607.5 5363.8 5474.9 5534.9 5602.7 5614.2 5451.4 5510.5 5511.4 5512.9 5513.9 6153.3 6164.0 6209.1 6244.2 6253.7 6775.4 6783.8 6856.9 6878.0 6878.8 6760.4 6819.9 6820.7 6831.1 6923.3 6233.9 6244.4 6251.8 6265.3 6276.2 6998.2 6998.8 7002.1 7016.2 7084.4 6651.9 6671.5 6745.9 6747.8 6748.5 6719.9 6854.5 6862.1 6894.9 6939.3 6718.5 6731.3 6758.6 6769.9 6777.3 6815.6 6816.3 6820.5 6826.8 6833.8 4879.7 4914.0 4923.8 4928.8 4949.0 4330.7 4394.5 4396.5 4400.7 4404.0 6197.9 6321.8 6368.2 6370.8 6401.6 6818.5 6822.7 6823.4 6825.7 6919.8 6362.7 6364.2 6439.7 6444.4 6468.5 5426.8 5457.2 5505.2 5517.9 5533.0 7000.3 7125.0 7142.4 7149.4 7158.0 6747.9 6799.5 6820.8 6822.6 6827.8 7122.9 7150.2 7156.0 7161.1 7163.4 6662.3 6679.4 6683.4 6683.5 6710.2 5976.2 6831.6 6851.3 6922.9 6945.6 6610.1 6611.8 6627.2 6710.4 6712.0 6496.3 6538.6 6569.6 6574.0 6662.9 6595.6 6610.7 6618.9 6647.8 6649.0 6661.0 6662.3 6698.9 6737.6 6748.7 6375.1 6425.7 6435.0 6436.5 6531.3 19:30:47 INFO - PID 24921 | 19:30:47 INFO - PID 24921 | [#1] ext.html Cycles:180 Average:41014.85 Median:18897.78 stddev:62825.92 (332.5%) stddev-sans-first:62929.87 19:30:47 INFO - PID 24921 | Values: 874.8 899.5 933.9 951.8 952.6 40909.8 41110.0 41883.8 41976.8 41980.4 38887.6 39377.0 39432.6 39450.8 39494.6 6747.3 6867.1 6868.5 6884.6 6890.9 6758.9 6833.0 6835.5 6839.0 6840.8 6808.1 6815.6 7258.4 7456.3 7481.9 7349.1 7379.4 7415.3 7442.0 7471.4 7160.9 7285.8 7334.4 7339.2 7351.2 39446.8 39589.0 39708.2 39813.6 39825.4 3350.5 3390.7 3399.3 3403.6 3405.4 30884.5 30977.4 30998.0 31010.5 31027.1 5031.6 5044.3 5060.2 5060.6 5071.8 216088.0 218502.0 219242.0 219387.0 220251.0 49360.3 49589.5 49600.5 49773.0 49978.0 51754.0 52045.0 52458.7 52504.2 52521.7 16402.4 16737.7 16772.4 16793.6 16869.8 13709.7 13773.1 13780.7 13782.0 13796.1 14864.1 14922.8 14953.8 15006.5 15157.5 5916.4 5919.1 5953.8 6028.5 6074.8 1058.5 1097.8 1098.9 1104.0 1111.4 24204.5 24593.5 24794.4 24812.6 24918.1 1195.0 1207.4 1210.7 1211.4 1220.6 13205.9 13297.9 13318.5 13362.2 13397.7 276380.0 277984.0 278161.0 278288.0 278977.0 54529.2 55343.4 55751.2 58414.4 58750.4 1444.7 1505.9 1506.9 1511.9 1517.6 28370.9 28677.6 29350.7 29397.3 29544.6 37739.0 37871.8 37909.4 37919.4 37960.8 222548.0 222696.0 223851.0 224365.0 224513.0 32232.0 32327.0 32619.8 32872.7 33147.7 42267.0 42395.0 42573.6 42695.6 42796.4 31870.8 31880.0 32035.8 32605.2 32771.7 32716.8 34390.1 34491.7 34576.8 34703.7 39403.0 39453.6 39957.2 40018.6 40170.6 32976.3 33470.8 33666.5 33693.0 34014.3 25758.5 26219.5 26232.7 26379.6 26488.6 19:30:47 INFO - PID 24921 | 19:30:47 INFO - PID 24921 | [#2] jquery.html Cycles:180 Average:40712.25 Median:12506.59 stddev:100005.98 (799.6%) stddev-sans-first:100241.07 19:30:47 INFO - PID 24921 | Values: 555.5 563.3 571.6 576.8 581.4 22431.2 23243.0 23332.7 23348.4 23355.3 25462.0 27796.4 27922.4 27962.3 27970.4 6285.9 6416.1 6421.9 6423.6 6424.4 5700.9 6239.4 6263.8 6313.3 6320.4 6234.8 6246.3 6246.9 6247.3 6247.9 6231.9 6244.1 6245.3 6247.9 6248.2 5775.3 5824.1 5825.8 5838.8 5840.4 30604.0 31507.2 31935.5 32184.2 32674.8 2220.4 2268.8 2269.9 2272.1 2272.3 20029.4 20557.4 20608.6 20618.8 20618.9 2405.2 2466.9 2513.9 2514.6 2520.5 157805.0 159834.0 160851.0 161092.0 161201.0 15196.9 15450.3 15518.0 15814.4 15955.4 22583.7 22640.2 22740.9 22835.0 22867.0 10719.1 10721.8 10800.0 10823.4 10864.5 10158.6 10162.9 10183.0 10278.2 10307.6 9227.4 9480.2 9571.3 9800.5 10026.8 2746.6 2761.2 2765.4 2807.3 2815.3 1026.7 1059.3 1060.3 1060.3 1064.6 22320.3 22520.7 22927.8 23293.9 23422.2 1031.6 1123.3 1135.6 1143.7 1149.5 12101.6 12404.8 12487.6 12540.6 12597.4 580294.0 591385.0 593772.0 595500.0 599508.0 137917.0 142633.0 144841.0 145486.3 146116.3 1298.8 1307.8 1332.8 1339.2 1358.3 23079.4 23465.1 23467.3 23634.0 23747.0 68315.0 69150.0 69310.0 69344.7 71916.0 88620.6 89406.6 89412.6 89724.0 89823.0 13348.3 13812.3 14916.2 15450.9 15479.8 24344.4 24755.4 24858.8 24915.4 25520.9 20237.3 20239.4 21253.0 21508.8 21713.7 18042.0 18279.1 18759.4 19406.6 19584.5 21930.3 22029.3 22058.3 22069.1 22158.8 15481.1 15610.5 15709.6 15759.5 15818.4 20786.2 20837.8 20923.6 21057.3 21076.6 19:30:47 INFO - PID 24921 | 19:30:47 INFO - PID 24921 | [#3] mootools.html Cycles:180 Average:9575.73 Median:2723.44 stddev:6928.22 (254.4%) stddev-sans-first:6920.80 19:30:47 INFO - PID 24921 | Values: 1456.3 1523.8 1526.2 1527.3 1538.8 15165.3 15816.5 15842.8 15843.4 15855.4 15187.2 15261.7 15327.8 15344.8 15361.4 2691.8 2723.4 2723.5 2728.4 2743.9 2627.1 2737.7 2741.0 2741.2 2742.5 2455.2 2757.8 2758.4 2759.1 2760.1 2688.7 2717.6 2739.0 2757.7 2793.6 2744.8 2830.0 2832.8 2834.4 2840.7 15290.5 15390.0 15391.8 15405.2 15416.4 8137.2 8439.9 8448.6 8462.6 8468.0 5084.1 5205.1 5303.8 5322.3 5336.5 1953.3 1953.4 1963.6 1964.6 2010.9 26639.6 26810.7 27095.6 27121.7 27142.2 7140.1 7149.7 7239.5 7292.0 7295.5 18288.9 18295.7 18387.4 18422.5 18445.6 8088.2 8244.9 8249.5 8285.2 8302.2 7582.1 7590.0 7776.0 7809.5 7828.5 5653.7 5814.5 5882.1 5899.4 5901.9 1756.8 1788.9 1830.0 1831.3 1835.5 888.8 901.2 908.2 919.8 928.6 7157.8 7244.9 7263.1 7348.0 7393.2 745.4 757.7 760.2 761.9 771.1 4620.8 4766.5 4768.3 4770.4 5289.1 21301.0 21755.2 22579.9 22612.0 22690.9 21486.1 22341.8 22574.9 22677.4 22694.9 12084.1 12337.9 12358.6 12436.3 12494.3 8150.4 8503.3 8509.2 8802.8 8936.3 19414.5 19580.4 19655.9 19786.9 20186.2 20057.7 20140.5 20237.4 20321.9 20423.9 11922.3 11966.2 11978.6 12073.7 12084.2 13936.1 13994.9 14131.4 14137.8 14152.6 11604.2 11670.1 11671.2 11776.9 11789.6 10754.9 10828.9 10862.6 10878.9 11068.4 9002.5 9121.6 9138.8 9139.0 9156.7 7064.5 7082.5 7112.6 7152.9 7165.5 7206.5 7235.2 7267.3 7340.7 7349.3 19:30:47 INFO - PID 24921 | 19:30:47 INFO - PID 24921 | [#4] prototype.html Cycles:180 Average:5484.60 Median:6085.62 stddev:1573.75 (25.9%) stddev-sans-first:1533.06 19:30:47 INFO - PID 24921 | Values: 500.3 505.1 535.5 536.3 540.8 5953.3 6047.8 6083.5 6092.8 6132.8 5783.0 5925.7 5973.4 5987.4 6005.7 4708.0 4750.7 4765.4 4773.5 4786.4 4681.4 4733.9 4743.3 4747.9 4748.9 4699.8 4707.6 4732.7 4738.9 4752.3 4671.0 4714.6 4731.3 4753.3 4771.7 4238.2 4261.7 4289.8 4291.4 4308.8 5848.2 5864.7 5884.2 5918.2 5918.6 5586.0 5629.3 5655.9 5666.4 5708.6 6348.8 6361.5 6375.0 6382.3 6421.4 4767.5 4801.9 4844.3 4866.5 4870.0 6730.2 6802.0 6803.9 6844.6 6859.4 4913.9 4933.1 4967.6 4985.0 4995.8 4989.3 4996.8 5024.2 5048.7 5058.3 5600.4 5657.7 5684.3 5709.0 5749.0 6156.9 6500.4 6504.2 6509.2 6522.2 1696.3 1697.8 1724.4 1743.6 1765.5 1211.2 1236.0 1237.4 1257.9 1271.8 5976.8 6056.5 6064.2 6087.7 6095.9 6389.1 6571.7 6665.1 6666.7 6677.5 6138.5 6144.0 6193.2 6194.4 6209.2 3478.9 3520.4 3525.3 3530.6 3562.1 6969.0 6989.9 6997.2 7005.1 7017.2 6719.9 6761.2 6764.9 6794.3 6809.9 6972.2 6980.9 7014.1 7074.6 7081.8 6623.4 6696.6 6737.2 6760.9 6809.0 6513.5 6555.7 6567.4 6626.0 6630.6 6917.5 6964.4 6972.3 6988.4 7071.3 4980.2 4990.4 4993.9 4997.5 5009.6 6506.2 6657.9 6676.2 6693.6 6702.6 6246.1 6409.7 6424.6 6452.0 6542.7 6385.4 6399.7 6405.6 6445.9 6489.2 6347.9 6454.5 6459.4 6483.1 6504.4 6306.7 6350.4 6416.3 6456.3 6538.7 6250.3 6270.6 6313.8 6350.2 6369.6 19:30:47 INFO - PID 24921 | 19:30:47 INFO - PID 24921 | [#5] yui.html Cycles:180 Average:26455.00 Median:17078.62 stddev:39319.39 (230.2%) stddev-sans-first:39382.91 19:30:47 INFO - PID 24921 | Values: 912.4 936.5 939.2 942.8 943.5 18231.6 19198.7 19261.3 19285.2 19291.1 17511.6 18226.8 20250.0 20367.3 20493.5 1057.2 1074.4 1080.2 1083.5 1087.2 1035.0 1069.4 1071.7 1075.0 1094.3 1138.9 1150.2 1151.5 1153.3 1154.1 1124.7 1130.3 1132.3 1139.4 1139.5 823.7 836.4 838.0 840.8 845.1 19264.0 19276.9 19345.5 19778.6 20248.7 22049.3 22132.1 22253.1 22491.0 22546.3 16364.0 16545.1 16726.2 16855.0 17088.6 3689.6 3705.7 3706.5 3706.5 3707.2 145418.3 146228.0 146760.0 147873.0 150581.0 17076.9 17080.3 17311.9 17323.1 17399.9 32099.8 32305.4 32566.3 32645.5 32845.2 9217.5 9376.5 9394.4 9411.7 9427.2 4150.4 4205.2 4205.2 4206.9 4232.9 5636.0 5728.5 5802.3 5830.5 5848.9 1049.2 1078.5 1094.8 1097.3 1099.1 721.3 727.5 734.0 742.8 755.7 12457.0 12539.8 12661.4 13326.5 13575.3 682.9 690.6 692.2 702.7 705.4 5968.7 6007.7 6020.6 6049.1 6077.0 138242.0 138938.3 139540.0 143631.0 145965.0 121387.4 122102.0 122744.4 123015.0 125315.0 105371.5 106418.0 106676.0 107909.5 108148.5 11625.8 11715.6 11855.5 11892.7 11978.0 50010.2 50973.5 51562.0 51661.0 51992.2 63952.7 64514.4 64561.7 64740.7 67539.7 15944.7 16000.1 16147.1 16217.7 16334.6 16800.8 18155.7 18166.5 18177.8 18181.8 16168.1 16519.5 16541.3 16676.0 16726.4 15690.8 15835.7 15886.5 15959.3 16026.9 15953.8 16147.9 16226.7 16245.2 16344.6 12647.9 12746.8 12774.7 12824.1 12921.5 12907.6 12931.9 12932.5 13021.6 13092.5 19:30:47 INFO - PID 24921 | -------- Summary: end -------- 19:30:47 INFO - PID 24921 | 19:30:48 INFO - TEST-INFO | 24921: exit 0 19:30:48 INFO - TEST-OK | dromaeo_css | took 1111082ms 19:30:48 INFO - TEST-START | kraken 19:30:48 INFO - Initialising browser for kraken test... 19:30:48 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53135/getInfo.html -profile /tmp/tmp3AJ7f1/profile 19:30:48 INFO - TEST-INFO | started process 25301 (/builds/slave/test/build/application/firefox/firefox http://localhost:53135/getInfo.html) 19:30:54 INFO - TEST-INFO | 25301: exit 0 19:30:54 INFO - Browser initialized. 19:30:54 INFO - Running cycle 1/1 for kraken test... 19:30:54 INFO - TEST-INFO | started process 25509 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3AJ7f1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:30:55 INFO - PID 25509 | 19:30:55 INFO - PID 25509 | (/builds/slave/test/build/application/firefox/firefox:25558): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 19:30:55 INFO - PID 25509 | 19:31:05 INFO - PID 25509 | RSS: Main: 158830592 19:31:05 INFO - PID 25509 | 19:31:08 INFO - PID 25509 | Cycle 1(1): loaded http://localhost:53135/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53135/tests/kraken/driver.html?testName=audio-beat-detection) 19:31:09 INFO - PID 25509 | RSS: Main: 164773888 19:31:09 INFO - PID 25509 | 19:31:11 INFO - PID 25509 | Cycle 1(1): loaded http://localhost:53135/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53135/tests/kraken/driver.html?testName=audio-dft) 19:31:12 INFO - PID 25509 | RSS: Main: 168804352 19:31:12 INFO - PID 25509 | 19:31:15 INFO - PID 25509 | Cycle 1(1): loaded http://localhost:53135/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53135/tests/kraken/driver.html?testName=audio-fft) 19:31:16 INFO - PID 25509 | RSS: Main: 163041280 19:31:16 INFO - PID 25509 | 19:31:18 INFO - PID 25509 | Cycle 1(1): loaded http://localhost:53135/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53135/tests/kraken/driver.html?testName=audio-oscillator) 19:31:18 INFO - PID 25509 | RSS: Main: 163287040 19:31:18 INFO - PID 25509 | 19:31:20 INFO - PID 25509 | Cycle 1(1): loaded http://localhost:53135/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53135/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:31:21 INFO - PID 25509 | RSS: Main: 164065280 19:31:21 INFO - PID 25509 | 19:31:24 INFO - PID 25509 | Cycle 1(1): loaded http://localhost:53135/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53135/tests/kraken/driver.html?testName=imaging-darkroom) 19:31:25 INFO - PID 25509 | RSS: Main: 164982784 19:31:25 INFO - PID 25509 | 19:31:28 INFO - PID 25509 | Cycle 1(1): loaded http://localhost:53135/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53135/tests/kraken/driver.html?testName=imaging-desaturate) 19:31:29 INFO - PID 25509 | RSS: Main: 166871040 19:31:29 INFO - PID 25509 | 19:31:31 INFO - PID 25509 | Cycle 1(1): loaded http://localhost:53135/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53135/tests/kraken/driver.html?testName=json-parse-financial) 19:31:32 INFO - PID 25509 | RSS: Main: 165507072 19:31:32 INFO - PID 25509 | 19:31:34 INFO - PID 25509 | Cycle 1(1): loaded http://localhost:53135/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53135/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:31:34 INFO - PID 25509 | RSS: Main: 165195776 19:31:34 INFO - PID 25509 | 19:31:36 INFO - PID 25509 | Cycle 1(1): loaded http://localhost:53135/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53135/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:31:37 INFO - PID 25509 | RSS: Main: 165437440 19:31:37 INFO - PID 25509 | 19:31:39 INFO - PID 25509 | Cycle 1(1): loaded http://localhost:53135/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53135/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:31:39 INFO - PID 25509 | RSS: Main: 165531648 19:31:39 INFO - PID 25509 | 19:31:42 INFO - PID 25509 | Cycle 1(1): loaded http://localhost:53135/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53135/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:31:43 INFO - PID 25509 | RSS: Main: 165330944 19:31:43 INFO - PID 25509 | 19:31:45 INFO - PID 25509 | Cycle 1(1): loaded http://localhost:53135/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53135/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:31:46 INFO - PID 25509 | RSS: Main: 166014976 19:31:46 INFO - PID 25509 | 19:31:48 INFO - PID 25509 | Cycle 1(1): loaded http://localhost:53135/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53135/tests/kraken/driver.html?testName=ai-astar) 19:31:48 INFO - PID 25509 | RSS: Main: 167587840 19:31:48 INFO - PID 25509 | 19:31:48 INFO - PID 25509 | __start_tp_report 19:31:48 INFO - PID 25509 | _x_x_mozilla_page_load 19:31:48 INFO - PID 25509 | _x_x_mozilla_page_load_details 19:31:48 INFO - PID 25509 | |i|pagename|runs| 19:31:48 INFO - PID 25509 | |0;ai-astar;97;108;100;107;105;111;108;100;108;105 19:31:48 INFO - PID 25509 | |1;audio-beat-detection;141;119;139;171;133;139;148;116;167;121 19:31:48 INFO - PID 25509 | |2;audio-dft;164;163;162;164;163;162;161;161;164;167 19:31:48 INFO - PID 25509 | |3;audio-fft;75;73;75;183;78;76;74;76;170;75 19:31:48 INFO - PID 25509 | |4;audio-oscillator;78;78;132;81;81;81;134;78;78;125 19:31:48 INFO - PID 25509 | |5;imaging-gaussian-blur;114;114;113;114;113;114;114;113;114;114 19:31:48 INFO - PID 25509 | |6;imaging-darkroom;149;150;148;148;148;151;150;149;151;148 19:31:48 INFO - PID 25509 | |7;imaging-desaturate;94;94;94;94;94;94;95;94;96;94 19:31:48 INFO - PID 25509 | |8;json-parse-financial;47;48;46;50;45;46;47;46;46;46 19:31:48 INFO - PID 25509 | |9;json-stringify-tinderbox;55;55;56;56;55;55;56;56;56;56 19:31:48 INFO - PID 25509 | |10;stanford-crypto-aes;74;89;82;74;75;75;81;73;77;75 19:31:48 INFO - PID 25509 | |11;stanford-crypto-ccm;119;125;120;118;127;117;115;122;116;161 19:31:48 INFO - PID 25509 | |12;stanford-crypto-pbkdf2;160;164;162;160;169;163;163;161;166;169 19:31:48 INFO - PID 25509 | |13;stanford-crypto-sha256-iterative;68;62;63;60;63;65;62;59;62;59 19:31:48 INFO - PID 25509 | __end_tp_report 19:31:48 INFO - PID 25509 | __start_cc_report 19:31:48 INFO - PID 25509 | _x_x_mozilla_cycle_collect,861 19:31:48 INFO - PID 25509 | __end_cc_report 19:31:48 INFO - PID 25509 | __startTimestamp1502418708492__endTimestamp 19:31:48 INFO - PID 25509 | 19:31:48 INFO - PID 25509 | ------- Summary: start ------- 19:31:48 INFO - PID 25509 | Number of tests: 14 19:31:48 INFO - PID 25509 | 19:31:48 INFO - PID 25509 | [#0] ai-astar Cycles:10 Average:104.90 Median:108.00 stddev:4.48 (4.2%) stddev-sans-first:3.73 19:31:48 INFO - PID 25509 | Values: 97.0 108.0 100.0 107.0 105.0 111.0 108.0 100.0 108.0 105.0 19:31:48 INFO - PID 25509 | 19:31:48 INFO - PID 25509 | [#1] audio-beat-detection Cycles:10 Average:139.40 Median:140.00 stddev:18.80 (13.4%) stddev-sans-first:19.93 19:31:48 INFO - PID 25509 | Values: 141.0 119.0 139.0 171.0 133.0 139.0 148.0 116.0 167.0 121.0 19:31:48 INFO - PID 25509 | 19:31:48 INFO - PID 25509 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.50 stddev:1.79 (1.1%) stddev-sans-first:1.87 19:31:48 INFO - PID 25509 | Values: 164.0 163.0 162.0 164.0 163.0 162.0 161.0 161.0 164.0 167.0 19:31:48 INFO - PID 25509 | 19:31:48 INFO - PID 25509 | [#3] audio-fft Cycles:10 Average:95.50 Median:75.00 stddev:42.82 (57.1%) stddev-sans-first:44.77 19:31:48 INFO - PID 25509 | Values: 75.0 73.0 75.0 183.0 78.0 76.0 74.0 76.0 170.0 75.0 19:31:48 INFO - PID 25509 | 19:31:48 INFO - PID 25509 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:78.00 stddev:24.79 (31.8%) stddev-sans-first:25.56 19:31:48 INFO - PID 25509 | Values: 78.0 78.0 132.0 81.0 81.0 81.0 134.0 78.0 78.0 125.0 19:31:48 INFO - PID 25509 | 19:31:48 INFO - PID 25509 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 19:31:48 INFO - PID 25509 | Values: 114.0 114.0 113.0 114.0 113.0 114.0 114.0 113.0 114.0 114.0 19:31:48 INFO - PID 25509 | 19:31:48 INFO - PID 25509 | [#6] imaging-darkroom Cycles:10 Average:149.20 Median:149.50 stddev:1.23 (0.8%) stddev-sans-first:1.30 19:31:48 INFO - PID 25509 | Values: 149.0 150.0 148.0 148.0 148.0 151.0 150.0 149.0 151.0 148.0 19:31:48 INFO - PID 25509 | 19:31:48 INFO - PID 25509 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 19:31:48 INFO - PID 25509 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 95.0 94.0 96.0 94.0 19:31:48 INFO - PID 25509 | 19:31:48 INFO - PID 25509 | [#8] json-parse-financial Cycles:10 Average:46.70 Median:46.50 stddev:1.42 (3.0%) stddev-sans-first:1.50 19:31:48 INFO - PID 25509 | Values: 47.0 48.0 46.0 50.0 45.0 46.0 47.0 46.0 46.0 46.0 19:31:48 INFO - PID 25509 | 19:31:48 INFO - PID 25509 | [#9] json-stringify-tinderbox Cycles:10 Average:55.60 Median:56.00 stddev:0.52 (0.9%) stddev-sans-first:0.50 19:31:48 INFO - PID 25509 | Values: 55.0 55.0 56.0 56.0 55.0 55.0 56.0 56.0 56.0 56.0 19:31:48 INFO - PID 25509 | 19:31:48 INFO - PID 25509 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:76.00 stddev:5.04 (6.6%) stddev-sans-first:5.18 19:31:48 INFO - PID 25509 | Values: 74.0 89.0 82.0 74.0 75.0 75.0 81.0 73.0 77.0 75.0 19:31:48 INFO - PID 25509 | 19:31:48 INFO - PID 25509 | [#11] stanford-crypto-ccm Cycles:10 Average:124.00 Median:121.00 stddev:13.56 (11.2%) stddev-sans-first:14.26 19:31:48 INFO - PID 25509 | Values: 119.0 125.0 120.0 118.0 127.0 117.0 115.0 122.0 116.0 161.0 19:31:48 INFO - PID 25509 | 19:31:48 INFO - PID 25509 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.70 Median:163.50 stddev:3.33 (2.0%) stddev-sans-first:3.26 19:31:48 INFO - PID 25509 | Values: 160.0 164.0 162.0 160.0 169.0 163.0 163.0 161.0 166.0 169.0 19:31:48 INFO - PID 25509 | 19:31:48 INFO - PID 25509 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:62.50 stddev:2.75 (4.4%) stddev-sans-first:2.00 19:31:48 INFO - PID 25509 | Values: 68.0 62.0 63.0 60.0 63.0 65.0 62.0 59.0 62.0 59.0 19:31:48 INFO - PID 25509 | -------- Summary: end -------- 19:31:48 INFO - PID 25509 | 19:31:48 INFO - PID 25509 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 19:31:49 INFO - TEST-INFO | 25509: exit 0 19:31:49 INFO - TEST-OK | kraken | took 60913ms 19:31:49 INFO - SUITE-END | took 1171s 19:31:49 INFO - Completed test suite (00:19:32) 19:31:49 INFO - javascript benchmark 19:31:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8784.85849772279, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3519.70082542984, 3540.168060505781, 3564.1802385451347, 3569.3396721606487, 3582.3909935310994, 6110.69446527673, 6165.0, 6286.119943207955, 6293.496520278378, 6352.618842869425, 6109.877802443949, 6285.748570057203, 6293.181886354779, 6297.748090076403, 6312.495000399968, 5495.203195536645, 5504.697241651697, 5509.063459211943, 5514.779408823642, 5542.667439953616, 5519.586031047667, 5521.3926468088475, 5522.6686398816, 5541.168824676291, 5551.2228288039705, 5516.14499752537, 5566.137248726453, 5595.664260144384, 5602.0196465618355, 5607.495325420711, 5363.839084827461, 5474.945250547523, 5534.944650553523, 5602.747876345554, 5614.214010038598, 5451.373092094381, 5510.504054635102, 5511.3937466878615, 5512.91730624041, 5513.917291240635, 6153.292371377304, 6164.0, 6209.068639704035, 6244.188255526752, 6253.656048917308, 6775.356341147583, 6783.796486105425, 6856.931430685729, 6878.037074809531, 6878.830598798217, 6760.357766012221, 6819.897701534481, 6820.658967051677, 6831.146106736658, 6923.342282483156, 6233.937660623381, 6244.406781355764, 6251.78118765841, 6265.310815810257, 6276.246850377938, 6998.160220773438, 6998.790036298919, 7002.089728335386, 7016.158061032606, 7084.362407383257, 6651.86696266072, 6671.466282697373, 6745.865082698417, 6747.797566073025, 6748.4938629602975, 6719.899201511981, 6854.451643868479, 6862.142232220973, 6894.931050689529, 6939.340762627542, 6718.529702920847, 6731.2932142125355, 6758.560693554903, 6769.8646027079185, 6777.2545020047755, 6815.556988795713, 6816.284290149463, 6820.522563420612, 6826.761063362758, 6833.829154271183, 4879.731614761222, 4913.950860491349, 4923.8276660316715, 4928.778204980785, 4948.950510494849, 4330.696851220448, 4394.472663280363, 4396.516383197845, 4400.713953593006, 4403.955960440355, 6197.876042479215, 6321.778737744157, 6368.172137622079, 6370.8088757337355, 6401.615903045832, 6818.454523638097, 6822.692978815965, 6823.420009299265, 6825.69284382194, 6919.827004324932, 6362.6500542469685, 6364.204474440695, 6439.742410303629, 6444.355564443612, 6468.514861385415, 5426.782928682808, 5457.181422786534, 5505.229267902497, 5517.889642207214, 5533.03171944908, 7000.299970002959, 7125.002499650053, 7142.4286057115305, 7149.428045756327, 7158.0, 6747.865042699021, 6799.490038247251, 6820.761273355607, 6822.590644561342, 6827.7610283641825, 7122.928770712227, 7150.249223831631, 7155.964220178866, 7161.104861892263, 7163.4269258460245, 6662.267150613332, 6679.398854103154, 6683.43190828785, 6683.498737594797, 6710.16122984627, 5976.223090998143, 6831.555948863308, 6851.280615535297, 6922.896156557555, 6945.617991010543, 6610.140681711347, 6611.790878754171, 6627.1716035495565, 6710.396064354231, 6712.026756120433, 6496.285408604956, 6538.607683539003, 6569.605823650596, 6574.04676321921, 6662.933370666231, 6595.571287866273, 6610.70251838678, 6618.933810661832, 6647.803395388876, 6649.0, 6661.0, 6662.333766623299, 6698.933010669831, 6737.629430381376, 6748.6963086660235, 6375.075614036032, 6425.742970281136, 6434.967825160844, 6436.485081193587, 6531.281559028408], "value": 6175.009208698415, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [874.8093990694764, 899.4917871402657, 933.9346245762796, 951.8477043673014, 952.6332362040621, 40909.79545102278, 41110.0, 41883.79058104709, 41976.79011604945, 41980.37029444553, 38887.61112388875, 39377.0, 39432.60567394325, 39450.80274598623, 39494.60505394945, 6747.257801641816, 6867.107276054131, 6868.519203655746, 6884.552504087218, 6890.862182756342, 6758.864822703543, 6833.0, 6835.496190838033, 6839.0, 6840.828979275509, 6808.114945057136, 6815.625140617289, 7258.383037441798, 7456.254374562554, 7481.8877716834295, 7349.118105827281, 7379.3727533159745, 7415.3326200642205, 7442.0, 7471.402287816962, 7160.892586611205, 7285.7814265572115, 7334.413246940232, 7339.155997060353, 7351.154617219035, 39446.80276598627, 39589.0, 39708.20583588341, 39813.60186398157, 39825.40261896074, 3350.480675495278, 3390.6778856008887, 3399.2521645238007, 3403.6085850127306, 3405.4210784166503, 30884.53673194904, 30977.380452390826, 30998.0, 31010.534841977387, 31027.069187924397, 5031.622628302855, 5044.344235249431, 5060.1903695408555, 5060.620453465968, 5071.847844564669, 216088.0, 218502.0, 219242.0, 219387.0, 220251.0, 49360.25959610609, 49589.50410495849, 49600.50399495959, 49773.0, 49978.0, 51754.0, 52045.0, 52458.73770631122, 52504.212436813476, 52521.737391312796, 16402.425915092914, 16737.748933766004, 16772.41296554639, 16793.58016049584, 16869.831301686827, 13709.725805483835, 13773.104748191336, 13780.724385512234, 13782.0, 13796.103253288504, 14864.108153510824, 14922.776158357634, 14953.775693364609, 15006.474773382879, 15157.469488568067, 5916.378780228014, 5919.112133180058, 5953.779475207572, 6028.517718582503, 6074.787382441594, 1058.4601853054996, 1097.7934351952474, 1098.9120870330355, 1103.9668809935715, 1111.4276147783899, 24204.51590968206, 24593.508129837304, 24794.380140496633, 24812.627810582857, 24918.12786552462, 1194.9902332529, 1207.3540655749307, 1210.7033776724759, 1211.4366819429008, 1220.5911019808286, 13205.93397033028, 13297.867021329663, 13318.467261309634, 13362.198268103944, 13397.732045359038, 276380.0, 277984.0, 278161.0, 278288.0, 278977.0, 54529.1820622691, 55343.446565534636, 55751.163732544046, 58414.41585584175, 58750.412495875345, 1444.7038357136762, 1505.8795296376263, 1506.864382205585, 1511.909285442855, 1517.6433538118533, 28370.858145709964, 28677.569836452054, 29350.706492934798, 29397.265068372606, 29544.55683164711, 37739.0, 37871.81064094662, 37909.431358529095, 37919.43120853134, 37960.81019594995, 222548.0, 222696.0, 223851.0, 224365.0, 224513.0, 32232.0, 32327.0, 32619.836900815342, 32872.671273286964, 33147.66852331446, 42267.0, 42395.0, 42573.57426425696, 42695.5730442704, 42796.358054629825, 31870.840645796623, 31880.0, 32035.83982080168, 32605.18487037843, 32771.672283276865, 32716.83641581777, 34390.14024649404, 34491.655083448844, 34576.82711586426, 34703.65296347105, 39403.0, 39453.605463944994, 39957.2008559833, 40018.599814001485, 40170.59829401786, 32976.34047319088, 33470.832645836614, 33666.49500257547, 33693.0, 34014.319713606084, 25758.484830302914, 26219.4756104873, 26232.73767262303, 26379.60430593581, 26488.602670960336], "value": 17736.55118206815, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.4667519181588, 563.2565014181281, 571.6391303914831, 576.75487917635, 581.3546962871212, 22431.214907478243, 23243.0, 23332.65001024986, 23348.41628959277, 23355.299341019752, 25462.0, 27796.444071118567, 27922.441551169017, 27962.30094247645, 27970.440591188162, 6285.874282514347, 6416.069669897862, 6421.8715625687455, 6423.582467139644, 6424.421802037816, 5700.942990570104, 6239.407256310643, 6263.780767673133, 6313.273973493038, 6320.399562041599, 6234.8441288967915, 6246.281677607065, 6246.906296405557, 6247.250329960389, 6247.937520624781, 6231.906521402183, 6244.094606282109, 6245.250569931637, 6247.9062814057825, 6248.1564988726395, 5775.335836378787, 5824.126381042835, 5825.796097136622, 5838.795642152504, 5840.386759390245, 30604.0, 31507.21231969196, 31935.4532320876, 32184.19539511531, 32674.83662581672, 2220.4004918671867, 2268.7844654757937, 2269.8524595901213, 2272.0570963050313, 2272.2955883676113, 20029.399118026482, 20557.383278501668, 20608.58782824335, 20618.793812061987, 20618.896905515376, 2405.230326295586, 2466.938326541833, 2513.899444022237, 2514.559952008391, 2520.5463016656995, 157805.0, 159834.0, 160851.0, 161092.0, 161201.0, 15196.924015379853, 15450.304736286895, 15518.0, 15814.36742530309, 15955.361785528448, 22583.661245081337, 22640.207592734176, 22740.886295568416, 22835.0, 22867.0, 10719.142468602493, 10721.785564288826, 10800.0, 10823.35059896393, 10864.511097000654, 10158.644447444303, 10162.949185254027, 10183.0, 10278.22913281507, 10307.587696492206, 9227.400218985744, 9480.241580673668, 9571.33000689945, 9800.509974501389, 10026.799464010825, 2746.6429364182527, 2761.1716485054403, 2765.4054378308356, 2807.3402750353653, 2815.296175956011, 1026.7484466305802, 1059.3167407022427, 1060.2578195263347, 1060.3266925502362, 1064.5688496159069, 22320.330390088322, 22520.662190067163, 22927.770722292564, 23293.88353058224, 23422.18022369243, 1031.6079889642037, 1123.2642619084513, 1135.6025391113044, 1143.6683361825144, 1149.4712432281244, 12101.636950891487, 12404.81392779109, 12487.562935297221, 12540.623781286577, 12597.370131493572, 580294.0, 591385.0, 593772.0, 595500.0, 599508.0, 137917.0, 142633.0, 144841.0, 145486.27256863858, 146116.26941865223, 1298.8181654568368, 1307.7972914198315, 1332.8267325247655, 1339.1830983100301, 1358.280111540885, 23079.423014424774, 23465.06139754391, 23467.295981120595, 23634.0, 23747.0, 68315.0, 69150.0, 69309.99999999798, 69344.6532767333, 71916.0, 88620.5568972151, 89406.55296723475, 89412.5529372349, 89724.0, 89823.0, 13348.265845378597, 13812.309384530934, 14916.179610121548, 15450.9227453862, 15479.84520154784, 24344.391390215387, 24755.381115472257, 24858.751412485643, 24915.37711557153, 25520.872395637904, 20237.291694790612, 20239.392818215478, 21253.01804604854, 21508.784912151303, 21713.674294885273, 18042.0, 18279.086045697928, 18759.437216883514, 19406.611867762847, 19584.51038723986, 21930.342089737333, 22029.339119826433, 22058.33824985253, 22069.11723531041, 22158.77841221567, 15481.148536830582, 15610.531684049496, 15709.607259818597, 15759.527214183134, 15818.367265309258, 20786.1685532577, 20837.79162208419, 20923.58152836965, 21057.262995795074, 21076.578468430853], "value": 12962.089935978387, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1456.3446449097905, 1523.824760152582, 1526.1682383101208, 1527.2974431761388, 1538.7768773527846, 15165.317560709767, 15816.525504234862, 15842.76235856463, 15843.445479408223, 15855.365785368585, 15187.240637968085, 15261.6947661047, 15327.770083448757, 15344.846551534481, 15361.385544578203, 2691.8115731898774, 2723.3872378714827, 2723.496153211652, 2728.372474330905, 2743.903963361283, 2627.106783693544, 2737.7262273772562, 2740.986295068522, 2741.2050505353423, 2742.506348857205, 2455.1897873701723, 2757.820741651786, 2758.3517873299757, 2759.1446651538085, 2760.144355249869, 2688.6639170103736, 2717.619533265354, 2739.0, 2757.655293088354, 2793.622860913781, 2744.8490333031677, 2829.9717002829916, 2832.8017038807293, 2834.4331133773326, 2840.6733225679104, 15290.541283761506, 15390.0, 15391.769123463157, 15405.22973851303, 15416.3833446662, 8137.186281371815, 8439.915600843975, 8448.619812108469, 8462.57687115648, 8468.0, 5084.084864724348, 5205.063088644042, 5303.787848486056, 5322.33470816148, 5336.546393556552, 1953.345629214215, 1953.4042117154263, 1963.6170946665407, 1964.5972575621963, 2010.859239853211, 26639.600405993926, 26810.731892681215, 27095.593566096326, 27121.728782712118, 27142.185734428, 7140.107486564179, 7149.749758758522, 7239.529430586995, 7292.0, 7295.52579082358, 18288.90855545714, 18295.72556411655, 18387.448376548724, 18422.539436514195, 18445.631087378446, 8088.231617996281, 8244.917550824535, 8249.546274954935, 8285.171482851787, 8302.169783021649, 7582.052243469567, 7590.0, 7776.0, 7809.492382995087, 7828.452008359474, 5653.660780353192, 5814.534837213013, 5882.058870580687, 5899.439553242435, 5901.852453688606, 1756.7891852977468, 1788.9069788347665, 1829.9634007319778, 1831.3041044403042, 1835.476889086604, 888.7955770172767, 901.2024358442825, 908.1871724806393, 919.8022425178618, 928.5682157796657, 7157.785266442015, 7244.855102897913, 7263.128424588977, 7348.0, 7393.223711510214, 745.4036770583511, 757.6893473675766, 760.1676164599754, 761.8819083042138, 771.1132197972377, 4620.792064357112, 4766.451858036301, 4768.284757286435, 4770.356001939763, 5289.127293996447, 21301.0, 21755.238566650092, 22579.887100564392, 22612.0, 22690.886545567497, 21486.140554377962, 22341.776582234295, 22574.887125564266, 22677.43306417353, 22694.886525567596, 12084.093692973061, 12337.876621233852, 12358.62924112278, 12436.316002619762, 12494.250344979511, 8150.4294699370475, 8503.319734421355, 8509.191626795444, 8802.811650254009, 8936.28509719234, 19414.51463713362, 19580.412587622395, 19655.901720491307, 19786.90106549458, 20186.192552297744, 20057.699134512703, 20140.496487587927, 20237.392878213675, 20321.89839050795, 20423.897880510503, 11922.344271065174, 11966.22219555726, 11978.64064078079, 12073.69815754578, 12084.214526055779, 13936.094153879965, 13994.860051399355, 14131.434742610181, 14137.787933181216, 14152.575422737335, 11604.245724027911, 11670.124740644655, 11671.241369311307, 11776.88223117792, 11789.646310610695, 10754.892451075702, 10828.945855270988, 10862.619808306672, 10878.891211087788, 11068.391238481961, 9002.50486223264, 9121.589528471102, 9138.771530711785, 9138.954305228432, 9156.6795162169, 7064.470164737768, 7082.4688148390105, 7112.644367781487, 7152.892706609301, 7165.534240274365, 7206.495545311778, 7235.204127546071, 7267.273272672691, 7340.669669864976, 7349.30181632744], "value": 6799.494767947562, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.2895887839269, 505.1437812907124, 535.5287347134522, 536.2813829468512, 540.7944980907255, 5953.345132035478, 6047.762327938658, 6083.543734219929, 6092.847678808026, 6132.754689812407, 5782.971085144579, 5925.674087925162, 5973.372795856438, 5987.40125987401, 6005.687810193074, 4707.976460117703, 4750.667453278272, 4765.356676848615, 4773.451053128882, 4786.425628924534, 4681.438227412716, 4733.90532189356, 4743.264793956942, 4747.8575642730775, 4748.928766068511, 4699.812007519712, 4707.6233901287815, 4732.6748510416965, 4738.928916066262, 4752.310914917335, 4671.0, 4714.599259062984, 4731.266653668669, 4753.287006948951, 4771.665983381147, 4238.19474299882, 4261.74429534229, 4289.849855255083, 4291.35629655551, 4308.80610372534, 5848.210491583624, 5864.677442740647, 5884.205632239678, 5918.201042859245, 5918.615290006136, 5585.972070139624, 5629.268195134648, 5655.943440565624, 5666.376698563155, 5708.631907174746, 6348.809535713936, 6361.522885783538, 6374.9800031994655, 6382.266039405435, 6421.389967953037, 4767.4994125617, 4801.903961920777, 4844.2733589961435, 4866.537678920497, 4869.951300486985, 6730.158730158731, 6802.020817821581, 6803.897941530881, 6844.623545704984, 6859.416949559293, 4913.87715307113, 4933.112039832793, 4967.552920237196, 4984.975075124601, 4995.8001679932395, 4989.307912144986, 4996.825111121166, 5024.171011783088, 5048.72232027242, 5058.266551350033, 5600.411956744483, 5657.745401456944, 5684.289463817023, 5709.0, 5748.971255143698, 6156.938430615726, 6500.447461965786, 6504.1869766279215, 6509.218893732783, 6522.152120224436, 1696.3214714114206, 1697.7691173898825, 1724.430937790526, 1743.616404391032, 1765.496833402474, 1211.19455562052, 1235.9926659772257, 1237.3936770982334, 1257.9245245285313, 1271.7965125579863, 5976.760929562855, 6056.454919057306, 6064.181335519736, 6087.69561521931, 6095.939040609537, 6389.137466442064, 6571.737130514726, 6665.100211471389, 6666.699998500079, 6677.465802735769, 6138.508919286446, 6143.96928015357, 6193.225846769154, 6194.38056194377, 6209.223847019122, 3478.913027174341, 3520.4191308434333, 3525.347810655037, 3530.5763308402643, 3562.0738607962116, 6969.0, 6989.89515157273, 6997.230304666483, 7005.0893383859775, 7017.228104908456, 6719.916825783925, 6761.222459417131, 6764.898526522106, 6794.320567943166, 6809.93190068093, 6972.163340399185, 6980.93019069813, 7014.123234595778, 7074.610896400542, 7081.752138675225, 6623.437007854386, 6696.631685257357, 6737.193485680575, 6760.93239067603, 6808.9659551701925, 6513.54405191632, 6555.672216389257, 6567.44176744982, 6625.966870165618, 6630.602163870183, 6917.515773895779, 6964.408025317702, 6972.302769722987, 6988.40598549129, 7071.338235514753, 4980.228064649985, 4990.3762029746285, 4993.925091123709, 4997.475265097112, 5009.574186194214, 6506.219253689587, 6657.866842663217, 6676.165479315086, 6693.631850248283, 6702.631355275506, 6246.064979063342, 6409.743610255724, 6424.614523128627, 6451.967740161269, 6542.705578248895, 6385.402510192654, 6399.712012959521, 6405.647689376942, 6445.903311450238, 6489.156409666713, 6347.873042539216, 6454.5159113065765, 6459.386358295955, 6483.059956306403, 6504.414602685781, 6306.65313407767, 6350.396712312323, 6416.326285740117, 6456.320626939767, 6538.738450461929, 6250.312465628686, 6270.592411493239, 6313.779017734358, 6350.206224221973, 6369.649669268235], "value": 5026.938100368735, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [912.4251721415508, 936.4989730494185, 939.1829108675454, 942.8020115775687, 943.4952300519224, 18231.635367292645, 19198.712019319704, 19261.325853595128, 19285.22859085635, 19291.13189906456, 17511.649767004652, 18226.817731822677, 20250.0, 20367.28714494993, 20493.48766280844, 1057.1595581512697, 1074.3875990685312, 1080.2438293194755, 1083.5340803454512, 1087.24979763963, 1034.9896501034968, 1069.4011353641947, 1071.6784964510655, 1074.9946250268738, 1094.2996482251365, 1138.8918052784973, 1150.1603829204685, 1151.5336288803048, 1153.2561497833892, 1154.1171004181808, 1124.6850881753123, 1130.3161587239765, 1132.2979752553429, 1139.3562637110049, 1139.4587570903836, 823.6622984576295, 836.4103307168492, 838.0488145954386, 840.8402403543307, 845.0662018469626, 19264.0, 19276.90361548183, 19345.51636209092, 19778.60442791136, 20248.696269555967, 22049.33851984443, 22132.114715411364, 22253.109875604958, 22491.0, 22546.323610291718, 16364.0, 16545.090020048894, 16726.16369181536, 16855.0, 17088.57278568033, 3689.575698794646, 3705.7035437164964, 3706.4810926470313, 3706.499622550975, 3707.2029513654425, 145418.27290863477, 146228.0, 146760.0, 147873.0, 150581.0, 17076.914615426842, 17080.316787328367, 17311.913440432716, 17323.133843307784, 17399.913000434917, 32099.839500802347, 32305.35389292248, 32566.34867302688, 32645.51031734526, 32845.17887052843, 9217.493037882981, 9376.531173441437, 9394.436333819993, 9411.717648470556, 9427.19868811145, 4150.377443383456, 4205.158968206371, 4205.17998990194, 4206.915861682749, 4232.894177645583, 5636.013697602903, 5728.484436400744, 5802.332731735904, 5830.475257226785, 5848.88302233953, 1049.1711547877244, 1078.5254488025244, 1094.7919895219882, 1097.3251450358132, 1099.0767755085767, 721.3111478537984, 727.5162017258464, 733.9669714862844, 742.8180095876437, 755.6788364944877, 12457.0034397248, 12539.811902821282, 12661.430235639418, 13326.466941322238, 13575.253361065039, 682.8804959132232, 690.6270613868455, 692.2177938928978, 702.7329614746363, 705.4462247135974, 5968.731407086691, 6007.699615019232, 6020.578559500793, 6049.122877182784, 6077.0, 138242.0, 138938.3053084728, 139540.0, 143631.0, 145965.0, 121387.39306303412, 122102.0, 122744.38627806804, 123015.0, 125315.0, 105371.4731426338, 106418.0, 106676.0, 107909.46045269724, 108148.4592577032, 11625.825612615648, 11715.589954351557, 11855.52577896909, 11892.702682433008, 11978.0, 50010.24984625161, 50973.49026509687, 51561.9999999985, 51661.0, 51992.220116699034, 63952.68023659852, 64514.35485645084, 64561.67719161562, 64740.676296618214, 67539.66230168818, 15944.681106378039, 16000.119993400474, 16147.111908844656, 16217.67564648724, 16334.591635209215, 16800.831991679926, 18155.727664084785, 18166.5458363542, 18177.81822181761, 18181.818181818013, 16168.110753908648, 16519.504414867573, 16541.338346466007, 16676.0, 16726.414575489798, 15690.76463853066, 15835.683286333979, 15886.52340429789, 15959.281832317805, 16026.919865400598, 15953.760693589373, 16147.919260403623, 16226.67546649084, 16245.187740612686, 16344.591385215464, 12647.936760316139, 12746.808797867854, 12774.680632983878, 12824.102312838386, 12921.483140674643, 12907.612771616867, 12931.935340323238, 12932.547360842325, 13021.609351719464, 13092.476300947856], "value": 9471.50105721169, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1484.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 108.0, 100.0, 107.0, 105.0, 111.0, 108.0, 100.0, 108.0, 105.0], "value": 104.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 119.0, 139.0, 171.0, 133.0, 139.0, 148.0, 116.0, 167.0, 121.0], "value": 139.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 162.0, 164.0, 163.0, 162.0, 161.0, 161.0, 164.0, 167.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 75.0, 183.0, 78.0, 76.0, 74.0, 76.0, 170.0, 75.0], "value": 95.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 132.0, 81.0, 81.0, 81.0, 134.0, 78.0, 78.0, 125.0], "value": 94.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 114.0, 113.0, 114.0, 114.0, 113.0, 114.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 148.0, 148.0, 148.0, 151.0, 150.0, 149.0, 151.0, 148.0], "value": 149.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 96.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 48.0, 46.0, 50.0, 45.0, 46.0, 47.0, 46.0, 46.0, 46.0], "value": 46.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 56.0, 56.0, 55.0, 55.0, 56.0, 56.0, 56.0, 56.0], "value": 55.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 89.0, 82.0, 74.0, 75.0, 75.0, 81.0, 73.0, 77.0, 75.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 125.0, 120.0, 118.0, 127.0, 117.0, 115.0, 122.0, 116.0, 161.0], "value": 124.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 164.0, 162.0, 160.0, 169.0, 163.0, 163.0, 161.0, 166.0, 169.0], "value": 163.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 62.0, 63.0, 60.0, 63.0, 65.0, 62.0, 59.0, 62.0, 59.0], "value": 62.3, "unit": "score"}]}]} 19:31:49 INFO - Return code: 0 19:31:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:31:49 INFO - # TBPL SUCCESS # 19:31:49 INFO - Running post-action listener: _package_coverage_data 19:31:49 INFO - Running post-action listener: _resource_record_post_action 19:31:49 INFO - [mozharness: 2017-08-11 02:31:49.788105Z] Finished run-tests step (success) 19:31:49 INFO - Running post-run listener: _resource_record_post_run 19:31:49 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 427315200; Read time: 288; Write time: 524444 19:31:49 INFO - TinderboxPrint: CPU usage
13.1% 19:31:49 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 288 19:31:49 INFO - TinderboxPrint: I/O write bytes / time
427,315,200 / 524,444 19:31:49 INFO - TinderboxPrint: CPU idle
8,251.9 (86.9%) 19:31:49 INFO - TinderboxPrint: CPU user
1,190.6 (12.5%) 19:31:49 INFO - TinderboxPrint: Swap in / out
0 / 0 19:31:49 INFO - install - Wall time: 19s; CPU: 14.0%; Read bytes: 0; Write bytes: 107286528; Read time: 0; Write time: 184304 19:31:49 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 19:31:49 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 320028672; Read time: 288; Write time: 340140 19:31:50 INFO - Running post-run listener: _upload_blobber_files 19:31:50 INFO - Blob upload gear active. 19:31:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:31:50 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 19:31:50 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'] 19:31:50 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 19:31:50 INFO - (blobuploader) - INFO - Open directory for files ... 19:31:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:31:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:31:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:31:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:31:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:31:58 INFO - (blobuploader) - INFO - Done attempting. 19:31:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:31:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:31:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:31:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:31:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:31:58 INFO - (blobuploader) - INFO - Done attempting. 19:31:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:31:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:31:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:31:59 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:31:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:31:59 INFO - (blobuploader) - INFO - Done attempting. 19:31:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:31:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:31:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:32:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:32:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:32:00 INFO - (blobuploader) - INFO - Done attempting. 19:32:00 INFO - (blobuploader) - INFO - Iteration through files over. 19:32:00 INFO - Return code: 0 19:32:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:32:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:32:00 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f89e910b61566c4b01abc48c30f8ee752a5aac04d429d2a87a8edb5f20ef95d534b113902ef5b718c08f99151ec9e612712e83d57a158bb1bd2d0aacc35fb569", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1be574816c07702416f47dcaac189ef2c4ec8a3f1362bd3cecd364cb3ce5c539708f3e1c1261d9df4eaf1b54526232a51c1c770c03627e425db9928ec89c3795", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/102a23d21dc5c94ad37fe92cde8986bd6f84d8023d2c9099a9ff323bcffec4011e9c5aae1ecacf6fbdb3cfefd47806bcfcb6c3f7e86f1adc6323c95cc5baacf3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/94e0a1ba76d50e1a9f8fc9d081b07f6a377f923bb864e34b75e979c844603ba061df9b8fd58967a2bcce8ad32654f4ae04da3e99b785ee2ef2a40ddcbf4eb5b4"} 19:32:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:32:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:32:00 INFO - Contents: 19:32:00 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f89e910b61566c4b01abc48c30f8ee752a5aac04d429d2a87a8edb5f20ef95d534b113902ef5b718c08f99151ec9e612712e83d57a158bb1bd2d0aacc35fb569", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1be574816c07702416f47dcaac189ef2c4ec8a3f1362bd3cecd364cb3ce5c539708f3e1c1261d9df4eaf1b54526232a51c1c770c03627e425db9928ec89c3795", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/102a23d21dc5c94ad37fe92cde8986bd6f84d8023d2c9099a9ff323bcffec4011e9c5aae1ecacf6fbdb3cfefd47806bcfcb6c3f7e86f1adc6323c95cc5baacf3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/94e0a1ba76d50e1a9f8fc9d081b07f6a377f923bb864e34b75e979c844603ba061df9b8fd58967a2bcce8ad32654f4ae04da3e99b785ee2ef2a40ddcbf4eb5b4"} 19:32:00 INFO - Running post-run listener: copy_logs_to_upload_dir 19:32:00 INFO - Copying logs to upload dir... 19:32:00 INFO - mkdir: /builds/slave/test/build/upload/logs 19:32:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.920826 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-08-10 19:32:00.338537) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-10 19:32:00.346429) ========= 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=eca2ab57546de7b41f256b19000001ef-1502417289.658245-582301924 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/f89e910b61566c4b01abc48c30f8ee752a5aac04d429d2a87a8edb5f20ef95d534b113902ef5b718c08f99151ec9e612712e83d57a158bb1bd2d0aacc35fb569", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1be574816c07702416f47dcaac189ef2c4ec8a3f1362bd3cecd364cb3ce5c539708f3e1c1261d9df4eaf1b54526232a51c1c770c03627e425db9928ec89c3795", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/102a23d21dc5c94ad37fe92cde8986bd6f84d8023d2c9099a9ff323bcffec4011e9c5aae1ecacf6fbdb3cfefd47806bcfcb6c3f7e86f1adc6323c95cc5baacf3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/94e0a1ba76d50e1a9f8fc9d081b07f6a377f923bb864e34b75e979c844603ba061df9b8fd58967a2bcce8ad32654f4ae04da3e99b785ee2ef2a40ddcbf4eb5b4"} build_url:https://queue.taskcluster.net/v1/task/MdTQ30e8RrmpX7d1b_CT_g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011074 build_url: 'https://queue.taskcluster.net/v1/task/MdTQ30e8RrmpX7d1b_CT_g/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f89e910b61566c4b01abc48c30f8ee752a5aac04d429d2a87a8edb5f20ef95d534b113902ef5b718c08f99151ec9e612712e83d57a158bb1bd2d0aacc35fb569", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1be574816c07702416f47dcaac189ef2c4ec8a3f1362bd3cecd364cb3ce5c539708f3e1c1261d9df4eaf1b54526232a51c1c770c03627e425db9928ec89c3795", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/102a23d21dc5c94ad37fe92cde8986bd6f84d8023d2c9099a9ff323bcffec4011e9c5aae1ecacf6fbdb3cfefd47806bcfcb6c3f7e86f1adc6323c95cc5baacf3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/94e0a1ba76d50e1a9f8fc9d081b07f6a377f923bb864e34b75e979c844603ba061df9b8fd58967a2bcce8ad32654f4ae04da3e99b785ee2ef2a40ddcbf4eb5b4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-10 19:32:00.374139) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-10 19:32:00.374493) ========= 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=eca2ab57546de7b41f256b19000001ef-1502417289.658245-582301924 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004457 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-10 19:32:00.456963) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-10 19:32:00.457291) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-10 19:32:00.457601) ========= ========= Total master_lag: 0.22 =========