builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-005 starttime: 1501878140.87 results: success (0) revision: 4cfb674227051e22bab651e5759f3de503a50560 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-04 13:22:20.872373) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-04 13:22:20.872796) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-04 13:22:20.873078) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-04 13:22:20.919335) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 13:22:20.919609) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1501874190.24912-1481130047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-04 13:22:21-- 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% 58.5K=0.2s 2017-08-04 13:22:21 (58.5 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.285821 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 13:22:21.219122) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 13:22:21.219464) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1501874190.24912-1481130047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023280 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 13:22:21.269463) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 13:22:21.269855) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4cfb674227051e22bab651e5759f3de503a50560 --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 4cfb674227051e22bab651e5759f3de503a50560 --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=7fc86f70bae03e018da0b1d8000001c4-1501874190.24912-1481130047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-04 13:22:21,466 truncating revision to first 12 chars 2017-08-04 13:22:21,466 Setting DEBUG logging. 2017-08-04 13:22:21,466 attempt 1/10 2017-08-04 13:22:21,466 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4cfb67422705?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-04 13:22:21,762 unpacking tar archive at: mozilla-central-4cfb67422705/testing/mozharness/ program finished with exit code 0 elapsedTime=0.615999 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 13:22:21.898421) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-04 13:22:21.898732) ========= script_repo_revision: 4cfb674227051e22bab651e5759f3de503a50560 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-04 13:22:21.899110) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-04 13:22:21.899420) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-04 13:22:21.907302) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-08-04 13:22:21.907594) ========= /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=7fc86f70bae03e018da0b1d8000001c4-1501874190.24912-1481130047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:22:22 INFO - MultiFileLogger online at 20170804 13:22:22 in /builds/slave/test 13:22:22 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 13:22:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:22:22 INFO - {'append_to_log': False, 13:22:22 INFO - 'base_work_dir': '/builds/slave/test', 13:22:22 INFO - 'blob_upload_branch': 'Firefox', 13:22:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:22:22 INFO - 'branch': 'Firefox', 13:22:22 INFO - 'buildbot_json_path': 'buildprops.json', 13:22:22 INFO - 'code_coverage': False, 13:22:22 INFO - 'config_files': ('talos/linux_config.py',), 13:22:22 INFO - 'default_actions': ('clobber', 13:22:22 INFO - 'read-buildbot-config', 13:22:22 INFO - 'download-and-extract', 13:22:22 INFO - 'populate-webroot', 13:22:22 INFO - 'create-virtualenv', 13:22:22 INFO - 'install', 13:22:22 INFO - 'setup-mitmproxy', 13:22:22 INFO - 'run-tests'), 13:22:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:22:22 INFO - 'disable_ccov_upload': False, 13:22:22 INFO - 'download_minidump_stackwalk': True, 13:22:22 INFO - 'download_symbols': 'ondemand', 13:22:22 INFO - 'enable_stylo': False, 13:22:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:22:22 INFO - 'tooltool.py': '/tools/tooltool.py', 13:22:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:22:22 INFO - '/tools/misc-python/virtualenv.py')}, 13:22:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:22:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:22:22 INFO - 'gecko_profile': False, 13:22:22 INFO - 'gecko_profile_interval': 0, 13:22:22 INFO - 'installer_path': 'installer.exe', 13:22:22 INFO - 'log_level': 'info', 13:22:22 INFO - 'log_name': 'talos', 13:22:22 INFO - 'log_to_console': True, 13:22:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:22:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:22:22 INFO - 'opt_config_files': (), 13:22:22 INFO - 'pip_index': False, 13:22:22 INFO - 'suite': 'dromaeojs-e10s', 13:22:22 INFO - 'system_bits': '32', 13:22:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:22:22 INFO - 'title': 'talos-linux64-ix-005', 13:22:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:22:22 INFO - 'use_talos_json': True, 13:22:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:22:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:22:22 INFO - 'work_dir': 'build'} 13:22:22 INFO - [mozharness: 2017-08-04 20:22:22.207697Z] Running clobber step. 13:22:22 INFO - Running pre-action listener: _resource_record_pre_action 13:22:22 INFO - Running main action method: clobber 13:22:22 INFO - rmtree: /builds/slave/test/build 13:22:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:22:23 INFO - Running post-action listener: _resource_record_post_action 13:22:23 INFO - [mozharness: 2017-08-04 20:22:23.254894Z] Finished clobber step (success) 13:22:23 INFO - [mozharness: 2017-08-04 20:22:23.254997Z] Running read-buildbot-config step. 13:22:23 INFO - Running pre-action listener: _resource_record_pre_action 13:22:23 INFO - Running main action method: read_buildbot_config 13:22:23 INFO - Using buildbot properties: 13:22:23 INFO - { 13:22:23 INFO - "project": "", 13:22:23 INFO - "product": "firefox", 13:22:23 INFO - "who": "ryanvm@gmail.com", 13:22:23 INFO - "installer_path": "public/build/target.tar.bz2", 13:22:23 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 13:22:23 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 13:22:23 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 13:22:23 INFO - "stage_platform": "linux64-stylo", 13:22:23 INFO - "basedir": "/builds/slave/test", 13:22:23 INFO - "buildnumber": 257, 13:22:23 INFO - "platform": "ubuntu64_hw_stylo", 13:22:23 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:22:23 INFO - "slavebuilddir": "test", 13:22:23 INFO - "taskId": "bxQJ1qrCR2GCoMoK6lbZSg", 13:22:23 INFO - "branch": "mozilla-central", 13:22:23 INFO - "script_repo_revision": "production", 13:22:23 INFO - "revision": "4cfb674227051e22bab651e5759f3de503a50560", 13:22:23 INFO - "slavename": "talos-linux64-ix-005", 13:22:23 INFO - "repo_path": "mozilla-central" 13:22:23 INFO - } 13:22:23 INFO - Finding installer, test and symbols from parent task. 13:22:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bxQJ1qrCR2GCoMoK6lbZSg'}, attempt #1 13:22:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bxQJ1qrCR2GCoMoK6lbZSg'}, attempt #1 13:22:24 INFO - Task dependencies: fr-KaQa9SOOeGyxNTNR3Ww 13:22:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww'}, attempt #1 13:22:27 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.tar.bz2 13:22:27 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.test_packages.json 13:22:27 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.crashreporter-symbols.zip 13:22:27 INFO - Running post-action listener: _resource_record_post_action 13:22:27 INFO - [mozharness: 2017-08-04 20:22:27.625864Z] Finished read-buildbot-config step (success) 13:22:27 INFO - [mozharness: 2017-08-04 20:22:27.626089Z] Running download-and-extract step. 13:22:27 INFO - Running pre-action listener: _resource_record_pre_action 13:22:27 INFO - Running main action method: download_and_extract 13:22:27 INFO - mkdir: /builds/slave/test/build/tests 13:22:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:22:27 INFO - trying https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.test_packages.json 13:22:27 INFO - Downloading https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 13:22:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 13:22:28 INFO - Downloaded 989 bytes. 13:22:28 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 13:22:28 INFO - Using the following test package requirements: 13:22:28 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 13:22:28 INFO - u'common': [u'target.common.tests.zip'], 13:22:28 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 13:22:28 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 13:22:28 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 13:22:28 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 13:22:28 INFO - u'mozbase': [u'target.common.tests.zip'], 13:22:28 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 13:22:28 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 13:22:28 INFO - u'web-platform': [u'target.common.tests.zip', 13:22:28 INFO - u'target.web-platform.tests.tar.gz'], 13:22:28 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 13:22:28 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 13:22:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.common.tests.zip 13:22:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:22:28 INFO - Fetch https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.common.tests.zip into memory 13:22:29 INFO - Content-Length response header: 54282413 13:22:29 INFO - Bytes received: 54282413 13:22:40 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 13:22:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.common.tests.zip 13:22:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:22:40 INFO - Fetch https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.common.tests.zip into memory 13:22:41 INFO - Content-Length response header: 54282413 13:22:41 INFO - Bytes received: 54282413 13:22:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.talos.tests.zip 13:22:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.talos.tests.zip'}, attempt #1 13:22:53 INFO - Fetch https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.talos.tests.zip into memory 13:22:54 INFO - Content-Length response header: 14496008 13:22:54 INFO - Bytes received: 14496008 13:22:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:22:54 INFO - trying https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.tar.bz2 13:22:54 INFO - Downloading https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 13:22:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 13:22:56 INFO - Downloaded 61895863 bytes. 13:22:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.tar.bz2 13:22:56 INFO - mkdir: /builds/slave/test/properties 13:22:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:22:56 INFO - Writing to file /builds/slave/test/properties/build_url 13:22:56 INFO - Contents: 13:22:56 INFO - build_url:https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.tar.bz2 13:22:56 INFO - Running post-action listener: _resource_record_post_action 13:22:56 INFO - Running post-action listener: set_extra_try_arguments 13:22:56 INFO - [mozharness: 2017-08-04 20:22:56.319547Z] Finished download-and-extract step (success) 13:22:56 INFO - [mozharness: 2017-08-04 20:22:56.319646Z] Running populate-webroot step. 13:22:56 INFO - Running pre-action listener: _resource_record_pre_action 13:22:56 INFO - Running main action method: populate_webroot 13:22:56 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:22:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:22:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:22:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:22:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:22:56 INFO - 'tests': ['damp', 'tps']}, 13:22:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:22:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 13:22:56 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 13:22:56 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 13:22:56 INFO - 'other-e10s': {'tests': ['a11yr', 13:22:56 INFO - 'ts_paint', 13:22:56 INFO - 'tpaint', 13:22:56 INFO - 'sessionrestore', 13:22:56 INFO - 'sessionrestore_many_windows', 13:22:56 INFO - 'sessionrestore_no_auto_restore', 13:22:56 INFO - 'tabpaint']}, 13:22:56 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 13:22:56 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 13:22:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:22:56 INFO - 'tsvgr_opacity', 13:22:56 INFO - 'tart', 13:22:56 INFO - 'tscrollx', 13:22:56 INFO - 'tsvg_static']}, 13:22:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:22:56 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:22:56 INFO - 'talos_options': ['--mitmproxy', 13:22:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:22:56 INFO - '--firstNonBlankPaint'], 13:22:56 INFO - 'tests': ['tp6_google', 13:22:56 INFO - 'tp6_youtube', 13:22:56 INFO - 'tp6_amazon', 13:22:56 INFO - 'tp6_facebook']}, 13:22:56 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:22:56 INFO - 'talos_options': ['--stylo', 13:22:56 INFO - '--mitmproxy', 13:22:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:22:56 INFO - '--firstNonBlankPaint'], 13:22:56 INFO - 'tests': ['tp6_google', 13:22:56 INFO - 'tp6_youtube', 13:22:56 INFO - 'tp6_amazon', 13:22:56 INFO - 'tp6_facebook']}, 13:22:56 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:22:56 INFO - 'talos_options': ['--stylo', 13:22:56 INFO - '--stylo-threads=1', 13:22:56 INFO - '--mitmproxy', 13:22:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:22:56 INFO - '--firstNonBlankPaint'], 13:22:56 INFO - 'tests': ['tp6_google', 13:22:56 INFO - 'tp6_youtube', 13:22:56 INFO - 'tp6_amazon', 13:22:56 INFO - 'tp6_facebook']}, 13:22:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:22:56 INFO - 'talos_options': ['--xperf_path', 13:22:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:22:56 INFO - 'tests': ['tp5n']}}} 13:22:56 INFO - Running post-action listener: _resource_record_post_action 13:22:56 INFO - [mozharness: 2017-08-04 20:22:56.328081Z] Finished populate-webroot step (success) 13:22:56 INFO - [mozharness: 2017-08-04 20:22:56.328171Z] Running create-virtualenv step. 13:22:56 INFO - Running pre-action listener: _resource_record_pre_action 13:22:56 INFO - Running main action method: create_virtualenv 13:22:56 INFO - Creating virtualenv /builds/slave/test/build/venv 13:22:56 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 13:22:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:22:56 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 13:22:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:22:56 INFO - Using real prefix '/usr' 13:22:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:22:56 INFO - Installing distribute.............................................................................................................................................................................................done. 13:22:58 INFO - Installing pip.................done. 13:22:58 INFO - Return code: 0 13:22:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:22:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:22:59 INFO - Reading from file tmpfile_stdout 13:22:59 INFO - Output received: 13:22:59 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) 13:22:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:22:59 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')]} 13:22:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:22:59 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')]} 13:22:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:22:59 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 0x1f561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2122a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c2eb0>, '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 0x22c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c4240>, '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': '7fc86f70bae03e018da0b1d8000001c4-1501874190.24912-1481130047', '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 13:22:59 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 13:22:59 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 13:22:59 INFO - Using env: {'DISPLAY': ':0', 13:22:59 INFO - 'HOME': '/home/cltbld', 13:22:59 INFO - 'LANG': 'en_US.UTF-8', 13:22:59 INFO - 'LANGUAGE': 'en_US:en', 13:22:59 INFO - 'LOGNAME': 'cltbld', 13:22:59 INFO - 'MAIL': '/var/mail/cltbld', 13:22:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:22:59 INFO - 'MOZ_NO_REMOTE': '1', 13:22:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:22:59 INFO - 'NO_EM_RESTART': '1', 13:22:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:22:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:22:59 INFO - 'PWD': '/builds/slave/test', 13:22:59 INFO - 'SHELL': '/bin/bash', 13:22:59 INFO - 'SHLVL': '1', 13:22:59 INFO - 'TERM': 'linux', 13:22:59 INFO - 'TMOUT': '86400', 13:22:59 INFO - 'USER': 'cltbld', 13:22:59 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1501874190.24912-1481130047', 13:22:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:22:59 INFO - '_': '/tools/buildbot/bin/python'} 13:22:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:22:59 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 13:22:59 INFO - Cleaning up... 13:22:59 INFO - Return code: 0 13:22:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:22:59 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')]} 13:22:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:22:59 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')]} 13:22:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:22:59 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 0x1f561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2122a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c2eb0>, '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 0x22c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c4240>, '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': '7fc86f70bae03e018da0b1d8000001c4-1501874190.24912-1481130047', '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 13:22:59 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 13:22:59 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 13:22:59 INFO - Using env: {'DISPLAY': ':0', 13:22:59 INFO - 'HOME': '/home/cltbld', 13:22:59 INFO - 'LANG': 'en_US.UTF-8', 13:22:59 INFO - 'LANGUAGE': 'en_US:en', 13:22:59 INFO - 'LOGNAME': 'cltbld', 13:22:59 INFO - 'MAIL': '/var/mail/cltbld', 13:22:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:22:59 INFO - 'MOZ_NO_REMOTE': '1', 13:22:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:22:59 INFO - 'NO_EM_RESTART': '1', 13:22:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:22:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:22:59 INFO - 'PWD': '/builds/slave/test', 13:22:59 INFO - 'SHELL': '/bin/bash', 13:22:59 INFO - 'SHLVL': '1', 13:22:59 INFO - 'TERM': 'linux', 13:22:59 INFO - 'TMOUT': '86400', 13:22:59 INFO - 'USER': 'cltbld', 13:22:59 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1501874190.24912-1481130047', 13:22:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:22:59 INFO - '_': '/tools/buildbot/bin/python'} 13:22:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:22:59 INFO - Downloading/unpacking psutil>=3.1.1 13:22:59 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 13:22:59 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 13:22:59 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 13:22:59 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 13:23:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:23:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:23:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:23:00 INFO - Installing collected packages: psutil 13:23:00 INFO - Running setup.py install for psutil 13:23:00 INFO - building 'psutil._psutil_linux' extension 13:23:00 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 13:23:01 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 13:23:01 INFO - building 'psutil._psutil_posix' extension 13:23:01 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 13:23:01 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 13:23:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:23:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:23:01 INFO - Successfully installed psutil 13:23:01 INFO - Cleaning up... 13:23:01 INFO - Return code: 0 13:23:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:23:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:01 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 0x1f561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2122a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c2eb0>, '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 0x22c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c4240>, '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': '7fc86f70bae03e018da0b1d8000001c4-1501874190.24912-1481130047', '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 13:23:01 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 13:23:01 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 13:23:01 INFO - Using env: {'DISPLAY': ':0', 13:23:01 INFO - 'HOME': '/home/cltbld', 13:23:01 INFO - 'LANG': 'en_US.UTF-8', 13:23:01 INFO - 'LANGUAGE': 'en_US:en', 13:23:01 INFO - 'LOGNAME': 'cltbld', 13:23:01 INFO - 'MAIL': '/var/mail/cltbld', 13:23:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:01 INFO - 'MOZ_NO_REMOTE': '1', 13:23:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:01 INFO - 'NO_EM_RESTART': '1', 13:23:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:01 INFO - 'PWD': '/builds/slave/test', 13:23:01 INFO - 'SHELL': '/bin/bash', 13:23:01 INFO - 'SHLVL': '1', 13:23:01 INFO - 'TERM': 'linux', 13:23:01 INFO - 'TMOUT': '86400', 13:23:01 INFO - 'USER': 'cltbld', 13:23:01 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1501874190.24912-1481130047', 13:23:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:01 INFO - '_': '/tools/buildbot/bin/python'} 13:23:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:23:01 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 13:23:01 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 13:23:01 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 13:23:01 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 13:23:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:23:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:23:02 INFO - Installing collected packages: mozsystemmonitor 13:23:02 INFO - Running setup.py install for mozsystemmonitor 13:23:02 INFO - Successfully installed mozsystemmonitor 13:23:02 INFO - Cleaning up... 13:23:02 INFO - Return code: 0 13:23:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:23:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:02 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 0x1f561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2122a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c2eb0>, '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 0x22c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c4240>, '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': '7fc86f70bae03e018da0b1d8000001c4-1501874190.24912-1481130047', '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 13:23:02 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 13:23:02 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 13:23:02 INFO - Using env: {'DISPLAY': ':0', 13:23:02 INFO - 'HOME': '/home/cltbld', 13:23:02 INFO - 'LANG': 'en_US.UTF-8', 13:23:02 INFO - 'LANGUAGE': 'en_US:en', 13:23:02 INFO - 'LOGNAME': 'cltbld', 13:23:02 INFO - 'MAIL': '/var/mail/cltbld', 13:23:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:02 INFO - 'MOZ_NO_REMOTE': '1', 13:23:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:02 INFO - 'NO_EM_RESTART': '1', 13:23:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:02 INFO - 'PWD': '/builds/slave/test', 13:23:02 INFO - 'SHELL': '/bin/bash', 13:23:02 INFO - 'SHLVL': '1', 13:23:02 INFO - 'TERM': 'linux', 13:23:02 INFO - 'TMOUT': '86400', 13:23:02 INFO - 'USER': 'cltbld', 13:23:02 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1501874190.24912-1481130047', 13:23:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:02 INFO - '_': '/tools/buildbot/bin/python'} 13:23:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:03 INFO - Downloading/unpacking jsonschema==2.5.1 13:23:03 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 13:23:03 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 13:23:03 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 13:23:03 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 13:23:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:23:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:23:04 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 13:23:04 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 13:23:04 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 13:23:04 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 13:23:04 INFO - Downloading functools32-3.2.3-2.tar.gz 13:23:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:23:04 INFO - warning: no files found matching '*.txt' 13:23:04 INFO - no previously-included directories found matching 'build' 13:23:04 INFO - no previously-included directories found matching 'dist' 13:23:04 INFO - no previously-included directories found matching '.git*' 13:23:04 INFO - Installing collected packages: jsonschema, functools32 13:23:04 INFO - Running setup.py install for functools32 13:23:04 INFO - warning: no files found matching '*.txt' 13:23:04 INFO - no previously-included directories found matching 'build' 13:23:04 INFO - no previously-included directories found matching 'dist' 13:23:04 INFO - no previously-included directories found matching '.git*' 13:23:04 INFO - Successfully installed jsonschema functools32 13:23:04 INFO - Cleaning up... 13:23:04 INFO - Return code: 0 13:23:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:23:04 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')]} 13:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:04 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')]} 13:23:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:04 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 0x1f561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2122a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c2eb0>, '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 0x22c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c4240>, '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': '7fc86f70bae03e018da0b1d8000001c4-1501874190.24912-1481130047', '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 13:23:04 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 13:23:04 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 13:23:04 INFO - Using env: {'DISPLAY': ':0', 13:23:04 INFO - 'HOME': '/home/cltbld', 13:23:04 INFO - 'LANG': 'en_US.UTF-8', 13:23:04 INFO - 'LANGUAGE': 'en_US:en', 13:23:04 INFO - 'LOGNAME': 'cltbld', 13:23:04 INFO - 'MAIL': '/var/mail/cltbld', 13:23:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:04 INFO - 'MOZ_NO_REMOTE': '1', 13:23:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:04 INFO - 'NO_EM_RESTART': '1', 13:23:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:04 INFO - 'PWD': '/builds/slave/test', 13:23:04 INFO - 'SHELL': '/bin/bash', 13:23:04 INFO - 'SHLVL': '1', 13:23:04 INFO - 'TERM': 'linux', 13:23:04 INFO - 'TMOUT': '86400', 13:23:04 INFO - 'USER': 'cltbld', 13:23:04 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1501874190.24912-1481130047', 13:23:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:04 INFO - '_': '/tools/buildbot/bin/python'} 13:23:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:23:04 INFO - Cleaning up... 13:23:04 INFO - Return code: 0 13:23:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:23:04 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')]} 13:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:04 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')]} 13:23:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:04 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 0x1f561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2122a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c2eb0>, '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 0x22c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c4240>, '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': '7fc86f70bae03e018da0b1d8000001c4-1501874190.24912-1481130047', '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 13:23:04 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 13:23:04 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 13:23:04 INFO - Using env: {'DISPLAY': ':0', 13:23:04 INFO - 'HOME': '/home/cltbld', 13:23:04 INFO - 'LANG': 'en_US.UTF-8', 13:23:04 INFO - 'LANGUAGE': 'en_US:en', 13:23:04 INFO - 'LOGNAME': 'cltbld', 13:23:04 INFO - 'MAIL': '/var/mail/cltbld', 13:23:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:04 INFO - 'MOZ_NO_REMOTE': '1', 13:23:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:04 INFO - 'NO_EM_RESTART': '1', 13:23:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:04 INFO - 'PWD': '/builds/slave/test', 13:23:04 INFO - 'SHELL': '/bin/bash', 13:23:04 INFO - 'SHLVL': '1', 13:23:04 INFO - 'TERM': 'linux', 13:23:04 INFO - 'TMOUT': '86400', 13:23:04 INFO - 'USER': 'cltbld', 13:23:04 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1501874190.24912-1481130047', 13:23:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:04 INFO - '_': '/tools/buildbot/bin/python'} 13:23:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:04 INFO - Downloading/unpacking blobuploader==1.2.4 13:23:04 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 13:23:04 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 13:23:04 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 13:23:04 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 13:23:05 INFO - Downloading blobuploader-1.2.4.tar.gz 13:23:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:23:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:23:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:06 INFO - Downloading docopt-0.6.1.tar.gz 13:23:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:23:06 INFO - Installing collected packages: blobuploader, requests, docopt 13:23:06 INFO - Running setup.py install for blobuploader 13:23:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:23:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:23:06 INFO - Running setup.py install for requests 13:23:07 INFO - Running setup.py install for docopt 13:23:07 INFO - Successfully installed blobuploader requests docopt 13:23:07 INFO - Cleaning up... 13:23:07 INFO - Return code: 0 13:23:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:23:07 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')]} 13:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:07 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')]} 13:23:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:07 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 0x1f561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2122a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c2eb0>, '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 0x22c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c4240>, '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': '7fc86f70bae03e018da0b1d8000001c4-1501874190.24912-1481130047', '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 13:23:07 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 13:23:07 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 13:23:07 INFO - Using env: {'DISPLAY': ':0', 13:23:07 INFO - 'HOME': '/home/cltbld', 13:23:07 INFO - 'LANG': 'en_US.UTF-8', 13:23:07 INFO - 'LANGUAGE': 'en_US:en', 13:23:07 INFO - 'LOGNAME': 'cltbld', 13:23:07 INFO - 'MAIL': '/var/mail/cltbld', 13:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:07 INFO - 'MOZ_NO_REMOTE': '1', 13:23:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:07 INFO - 'NO_EM_RESTART': '1', 13:23:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:07 INFO - 'PWD': '/builds/slave/test', 13:23:07 INFO - 'SHELL': '/bin/bash', 13:23:07 INFO - 'SHLVL': '1', 13:23:07 INFO - 'TERM': 'linux', 13:23:07 INFO - 'TMOUT': '86400', 13:23:07 INFO - 'USER': 'cltbld', 13:23:07 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1501874190.24912-1481130047', 13:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:07 INFO - '_': '/tools/buildbot/bin/python'} 13:23:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:23:07 INFO - Running setup.py (path:/tmp/pip-NGZAT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:23:07 INFO - Running setup.py (path:/tmp/pip-miQheG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:23:07 INFO - Running setup.py (path:/tmp/pip-nSsd1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:23:07 INFO - Running setup.py (path:/tmp/pip-Yhqcf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:23:07 INFO - Running setup.py (path:/tmp/pip-_Agyik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:23:07 INFO - Running setup.py (path:/tmp/pip-tcj3km-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:23:07 INFO - Running setup.py (path:/tmp/pip-07joOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:23:07 INFO - Running setup.py (path:/tmp/pip-tfNXIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:23:07 INFO - Running setup.py (path:/tmp/pip-EcebQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:23:08 INFO - Running setup.py (path:/tmp/pip-Y1k_kP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:23:08 INFO - Running setup.py (path:/tmp/pip-hPa2Vh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:23:08 INFO - Running setup.py (path:/tmp/pip-Eh_AF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:23:08 INFO - Running setup.py (path:/tmp/pip-zTkF8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:23:08 INFO - Running setup.py (path:/tmp/pip-T_LuE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:23:08 INFO - Running setup.py (path:/tmp/pip-k8r3GA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:23:08 INFO - Running setup.py (path:/tmp/pip-enddXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:23:08 INFO - Running setup.py (path:/tmp/pip-wRjRNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:23:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:23:08 INFO - Running setup.py install for manifestparser 13:23:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:23:08 INFO - Running setup.py install for mozcrash 13:23:08 INFO - Running setup.py install for mozdebug 13:23:08 INFO - Running setup.py install for mozdevice 13:23:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:23:08 INFO - Running setup.py install for mozfile 13:23:09 INFO - Running setup.py install for mozhttpd 13:23:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:23:09 INFO - Running setup.py install for mozinfo 13:23:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:23:09 INFO - Running setup.py install for mozInstall 13:23:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:23:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:23:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:23:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:23:09 INFO - Running setup.py install for mozleak 13:23:09 INFO - Running setup.py install for mozlog 13:23:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:23:09 INFO - Running setup.py install for moznetwork 13:23:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:23:09 INFO - Running setup.py install for mozprocess 13:23:09 INFO - Running setup.py install for mozprofile 13:23:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:23:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:23:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:23:09 INFO - Running setup.py install for mozrunner 13:23:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:23:10 INFO - Running setup.py install for mozscreenshot 13:23:10 INFO - Running setup.py install for moztest 13:23:10 INFO - Running setup.py install for mozversion 13:23:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:23:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:23:10 INFO - Cleaning up... 13:23:10 INFO - Return code: 0 13:23:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:23: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')]} 13:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23: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')]} 13:23:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:10 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 0x1f561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2122a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c2eb0>, '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 0x22c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c4240>, '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': '7fc86f70bae03e018da0b1d8000001c4-1501874190.24912-1481130047', '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 13:23:10 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 13:23:10 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 13:23:10 INFO - Using env: {'DISPLAY': ':0', 13:23:10 INFO - 'HOME': '/home/cltbld', 13:23:10 INFO - 'LANG': 'en_US.UTF-8', 13:23:10 INFO - 'LANGUAGE': 'en_US:en', 13:23:10 INFO - 'LOGNAME': 'cltbld', 13:23:10 INFO - 'MAIL': '/var/mail/cltbld', 13:23:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:10 INFO - 'MOZ_NO_REMOTE': '1', 13:23:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:10 INFO - 'NO_EM_RESTART': '1', 13:23:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:10 INFO - 'PWD': '/builds/slave/test', 13:23:10 INFO - 'SHELL': '/bin/bash', 13:23:10 INFO - 'SHLVL': '1', 13:23:10 INFO - 'TERM': 'linux', 13:23:10 INFO - 'TMOUT': '86400', 13:23:10 INFO - 'USER': 'cltbld', 13:23:10 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1501874190.24912-1481130047', 13:23:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:10 INFO - '_': '/tools/buildbot/bin/python'} 13:23:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:23:10 INFO - Running setup.py (path:/tmp/pip-koT8bY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:23:10 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)) 13:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:23:10 INFO - Running setup.py (path:/tmp/pip-99ax3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:23:10 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)) 13:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:23:10 INFO - Running setup.py (path:/tmp/pip-Eu0E10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:23:10 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)) 13:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:23:10 INFO - Running setup.py (path:/tmp/pip-W_uQ3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:23:10 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)) 13:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:23:10 INFO - Running setup.py (path:/tmp/pip-x9oE1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:23:10 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)) 13:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:23:10 INFO - Running setup.py (path:/tmp/pip-OWdujt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:23:11 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)) 13:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:23:11 INFO - Running setup.py (path:/tmp/pip-OA5Gg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:23:11 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)) 13:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:23:11 INFO - Running setup.py (path:/tmp/pip-ihSY6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:23:11 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)) 13:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:23:11 INFO - Running setup.py (path:/tmp/pip-xYuUYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:23:11 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)) 13:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:23:11 INFO - Running setup.py (path:/tmp/pip-36f2p7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:23:11 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)) 13:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:23:11 INFO - Running setup.py (path:/tmp/pip-JFAWtT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:23:11 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)) 13:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:23:11 INFO - Running setup.py (path:/tmp/pip-bRAfPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:23:11 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)) 13:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:23:11 INFO - Running setup.py (path:/tmp/pip-zRzrVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:23:11 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)) 13:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:23:11 INFO - Running setup.py (path:/tmp/pip-1sTM2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:23:11 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)) 13:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:23:11 INFO - Running setup.py (path:/tmp/pip-9ed9ic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:23:11 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)) 13:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:23:11 INFO - Running setup.py (path:/tmp/pip-sh4iFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:23:11 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)) 13:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:23:11 INFO - Running setup.py (path:/tmp/pip-3nZcdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:23:11 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)) 13:23:11 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)) 13:23:11 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)) 13:23:11 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)) 13:23:11 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)) 13:23:11 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)) 13:23:11 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)) 13:23:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:12 INFO - Downloading blessings-1.6.tar.gz 13:23:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:23:12 INFO - Installing collected packages: blessings 13:23:12 INFO - Running setup.py install for blessings 13:23:13 INFO - Successfully installed blessings 13:23:13 INFO - Cleaning up... 13:23:13 INFO - Return code: 0 13:23:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:23:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:23:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:23:13 INFO - Reading from file tmpfile_stdout 13:23:13 INFO - Current package versions: 13:23:13 INFO - argparse == 1.2.1 13:23:13 INFO - blessings == 1.6 13:23:13 INFO - blobuploader == 1.2.4 13:23:13 INFO - docopt == 0.6.1 13:23:13 INFO - functools32 == 3.2.3-2 13:23:13 INFO - jsonschema == 2.5.1 13:23:13 INFO - manifestparser == 1.1 13:23:13 INFO - mozInstall == 1.13 13:23:13 INFO - mozcrash == 1.0 13:23:13 INFO - mozdebug == 0.1 13:23:13 INFO - mozdevice == 0.51 13:23:13 INFO - mozfile == 1.2 13:23:13 INFO - mozhttpd == 0.7 13:23:13 INFO - mozinfo == 0.10 13:23:13 INFO - mozleak == 0.1 13:23:13 INFO - mozlog == 3.5 13:23:13 INFO - moznetwork == 0.27 13:23:13 INFO - mozprocess == 0.25 13:23:13 INFO - mozprofile == 0.28 13:23:13 INFO - mozrunner == 6.13 13:23:13 INFO - mozscreenshot == 0.1 13:23:13 INFO - mozsystemmonitor == 0.3 13:23:13 INFO - moztest == 0.8 13:23:13 INFO - mozversion == 1.4 13:23:13 INFO - psutil == 3.1.1 13:23:13 INFO - requests == 1.2.3 13:23:13 INFO - wsgiref == 0.1.2 13:23:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:13 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 0x1f561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2122a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c2eb0>, '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 0x22c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c4240>, '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': '7fc86f70bae03e018da0b1d8000001c4-1501874190.24912-1481130047', '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 13:23:13 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 13:23:13 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 13:23:13 INFO - Using env: {'DISPLAY': ':0', 13:23:13 INFO - 'HOME': '/home/cltbld', 13:23:13 INFO - 'LANG': 'en_US.UTF-8', 13:23:13 INFO - 'LANGUAGE': 'en_US:en', 13:23:13 INFO - 'LOGNAME': 'cltbld', 13:23:13 INFO - 'MAIL': '/var/mail/cltbld', 13:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:13 INFO - 'MOZ_NO_REMOTE': '1', 13:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:13 INFO - 'NO_EM_RESTART': '1', 13:23:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:13 INFO - 'PWD': '/builds/slave/test', 13:23:13 INFO - 'SHELL': '/bin/bash', 13:23:13 INFO - 'SHLVL': '1', 13:23:13 INFO - 'TERM': 'linux', 13:23:13 INFO - 'TMOUT': '86400', 13:23:13 INFO - 'USER': 'cltbld', 13:23:13 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1501874190.24912-1481130047', 13:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:13 INFO - '_': '/tools/buildbot/bin/python'} 13:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:13 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)) 13:23:13 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)) 13:23:13 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)) 13:23:13 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)) 13:23:13 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)) 13:23:13 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)) 13:23:13 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)) 13:23:13 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)) 13:23:13 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)) 13:23:13 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 13:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:23:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:23:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 13:23:14 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)) 13:23:14 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)) 13:23:14 INFO - Installing collected packages: simplejson 13:23:14 INFO - Running setup.py install for simplejson 13:23:14 INFO - building 'simplejson._speedups' extension 13:23:14 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 13:23:15 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 13:23:15 INFO - Successfully installed simplejson 13:23:15 INFO - Cleaning up... 13:23:15 INFO - Return code: 0 13:23:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:23:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:23:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2122a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c2eb0>, '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 0x22c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c4240>, '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': '7fc86f70bae03e018da0b1d8000001c4-1501874190.24912-1481130047', '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 13:23:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:23:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:23:15 INFO - Using env: {'DISPLAY': ':0', 13:23:15 INFO - 'HOME': '/home/cltbld', 13:23:15 INFO - 'LANG': 'en_US.UTF-8', 13:23:15 INFO - 'LANGUAGE': 'en_US:en', 13:23:15 INFO - 'LOGNAME': 'cltbld', 13:23:15 INFO - 'MAIL': '/var/mail/cltbld', 13:23:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:15 INFO - 'MOZ_NO_REMOTE': '1', 13:23:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:15 INFO - 'NO_EM_RESTART': '1', 13:23:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:15 INFO - 'PWD': '/builds/slave/test', 13:23:15 INFO - 'SHELL': '/bin/bash', 13:23:15 INFO - 'SHLVL': '1', 13:23:15 INFO - 'TERM': 'linux', 13:23:15 INFO - 'TMOUT': '86400', 13:23:15 INFO - 'USER': 'cltbld', 13:23:15 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1501874190.24912-1481130047', 13:23:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:15 INFO - '_': '/tools/buildbot/bin/python'} 13:23:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:23:15 INFO - Cleaning up... 13:23:16 INFO - Return code: 0 13:23:16 INFO - Running post-action listener: _resource_record_post_action 13:23:16 INFO - Running post-action listener: _start_resource_monitoring 13:23:16 INFO - Starting resource monitoring. 13:23:16 INFO - [mozharness: 2017-08-04 20:23:16.038090Z] Finished create-virtualenv step (success) 13:23:16 INFO - [mozharness: 2017-08-04 20:23:16.038559Z] Running install step. 13:23:16 INFO - Running pre-action listener: _resource_record_pre_action 13:23:16 INFO - Running main action method: install 13:23:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:23:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:23:16 INFO - Reading from file tmpfile_stdout 13:23:16 INFO - Detecting whether we're running mozinstall >=1.0... 13:23:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:23:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:23:16 INFO - Reading from file tmpfile_stdout 13:23:16 INFO - Output received: 13:23:16 INFO - Usage: mozinstall [options] installer 13:23:16 INFO - Options: 13:23:16 INFO - -h, --help show this help message and exit 13:23:16 INFO - -d DEST, --destination=DEST 13:23:16 INFO - Directory to install application into. [default: 13:23:16 INFO - "/builds/slave/test"] 13:23:16 INFO - --app=APP Application being installed. [default: firefox] 13:23:16 INFO - mkdir: /builds/slave/test/build/application 13:23:16 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'] 13:23:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 13:23:34 INFO - Reading from file tmpfile_stdout 13:23:34 INFO - Output received: 13:23:34 INFO - /builds/slave/test/build/application/firefox/firefox 13:23:34 INFO - Running post-action listener: _resource_record_post_action 13:23:34 INFO - [mozharness: 2017-08-04 20:23:34.356607Z] Finished install step (success) 13:23:34 INFO - [mozharness: 2017-08-04 20:23:34.356756Z] Running setup-mitmproxy step. 13:23:34 INFO - Running pre-action listener: _resource_record_pre_action 13:23:34 INFO - Running main action method: setup_mitmproxy 13:23:34 INFO - Skipping: mitmproxy is not required 13:23:34 INFO - Running post-action listener: _resource_record_post_action 13:23:34 INFO - [mozharness: 2017-08-04 20:23:34.357316Z] Finished setup-mitmproxy step (success) 13:23:34 INFO - [mozharness: 2017-08-04 20:23:34.357545Z] Running run-tests step. 13:23:34 INFO - Running pre-action listener: _resource_record_pre_action 13:23:34 INFO - Running pre-action listener: _set_gcov_prefix 13:23:34 INFO - Running main action method: run_tests 13:23:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:23:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:23:34 INFO - Python 2.7.3 13:23:34 INFO - Return code: 0 13:23:34 INFO - grabbing minidump binary from tooltool 13:23:34 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')]} 13:23:34 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 0x22c2eb0>, '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 0x22c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c4240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:23:34 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 13:23:34 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 13:23:34 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 13:23:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:23:34 INFO - Return code: 0 13:23:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:23:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:23:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:23:34 INFO - ENV: RUST_BACKTRACE is now 1 13:23:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:23:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:23:34 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/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 13:23:34 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/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 13:23:34 INFO - Using env: {'DISPLAY': ':0', 13:23:34 INFO - 'HOME': '/home/cltbld', 13:23:34 INFO - 'LANG': 'en_US.UTF-8', 13:23:34 INFO - 'LANGUAGE': 'en_US:en', 13:23:34 INFO - 'LOGNAME': 'cltbld', 13:23:34 INFO - 'MAIL': '/var/mail/cltbld', 13:23:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:23:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:23:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:34 INFO - 'MOZ_NO_REMOTE': '1', 13:23:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:23:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:34 INFO - 'NO_EM_RESTART': '1', 13:23:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:34 INFO - 'PWD': '/builds/slave/test', 13:23:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:23:34 INFO - 'RUST_BACKTRACE': '1', 13:23:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:23:34 INFO - 'SHELL': '/bin/bash', 13:23:34 INFO - 'SHLVL': '1', 13:23:34 INFO - 'STYLO_FORCE_ENABLED': '1', 13:23:34 INFO - 'TERM': 'linux', 13:23:34 INFO - 'TMOUT': '86400', 13:23:34 INFO - 'USER': 'cltbld', 13:23:34 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1501874190.24912-1481130047', 13:23:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:34 INFO - '_': '/tools/buildbot/bin/python'} 13:23:34 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/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 13:23:34 INFO - mozversion application_buildid: 20170804193407 13:23:34 INFO - mozversion application_changeset: 4cfb674227051e22bab651e5759f3de503a50560 13:23:34 INFO - mozversion application_display_name: Nightly 13:23:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:23:34 INFO - mozversion application_name: Firefox 13:23:34 INFO - mozversion application_remotingname: firefox 13:23:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:23:34 INFO - mozversion application_vendor: Mozilla 13:23:34 INFO - mozversion application_version: 57.0a1 13:23:34 INFO - mozversion platform_buildid: 20170804193407 13:23:34 INFO - mozversion platform_changeset: 4cfb674227051e22bab651e5759f3de503a50560 13:23:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:23:34 INFO - mozversion platform_version: 57.0a1 13:23:34 INFO - using testdate: 1501878214 13:23:34 INFO - actual date: 1501878214 13:23:34 INFO - starting webserver on 'localhost:52623' 13:23:34 INFO - SUITE-START | Running 2 tests 13:23:34 INFO - TEST-START | dromaeo_css 13:23:34 INFO - Initialising browser for dromaeo_css test... 13:23:34 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52623/getInfo.html -profile /tmp/tmprUaCR_/profile 13:23:34 INFO - TEST-INFO | started process 9254 (/builds/slave/test/build/application/firefox/firefox http://localhost:52623/getInfo.html) 13:23:40 INFO - TEST-INFO | 9254: exit 0 13:23:40 INFO - Browser initialized. 13:23:40 INFO - Running cycle 1/1 for dromaeo_css test... 13:23:40 INFO - TEST-INFO | started process 9479 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprUaCR_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 13:23:41 INFO - PID 9479 | 13:23:41 INFO - PID 9479 | (/builds/slave/test/build/application/firefox/firefox:9533): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 13:23:41 INFO - PID 9479 | 13:23:51 INFO - PID 9479 | RSS: Main: 173330432 13:23:51 INFO - PID 9479 | 13:26:49 INFO - PID 9479 | Cycle 1(1): loaded http://localhost:52623/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52623/tests/dromaeo/cssquery-ext.html) 13:26:51 INFO - PID 9479 | RSS: Main: 172736512 13:26:51 INFO - PID 9479 | 13:29:53 INFO - PID 9479 | Cycle 1(1): loaded http://localhost:52623/tests/dromaeo/cssquery-ext.html (next: http://localhost:52623/tests/dromaeo/cssquery-jquery.html) 13:29:53 INFO - PID 9479 | RSS: Main: 172548096 13:29:53 INFO - PID 9479 | 13:32:55 INFO - PID 9479 | Cycle 1(1): loaded http://localhost:52623/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52623/tests/dromaeo/cssquery-mootools.html) 13:32:56 INFO - PID 9479 | RSS: Main: 174432256 13:32:56 INFO - PID 9479 | 13:35:58 INFO - PID 9479 | Cycle 1(1): loaded http://localhost:52623/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52623/tests/dromaeo/cssquery-prototype.html) 13:35:58 INFO - PID 9479 | RSS: Main: 172908544 13:35:58 INFO - PID 9479 | 13:39:02 INFO - PID 9479 | Cycle 1(1): loaded http://localhost:52623/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52623/tests/dromaeo/cssquery-yui.html) 13:39:03 INFO - PID 9479 | RSS: Main: 176435200 13:39:03 INFO - PID 9479 | 13:42:04 INFO - PID 9479 | Cycle 1(1): loaded http://localhost:52623/tests/dromaeo/cssquery-yui.html (next: http://localhost:52623/tests/dromaeo/cssquery-dojo.html) 13:42:05 INFO - PID 9479 | RSS: Main: 176410624 13:42:05 INFO - PID 9479 | 13:42:05 INFO - PID 9479 | __start_tp_report 13:42:05 INFO - PID 9479 | _x_x_mozilla_page_load 13:42:05 INFO - PID 9479 | _x_x_mozilla_page_load_details 13:42:05 INFO - PID 9479 | |i|pagename|runs| 13:42:05 INFO - PID 9479 | |0;dojo.html;3140.5760222369972;3169.524571314304;3175.507796291575;3177.714005739483;3234.967650323496;6146.231721034871;6267.153934218891;6276.372362763727;6292.3707629237115;6295.590786598867;6124.081387791834;6226.564140510166;6246.562740608159;6251.4686251668545;6259.749610015605;5674.432556744313;5701.629394089392;5725.312962444492;5739.139129130622;5810.099434587624;5732.828015159531;5785.247917770684;5790.797322093727;5798;5802.39074897136;135.90901997348988;5621.634593751393;5648.237487939137;5759.913601295984;5773.913391299134;5586.804461843816;5611.971940140314;5631.690257035862;5720.771169153229;5734.225879506255;5554.1391084381585;5600.691961942091;5678.886422271573;5693.800716974927;5694;6025.457708806184;6043.3956604339655;6048.183495228176;6121.693915304261;6128.601640893327;6597.703103360361;6635.93364066358;6665.200175978865;6696.263411024784;6718.6304753238555;6598;6688.966555167193;6709.664516774191;6789.388954994025;6799.320067993211;6211.9689401552705;6222.471089957359;6224.751009959641;6227.87544249117;6230.688465576748;6772.5936443813525;6844.110265665531;6853.383195512428;6854.3145685432055;6865.41643960269;6403.48772098231;6449.59423082647;6501.8699626008165;6502;6504.869902602016;6606.141201643852;6616;6623.43700785429;6657.367550082734;6657.766978155838;6437.517186211053;6474.967625161844;6540.967295163494;6546.050822630692;6552.049952756824;6471.313118315801;6513.967430162819;6541;6589.143411356589;6655.6339401332425;5423.132298832168;5440.211169380417;5466.262054622575;5469.589780766459;5469.781208751685;4673.462551806518;4701.365315682339;4749.548792864673;4755.429348478205;4775.21209000518;5776.537876969833;5840.445157710011;5847.649141051551;5847.707614619337;5858.150568167592;6660.60036397808;6669.733210671616;6689.364510371507;6765.830854228684;6768.289329620417;5657.830265092054;5701.743421546041;5724.026915424388;5731.340895797037;5738.971305143531;5897.439743224387;5971.4327138921735;5972.343042265347;5974.2830860297045;5974.3726908674835;6471.9029214561815;6480.935190648128;6517.478601711851;6557.245916719543;6560.835979100465;6669.566478178903;6684.7326106957125;6746.325367463312;6781.966090169715;6787.592744435349;6334.239891213084;6387.712552935036;6436.903446448214;6446.580972236789;6553.901691474536;6560.868782624416;6568.770093046721;6582.275949645439;6591.901121483085;6602.042703808017;6660.900086498609;6820.522563420712;6826.214985276558;6827.180738311435;6832.214295356098;6478.449331806849;6486.254080780771;6569.310222426577;6578.407943284936;6588.934110658832;6321.462675672619;6465.967670161619;6479.643619600967;6537.803865884031;6562.179727534059;6380.776672816429;6382.425581697669;6397.936020639734;6409;6438.484921206386;6393.552451328363;6512.511561632802;6529.118568993315;6532.967335163294;6588.275289718032;6266.780662676784;6280.152179455715;6355.682215889279;6370.203724534434;6385.265694445013 13:42:05 INFO - PID 9479 | |1;ext.html;801.5150833745583;840.2311884625568;869.1308691308691;888.9644414223435;893.8703887936249;39738.80130599347;40849.18301633966;40877.38683919744;40897;40908.59091409085;36764;37252.81373593128;37287;37362.252754944886;37365.813170934176;6742.056112144292;6845.555038922479;6849.657517124148;6851.931480685204;6873.140857392826;6776.186857577073;6856.862862742742;6857.931420685779;6868.141482314711;6872.828179295508;6821.079154314179;7412.925870741277;7679.347255483291;7683.692652293901;7690.730824421146;7610.353119984808;7643.732469363574;7647.158812530617;7663.961680191619;7671.079470463525;7402.370798482136;7545.320921117126;7584.317411432942;7610.695572177106;7624.466287359887;38501.229975400616;39135;39239.21521569553;39246;39346.40980385296;3385.6106547747077;3430.262493563871;3439.8108104054268;3447.207142357272;3448.413769659164;30774.230644234074;30985.605647745906;30992.53511197334;31038.534421983688;31148.377032459222;4989.950100498985;5010.048090862724;5013.24801279811;5036.320096786923;5074.873128171788;221659;224336;225312;226371;226699;47360.28959565609;47420.7628961853;47447;47568.762156189;47594.52405475901;49279.260811087865;49379;49388.50611493911;49487.25769113466;49543.50456495389;16313.265903034391;16668.49994500167;16678.416255431002;16685.16574171311;16716.331346746236;13816.654583635489;13868.86131138696;13975.09161904473;13976.790348144787;13978.231197284043;13996.16023038621;14005.859941400658;14091.577252682437;14121.08212966154;14285.500007499688;5703.7433315500075;5713.285839270091;5734.225879506297;5756.510696590753;5760.539156867524;916.1159481100769;923.6905636611676;929.7783181276908;934.4253284230285;940.3323640215524;22390.776092239194;22480.550388992127;22558;22703.432414189778;22756.658650120262;1023.130339211679;1036.7149034015706;1038.4340534408766;1046.5133712823574;1047.5547892145808;11926.582569610195;12006.819897701542;12032.87967120335;12090.69773255658;12116.333601651993;237404;241413;241584;241635;242545;51555;51583.742081289354;52662;57167.142492862644;57193.14210286849;1443.314425647809;1494.8579884910698;1496.311696619567;1505.7515509940956;1514.5834895403852;27199.59200612032;27291.31771705723;27524.58713119345;27619.585706214824;27623;36697.26605467929;36757;36783.63216367909;36816.63183368132;36905.81547092248;208338;209339;209360;210107;210894;34748.65251347454;34850.128746780516;34958.65041349554;34991;35063;40216.597834022454;41723.7913810429;41733.37399938943;41992;42203.788981054895;31217.063488095395;31273.530897036107;31420.52869206918;31669.524957126123;32448.026559203263;28515.857420712764;28704.712952870203;28907.988220412186;29051.56422653704;29128.27179320534;33578.3284334307;38149.23701526009;38791.80604096961;38815.223695526496;38846;33666.66333336733;33700.662993369755;33856.830715847245;34205.486917696755;34291.31417371589;24126.39684007914;24644;25170.74829251684;25383.6192457117;25572.360690982874 13:42:05 INFO - PID 9479 | |2;jquery.html;570.8629928817082;579.4176852263475;588.8645611509353;589.3046205477535;603.529247187194;21959;22867.19964801228;22913.312600622008;22919.656205156894;22940;24383.512329753394;26977.32556686084;27093.864530677318;27121.593176102375;27238.59142112865;6464.062710906904;6608.867822643544;6615.6030638161865;6634.502412319095;6635.7677481288165;5935.88128237435;6432.163818703562;6508.414242718154;6510.18622672166;6523.510736694743;6487.448566871822;6488.545801793876;6492.156019717454;6493.220813502387;6493.805185844409;6471.9029214561815;6473.320301368359;6476.708548115323;6480.319566445526;6483.189601299838;5941.376155503696;5967.522598192134;5967.5524335675;5971.611845230046;6007.969960150215;29906.85046574775;30039.699603003908;30245.336506492135;30559.08322750321;30590.082297530887;1919.5393105654682;1973.802619738029;1975.3086419752972;1975.4073777866727;1979.257778333125;18743;19161.61676766471;19165.425037248766;19239.23043078275;19325.13036913342;2295.185209250725;2355.140373763581;2384.9642255366184;2404.8557086574688;2420.9031638734427;133768.33115834455;135576;136179;136317.3184134083;136403.6359636401;13935.516120969758;14949.860529288753;15063;15308.004979676509;15504.689906202038;22648.094076236765;24004.51990960171;24147.7585224149;24281.271561853173;24326.51346973086;10557.832650204908;10666.253362264568;10681.519331630096;10841.620543280947;10853.403062831461;9925.255605829592;9933.453660048623;10008.749781255527;10055.798884022279;10076.59693612262;9201.309901757395;9390.62437502506;9441.339106262496;9474.95262523683;9883.950580247052;2723.836569805818;2787.4044719793133;2821.3510892494432;2830.377316990259;2891.334992951633;880.106691707917;896.4934811831295;897.8069715011304;933.4725879877983;995.2635050062902;19343;19522.70715939262;19834.404967850987;20163.899180504002;20356.083976221107;1008.1984822066474;1046.9371837689612;1047.4867315015588;1055.350959160111;1056.5615269663158;10714.357138571555;11113.83329250062;11147.21969462146;11178.329300242012;11233.66299011031;489711;509278;511564;522708;525739;118773;120623;120903.39548302202;121217;125713;1201.5934824771869;1223.2721530689225;1240.1504969096197;1240.3674126195706;1244.3467179730715;17193.828061719723;17289.308427663254;17469;17601.471955841345;18025;56280.15579766389;57207.42792572021;60057.399426005184;60732.39267607444;62239.688801555705;67848;68829;69368.6531567339;69378;69596.6520167396;14563.271836408348;14652.926735366254;15234.77147842761;15251.389944402543;15273.77089343683;23961.400964976016;24183.879080604485;24287.392815179053;24338;24439.877800611594;18116.547086322946;18126;18901.621967560848;18910;18913.905430472758;17354.82645173532;17357.30570777205;17508.737368939223;17636.73544896853;17846.643067138324;17985.910070449565;19252.4224273272;19389;19709.1130899107;19714.309999149962;14908.030977986396;15016.849831501546;15021.474248401253;15027.549173524812;15039.548813535612;18673.53316167107;18673.972931488355;18694.53263668365;18921.810781892003;18925.337613183474 13:42:05 INFO - PID 9479 | |3;mootools.html;1357.1178733823015;1411.498917884151;1429.7354989326975;1442.18516538156;1447.5584946591287;12980.415881285342;13691.17852928825;13706.725865482684;13738.107023043507;13761.931190344034;14205.502807401743;14417.134971901667;14429;14439.350229239682;14467.78298325526;2404.3989002749313;2438.3050830513307;2440.890159942798;2449.497852940152;2449.889754961022;2212.0156530344;2217.589745897006;2225.3324002799177;2303.5968705476475;2358.13927916311;2347.565700345433;2382.642603609455;2383.2969274064108;2396.1254142238045;2408.157144999245;2335.5679199348174;2346.2022912209845;2350.823688223373;2354.399628094842;2357.363511851799;2271.7728227177317;2276;2277.419258089193;2280.680704701343;2284.3261237934685;13509.59471215865;13671.589852304447;13835.723285534234;13849.86150138506;13856.237906915116;7157.069580954495;7259.927400726031;7458.888116678254;7466.925330746677;7507.662155203029;4952.7523623819025;5022.84931452057;5105.463926287761;5128.205128205134;5133.743312834344;2206.5255969966533;2223.3663405929397;2334.5526771500317;2358.2217868103658;2391.5216956608747;23034.308970730905;23440.17959371414;23531.647025294635;23659.526809463714;23714.288571342713;6550.770723024767;6691.531592788556;6874.346937040973;6933.306669333027;6946.16646002483;18115.909420452812;18147.63704725898;18176.091195440174;18179;18187.818121818877;7476.663550140257;7691.269329413697;7691.615419229016;7692.384609231248;7712.691492340356;6810.591364518045;6915.861682766316;6967.93032069683;6992.091028166407;7016.298370163045;5326.893462130735;5434.64674796137;5451.918221226685;5473.890522189534;5519.751611177507;1659.402615058578;1676.555712736126;1730.7576939228518;1738.7391891216166;1745.1361576019951;842.8735689646602;870.7474832298689;901.8782464367358;903.408267584733;907.464595888429;7499.137599176055;7515.023047003854;7536.547807131589;7568.356689681329;7591.354734847489;723.4321057969574;745.8993035940078;746.1046743907333;750.6359415683389;755.8752805787094;5398.595105367034;5675.971620141955;5702.743376547983;5810.564207684441;5924.7333869975955;18627.81372186288;18969.24123035063;19262.229510819692;19317.903410482857;19321.613567728567;17783.644327113387;17911.462656120337;18294.63410731778;18377.81622183788;18689.158987845578;9325.393849399767;9661.178799802095;10888.564457421615;10914.290571113012;10926.562937482571;7300.598467084149;8247.670093196204;8383.748487545383;8431.451955622864;8460.873086903579;15589.29848156813;15603.531894043197;15783.921080394524;15962;16036.679266414372;16320.428784992468;16496.587585310463;16525.83474165243;16529.33882644681;16701.081440520888;10518.947405262925;10823;10851.077658399125;10856.077233434931;10860.945695271788;12547.937260314005;12705.745885082431;12883.033772466915;12951.028672849763;13102.410391532594;10506.791718952418;10703.678889633324;10735.89264107349;10755.462226888782;11052.281601695864;10510.369377837354;10528.736781580521;10644.148468122687;10669.093127083974;10720.303180293256;9652.179564736794;9788.951055244679;9790.657326993805;9794.461304628314;9795.608175672893;7076.71693132269;7154.642267886481;7191.3887319578425;7240.384567311838;7306.817329566803;7346.77959661211;7393.223711510214;7508.58702771331;7514.887276690744;7573.242675732383 13:42:05 INFO - PID 9479 | |4;prototype.html;500.80896079651524;500.989980200396;514.6834696661555;526.1187510919211;536.5627013983603;6126.387361263872;6164.476019538339;6172.475339596129;6176.691165441721;6224.595401298918;5992.970035149818;6102.877942441149;6126.203593532835;6162.137300777895;6167.167432396625;4799.904001919959;4927.753612319388;4946;5048.570871475929;5069.898602027957;4847.733374664392;4910;4912.852614421573;4924.80300787968;4946.876328091808;4862.7325497097645;4862.854114376557;4902.558769710726;4922.483139270379;4942.406911170647;4927.457979622257;4944.307796908436;4953.5541801237705;4961.5038496150455;4963.503649635044;4398.912021759579;4446.133004064209;4460.149038149164;4466.977665111686;4483.237849565549;5775.913361299584;5779.988502012173;5845.210896528999;5889.352171261158;5911.55663325248;5656.604037717361;5670.716464176816;5671.859542533932;5691.743871525791;5694.316681998145;6316.463100636452;6442.549021568492;6457.515686323498;6479.6760161991715;6482.708278127496;4813.66304358695;4842.951570484285;4849.151398505247;4852.17513022787;4855.854324370239;6511.641859697715;6551.508636852255;6697.129373181504;6723.5965842049145;6863.38229559342;4898.90202195954;4927.211646136601;4945.802167913315;4951.900961980812;4972.602191824645;5010.123228435009;5042.218456139304;5044.218146187347;5065.442801291855;5070.873228169326;5478.534324582375;5565.888682226333;5652.74562644682;5659.783146623414;5681.204631351614;6509.349065093547;6516.6415847128865;6525.282218955911;6537.509686773511;6584.407403333723;1734.4276388791668;1738.209114852739;1741.1642411642229;1771.6545273671768;1776.0764402510622;1167.2529581068122;1200.8919197272287;1225.7916154253799;1245.2839617219954;1251.1429670675616;5724.484796368347;5746.511546518509;5769.48074673273;5773.538116950634;5778.566607504454;6508.479321654257;6555.901661475082;6649.767258146038;6653.667316634149;6653.733850646016;5759.6832174229985;5786.305643322744;5790.88418231633;5814.76740930358;5816.680082595498;3484.9477257841154;3575.7496975211484;3596.5684117906017;3597.892063238107;3603.9099022524124;6422.550421470546;6456.257530384066;6488.188976377953;6502.317256687979;6545.280019197884;6749.730010799612;6790.287019862942;6850.897236541456;6859.5541289817;6860.451163906875;6485.383888530582;6489.67551622417;6560.179977502812;6560.540762146604;6570.638614876132;6091.482224011009;6725.630090345078;6738.966305168639;6750.257471678014;6762.49281303914;6482.546221764431;6496.382843629847;6530.579618916383;6622.139121914313;6645.401913827779;6298.622082675054;6354.090695653087;6364.64994425311;6494.285628580947;6517;4966.428860681068;4975.975120124376;4976.004799040279;4977.875553111201;5027.974860125676;6370.8088757337355;6391.886490807243;6415.615063096229;6645.468362530889;6683.6324002180345;6363.331850155852;6402.519811014286;6416.326285740117;6417.71645670877;6474.863295112696;6331.2085989251345;6350.460210882126;6417.96791016042;6494.675266236574;6497.967510162419;6368.108464814837;6402.775902843378;6452.741890324334;6479.416852483299;6482.35176482348;6457.6771161442675;6495.5966292472085;6554.705038273194;6564.409203171737;6599.53803233769;6282.811515654537;6316.494680425463;6329.493640508656;6333.398327158912;6339.270983836917 13:42:05 INFO - PID 9479 | |5;yui.html;897.8832751742273;913.0413066280405;916.9541522923852;929.7257309093817;934.2059249637806;18727.906360468194;19717.901410492945;19722.30971915983;19749.210031598755;21596.784032159674;21716.2399316024;22309;22348.21781237657;22394.32817015492;22424.215152469667;1014.1379827146922;1056.5404049238605;1059.7191744187796;1060.0883240413239;1060.0989159214682;1016.9847452288221;1048.0043958239664;1051.805415998043;1055.208593554834;1055.6621880998084;1099.4612639806478;1100.7138144082517;1100.785346857363;1101.7686285879975;1102.1733699725205;1098.4288170151517;1099.4118146791468;1101.058594901364;1101.2236373356845;1101.5428597132181;809.3323008517996;811.2698571285831;812.8943237379162;814;815.8898548695969;19281.903590481958;20078;20342.18631254748;20732.5853482931;20848.895755521276;21774.45563860916;22020.229291974705;22066.66899996501;22279.220227292128;22370.55258894813;16987.91506042474;17125.743113853303;17176.39882604103;17362;17519.124043797885;3445.810480423576;3463.307338532278;3464.0993341731332;3464.826758662057;3465.8440370183403;130772;131886;132816;133661;136753.31623341818;16429.753553696704;16590.83409165917;16740.49778506647;16859.409920652717;16933.83066169347;27654.72345276562;28716.425671486453;28887.133385998455;28893.71106288952;29137.7086229135;7806.570638614817;8173.591320433955;8191.631376588068;8527.872081918777;8751.212390884724;4257.382679511454;4343.67422443318;4377.8248870044845;4387.363832244307;4390.275604525217;5164.147915593885;5247.2653828464045;5255.448177941337;5299.761510732026;5317.813876514381;974.9415035097917;978.3054031637474;991.6281394477071;1007.2999265510547;1007.5012868630075;641.3970867384644;657.3295238856435;671.8454755406284;678.1929503890354;679.3104998426601;11172.832407513893;11977.576954535556;12272.202306850026;13220.083087952193;13295.335233238493;700.3381804194987;712.3588770106842;715.6242972439511;726.2555880222814;733.8385555177853;5426.914617076601;5647.124695672177;5745.741441635137;6290.370962903765;6300.243970723543;101892.49053754832;106119.4694026525;108153;110323;111721;94475.3969282302;95550.52224738832;96036.51981740046;96156;97101;78459.60770196226;79120.60439697765;80870;82637;83216.75174872382;12489.313087779896;12804.679883003;13200.405981731037;13201.273929933946;13284.800727988895;36621.26757464783;37389.81305093457;37472.437913431866;37600.43599346067;37912.24175516419;65241;68099.65950170218;68408;70913;73613.63193183999;15809.446669366516;17749.822501774815;18039.729404058686;18150.45548633543;18249.81750182481;20762.792372076085;21703.45741356479;21971.450713732283;22259.109635614393;22796.88601557048;18954.24183032663;19137.712934306273;19474.902625486782;19622.8037719621;19685.60628787445;18627.90686046561;18936.715949260495;19676.60646787085;19937.102830372958;20348.28780992658;18405.81594184041;18821.529461763566;19087.8091219086;19191;19470.513237169183;13219.867801321863;13595.86404135946;13904.791428128385;14128.78806817878;14161.575152745434;13092.214467132002;13450;13699.726005480034;13703.246321452416;15022.248887555797 13:42:05 INFO - PID 9479 | __end_tp_report 13:42:05 INFO - PID 9479 | __start_cc_report 13:42:05 INFO - PID 9479 | _x_x_mozilla_cycle_collect,360 13:42:05 INFO - PID 9479 | __end_cc_report 13:42:05 INFO - PID 9479 | __startTimestamp1501879325218__endTimestamp 13:42:05 INFO - PID 9479 | 13:42:05 INFO - PID 9479 | ------- Summary: start ------- 13:42:05 INFO - PID 9479 | Number of tests: 6 13:42:05 INFO - PID 9479 | 13:42:05 INFO - PID 9479 | [#0] dojo.html Cycles:165 Average:6104.75 Median:6382.43 stddev:847.02 (13.3%) stddev-sans-first:817.08 13:42:05 INFO - PID 9479 | Values: 3140.6 3169.5 3175.5 3177.7 3235.0 6146.2 6267.2 6276.4 6292.4 6295.6 6124.1 6226.6 6246.6 6251.5 6259.7 5674.4 5701.6 5725.3 5739.1 5810.1 5732.8 5785.2 5790.8 5798.0 5802.4 135.9 5621.6 5648.2 5759.9 5773.9 5586.8 5612.0 5631.7 5720.8 5734.2 5554.1 5600.7 5678.9 5693.8 5694.0 6025.5 6043.4 6048.2 6121.7 6128.6 6597.7 6635.9 6665.2 6696.3 6718.6 6598.0 6689.0 6709.7 6789.4 6799.3 6212.0 6222.5 6224.8 6227.9 6230.7 6772.6 6844.1 6853.4 6854.3 6865.4 6403.5 6449.6 6501.9 6502.0 6504.9 6606.1 6616.0 6623.4 6657.4 6657.8 6437.5 6475.0 6541.0 6546.1 6552.0 6471.3 6514.0 6541.0 6589.1 6655.6 5423.1 5440.2 5466.3 5469.6 5469.8 4673.5 4701.4 4749.5 4755.4 4775.2 5776.5 5840.4 5847.6 5847.7 5858.2 6660.6 6669.7 6689.4 6765.8 6768.3 5657.8 5701.7 5724.0 5731.3 5739.0 5897.4 5971.4 5972.3 5974.3 5974.4 6471.9 6480.9 6517.5 6557.2 6560.8 6669.6 6684.7 6746.3 6782.0 6787.6 6334.2 6387.7 6436.9 6446.6 6553.9 6560.9 6568.8 6582.3 6591.9 6602.0 6660.9 6820.5 6826.2 6827.2 6832.2 6478.4 6486.3 6569.3 6578.4 6588.9 6321.5 6466.0 6479.6 6537.8 6562.2 6380.8 6382.4 6397.9 6409.0 6438.5 6393.6 6512.5 6529.1 6533.0 6588.3 6266.8 6280.2 6355.7 6370.2 6385.3 13:42:05 INFO - PID 9479 | 13:42:05 INFO - PID 9479 | [#1] ext.html Cycles:180 Average:39059.03 Median:35880.13 stddev:58502.40 (163.0%) stddev-sans-first:58595.99 13:42:05 INFO - PID 9479 | Values: 801.5 840.2 869.1 889.0 893.9 39738.8 40849.2 40877.4 40897.0 40908.6 36764.0 37252.8 37287.0 37362.3 37365.8 6742.1 6845.6 6849.7 6851.9 6873.1 6776.2 6856.9 6857.9 6868.1 6872.8 6821.1 7412.9 7679.3 7683.7 7690.7 7610.4 7643.7 7647.2 7664.0 7671.1 7402.4 7545.3 7584.3 7610.7 7624.5 38501.2 39135.0 39239.2 39246.0 39346.4 3385.6 3430.3 3439.8 3447.2 3448.4 30774.2 30985.6 30992.5 31038.5 31148.4 4990.0 5010.0 5013.2 5036.3 5074.9 221659.0 224336.0 225312.0 226371.0 226699.0 47360.3 47420.8 47447.0 47568.8 47594.5 49279.3 49379.0 49388.5 49487.3 49543.5 16313.3 16668.5 16678.4 16685.2 16716.3 13816.7 13868.9 13975.1 13976.8 13978.2 13996.2 14005.9 14091.6 14121.1 14285.5 5703.7 5713.3 5734.2 5756.5 5760.5 916.1 923.7 929.8 934.4 940.3 22390.8 22480.6 22558.0 22703.4 22756.7 1023.1 1036.7 1038.4 1046.5 1047.6 11926.6 12006.8 12032.9 12090.7 12116.3 237404.0 241413.0 241584.0 241635.0 242545.0 51555.0 51583.7 52662.0 57167.1 57193.1 1443.3 1494.9 1496.3 1505.8 1514.6 27199.6 27291.3 27524.6 27619.6 27623.0 36697.3 36757.0 36783.6 36816.6 36905.8 208338.0 209339.0 209360.0 210107.0 210894.0 34748.7 34850.1 34958.7 34991.0 35063.0 40216.6 41723.8 41733.4 41992.0 42203.8 31217.1 31273.5 31420.5 31669.5 32448.0 28515.9 28704.7 28908.0 29051.6 29128.3 33578.3 38149.2 38791.8 38815.2 38846.0 33666.7 33700.7 33856.8 34205.5 34291.3 24126.4 24644.0 25170.7 25383.6 25572.4 13:42:05 INFO - PID 9479 | 13:42:05 INFO - PID 9479 | [#2] jquery.html Cycles:180 Average:35682.03 Median:22890.26 stddev:85999.20 (375.7%) stddev-sans-first:86200.04 13:42:05 INFO - PID 9479 | Values: 570.9 579.4 588.9 589.3 603.5 21959.0 22867.2 22913.3 22919.7 22940.0 24383.5 26977.3 27093.9 27121.6 27238.6 6464.1 6608.9 6615.6 6634.5 6635.8 5935.9 6432.2 6508.4 6510.2 6523.5 6487.4 6488.5 6492.2 6493.2 6493.8 6471.9 6473.3 6476.7 6480.3 6483.2 5941.4 5967.5 5967.6 5971.6 6008.0 29906.9 30039.7 30245.3 30559.1 30590.1 1919.5 1973.8 1975.3 1975.4 1979.3 18743.0 19161.6 19165.4 19239.2 19325.1 2295.2 2355.1 2385.0 2404.9 2420.9 133768.3 135576.0 136179.0 136317.3 136403.6 13935.5 14949.9 15063.0 15308.0 15504.7 22648.1 24004.5 24147.8 24281.3 24326.5 10557.8 10666.3 10681.5 10841.6 10853.4 9925.3 9933.5 10008.7 10055.8 10076.6 9201.3 9390.6 9441.3 9475.0 9884.0 2723.8 2787.4 2821.4 2830.4 2891.3 880.1 896.5 897.8 933.5 995.3 19343.0 19522.7 19834.4 20163.9 20356.1 1008.2 1046.9 1047.5 1055.4 1056.6 10714.4 11113.8 11147.2 11178.3 11233.7 489711.0 509278.0 511564.0 522708.0 525739.0 118773.0 120623.0 120903.4 121217.0 125713.0 1201.6 1223.3 1240.2 1240.4 1244.3 17193.8 17289.3 17469.0 17601.5 18025.0 56280.2 57207.4 60057.4 60732.4 62239.7 67848.0 68829.0 69368.7 69378.0 69596.7 14563.3 14652.9 15234.8 15251.4 15273.8 23961.4 24183.9 24287.4 24338.0 24439.9 18116.5 18126.0 18901.6 18910.0 18913.9 17354.8 17357.3 17508.7 17636.7 17846.6 17985.9 19252.4 19389.0 19709.1 19714.3 14908.0 15016.8 15021.5 15027.5 15039.5 18673.5 18674.0 18694.5 18921.8 18925.3 13:42:05 INFO - PID 9479 | 13:42:05 INFO - PID 9479 | [#3] mootools.html Cycles:180 Average:8671.59 Median:12941.24 stddev:5911.41 (45.7%) stddev-sans-first:5902.44 13:42:05 INFO - PID 9479 | Values: 1357.1 1411.5 1429.7 1442.2 1447.6 12980.4 13691.2 13706.7 13738.1 13761.9 14205.5 14417.1 14429.0 14439.4 14467.8 2404.4 2438.3 2440.9 2449.5 2449.9 2212.0 2217.6 2225.3 2303.6 2358.1 2347.6 2382.6 2383.3 2396.1 2408.2 2335.6 2346.2 2350.8 2354.4 2357.4 2271.8 2276.0 2277.4 2280.7 2284.3 13509.6 13671.6 13835.7 13849.9 13856.2 7157.1 7259.9 7458.9 7466.9 7507.7 4952.8 5022.8 5105.5 5128.2 5133.7 2206.5 2223.4 2334.6 2358.2 2391.5 23034.3 23440.2 23531.6 23659.5 23714.3 6550.8 6691.5 6874.3 6933.3 6946.2 18115.9 18147.6 18176.1 18179.0 18187.8 7476.7 7691.3 7691.6 7692.4 7712.7 6810.6 6915.9 6967.9 6992.1 7016.3 5326.9 5434.6 5451.9 5473.9 5519.8 1659.4 1676.6 1730.8 1738.7 1745.1 842.9 870.7 901.9 903.4 907.5 7499.1 7515.0 7536.5 7568.4 7591.4 723.4 745.9 746.1 750.6 755.9 5398.6 5676.0 5702.7 5810.6 5924.7 18627.8 18969.2 19262.2 19317.9 19321.6 17783.6 17911.5 18294.6 18377.8 18689.2 9325.4 9661.2 10888.6 10914.3 10926.6 7300.6 8247.7 8383.7 8431.5 8460.9 15589.3 15603.5 15783.9 15962.0 16036.7 16320.4 16496.6 16525.8 16529.3 16701.1 10518.9 10823.0 10851.1 10856.1 10860.9 12547.9 12705.7 12883.0 12951.0 13102.4 10506.8 10703.7 10735.9 10755.5 11052.3 10510.4 10528.7 10644.1 10669.1 10720.3 9652.2 9789.0 9790.7 9794.5 9795.6 7076.7 7154.6 7191.4 7240.4 7306.8 7346.8 7393.2 7508.6 7514.9 7573.2 13:42:05 INFO - PID 9479 | 13:42:05 INFO - PID 9479 | [#4] prototype.html Cycles:180 Average:5452.30 Median:6042.23 stddev:1518.84 (25.1%) stddev-sans-first:1476.93 13:42:05 INFO - PID 9479 | Values: 500.8 501.0 514.7 526.1 536.6 6126.4 6164.5 6172.5 6176.7 6224.6 5993.0 6102.9 6126.2 6162.1 6167.2 4799.9 4927.8 4946.0 5048.6 5069.9 4847.7 4910.0 4912.9 4924.8 4946.9 4862.7 4862.9 4902.6 4922.5 4942.4 4927.5 4944.3 4953.6 4961.5 4963.5 4398.9 4446.1 4460.1 4467.0 4483.2 5775.9 5780.0 5845.2 5889.4 5911.6 5656.6 5670.7 5671.9 5691.7 5694.3 6316.5 6442.5 6457.5 6479.7 6482.7 4813.7 4843.0 4849.2 4852.2 4855.9 6511.6 6551.5 6697.1 6723.6 6863.4 4898.9 4927.2 4945.8 4951.9 4972.6 5010.1 5042.2 5044.2 5065.4 5070.9 5478.5 5565.9 5652.7 5659.8 5681.2 6509.3 6516.6 6525.3 6537.5 6584.4 1734.4 1738.2 1741.2 1771.7 1776.1 1167.3 1200.9 1225.8 1245.3 1251.1 5724.5 5746.5 5769.5 5773.5 5778.6 6508.5 6555.9 6649.8 6653.7 6653.7 5759.7 5786.3 5790.9 5814.8 5816.7 3484.9 3575.7 3596.6 3597.9 3603.9 6422.6 6456.3 6488.2 6502.3 6545.3 6749.7 6790.3 6850.9 6859.6 6860.5 6485.4 6489.7 6560.2 6560.5 6570.6 6091.5 6725.6 6739.0 6750.3 6762.5 6482.5 6496.4 6530.6 6622.1 6645.4 6298.6 6354.1 6364.6 6494.3 6517.0 4966.4 4976.0 4976.0 4977.9 5028.0 6370.8 6391.9 6415.6 6645.5 6683.6 6363.3 6402.5 6416.3 6417.7 6474.9 6331.2 6350.5 6418.0 6494.7 6498.0 6368.1 6402.8 6452.7 6479.4 6482.4 6457.7 6495.6 6554.7 6564.4 6599.5 6282.8 6316.5 6329.5 6333.4 6339.3 13:42:05 INFO - PID 9479 | 13:42:05 INFO - PID 9479 | [#5] yui.html Cycles:180 Average:23813.88 Median:20805.84 stddev:32074.58 (154.2%) stddev-sans-first:32118.40 13:42:05 INFO - PID 9479 | Values: 897.9 913.0 917.0 929.7 934.2 18727.9 19717.9 19722.3 19749.2 21596.8 21716.2 22309.0 22348.2 22394.3 22424.2 1014.1 1056.5 1059.7 1060.1 1060.1 1017.0 1048.0 1051.8 1055.2 1055.7 1099.5 1100.7 1100.8 1101.8 1102.2 1098.4 1099.4 1101.1 1101.2 1101.5 809.3 811.3 812.9 814.0 815.9 19281.9 20078.0 20342.2 20732.6 20848.9 21774.5 22020.2 22066.7 22279.2 22370.6 16987.9 17125.7 17176.4 17362.0 17519.1 3445.8 3463.3 3464.1 3464.8 3465.8 130772.0 131886.0 132816.0 133661.0 136753.3 16429.8 16590.8 16740.5 16859.4 16933.8 27654.7 28716.4 28887.1 28893.7 29137.7 7806.6 8173.6 8191.6 8527.9 8751.2 4257.4 4343.7 4377.8 4387.4 4390.3 5164.1 5247.3 5255.4 5299.8 5317.8 974.9 978.3 991.6 1007.3 1007.5 641.4 657.3 671.8 678.2 679.3 11172.8 11977.6 12272.2 13220.1 13295.3 700.3 712.4 715.6 726.3 733.8 5426.9 5647.1 5745.7 6290.4 6300.2 101892.5 106119.5 108153.0 110323.0 111721.0 94475.4 95550.5 96036.5 96156.0 97101.0 78459.6 79120.6 80870.0 82637.0 83216.8 12489.3 12804.7 13200.4 13201.3 13284.8 36621.3 37389.8 37472.4 37600.4 37912.2 65241.0 68099.7 68408.0 70913.0 73613.6 15809.4 17749.8 18039.7 18150.5 18249.8 20762.8 21703.5 21971.5 22259.1 22796.9 18954.2 19137.7 19474.9 19622.8 19685.6 18627.9 18936.7 19676.6 19937.1 20348.3 18405.8 18821.5 19087.8 19191.0 19470.5 13219.9 13595.9 13904.8 14128.8 14161.6 13092.2 13450.0 13699.7 13703.2 15022.2 13:42:05 INFO - PID 9479 | -------- Summary: end -------- 13:42:05 INFO - PID 9479 | 13:42:06 INFO - TEST-INFO | 9479: exit 0 13:42:06 INFO - TEST-OK | dromaeo_css | took 1111342ms 13:42:06 INFO - TEST-START | kraken 13:42:06 INFO - Initialising browser for kraken test... 13:42:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52623/getInfo.html -profile /tmp/tmpKATh34/profile 13:42:06 INFO - TEST-INFO | started process 9847 (/builds/slave/test/build/application/firefox/firefox http://localhost:52623/getInfo.html) 13:42:11 INFO - TEST-INFO | 9847: exit 0 13:42:11 INFO - Browser initialized. 13:42:11 INFO - Running cycle 1/1 for kraken test... 13:42:11 INFO - TEST-INFO | started process 10071 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKATh34/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 13:42:12 INFO - PID 10071 | 13:42:12 INFO - PID 10071 | (/builds/slave/test/build/application/firefox/firefox:10125): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 13:42:12 INFO - PID 10071 | 13:42:23 INFO - PID 10071 | RSS: Main: 173563904 13:42:23 INFO - PID 10071 | 13:42:25 INFO - PID 10071 | Cycle 1(1): loaded http://localhost:52623/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52623/tests/kraken/driver.html?testName=audio-beat-detection) 13:42:26 INFO - PID 10071 | RSS: Main: 178614272 13:42:26 INFO - PID 10071 | 13:42:29 INFO - PID 10071 | Cycle 1(1): loaded http://localhost:52623/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52623/tests/kraken/driver.html?testName=audio-dft) 13:42:29 INFO - PID 10071 | RSS: Main: 179101696 13:42:29 INFO - PID 10071 | 13:42:33 INFO - PID 10071 | Cycle 1(1): loaded http://localhost:52623/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52623/tests/kraken/driver.html?testName=audio-fft) 13:42:33 INFO - PID 10071 | RSS: Main: 174202880 13:42:33 INFO - PID 10071 | 13:42:35 INFO - PID 10071 | Cycle 1(1): loaded http://localhost:52623/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52623/tests/kraken/driver.html?testName=audio-oscillator) 13:42:36 INFO - PID 10071 | RSS: Main: 174284800 13:42:36 INFO - PID 10071 | 13:42:38 INFO - PID 10071 | Cycle 1(1): loaded http://localhost:52623/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52623/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:42:39 INFO - PID 10071 | RSS: Main: 175521792 13:42:39 INFO - PID 10071 | 13:42:42 INFO - PID 10071 | Cycle 1(1): loaded http://localhost:52623/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52623/tests/kraken/driver.html?testName=imaging-darkroom) 13:42:43 INFO - PID 10071 | RSS: Main: 177573888 13:42:43 INFO - PID 10071 | 13:42:46 INFO - PID 10071 | Cycle 1(1): loaded http://localhost:52623/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52623/tests/kraken/driver.html?testName=imaging-desaturate) 13:42:47 INFO - PID 10071 | RSS: Main: 176680960 13:42:47 INFO - PID 10071 | 13:42:50 INFO - PID 10071 | Cycle 1(1): loaded http://localhost:52623/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52623/tests/kraken/driver.html?testName=json-parse-financial) 13:42:50 INFO - PID 10071 | RSS: Main: 177672192 13:42:50 INFO - PID 10071 | 13:42:52 INFO - PID 10071 | Cycle 1(1): loaded http://localhost:52623/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52623/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:42:53 INFO - PID 10071 | RSS: Main: 177680384 13:42:53 INFO - PID 10071 | 13:42:55 INFO - PID 10071 | Cycle 1(1): loaded http://localhost:52623/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52623/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:42:55 INFO - PID 10071 | RSS: Main: 174813184 13:42:55 INFO - PID 10071 | 13:42:58 INFO - PID 10071 | Cycle 1(1): loaded http://localhost:52623/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52623/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:42:58 INFO - PID 10071 | RSS: Main: 174804992 13:42:58 INFO - PID 10071 | 13:43:01 INFO - PID 10071 | Cycle 1(1): loaded http://localhost:52623/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52623/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:43:02 INFO - PID 10071 | RSS: Main: 175398912 13:43:02 INFO - PID 10071 | 13:43:05 INFO - PID 10071 | Cycle 1(1): loaded http://localhost:52623/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52623/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:43:06 INFO - PID 10071 | RSS: Main: 175579136 13:43:06 INFO - PID 10071 | 13:43:07 INFO - PID 10071 | Cycle 1(1): loaded http://localhost:52623/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52623/tests/kraken/driver.html?testName=ai-astar) 13:43:08 INFO - PID 10071 | RSS: Main: 176852992 13:43:08 INFO - PID 10071 | 13:43:08 INFO - PID 10071 | __start_tp_report 13:43:08 INFO - PID 10071 | _x_x_mozilla_page_load 13:43:08 INFO - PID 10071 | _x_x_mozilla_page_load_details 13:43:08 INFO - PID 10071 | |i|pagename|runs| 13:43:08 INFO - PID 10071 | |0;ai-astar;109;107;101;107;109;113;110;98;111;108 13:43:08 INFO - PID 10071 | |1;audio-beat-detection;150;123;140;177;125;159;147;124;172;120 13:43:08 INFO - PID 10071 | |2;audio-dft;162;163;168;161;164;169;175;166;162;163 13:43:08 INFO - PID 10071 | |3;audio-fft;75;74;79;184;75;77;76;86;97;74 13:43:08 INFO - PID 10071 | |4;audio-oscillator;78;82;135;80;81;83;129;78;79;149 13:43:08 INFO - PID 10071 | |5;imaging-gaussian-blur;113;114;114;114;115;117;117;114;115;121 13:43:08 INFO - PID 10071 | |6;imaging-darkroom;151;150;151;156;150;150;154;154;150;149 13:43:08 INFO - PID 10071 | |7;imaging-desaturate;100;102;95;94;93;96;98;94;94;94 13:43:08 INFO - PID 10071 | |8;json-parse-financial;58;58;58;55;61;55;62;59;56;54 13:43:08 INFO - PID 10071 | |9;json-stringify-tinderbox;54;53;54;54;55;53;57;53;54;54 13:43:08 INFO - PID 10071 | |10;stanford-crypto-aes;94;95;79;79;84;82;75;93;88;93 13:43:08 INFO - PID 10071 | |11;stanford-crypto-ccm;130;138;146;140;142;126;136;125;130;172 13:43:08 INFO - PID 10071 | |12;stanford-crypto-pbkdf2;180;177;175;191;172;182;189;181;170;178 13:43:08 INFO - PID 10071 | |13;stanford-crypto-sha256-iterative;69;70;67;65;71;68;72;65;64;66 13:43:08 INFO - PID 10071 | __end_tp_report 13:43:08 INFO - PID 10071 | __start_cc_report 13:43:08 INFO - PID 10071 | _x_x_mozilla_cycle_collect,983 13:43:08 INFO - PID 10071 | __end_cc_report 13:43:08 INFO - PID 10071 | __startTimestamp1501879388113__endTimestamp 13:43:08 INFO - PID 10071 | 13:43:08 INFO - PID 10071 | ------- Summary: start ------- 13:43:08 INFO - PID 10071 | Number of tests: 14 13:43:08 INFO - PID 10071 | 13:43:08 INFO - PID 10071 | [#0] ai-astar Cycles:10 Average:107.30 Median:109.50 stddev:4.55 (4.2%) stddev-sans-first:4.78 13:43:08 INFO - PID 10071 | Values: 109.0 107.0 101.0 107.0 109.0 113.0 110.0 98.0 111.0 108.0 13:43:08 INFO - PID 10071 | 13:43:08 INFO - PID 10071 | [#1] audio-beat-detection Cycles:10 Average:143.70 Median:148.50 stddev:20.91 (14.1%) stddev-sans-first:22.06 13:43:08 INFO - PID 10071 | Values: 150.0 123.0 140.0 177.0 125.0 159.0 147.0 124.0 172.0 120.0 13:43:08 INFO - PID 10071 | 13:43:08 INFO - PID 10071 | [#2] audio-dft Cycles:10 Average:165.30 Median:165.00 stddev:4.32 (2.6%) stddev-sans-first:4.42 13:43:08 INFO - PID 10071 | Values: 162.0 163.0 168.0 161.0 164.0 169.0 175.0 166.0 162.0 163.0 13:43:08 INFO - PID 10071 | 13:43:08 INFO - PID 10071 | [#3] audio-fft Cycles:10 Average:89.70 Median:76.50 stddev:33.91 (44.3%) stddev-sans-first:35.55 13:43:08 INFO - PID 10071 | Values: 75.0 74.0 79.0 184.0 75.0 77.0 76.0 86.0 97.0 74.0 13:43:08 INFO - PID 10071 | 13:43:08 INFO - PID 10071 | [#4] audio-oscillator Cycles:10 Average:97.40 Median:79.50 stddev:28.25 (35.5%) stddev-sans-first:29.08 13:43:08 INFO - PID 10071 | Values: 78.0 82.0 135.0 80.0 81.0 83.0 129.0 78.0 79.0 149.0 13:43:08 INFO - PID 10071 | 13:43:08 INFO - PID 10071 | [#5] imaging-gaussian-blur Cycles:10 Average:115.40 Median:115.00 stddev:2.37 (2.1%) stddev-sans-first:2.35 13:43:08 INFO - PID 10071 | Values: 113.0 114.0 114.0 114.0 115.0 117.0 117.0 114.0 115.0 121.0 13:43:08 INFO - PID 10071 | 13:43:08 INFO - PID 10071 | [#6] imaging-darkroom Cycles:10 Average:151.50 Median:151.00 stddev:2.32 (1.5%) stddev-sans-first:2.46 13:43:08 INFO - PID 10071 | Values: 151.0 150.0 151.0 156.0 150.0 150.0 154.0 154.0 150.0 149.0 13:43:08 INFO - PID 10071 | 13:43:08 INFO - PID 10071 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:94.00 stddev:3.02 (3.2%) stddev-sans-first:2.83 13:43:08 INFO - PID 10071 | Values: 100.0 102.0 95.0 94.0 93.0 96.0 98.0 94.0 94.0 94.0 13:43:08 INFO - PID 10071 | 13:43:08 INFO - PID 10071 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:58.00 stddev:2.63 (4.5%) stddev-sans-first:2.79 13:43:08 INFO - PID 10071 | Values: 58.0 58.0 58.0 55.0 61.0 55.0 62.0 59.0 56.0 54.0 13:43:08 INFO - PID 10071 | 13:43:08 INFO - PID 10071 | [#9] json-stringify-tinderbox Cycles:10 Average:54.10 Median:54.00 stddev:1.20 (2.2%) stddev-sans-first:1.27 13:43:08 INFO - PID 10071 | Values: 54.0 53.0 54.0 54.0 55.0 53.0 57.0 53.0 54.0 54.0 13:43:08 INFO - PID 10071 | 13:43:08 INFO - PID 10071 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:90.50 stddev:7.35 (8.1%) stddev-sans-first:7.23 13:43:08 INFO - PID 10071 | Values: 94.0 95.0 79.0 79.0 84.0 82.0 75.0 93.0 88.0 93.0 13:43:08 INFO - PID 10071 | 13:43:08 INFO - PID 10071 | [#11] stanford-crypto-ccm Cycles:10 Average:138.50 Median:139.00 stddev:13.67 (9.8%) stddev-sans-first:14.15 13:43:08 INFO - PID 10071 | Values: 130.0 138.0 146.0 140.0 142.0 126.0 136.0 125.0 130.0 172.0 13:43:08 INFO - PID 10071 | 13:43:08 INFO - PID 10071 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.50 Median:180.50 stddev:6.72 (3.7%) stddev-sans-first:7.13 13:43:08 INFO - PID 10071 | Values: 180.0 177.0 175.0 191.0 172.0 182.0 189.0 181.0 170.0 178.0 13:43:08 INFO - PID 10071 | 13:43:08 INFO - PID 10071 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.50 stddev:2.75 (4.0%) stddev-sans-first:2.88 13:43:08 INFO - PID 10071 | Values: 69.0 70.0 67.0 65.0 71.0 68.0 72.0 65.0 64.0 66.0 13:43:08 INFO - PID 10071 | -------- Summary: end -------- 13:43:08 INFO - PID 10071 | 13:43:08 INFO - PID 10071 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 13:43:08 INFO - TEST-INFO | 10071: exit 0 13:43:08 INFO - TEST-OK | kraken | took 62741ms 13:43:08 INFO - SUITE-END | took 1174s 13:43:09 INFO - Completed test suite (00:19:34) 13:43:09 INFO - javascript benchmark 13:43:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8465.355747394986, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3140.5760222369972, 3169.524571314304, 3175.507796291575, 3177.714005739483, 3234.967650323496, 6146.231721034871, 6267.153934218891, 6276.372362763727, 6292.3707629237115, 6295.590786598867, 6124.081387791834, 6226.564140510166, 6246.562740608159, 6251.4686251668545, 6259.749610015605, 5674.432556744313, 5701.629394089392, 5725.312962444492, 5739.139129130622, 5810.099434587624, 5732.828015159531, 5785.247917770684, 5790.797322093727, 5798.0, 5802.39074897136, 135.90901997348988, 5621.634593751393, 5648.237487939137, 5759.913601295984, 5773.913391299134, 5586.804461843816, 5611.971940140314, 5631.690257035862, 5720.771169153229, 5734.225879506255, 5554.1391084381585, 5600.691961942091, 5678.886422271573, 5693.800716974927, 5694.0, 6025.457708806184, 6043.3956604339655, 6048.183495228176, 6121.693915304261, 6128.601640893327, 6597.703103360361, 6635.93364066358, 6665.200175978865, 6696.263411024784, 6718.6304753238555, 6598.0, 6688.966555167193, 6709.664516774191, 6789.388954994025, 6799.320067993211, 6211.9689401552705, 6222.471089957359, 6224.751009959641, 6227.87544249117, 6230.688465576748, 6772.5936443813525, 6844.110265665531, 6853.383195512428, 6854.3145685432055, 6865.41643960269, 6403.48772098231, 6449.59423082647, 6501.8699626008165, 6502.0, 6504.869902602016, 6606.141201643852, 6616.0, 6623.43700785429, 6657.367550082734, 6657.766978155838, 6437.517186211053, 6474.967625161844, 6540.967295163494, 6546.050822630692, 6552.049952756824, 6471.313118315801, 6513.967430162819, 6541.0, 6589.143411356589, 6655.6339401332425, 5423.132298832168, 5440.211169380417, 5466.262054622575, 5469.589780766459, 5469.781208751685, 4673.462551806518, 4701.365315682339, 4749.548792864673, 4755.429348478205, 4775.21209000518, 5776.537876969833, 5840.445157710011, 5847.649141051551, 5847.707614619337, 5858.150568167592, 6660.60036397808, 6669.733210671616, 6689.364510371507, 6765.830854228684, 6768.289329620417, 5657.830265092054, 5701.743421546041, 5724.026915424388, 5731.340895797037, 5738.971305143531, 5897.439743224387, 5971.4327138921735, 5972.343042265347, 5974.2830860297045, 5974.3726908674835, 6471.9029214561815, 6480.935190648128, 6517.478601711851, 6557.245916719543, 6560.835979100465, 6669.566478178903, 6684.7326106957125, 6746.325367463312, 6781.966090169715, 6787.592744435349, 6334.239891213084, 6387.712552935036, 6436.903446448214, 6446.580972236789, 6553.901691474536, 6560.868782624416, 6568.770093046721, 6582.275949645439, 6591.901121483085, 6602.042703808017, 6660.900086498609, 6820.522563420712, 6826.214985276558, 6827.180738311435, 6832.214295356098, 6478.449331806849, 6486.254080780771, 6569.310222426577, 6578.407943284936, 6588.934110658832, 6321.462675672619, 6465.967670161619, 6479.643619600967, 6537.803865884031, 6562.179727534059, 6380.776672816429, 6382.425581697669, 6397.936020639734, 6409.0, 6438.484921206386, 6393.552451328363, 6512.511561632802, 6529.118568993315, 6532.967335163294, 6588.275289718032, 6266.780662676784, 6280.152179455715, 6355.682215889279, 6370.203724534434, 6385.265694445013], "value": 6046.740274794586, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [801.5150833745583, 840.2311884625568, 869.1308691308691, 888.9644414223435, 893.8703887936249, 39738.80130599347, 40849.18301633966, 40877.38683919744, 40897.0, 40908.59091409085, 36764.0, 37252.81373593128, 37287.0, 37362.252754944886, 37365.813170934176, 6742.056112144292, 6845.555038922479, 6849.657517124148, 6851.931480685204, 6873.140857392826, 6776.186857577073, 6856.862862742742, 6857.931420685779, 6868.141482314711, 6872.828179295508, 6821.079154314179, 7412.925870741277, 7679.347255483291, 7683.692652293901, 7690.730824421146, 7610.353119984808, 7643.732469363574, 7647.158812530617, 7663.961680191619, 7671.079470463525, 7402.370798482136, 7545.320921117126, 7584.317411432942, 7610.695572177106, 7624.466287359887, 38501.229975400616, 39135.0, 39239.21521569553, 39246.0, 39346.40980385296, 3385.6106547747077, 3430.262493563871, 3439.8108104054268, 3447.207142357272, 3448.413769659164, 30774.230644234074, 30985.605647745906, 30992.53511197334, 31038.534421983688, 31148.377032459222, 4989.950100498985, 5010.048090862724, 5013.24801279811, 5036.320096786923, 5074.873128171788, 221659.0, 224336.0, 225312.0, 226371.0, 226699.0, 47360.28959565609, 47420.7628961853, 47447.0, 47568.762156189, 47594.52405475901, 49279.260811087865, 49379.0, 49388.50611493911, 49487.25769113466, 49543.50456495389, 16313.265903034391, 16668.49994500167, 16678.416255431002, 16685.16574171311, 16716.331346746236, 13816.654583635489, 13868.86131138696, 13975.09161904473, 13976.790348144787, 13978.231197284043, 13996.16023038621, 14005.859941400658, 14091.577252682437, 14121.08212966154, 14285.500007499688, 5703.7433315500075, 5713.285839270091, 5734.225879506297, 5756.510696590753, 5760.539156867524, 916.1159481100769, 923.6905636611676, 929.7783181276908, 934.4253284230285, 940.3323640215524, 22390.776092239194, 22480.550388992127, 22558.0, 22703.432414189778, 22756.658650120262, 1023.130339211679, 1036.7149034015706, 1038.4340534408766, 1046.5133712823574, 1047.5547892145808, 11926.582569610195, 12006.819897701542, 12032.87967120335, 12090.69773255658, 12116.333601651993, 237404.0, 241413.0, 241584.0, 241635.0, 242545.0, 51555.0, 51583.742081289354, 52662.0, 57167.142492862644, 57193.14210286849, 1443.314425647809, 1494.8579884910698, 1496.311696619567, 1505.7515509940956, 1514.5834895403852, 27199.59200612032, 27291.31771705723, 27524.58713119345, 27619.585706214824, 27623.0, 36697.26605467929, 36757.0, 36783.63216367909, 36816.63183368132, 36905.81547092248, 208338.0, 209339.0, 209360.0, 210107.0, 210894.0, 34748.65251347454, 34850.128746780516, 34958.65041349554, 34991.0, 35063.0, 40216.597834022454, 41723.7913810429, 41733.37399938943, 41992.0, 42203.788981054895, 31217.063488095395, 31273.530897036107, 31420.52869206918, 31669.524957126123, 32448.026559203263, 28515.857420712764, 28704.712952870203, 28907.988220412186, 29051.56422653704, 29128.27179320534, 33578.3284334307, 38149.23701526009, 38791.80604096961, 38815.223695526496, 38846.0, 33666.66333336733, 33700.662993369755, 33856.830715847245, 34205.486917696755, 34291.31417371589, 24126.39684007914, 24644.0, 25170.74829251684, 25383.6192457117, 25572.360690982874], "value": 17104.0750426847, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.8629928817082, 579.4176852263475, 588.8645611509353, 589.3046205477535, 603.529247187194, 21959.0, 22867.19964801228, 22913.312600622008, 22919.656205156894, 22940.0, 24383.512329753394, 26977.32556686084, 27093.864530677318, 27121.593176102375, 27238.59142112865, 6464.062710906904, 6608.867822643544, 6615.6030638161865, 6634.502412319095, 6635.7677481288165, 5935.88128237435, 6432.163818703562, 6508.414242718154, 6510.18622672166, 6523.510736694743, 6487.448566871822, 6488.545801793876, 6492.156019717454, 6493.220813502387, 6493.805185844409, 6471.9029214561815, 6473.320301368359, 6476.708548115323, 6480.319566445526, 6483.189601299838, 5941.376155503696, 5967.522598192134, 5967.5524335675, 5971.611845230046, 6007.969960150215, 29906.85046574775, 30039.699603003908, 30245.336506492135, 30559.08322750321, 30590.082297530887, 1919.5393105654682, 1973.802619738029, 1975.3086419752972, 1975.4073777866727, 1979.257778333125, 18743.0, 19161.61676766471, 19165.425037248766, 19239.23043078275, 19325.13036913342, 2295.185209250725, 2355.140373763581, 2384.9642255366184, 2404.8557086574688, 2420.9031638734427, 133768.33115834455, 135576.0, 136179.0, 136317.3184134083, 136403.6359636401, 13935.516120969758, 14949.860529288753, 15063.0, 15308.004979676509, 15504.689906202038, 22648.094076236765, 24004.51990960171, 24147.7585224149, 24281.271561853173, 24326.51346973086, 10557.832650204908, 10666.253362264568, 10681.519331630096, 10841.620543280947, 10853.403062831461, 9925.255605829592, 9933.453660048623, 10008.749781255527, 10055.798884022279, 10076.59693612262, 9201.309901757395, 9390.62437502506, 9441.339106262496, 9474.95262523683, 9883.950580247052, 2723.836569805818, 2787.4044719793133, 2821.3510892494432, 2830.377316990259, 2891.334992951633, 880.106691707917, 896.4934811831295, 897.8069715011304, 933.4725879877983, 995.2635050062902, 19343.0, 19522.70715939262, 19834.404967850987, 20163.899180504002, 20356.083976221107, 1008.1984822066474, 1046.9371837689612, 1047.4867315015588, 1055.350959160111, 1056.5615269663158, 10714.357138571555, 11113.83329250062, 11147.21969462146, 11178.329300242012, 11233.66299011031, 489711.0, 509278.0, 511564.0, 522708.0, 525739.0, 118773.0, 120623.0, 120903.39548302202, 121217.0, 125713.0, 1201.5934824771869, 1223.2721530689225, 1240.1504969096197, 1240.3674126195706, 1244.3467179730715, 17193.828061719723, 17289.308427663254, 17469.0, 17601.471955841345, 18025.0, 56280.15579766389, 57207.42792572021, 60057.399426005184, 60732.39267607444, 62239.688801555705, 67848.0, 68829.0, 69368.6531567339, 69378.0, 69596.6520167396, 14563.271836408348, 14652.926735366254, 15234.77147842761, 15251.389944402543, 15273.77089343683, 23961.400964976016, 24183.879080604485, 24287.392815179053, 24338.0, 24439.877800611594, 18116.547086322946, 18126.0, 18901.621967560848, 18910.0, 18913.905430472758, 17354.82645173532, 17357.30570777205, 17508.737368939223, 17636.73544896853, 17846.643067138324, 17985.910070449565, 19252.4224273272, 19389.0, 19709.1130899107, 19714.309999149962, 14908.030977986396, 15016.849831501546, 15021.474248401253, 15027.549173524812, 15039.548813535612, 18673.53316167107, 18673.972931488355, 18694.53263668365, 18921.810781892003, 18925.337613183474], "value": 12128.59204632757, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1357.1178733823015, 1411.498917884151, 1429.7354989326975, 1442.18516538156, 1447.5584946591287, 12980.415881285342, 13691.17852928825, 13706.725865482684, 13738.107023043507, 13761.931190344034, 14205.502807401743, 14417.134971901667, 14429.0, 14439.350229239682, 14467.78298325526, 2404.3989002749313, 2438.3050830513307, 2440.890159942798, 2449.497852940152, 2449.889754961022, 2212.0156530344, 2217.589745897006, 2225.3324002799177, 2303.5968705476475, 2358.13927916311, 2347.565700345433, 2382.642603609455, 2383.2969274064108, 2396.1254142238045, 2408.157144999245, 2335.5679199348174, 2346.2022912209845, 2350.823688223373, 2354.399628094842, 2357.363511851799, 2271.7728227177317, 2276.0, 2277.419258089193, 2280.680704701343, 2284.3261237934685, 13509.59471215865, 13671.589852304447, 13835.723285534234, 13849.86150138506, 13856.237906915116, 7157.069580954495, 7259.927400726031, 7458.888116678254, 7466.925330746677, 7507.662155203029, 4952.7523623819025, 5022.84931452057, 5105.463926287761, 5128.205128205134, 5133.743312834344, 2206.5255969966533, 2223.3663405929397, 2334.5526771500317, 2358.2217868103658, 2391.5216956608747, 23034.308970730905, 23440.17959371414, 23531.647025294635, 23659.526809463714, 23714.288571342713, 6550.770723024767, 6691.531592788556, 6874.346937040973, 6933.306669333027, 6946.16646002483, 18115.909420452812, 18147.63704725898, 18176.091195440174, 18179.0, 18187.818121818877, 7476.663550140257, 7691.269329413697, 7691.615419229016, 7692.384609231248, 7712.691492340356, 6810.591364518045, 6915.861682766316, 6967.93032069683, 6992.091028166407, 7016.298370163045, 5326.893462130735, 5434.64674796137, 5451.918221226685, 5473.890522189534, 5519.751611177507, 1659.402615058578, 1676.555712736126, 1730.7576939228518, 1738.7391891216166, 1745.1361576019951, 842.8735689646602, 870.7474832298689, 901.8782464367358, 903.408267584733, 907.464595888429, 7499.137599176055, 7515.023047003854, 7536.547807131589, 7568.356689681329, 7591.354734847489, 723.4321057969574, 745.8993035940078, 746.1046743907333, 750.6359415683389, 755.8752805787094, 5398.595105367034, 5675.971620141955, 5702.743376547983, 5810.564207684441, 5924.7333869975955, 18627.81372186288, 18969.24123035063, 19262.229510819692, 19317.903410482857, 19321.613567728567, 17783.644327113387, 17911.462656120337, 18294.63410731778, 18377.81622183788, 18689.158987845578, 9325.393849399767, 9661.178799802095, 10888.564457421615, 10914.290571113012, 10926.562937482571, 7300.598467084149, 8247.670093196204, 8383.748487545383, 8431.451955622864, 8460.873086903579, 15589.29848156813, 15603.531894043197, 15783.921080394524, 15962.0, 16036.679266414372, 16320.428784992468, 16496.587585310463, 16525.83474165243, 16529.33882644681, 16701.081440520888, 10518.947405262925, 10823.0, 10851.077658399125, 10856.077233434931, 10860.945695271788, 12547.937260314005, 12705.745885082431, 12883.033772466915, 12951.028672849763, 13102.410391532594, 10506.791718952418, 10703.678889633324, 10735.89264107349, 10755.462226888782, 11052.281601695864, 10510.369377837354, 10528.736781580521, 10644.148468122687, 10669.093127083974, 10720.303180293256, 9652.179564736794, 9788.951055244679, 9790.657326993805, 9794.461304628314, 9795.608175672893, 7076.71693132269, 7154.642267886481, 7191.3887319578425, 7240.384567311838, 7306.817329566803, 7346.77959661211, 7393.223711510214, 7508.58702771331, 7514.887276690744, 7573.242675732383], "value": 6299.549689605625, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.80896079651524, 500.989980200396, 514.6834696661555, 526.1187510919211, 536.5627013983603, 6126.387361263872, 6164.476019538339, 6172.475339596129, 6176.691165441721, 6224.595401298918, 5992.970035149818, 6102.877942441149, 6126.203593532835, 6162.137300777895, 6167.167432396625, 4799.904001919959, 4927.753612319388, 4946.0, 5048.570871475929, 5069.898602027957, 4847.733374664392, 4910.0, 4912.852614421573, 4924.80300787968, 4946.876328091808, 4862.7325497097645, 4862.854114376557, 4902.558769710726, 4922.483139270379, 4942.406911170647, 4927.457979622257, 4944.307796908436, 4953.5541801237705, 4961.5038496150455, 4963.503649635044, 4398.912021759579, 4446.133004064209, 4460.149038149164, 4466.977665111686, 4483.237849565549, 5775.913361299584, 5779.988502012173, 5845.210896528999, 5889.352171261158, 5911.55663325248, 5656.604037717361, 5670.716464176816, 5671.859542533932, 5691.743871525791, 5694.316681998145, 6316.463100636452, 6442.549021568492, 6457.515686323498, 6479.6760161991715, 6482.708278127496, 4813.66304358695, 4842.951570484285, 4849.151398505247, 4852.17513022787, 4855.854324370239, 6511.641859697715, 6551.508636852255, 6697.129373181504, 6723.5965842049145, 6863.38229559342, 4898.90202195954, 4927.211646136601, 4945.802167913315, 4951.900961980812, 4972.602191824645, 5010.123228435009, 5042.218456139304, 5044.218146187347, 5065.442801291855, 5070.873228169326, 5478.534324582375, 5565.888682226333, 5652.74562644682, 5659.783146623414, 5681.204631351614, 6509.349065093547, 6516.6415847128865, 6525.282218955911, 6537.509686773511, 6584.407403333723, 1734.4276388791668, 1738.209114852739, 1741.1642411642229, 1771.6545273671768, 1776.0764402510622, 1167.2529581068122, 1200.8919197272287, 1225.7916154253799, 1245.2839617219954, 1251.1429670675616, 5724.484796368347, 5746.511546518509, 5769.48074673273, 5773.538116950634, 5778.566607504454, 6508.479321654257, 6555.901661475082, 6649.767258146038, 6653.667316634149, 6653.733850646016, 5759.6832174229985, 5786.305643322744, 5790.88418231633, 5814.76740930358, 5816.680082595498, 3484.9477257841154, 3575.7496975211484, 3596.5684117906017, 3597.892063238107, 3603.9099022524124, 6422.550421470546, 6456.257530384066, 6488.188976377953, 6502.317256687979, 6545.280019197884, 6749.730010799612, 6790.287019862942, 6850.897236541456, 6859.5541289817, 6860.451163906875, 6485.383888530582, 6489.67551622417, 6560.179977502812, 6560.540762146604, 6570.638614876132, 6091.482224011009, 6725.630090345078, 6738.966305168639, 6750.257471678014, 6762.49281303914, 6482.546221764431, 6496.382843629847, 6530.579618916383, 6622.139121914313, 6645.401913827779, 6298.622082675054, 6354.090695653087, 6364.64994425311, 6494.285628580947, 6517.0, 4966.428860681068, 4975.975120124376, 4976.004799040279, 4977.875553111201, 5027.974860125676, 6370.8088757337355, 6391.886490807243, 6415.615063096229, 6645.468362530889, 6683.6324002180345, 6363.331850155852, 6402.519811014286, 6416.326285740117, 6417.71645670877, 6474.863295112696, 6331.2085989251345, 6350.460210882126, 6417.96791016042, 6494.675266236574, 6497.967510162419, 6368.108464814837, 6402.775902843378, 6452.741890324334, 6479.416852483299, 6482.35176482348, 6457.6771161442675, 6495.5966292472085, 6554.705038273194, 6564.409203171737, 6599.53803233769, 6282.811515654537, 6316.494680425463, 6329.493640508656, 6333.398327158912, 6339.270983836917], "value": 5008.016676178118, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [897.8832751742273, 913.0413066280405, 916.9541522923852, 929.7257309093817, 934.2059249637806, 18727.906360468194, 19717.901410492945, 19722.30971915983, 19749.210031598755, 21596.784032159674, 21716.2399316024, 22309.0, 22348.21781237657, 22394.32817015492, 22424.215152469667, 1014.1379827146922, 1056.5404049238605, 1059.7191744187796, 1060.0883240413239, 1060.0989159214682, 1016.9847452288221, 1048.0043958239664, 1051.805415998043, 1055.208593554834, 1055.6621880998084, 1099.4612639806478, 1100.7138144082517, 1100.785346857363, 1101.7686285879975, 1102.1733699725205, 1098.4288170151517, 1099.4118146791468, 1101.058594901364, 1101.2236373356845, 1101.5428597132181, 809.3323008517996, 811.2698571285831, 812.8943237379162, 814.0, 815.8898548695969, 19281.903590481958, 20078.0, 20342.18631254748, 20732.5853482931, 20848.895755521276, 21774.45563860916, 22020.229291974705, 22066.66899996501, 22279.220227292128, 22370.55258894813, 16987.91506042474, 17125.743113853303, 17176.39882604103, 17362.0, 17519.124043797885, 3445.810480423576, 3463.307338532278, 3464.0993341731332, 3464.826758662057, 3465.8440370183403, 130772.0, 131886.0, 132816.0, 133661.0, 136753.31623341818, 16429.753553696704, 16590.83409165917, 16740.49778506647, 16859.409920652717, 16933.83066169347, 27654.72345276562, 28716.425671486453, 28887.133385998455, 28893.71106288952, 29137.7086229135, 7806.570638614817, 8173.591320433955, 8191.631376588068, 8527.872081918777, 8751.212390884724, 4257.382679511454, 4343.67422443318, 4377.8248870044845, 4387.363832244307, 4390.275604525217, 5164.147915593885, 5247.2653828464045, 5255.448177941337, 5299.761510732026, 5317.813876514381, 974.9415035097917, 978.3054031637474, 991.6281394477071, 1007.2999265510547, 1007.5012868630075, 641.3970867384644, 657.3295238856435, 671.8454755406284, 678.1929503890354, 679.3104998426601, 11172.832407513893, 11977.576954535556, 12272.202306850026, 13220.083087952193, 13295.335233238493, 700.3381804194987, 712.3588770106842, 715.6242972439511, 726.2555880222814, 733.8385555177853, 5426.914617076601, 5647.124695672177, 5745.741441635137, 6290.370962903765, 6300.243970723543, 101892.49053754832, 106119.4694026525, 108153.0, 110323.0, 111721.0, 94475.3969282302, 95550.52224738832, 96036.51981740046, 96156.0, 97101.0, 78459.60770196226, 79120.60439697765, 80870.0, 82637.0, 83216.75174872382, 12489.313087779896, 12804.679883003, 13200.405981731037, 13201.273929933946, 13284.800727988895, 36621.26757464783, 37389.81305093457, 37472.437913431866, 37600.43599346067, 37912.24175516419, 65241.0, 68099.65950170218, 68408.0, 70913.0, 73613.63193183999, 15809.446669366516, 17749.822501774815, 18039.729404058686, 18150.45548633543, 18249.81750182481, 20762.792372076085, 21703.45741356479, 21971.450713732283, 22259.109635614393, 22796.88601557048, 18954.24183032663, 19137.712934306273, 19474.902625486782, 19622.8037719621, 19685.60628787445, 18627.90686046561, 18936.715949260495, 19676.60646787085, 19937.102830372958, 20348.28780992658, 18405.81594184041, 18821.529461763566, 19087.8091219086, 19191.0, 19470.513237169183, 13219.867801321863, 13595.86404135946, 13904.791428128385, 14128.78806817878, 14161.575152745434, 13092.214467132002, 13450.0, 13699.726005480034, 13703.246321452416, 15022.248887555797], "value": 9299.019304519314, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1549.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 107.0, 101.0, 107.0, 109.0, 113.0, 110.0, 98.0, 111.0, 108.0], "value": 107.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 123.0, 140.0, 177.0, 125.0, 159.0, 147.0, 124.0, 172.0, 120.0], "value": 143.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 168.0, 161.0, 164.0, 169.0, 175.0, 166.0, 162.0, 163.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 79.0, 184.0, 75.0, 77.0, 76.0, 86.0, 97.0, 74.0], "value": 89.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 82.0, 135.0, 80.0, 81.0, 83.0, 129.0, 78.0, 79.0, 149.0], "value": 97.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 114.0, 115.0, 117.0, 117.0, 114.0, 115.0, 121.0], "value": 115.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 151.0, 156.0, 150.0, 150.0, 154.0, 154.0, 150.0, 149.0], "value": 151.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 102.0, 95.0, 94.0, 93.0, 96.0, 98.0, 94.0, 94.0, 94.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 55.0, 61.0, 55.0, 62.0, 59.0, 56.0, 54.0], "value": 57.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 54.0, 55.0, 53.0, 57.0, 53.0, 54.0, 54.0], "value": 54.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 79.0, 79.0, 84.0, 82.0, 75.0, 93.0, 88.0, 93.0], "value": 86.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 138.0, 146.0, 140.0, 142.0, 126.0, 136.0, 125.0, 130.0, 172.0], "value": 138.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 177.0, 175.0, 191.0, 172.0, 182.0, 189.0, 181.0, 170.0, 178.0], "value": 179.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 67.0, 65.0, 71.0, 68.0, 72.0, 65.0, 64.0, 66.0], "value": 67.7, "unit": "score"}]}]} 13:43:09 INFO - Return code: 0 13:43:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:43:09 INFO - # TBPL SUCCESS # 13:43:09 INFO - Running post-action listener: _package_coverage_data 13:43:09 INFO - Running post-action listener: _resource_record_post_action 13:43:09 INFO - [mozharness: 2017-08-04 20:43:09.376425Z] Finished run-tests step (success) 13:43:09 INFO - Running post-run listener: _resource_record_post_run 13:43:09 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 8192; Write bytes: 432320512; Read time: 180; Write time: 239856 13:43:09 INFO - TinderboxPrint: CPU usage
13.2% 13:43:09 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 180 13:43:09 INFO - TinderboxPrint: I/O write bytes / time
432,320,512 / 239,856 13:43:09 INFO - TinderboxPrint: CPU idle
8,258.0 (86.8%) 13:43:09 INFO - TinderboxPrint: CPU user
1,205.3 (12.7%) 13:43:09 INFO - TinderboxPrint: Swap in / out
0 / 0 13:43:09 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106782720; Read time: 0; Write time: 59680 13:43:09 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 13:43:09 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 325537792; Read time: 172; Write time: 180176 13:43:10 INFO - Running post-run listener: _upload_blobber_files 13:43:10 INFO - Blob upload gear active. 13:43:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:43:10 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 13:43:10 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'] 13:43:10 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 13:43:10 INFO - (blobuploader) - INFO - Open directory for files ... 13:43:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:43:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:43:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:43:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:43:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:43:11 INFO - (blobuploader) - INFO - Done attempting. 13:43:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:43:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:43:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:43:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:43:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:43:12 INFO - (blobuploader) - INFO - Done attempting. 13:43:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:43:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:43:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:43:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:43:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:43:19 INFO - (blobuploader) - INFO - Done attempting. 13:43:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:43:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:43:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:43:20 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:43:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:43:20 INFO - (blobuploader) - INFO - Done attempting. 13:43:20 INFO - (blobuploader) - INFO - Iteration through files over. 13:43:20 INFO - Return code: 0 13:43:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:43:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:43:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fba1c897af3424097ca35b5ca9ef126fa5be7d6e0e04a4a003a676b57529d23095e72f71c8551461ddb5fd6d81f2cfb59f60f5c0af350a3a37a40dfad0af67e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa01b842c9ecee3ea02de9c897650a6c157e835eec2a5356bced57e81089e5d071144d9aad664c77f00674658a0954867965c8d9b0e5802977a21458efb93ec7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/331829d5d526c76d7a1b22203c5ed7d4e294f7a13b5d30f60a3b61262b634e816406af5a9ded3d3a409832a87c7ce197ac0004206add592a0942b4297ba8cc1c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7fdd42e0ec73029f1a511ab5e1dbfaab3ee6b59a3bc8a02256a3bfa8753ccf7aa280b80c9d60e1a77e3730de67126517238310f9d16a44f0ebc5f961ab714ad"} 13:43:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:43:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:43:20 INFO - Contents: 13:43:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fba1c897af3424097ca35b5ca9ef126fa5be7d6e0e04a4a003a676b57529d23095e72f71c8551461ddb5fd6d81f2cfb59f60f5c0af350a3a37a40dfad0af67e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa01b842c9ecee3ea02de9c897650a6c157e835eec2a5356bced57e81089e5d071144d9aad664c77f00674658a0954867965c8d9b0e5802977a21458efb93ec7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/331829d5d526c76d7a1b22203c5ed7d4e294f7a13b5d30f60a3b61262b634e816406af5a9ded3d3a409832a87c7ce197ac0004206add592a0942b4297ba8cc1c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7fdd42e0ec73029f1a511ab5e1dbfaab3ee6b59a3bc8a02256a3bfa8753ccf7aa280b80c9d60e1a77e3730de67126517238310f9d16a44f0ebc5f961ab714ad"} 13:43:20 INFO - Running post-run listener: copy_logs_to_upload_dir 13:43:20 INFO - Copying logs to upload dir... 13:43:20 INFO - mkdir: /builds/slave/test/build/upload/logs 13:43:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.227853 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-08-04 13:43:20.147901) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-04 13:43:20.151745) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1501874190.24912-1481130047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fba1c897af3424097ca35b5ca9ef126fa5be7d6e0e04a4a003a676b57529d23095e72f71c8551461ddb5fd6d81f2cfb59f60f5c0af350a3a37a40dfad0af67e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa01b842c9ecee3ea02de9c897650a6c157e835eec2a5356bced57e81089e5d071144d9aad664c77f00674658a0954867965c8d9b0e5802977a21458efb93ec7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/331829d5d526c76d7a1b22203c5ed7d4e294f7a13b5d30f60a3b61262b634e816406af5a9ded3d3a409832a87c7ce197ac0004206add592a0942b4297ba8cc1c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7fdd42e0ec73029f1a511ab5e1dbfaab3ee6b59a3bc8a02256a3bfa8753ccf7aa280b80c9d60e1a77e3730de67126517238310f9d16a44f0ebc5f961ab714ad"} build_url:https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011380 build_url: 'https://queue.taskcluster.net/v1/task/fr-KaQa9SOOeGyxNTNR3Ww/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fba1c897af3424097ca35b5ca9ef126fa5be7d6e0e04a4a003a676b57529d23095e72f71c8551461ddb5fd6d81f2cfb59f60f5c0af350a3a37a40dfad0af67e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa01b842c9ecee3ea02de9c897650a6c157e835eec2a5356bced57e81089e5d071144d9aad664c77f00674658a0954867965c8d9b0e5802977a21458efb93ec7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/331829d5d526c76d7a1b22203c5ed7d4e294f7a13b5d30f60a3b61262b634e816406af5a9ded3d3a409832a87c7ce197ac0004206add592a0942b4297ba8cc1c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7fdd42e0ec73029f1a511ab5e1dbfaab3ee6b59a3bc8a02256a3bfa8753ccf7aa280b80c9d60e1a77e3730de67126517238310f9d16a44f0ebc5f961ab714ad"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-04 13:43:20.177704) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 13:43:20.178053) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1501874190.24912-1481130047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004499 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 13:43:20.227262) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-04 13:43:20.227570) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-04 13:43:20.227860) ========= ========= Total master_lag: 0.12 =========