builder: cedar_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-007 starttime: 1501774580.23 results: success (0) revision: ea2cff37acfa508d6d944e1773d8f474ee61cbb7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-03 08:36:20.225946) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-03 08:36:20.226658) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-03 08:36:20.227359) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-03 08:36:20.265418) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 08:36:20.266006) ========= 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=923d835db2ba3686ebe126b700000192-1501773957.580654-351862154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-03 08:36:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 39.7M=0s 2017-08-03 08:36:20 (39.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.096172 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 08:36:20.381474) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 08:36:20.381990) ========= 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=923d835db2ba3686ebe126b700000192-1501773957.580654-351862154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016982 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 08:36:20.432456) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 13 secs) (at 2017-08-03 08:36:20.432864) ========= bash -c 'python archiver_client.py mozharness --repo projects/cedar --rev ea2cff37acfa508d6d944e1773d8f474ee61cbb7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo projects/cedar --rev ea2cff37acfa508d6d944e1773d8f474ee61cbb7 --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=923d835db2ba3686ebe126b700000192-1501773957.580654-351862154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-03 08:36:20,670 truncating revision to first 12 chars 2017-08-03 08:36:20,670 Setting DEBUG logging. 2017-08-03 08:36:20,670 attempt 1/10 2017-08-03 08:36:20,670 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/cedar/ea2cff37acfa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-03 08:36:21,291 attempt 1/10 2017-08-03 08:36:21,957 current task status: no status available at this point. state: STARTED 2017-08-03 08:36:21,957 sleeping for 11.00s (attempt 1/10) 2017-08-03 08:36:32,968 attempt 2/10 2017-08-03 08:36:33,301 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-08-03 08:36:33,534 unpacking tar archive at: cedar-ea2cff37acfa/testing/mozharness/ program finished with exit code 0 elapsedTime=13.180610 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 13 secs) (at 2017-08-03 08:36:33.625664) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-03 08:36:33.626068) ========= script_repo_revision: ea2cff37acfa508d6d944e1773d8f474ee61cbb7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-03 08:36:33.626769) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-03 08:36:33.627256) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-03 08:36:33.637405) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-08-03 08:36:33.637805) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Cedar --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Cedar', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Cedar'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=923d835db2ba3686ebe126b700000192-1501773957.580654-351862154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:36:33 INFO - MultiFileLogger online at 20170803 08:36:33 in /builds/slave/test 08:36:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Cedar --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 08:36:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:36:33 INFO - {'append_to_log': False, 08:36:33 INFO - 'base_work_dir': '/builds/slave/test', 08:36:33 INFO - 'blob_upload_branch': 'Cedar', 08:36:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:36:33 INFO - 'branch': 'Cedar', 08:36:33 INFO - 'buildbot_json_path': 'buildprops.json', 08:36:33 INFO - 'code_coverage': False, 08:36:33 INFO - 'config_files': ('talos/linux_config.py',), 08:36:33 INFO - 'default_actions': ('clobber', 08:36:33 INFO - 'read-buildbot-config', 08:36:33 INFO - 'download-and-extract', 08:36:33 INFO - 'populate-webroot', 08:36:33 INFO - 'create-virtualenv', 08:36:33 INFO - 'install', 08:36:33 INFO - 'setup-mitmproxy', 08:36:33 INFO - 'run-tests'), 08:36:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:36:33 INFO - 'disable_ccov_upload': False, 08:36:33 INFO - 'download_minidump_stackwalk': True, 08:36:33 INFO - 'download_symbols': 'ondemand', 08:36:33 INFO - 'enable_stylo': False, 08:36:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:36:33 INFO - 'tooltool.py': '/tools/tooltool.py', 08:36:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:36:33 INFO - '/tools/misc-python/virtualenv.py')}, 08:36:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:36:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:36:33 INFO - 'gecko_profile': False, 08:36:33 INFO - 'gecko_profile_interval': 0, 08:36:33 INFO - 'installer_path': 'installer.exe', 08:36:33 INFO - 'log_level': 'info', 08:36:33 INFO - 'log_name': 'talos', 08:36:33 INFO - 'log_to_console': True, 08:36:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:36:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:36:33 INFO - 'opt_config_files': (), 08:36:33 INFO - 'pip_index': False, 08:36:33 INFO - 'suite': 'dromaeojs-e10s', 08:36:33 INFO - 'system_bits': '32', 08:36:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:36:33 INFO - 'title': 'talos-linux64-ix-007', 08:36:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:36:33 INFO - 'use_talos_json': True, 08:36:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:36:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:36:33 INFO - 'work_dir': 'build'} 08:36:33 INFO - [mozharness: 2017-08-03 15:36:33.990359Z] Running clobber step. 08:36:33 INFO - Running pre-action listener: _resource_record_pre_action 08:36:33 INFO - Running main action method: clobber 08:36:33 INFO - rmtree: /builds/slave/test/build 08:36:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:36:35 INFO - Running post-action listener: _resource_record_post_action 08:36:35 INFO - [mozharness: 2017-08-03 15:36:35.522905Z] Finished clobber step (success) 08:36:35 INFO - [mozharness: 2017-08-03 15:36:35.523007Z] Running read-buildbot-config step. 08:36:35 INFO - Running pre-action listener: _resource_record_pre_action 08:36:35 INFO - Running main action method: read_buildbot_config 08:36:35 INFO - Using buildbot properties: 08:36:35 INFO - { 08:36:35 INFO - "project": "", 08:36:35 INFO - "product": "firefox", 08:36:35 INFO - "who": "mconley@mozilla.com", 08:36:35 INFO - "installer_path": "public/build/target.tar.bz2", 08:36:35 INFO - "builddir": "cedar_ubuntu64_hw_test-dromaeojs-e10s", 08:36:35 INFO - "repository": "https://hg.mozilla.org/projects/cedar", 08:36:35 INFO - "buildername": "Ubuntu HW 12.04 x64 cedar talos dromaeojs-e10s", 08:36:35 INFO - "stage_platform": "linux64", 08:36:35 INFO - "basedir": "/builds/slave/test", 08:36:35 INFO - "buildnumber": 17, 08:36:35 INFO - "platform": "ubuntu64_hw", 08:36:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:36:35 INFO - "slavebuilddir": "test", 08:36:35 INFO - "taskId": "C3mLGmMoQWaSt-2dt0RVIQ", 08:36:35 INFO - "branch": "cedar", 08:36:35 INFO - "script_repo_revision": "default", 08:36:35 INFO - "revision": "ea2cff37acfa508d6d944e1773d8f474ee61cbb7", 08:36:35 INFO - "slavename": "talos-linux64-ix-007", 08:36:35 INFO - "repo_path": "projects/cedar" 08:36:35 INFO - } 08:36:35 INFO - Finding installer, test and symbols from parent task. 08:36:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C3mLGmMoQWaSt-2dt0RVIQ'}, attempt #1 08:36:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C3mLGmMoQWaSt-2dt0RVIQ'}, attempt #1 08:36:36 INFO - Task dependencies: eJMMbl1FT968FVBWv0HPng 08:36:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eJMMbl1FT968FVBWv0HPng'}, attempt #1 08:36:36 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/eJMMbl1FT968FVBWv0HPng/artifacts/public/build/target.tar.bz2 08:36:36 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/eJMMbl1FT968FVBWv0HPng/artifacts/public/build/target.test_packages.json 08:36:36 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/eJMMbl1FT968FVBWv0HPng/artifacts/public/build/target.crashreporter-symbols.zip 08:36:36 INFO - Running post-action listener: _resource_record_post_action 08:36:36 INFO - [mozharness: 2017-08-03 15:36:36.877878Z] Finished read-buildbot-config step (success) 08:36:36 INFO - [mozharness: 2017-08-03 15:36:36.878099Z] Running download-and-extract step. 08:36:36 INFO - Running pre-action listener: _resource_record_pre_action 08:36:36 INFO - Running main action method: download_and_extract 08:36:36 INFO - mkdir: /builds/slave/test/build/tests 08:36:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:36 INFO - trying https://queue.taskcluster.net/v1/task/eJMMbl1FT968FVBWv0HPng/artifacts/public/build/target.test_packages.json 08:36:36 INFO - Downloading https://queue.taskcluster.net/v1/task/eJMMbl1FT968FVBWv0HPng/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:36:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eJMMbl1FT968FVBWv0HPng/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:36:37 INFO - Downloaded 989 bytes. 08:36:37 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:36:37 INFO - Using the following test package requirements: 08:36:37 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:36:37 INFO - u'common': [u'target.common.tests.zip'], 08:36:37 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:36:37 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:36:37 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:36:37 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:36:37 INFO - u'mozbase': [u'target.common.tests.zip'], 08:36:37 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:36:37 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:36:37 INFO - u'web-platform': [u'target.common.tests.zip', 08:36:37 INFO - u'target.web-platform.tests.tar.gz'], 08:36:37 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:36:37 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:36:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eJMMbl1FT968FVBWv0HPng/artifacts/public/build/target.common.tests.zip 08:36:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eJMMbl1FT968FVBWv0HPng/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:36:37 INFO - Fetch https://queue.taskcluster.net/v1/task/eJMMbl1FT968FVBWv0HPng/artifacts/public/build/target.common.tests.zip into memory 08:36:38 INFO - Content-Length response header: 54278326 08:36:38 INFO - Bytes received: 54278326 08:36:49 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:36:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eJMMbl1FT968FVBWv0HPng/artifacts/public/build/target.common.tests.zip 08:36:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eJMMbl1FT968FVBWv0HPng/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:36:49 INFO - Fetch https://queue.taskcluster.net/v1/task/eJMMbl1FT968FVBWv0HPng/artifacts/public/build/target.common.tests.zip into memory 08:36:50 INFO - Content-Length response header: 54278326 08:36:50 INFO - Bytes received: 54278326 08:37:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eJMMbl1FT968FVBWv0HPng/artifacts/public/build/target.talos.tests.zip 08:37:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eJMMbl1FT968FVBWv0HPng/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:37:02 INFO - Fetch https://queue.taskcluster.net/v1/task/eJMMbl1FT968FVBWv0HPng/artifacts/public/build/target.talos.tests.zip into memory 08:37:03 INFO - Content-Length response header: 14496464 08:37:03 INFO - Bytes received: 14496464 08:37:03 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')]} 08:37:03 INFO - trying https://queue.taskcluster.net/v1/task/eJMMbl1FT968FVBWv0HPng/artifacts/public/build/target.tar.bz2 08:37:03 INFO - Downloading https://queue.taskcluster.net/v1/task/eJMMbl1FT968FVBWv0HPng/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:37:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eJMMbl1FT968FVBWv0HPng/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:37:04 INFO - Downloaded 62281492 bytes. 08:37:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eJMMbl1FT968FVBWv0HPng/artifacts/public/build/target.tar.bz2 08:37:04 INFO - mkdir: /builds/slave/test/properties 08:37:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:37:04 INFO - Writing to file /builds/slave/test/properties/build_url 08:37:04 INFO - Contents: 08:37:04 INFO - build_url:https://queue.taskcluster.net/v1/task/eJMMbl1FT968FVBWv0HPng/artifacts/public/build/target.tar.bz2 08:37:04 INFO - Running post-action listener: _resource_record_post_action 08:37:04 INFO - Running post-action listener: set_extra_try_arguments 08:37:04 INFO - [mozharness: 2017-08-03 15:37:04.866598Z] Finished download-and-extract step (success) 08:37:04 INFO - [mozharness: 2017-08-03 15:37:04.866697Z] Running populate-webroot step. 08:37:04 INFO - Running pre-action listener: _resource_record_pre_action 08:37:04 INFO - Running main action method: populate_webroot 08:37:04 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:37:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:37:04 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:37:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:37:04 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:37:04 INFO - 'tests': ['damp', 'tps']}, 08:37:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:37:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:37:04 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:37:04 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:37:04 INFO - 'other-e10s': {'tests': ['a11yr', 08:37:04 INFO - 'ts_paint', 08:37:04 INFO - 'tpaint', 08:37:04 INFO - 'sessionrestore', 08:37:04 INFO - 'sessionrestore_many_windows', 08:37:04 INFO - 'sessionrestore_no_auto_restore', 08:37:04 INFO - 'tabpaint']}, 08:37:04 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 08:37:04 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 08:37:04 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:37:04 INFO - 'talos_options': ['--mitmproxy', 08:37:04 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:37:04 INFO - '--firstNonBlankPaint'], 08:37:04 INFO - 'tests': ['quantum_pageload_google', 08:37:04 INFO - 'quantum_pageload_youtube', 08:37:04 INFO - 'quantum_pageload_amazon', 08:37:04 INFO - 'quantum_pageload_facebook']}, 08:37:04 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:37:04 INFO - 'talos_options': ['--stylo', 08:37:04 INFO - '--mitmproxy', 08:37:04 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:37:04 INFO - '--firstNonBlankPaint'], 08:37:04 INFO - 'tests': ['quantum_pageload_google', 08:37:04 INFO - 'quantum_pageload_youtube', 08:37:04 INFO - 'quantum_pageload_amazon', 08:37:04 INFO - 'quantum_pageload_facebook']}, 08:37:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:37:04 INFO - 'tsvgr_opacity', 08:37:04 INFO - 'tart', 08:37:04 INFO - 'tscrollx', 08:37:04 INFO - 'cart', 08:37:04 INFO - 'tsvg_static']}, 08:37:04 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:37:04 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:37:04 INFO - 'talos_options': ['--stylo', 08:37:04 INFO - '--stylo-threads=1', 08:37:04 INFO - '--mitmproxy', 08:37:04 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:37:04 INFO - '--firstNonBlankPaint'], 08:37:04 INFO - 'tests': ['tp6_google', 08:37:04 INFO - 'tp6_youtube', 08:37:04 INFO - 'tp6_amazon', 08:37:04 INFO - 'tp6_facebook']}, 08:37:04 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:37:04 INFO - 'talos_options': ['--xperf_path', 08:37:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:37:04 INFO - 'tests': ['tp5n']}}} 08:37:04 INFO - Running post-action listener: _resource_record_post_action 08:37:04 INFO - [mozharness: 2017-08-03 15:37:04.875322Z] Finished populate-webroot step (success) 08:37:04 INFO - [mozharness: 2017-08-03 15:37:04.875413Z] Running create-virtualenv step. 08:37:04 INFO - Running pre-action listener: _resource_record_pre_action 08:37:04 INFO - Running main action method: create_virtualenv 08:37:04 INFO - Creating virtualenv /builds/slave/test/build/venv 08:37:04 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 08:37:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:37:04 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 08:37:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:37:04 INFO - Using real prefix '/usr' 08:37:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:37:05 INFO - Installing distribute.............................................................................................................................................................................................done. 08:37:07 INFO - Installing pip.................done. 08:37:07 INFO - Return code: 0 08:37:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:37:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:37:07 INFO - Reading from file tmpfile_stdout 08:37:07 INFO - Output received: 08:37:07 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) 08:37:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:37: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')]} 08:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37: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')]} 08:37:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:07 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 0x11181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1487d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1484eb0>, '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 0x1485db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1486240>, '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': '923d835db2ba3686ebe126b700000192-1501773957.580654-351862154', '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 08:37:07 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 08:37:07 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 08:37:07 INFO - Using env: {'DISPLAY': ':0', 08:37:07 INFO - 'HOME': '/home/cltbld', 08:37:07 INFO - 'LANG': 'en_US.UTF-8', 08:37:07 INFO - 'LANGUAGE': 'en_US:en', 08:37:07 INFO - 'LOGNAME': 'cltbld', 08:37:07 INFO - 'MAIL': '/var/mail/cltbld', 08:37:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:07 INFO - 'MOZ_NO_REMOTE': '1', 08:37:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:07 INFO - 'NO_EM_RESTART': '1', 08:37:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:07 INFO - 'PWD': '/builds/slave/test', 08:37:07 INFO - 'SHELL': '/bin/bash', 08:37:07 INFO - 'SHLVL': '1', 08:37:07 INFO - 'TERM': 'linux', 08:37:07 INFO - 'TMOUT': '86400', 08:37:07 INFO - 'USER': 'cltbld', 08:37:07 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1501773957.580654-351862154', 08:37:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:07 INFO - '_': '/tools/buildbot/bin/python'} 08:37:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:07 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 08:37:07 INFO - Cleaning up... 08:37:07 INFO - Return code: 0 08:37:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:37: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')]} 08:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37: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')]} 08:37:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:07 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 0x11181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1487d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1484eb0>, '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 0x1485db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1486240>, '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': '923d835db2ba3686ebe126b700000192-1501773957.580654-351862154', '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 08:37:07 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 08:37:07 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 08:37:07 INFO - Using env: {'DISPLAY': ':0', 08:37:07 INFO - 'HOME': '/home/cltbld', 08:37:07 INFO - 'LANG': 'en_US.UTF-8', 08:37:07 INFO - 'LANGUAGE': 'en_US:en', 08:37:07 INFO - 'LOGNAME': 'cltbld', 08:37:07 INFO - 'MAIL': '/var/mail/cltbld', 08:37:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:07 INFO - 'MOZ_NO_REMOTE': '1', 08:37:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:07 INFO - 'NO_EM_RESTART': '1', 08:37:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:07 INFO - 'PWD': '/builds/slave/test', 08:37:07 INFO - 'SHELL': '/bin/bash', 08:37:07 INFO - 'SHLVL': '1', 08:37:07 INFO - 'TERM': 'linux', 08:37:07 INFO - 'TMOUT': '86400', 08:37:07 INFO - 'USER': 'cltbld', 08:37:07 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1501773957.580654-351862154', 08:37:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:07 INFO - '_': '/tools/buildbot/bin/python'} 08:37:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:08 INFO - Downloading/unpacking psutil>=3.1.1 08:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:37:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:37:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:37:09 INFO - Installing collected packages: psutil 08:37:09 INFO - Running setup.py install for psutil 08:37:09 INFO - building 'psutil._psutil_linux' extension 08:37:09 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 08:37:09 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 08:37:09 INFO - building 'psutil._psutil_posix' extension 08:37:09 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 08:37:09 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 08:37:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:37:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:37:09 INFO - Successfully installed psutil 08:37:09 INFO - Cleaning up... 08:37:09 INFO - Return code: 0 08:37:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:37:09 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')]} 08:37:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:09 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')]} 08:37:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:09 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 0x11181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1487d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1484eb0>, '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 0x1485db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1486240>, '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': '923d835db2ba3686ebe126b700000192-1501773957.580654-351862154', '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 08:37:09 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 08:37:09 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 08:37:09 INFO - Using env: {'DISPLAY': ':0', 08:37:09 INFO - 'HOME': '/home/cltbld', 08:37:09 INFO - 'LANG': 'en_US.UTF-8', 08:37:09 INFO - 'LANGUAGE': 'en_US:en', 08:37:09 INFO - 'LOGNAME': 'cltbld', 08:37:09 INFO - 'MAIL': '/var/mail/cltbld', 08:37:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:09 INFO - 'MOZ_NO_REMOTE': '1', 08:37:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:09 INFO - 'NO_EM_RESTART': '1', 08:37:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:09 INFO - 'PWD': '/builds/slave/test', 08:37:09 INFO - 'SHELL': '/bin/bash', 08:37:09 INFO - 'SHLVL': '1', 08:37:09 INFO - 'TERM': 'linux', 08:37:09 INFO - 'TMOUT': '86400', 08:37:09 INFO - 'USER': 'cltbld', 08:37:09 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1501773957.580654-351862154', 08:37:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:09 INFO - '_': '/tools/buildbot/bin/python'} 08:37:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:37:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:37:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:37:11 INFO - Installing collected packages: mozsystemmonitor 08:37:11 INFO - Running setup.py install for mozsystemmonitor 08:37:11 INFO - Successfully installed mozsystemmonitor 08:37:11 INFO - Cleaning up... 08:37:11 INFO - Return code: 0 08:37:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:37:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1487d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1484eb0>, '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 0x1485db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1486240>, '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': '923d835db2ba3686ebe126b700000192-1501773957.580654-351862154', '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 08:37:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:37:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:37:11 INFO - Using env: {'DISPLAY': ':0', 08:37:11 INFO - 'HOME': '/home/cltbld', 08:37:11 INFO - 'LANG': 'en_US.UTF-8', 08:37:11 INFO - 'LANGUAGE': 'en_US:en', 08:37:11 INFO - 'LOGNAME': 'cltbld', 08:37:11 INFO - 'MAIL': '/var/mail/cltbld', 08:37:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:11 INFO - 'MOZ_NO_REMOTE': '1', 08:37:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:11 INFO - 'NO_EM_RESTART': '1', 08:37:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:11 INFO - 'PWD': '/builds/slave/test', 08:37:11 INFO - 'SHELL': '/bin/bash', 08:37:11 INFO - 'SHLVL': '1', 08:37:11 INFO - 'TERM': 'linux', 08:37:11 INFO - 'TMOUT': '86400', 08:37:11 INFO - 'USER': 'cltbld', 08:37:11 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1501773957.580654-351862154', 08:37:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:11 INFO - '_': '/tools/buildbot/bin/python'} 08:37:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:11 INFO - Downloading/unpacking jsonschema==2.5.1 08:37: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 08:37: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 08:37: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 08:37: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 08:37:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:37:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:37:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:12 INFO - Downloading functools32-3.2.3-2.tar.gz 08:37:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:37:12 INFO - warning: no files found matching '*.txt' 08:37:12 INFO - no previously-included directories found matching 'build' 08:37:12 INFO - no previously-included directories found matching 'dist' 08:37:12 INFO - no previously-included directories found matching '.git*' 08:37:12 INFO - Installing collected packages: jsonschema, functools32 08:37:12 INFO - Running setup.py install for functools32 08:37:12 INFO - warning: no files found matching '*.txt' 08:37:12 INFO - no previously-included directories found matching 'build' 08:37:12 INFO - no previously-included directories found matching 'dist' 08:37:12 INFO - no previously-included directories found matching '.git*' 08:37:12 INFO - Successfully installed jsonschema functools32 08:37:12 INFO - Cleaning up... 08:37:12 INFO - Return code: 0 08:37:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:37:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1487d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1484eb0>, '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 0x1485db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1486240>, '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': '923d835db2ba3686ebe126b700000192-1501773957.580654-351862154', '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 08:37:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:37:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:37:12 INFO - Using env: {'DISPLAY': ':0', 08:37:12 INFO - 'HOME': '/home/cltbld', 08:37:12 INFO - 'LANG': 'en_US.UTF-8', 08:37:12 INFO - 'LANGUAGE': 'en_US:en', 08:37:12 INFO - 'LOGNAME': 'cltbld', 08:37:12 INFO - 'MAIL': '/var/mail/cltbld', 08:37:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:12 INFO - 'MOZ_NO_REMOTE': '1', 08:37:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:12 INFO - 'NO_EM_RESTART': '1', 08:37:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:12 INFO - 'PWD': '/builds/slave/test', 08:37:12 INFO - 'SHELL': '/bin/bash', 08:37:12 INFO - 'SHLVL': '1', 08:37:12 INFO - 'TERM': 'linux', 08:37:12 INFO - 'TMOUT': '86400', 08:37:12 INFO - 'USER': 'cltbld', 08:37:12 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1501773957.580654-351862154', 08:37:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:12 INFO - '_': '/tools/buildbot/bin/python'} 08:37:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:37:13 INFO - Cleaning up... 08:37:13 INFO - Return code: 0 08:37:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:37: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')]} 08:37:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37: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')]} 08:37:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1487d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1484eb0>, '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 0x1485db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1486240>, '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': '923d835db2ba3686ebe126b700000192-1501773957.580654-351862154', '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 08:37:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:37:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:37:13 INFO - Using env: {'DISPLAY': ':0', 08:37:13 INFO - 'HOME': '/home/cltbld', 08:37:13 INFO - 'LANG': 'en_US.UTF-8', 08:37:13 INFO - 'LANGUAGE': 'en_US:en', 08:37:13 INFO - 'LOGNAME': 'cltbld', 08:37:13 INFO - 'MAIL': '/var/mail/cltbld', 08:37:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:13 INFO - 'MOZ_NO_REMOTE': '1', 08:37:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:13 INFO - 'NO_EM_RESTART': '1', 08:37:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:13 INFO - 'PWD': '/builds/slave/test', 08:37:13 INFO - 'SHELL': '/bin/bash', 08:37:13 INFO - 'SHLVL': '1', 08:37:13 INFO - 'TERM': 'linux', 08:37:13 INFO - 'TMOUT': '86400', 08:37:13 INFO - 'USER': 'cltbld', 08:37:13 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1501773957.580654-351862154', 08:37:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:13 INFO - '_': '/tools/buildbot/bin/python'} 08:37:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:13 INFO - Downloading/unpacking blobuploader==1.2.4 08:37: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 08:37: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 08:37: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 08:37: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 08:37:14 INFO - Downloading blobuploader-1.2.4.tar.gz 08:37:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:37:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:37:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:37:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:37:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:15 INFO - Downloading docopt-0.6.1.tar.gz 08:37:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:37:15 INFO - Installing collected packages: blobuploader, requests, docopt 08:37:15 INFO - Running setup.py install for blobuploader 08:37:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:37:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:37:15 INFO - Running setup.py install for requests 08:37:15 INFO - Running setup.py install for docopt 08:37:15 INFO - Successfully installed blobuploader requests docopt 08:37:15 INFO - Cleaning up... 08:37:15 INFO - Return code: 0 08:37:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:37: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')]} 08:37:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37: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')]} 08:37:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:15 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 0x11181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1487d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1484eb0>, '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 0x1485db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1486240>, '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': '923d835db2ba3686ebe126b700000192-1501773957.580654-351862154', '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 08:37:15 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 08:37:15 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 08:37:15 INFO - Using env: {'DISPLAY': ':0', 08:37:15 INFO - 'HOME': '/home/cltbld', 08:37:15 INFO - 'LANG': 'en_US.UTF-8', 08:37:15 INFO - 'LANGUAGE': 'en_US:en', 08:37:15 INFO - 'LOGNAME': 'cltbld', 08:37:15 INFO - 'MAIL': '/var/mail/cltbld', 08:37:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:15 INFO - 'MOZ_NO_REMOTE': '1', 08:37:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:15 INFO - 'NO_EM_RESTART': '1', 08:37:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:15 INFO - 'PWD': '/builds/slave/test', 08:37:15 INFO - 'SHELL': '/bin/bash', 08:37:15 INFO - 'SHLVL': '1', 08:37:15 INFO - 'TERM': 'linux', 08:37:15 INFO - 'TMOUT': '86400', 08:37:15 INFO - 'USER': 'cltbld', 08:37:15 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1501773957.580654-351862154', 08:37:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:15 INFO - '_': '/tools/buildbot/bin/python'} 08:37:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:37:15 INFO - Running setup.py (path:/tmp/pip-sZvj0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:37:16 INFO - Running setup.py (path:/tmp/pip-fMRWWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:37:16 INFO - Running setup.py (path:/tmp/pip-50mdNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:37:16 INFO - Running setup.py (path:/tmp/pip-FfxmwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:37:16 INFO - Running setup.py (path:/tmp/pip-N5fqaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:37:16 INFO - Running setup.py (path:/tmp/pip-YM9f43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:37:16 INFO - Running setup.py (path:/tmp/pip-HSfyrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:37:16 INFO - Running setup.py (path:/tmp/pip-VUbnc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:37:16 INFO - Running setup.py (path:/tmp/pip-bP06qL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:37:16 INFO - Running setup.py (path:/tmp/pip-PZEsFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:37:16 INFO - Running setup.py (path:/tmp/pip-0KlUCf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:37:16 INFO - Running setup.py (path:/tmp/pip-L0CixX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:37:16 INFO - Running setup.py (path:/tmp/pip-AenbCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:37:16 INFO - Running setup.py (path:/tmp/pip-Y0IXNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:37:16 INFO - Running setup.py (path:/tmp/pip-idRFOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:37:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:37:17 INFO - Running setup.py (path:/tmp/pip-sBl16P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:37:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:37:17 INFO - Running setup.py (path:/tmp/pip-OWm5CQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:37:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:37:17 INFO - Running setup.py install for manifestparser 08:37:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:37:17 INFO - Running setup.py install for mozcrash 08:37:17 INFO - Running setup.py install for mozdebug 08:37:17 INFO - Running setup.py install for mozdevice 08:37:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:37:17 INFO - Running setup.py install for mozfile 08:37:17 INFO - Running setup.py install for mozhttpd 08:37:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:37:17 INFO - Running setup.py install for mozinfo 08:37:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:37:17 INFO - Running setup.py install for mozInstall 08:37:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:37:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:37:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:37:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:37:17 INFO - Running setup.py install for mozleak 08:37:18 INFO - Running setup.py install for mozlog 08:37:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:37:18 INFO - Running setup.py install for moznetwork 08:37:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:37:18 INFO - Running setup.py install for mozprocess 08:37:18 INFO - Running setup.py install for mozprofile 08:37:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:37:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:37:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:37:18 INFO - Running setup.py install for mozrunner 08:37:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:37:18 INFO - Running setup.py install for mozscreenshot 08:37:18 INFO - Running setup.py install for moztest 08:37:18 INFO - Running setup.py install for mozversion 08:37:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:37:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:37:18 INFO - Cleaning up... 08:37:18 INFO - Return code: 0 08:37:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:18 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 0x11181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1487d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1484eb0>, '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 0x1485db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1486240>, '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': '923d835db2ba3686ebe126b700000192-1501773957.580654-351862154', '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 08:37:18 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 08:37:18 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 08:37:18 INFO - Using env: {'DISPLAY': ':0', 08:37:18 INFO - 'HOME': '/home/cltbld', 08:37:18 INFO - 'LANG': 'en_US.UTF-8', 08:37:18 INFO - 'LANGUAGE': 'en_US:en', 08:37:18 INFO - 'LOGNAME': 'cltbld', 08:37:18 INFO - 'MAIL': '/var/mail/cltbld', 08:37:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:18 INFO - 'MOZ_NO_REMOTE': '1', 08:37:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:18 INFO - 'NO_EM_RESTART': '1', 08:37:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:18 INFO - 'PWD': '/builds/slave/test', 08:37:18 INFO - 'SHELL': '/bin/bash', 08:37:18 INFO - 'SHLVL': '1', 08:37:18 INFO - 'TERM': 'linux', 08:37:18 INFO - 'TMOUT': '86400', 08:37:18 INFO - 'USER': 'cltbld', 08:37:18 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1501773957.580654-351862154', 08:37:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:18 INFO - '_': '/tools/buildbot/bin/python'} 08:37:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:37:19 INFO - Running setup.py (path:/tmp/pip-Ylf_WV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:37:19 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)) 08:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:37:19 INFO - Running setup.py (path:/tmp/pip-1EVNzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:37:19 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)) 08:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:37:19 INFO - Running setup.py (path:/tmp/pip-cZ5b38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:37:19 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)) 08:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:37:19 INFO - Running setup.py (path:/tmp/pip-xfi6u3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:37:19 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)) 08:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:37:19 INFO - Running setup.py (path:/tmp/pip-4uTRJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:37:19 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)) 08:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:37:19 INFO - Running setup.py (path:/tmp/pip-NIhHhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:37:19 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)) 08:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:37:19 INFO - Running setup.py (path:/tmp/pip-Ev4x0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:37:19 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)) 08:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:37:19 INFO - Running setup.py (path:/tmp/pip-9pFcBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:37:19 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)) 08:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:37:19 INFO - Running setup.py (path:/tmp/pip-qS8Q8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:37:19 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)) 08:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:37:19 INFO - Running setup.py (path:/tmp/pip-gewu17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:37:19 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)) 08:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:37:19 INFO - Running setup.py (path:/tmp/pip-MF6FzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:37:20 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)) 08:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:37:20 INFO - Running setup.py (path:/tmp/pip-3lmwRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:37:20 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)) 08:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:37:20 INFO - Running setup.py (path:/tmp/pip-kDgAa0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:37:20 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)) 08:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:37:20 INFO - Running setup.py (path:/tmp/pip-OBZSwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:37:20 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)) 08:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:37:20 INFO - Running setup.py (path:/tmp/pip-ZVtttt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:37:20 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)) 08:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:37:20 INFO - Running setup.py (path:/tmp/pip-096hJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:37:20 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)) 08:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:37:20 INFO - Running setup.py (path:/tmp/pip-9rkzqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:37:20 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)) 08:37:20 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)) 08:37:20 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)) 08:37:20 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)) 08:37:20 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)) 08:37:20 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)) 08:37:20 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)) 08:37:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:37:20 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 08:37:20 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 08:37:20 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 08:37:20 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 08:37:21 INFO - Downloading blessings-1.6.tar.gz 08:37:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:37:21 INFO - Installing collected packages: blessings 08:37:21 INFO - Running setup.py install for blessings 08:37:21 INFO - Successfully installed blessings 08:37:21 INFO - Cleaning up... 08:37:21 INFO - Return code: 0 08:37:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:37:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:37:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:37:21 INFO - Reading from file tmpfile_stdout 08:37:21 INFO - Current package versions: 08:37:21 INFO - argparse == 1.2.1 08:37:21 INFO - blessings == 1.6 08:37:21 INFO - blobuploader == 1.2.4 08:37:21 INFO - docopt == 0.6.1 08:37:21 INFO - functools32 == 3.2.3-2 08:37:21 INFO - jsonschema == 2.5.1 08:37:21 INFO - manifestparser == 1.1 08:37:21 INFO - mozInstall == 1.13 08:37:21 INFO - mozcrash == 1.0 08:37:21 INFO - mozdebug == 0.1 08:37:21 INFO - mozdevice == 0.51 08:37:21 INFO - mozfile == 1.2 08:37:21 INFO - mozhttpd == 0.7 08:37:21 INFO - mozinfo == 0.10 08:37:21 INFO - mozleak == 0.1 08:37:21 INFO - mozlog == 3.5 08:37:21 INFO - moznetwork == 0.27 08:37:21 INFO - mozprocess == 0.25 08:37:21 INFO - mozprofile == 0.28 08:37:21 INFO - mozrunner == 6.13 08:37:21 INFO - mozscreenshot == 0.1 08:37:21 INFO - mozsystemmonitor == 0.3 08:37:21 INFO - moztest == 0.8 08:37:21 INFO - mozversion == 1.4 08:37:21 INFO - psutil == 3.1.1 08:37:21 INFO - requests == 1.2.3 08:37:21 INFO - wsgiref == 0.1.2 08:37:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:37:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:21 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 0x11181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1487d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1484eb0>, '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 0x1485db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1486240>, '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': '923d835db2ba3686ebe126b700000192-1501773957.580654-351862154', '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 08:37:22 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 08:37:22 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 08:37:22 INFO - Using env: {'DISPLAY': ':0', 08:37:22 INFO - 'HOME': '/home/cltbld', 08:37:22 INFO - 'LANG': 'en_US.UTF-8', 08:37:22 INFO - 'LANGUAGE': 'en_US:en', 08:37:22 INFO - 'LOGNAME': 'cltbld', 08:37:22 INFO - 'MAIL': '/var/mail/cltbld', 08:37:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:22 INFO - 'MOZ_NO_REMOTE': '1', 08:37:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:22 INFO - 'NO_EM_RESTART': '1', 08:37:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:22 INFO - 'PWD': '/builds/slave/test', 08:37:22 INFO - 'SHELL': '/bin/bash', 08:37:22 INFO - 'SHLVL': '1', 08:37:22 INFO - 'TERM': 'linux', 08:37:22 INFO - 'TMOUT': '86400', 08:37:22 INFO - 'USER': 'cltbld', 08:37:22 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1501773957.580654-351862154', 08:37:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:22 INFO - '_': '/tools/buildbot/bin/python'} 08:37:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:22 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)) 08:37:22 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)) 08:37:22 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)) 08:37:22 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)) 08:37:22 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)) 08:37:22 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)) 08:37:22 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)) 08:37:22 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)) 08:37:22 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)) 08:37:22 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:37:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 08:37:23 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)) 08:37:23 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)) 08:37:23 INFO - Installing collected packages: simplejson 08:37:23 INFO - Running setup.py install for simplejson 08:37:23 INFO - building 'simplejson._speedups' extension 08:37:23 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 08:37:24 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 08:37:24 INFO - Successfully installed simplejson 08:37:24 INFO - Cleaning up... 08:37:24 INFO - Return code: 0 08:37:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:37:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:24 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 0x11181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1487d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1484eb0>, '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 0x1485db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1486240>, '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': '923d835db2ba3686ebe126b700000192-1501773957.580654-351862154', '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 08:37:24 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 08:37:24 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 08:37:24 INFO - Using env: {'DISPLAY': ':0', 08:37:24 INFO - 'HOME': '/home/cltbld', 08:37:24 INFO - 'LANG': 'en_US.UTF-8', 08:37:24 INFO - 'LANGUAGE': 'en_US:en', 08:37:24 INFO - 'LOGNAME': 'cltbld', 08:37:24 INFO - 'MAIL': '/var/mail/cltbld', 08:37:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:24 INFO - 'MOZ_NO_REMOTE': '1', 08:37:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:24 INFO - 'NO_EM_RESTART': '1', 08:37:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:24 INFO - 'PWD': '/builds/slave/test', 08:37:24 INFO - 'SHELL': '/bin/bash', 08:37:24 INFO - 'SHLVL': '1', 08:37:24 INFO - 'TERM': 'linux', 08:37:24 INFO - 'TMOUT': '86400', 08:37:24 INFO - 'USER': 'cltbld', 08:37:24 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1501773957.580654-351862154', 08:37:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:24 INFO - '_': '/tools/buildbot/bin/python'} 08:37:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:37:24 INFO - Cleaning up... 08:37:24 INFO - Return code: 0 08:37:24 INFO - Running post-action listener: _resource_record_post_action 08:37:24 INFO - Running post-action listener: _start_resource_monitoring 08:37:24 INFO - Starting resource monitoring. 08:37:24 INFO - [mozharness: 2017-08-03 15:37:24.666171Z] Finished create-virtualenv step (success) 08:37:24 INFO - [mozharness: 2017-08-03 15:37:24.666690Z] Running install step. 08:37:24 INFO - Running pre-action listener: _resource_record_pre_action 08:37:24 INFO - Running main action method: install 08:37:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:37:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:37:24 INFO - Reading from file tmpfile_stdout 08:37:24 INFO - Detecting whether we're running mozinstall >=1.0... 08:37:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:37:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:37:25 INFO - Reading from file tmpfile_stdout 08:37:25 INFO - Output received: 08:37:25 INFO - Usage: mozinstall [options] installer 08:37:25 INFO - Options: 08:37:25 INFO - -h, --help show this help message and exit 08:37:25 INFO - -d DEST, --destination=DEST 08:37:25 INFO - Directory to install application into. [default: 08:37:25 INFO - "/builds/slave/test"] 08:37:25 INFO - --app=APP Application being installed. [default: firefox] 08:37:25 INFO - mkdir: /builds/slave/test/build/application 08:37:25 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'] 08:37:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:37:43 INFO - Reading from file tmpfile_stdout 08:37:43 INFO - Output received: 08:37:43 INFO - /builds/slave/test/build/application/firefox/firefox 08:37:43 INFO - Running post-action listener: _resource_record_post_action 08:37:43 INFO - [mozharness: 2017-08-03 15:37:43.750883Z] Finished install step (success) 08:37:43 INFO - [mozharness: 2017-08-03 15:37:43.751155Z] Running setup-mitmproxy step. 08:37:43 INFO - Running pre-action listener: _resource_record_pre_action 08:37:43 INFO - Running main action method: setup_mitmproxy 08:37:43 INFO - Skipping: mitmproxy is not required 08:37:43 INFO - Running post-action listener: _resource_record_post_action 08:37:43 INFO - [mozharness: 2017-08-03 15:37:43.752287Z] Finished setup-mitmproxy step (success) 08:37:43 INFO - [mozharness: 2017-08-03 15:37:43.752507Z] Running run-tests step. 08:37:43 INFO - Running pre-action listener: _resource_record_pre_action 08:37:43 INFO - Running pre-action listener: _set_gcov_prefix 08:37:43 INFO - Running main action method: run_tests 08:37:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:37:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:37:43 INFO - Python 2.7.3 08:37:43 INFO - Return code: 0 08:37:43 INFO - grabbing minidump binary from tooltool 08:37:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:43 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 0x1484eb0>, '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 0x1485db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1486240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:37:43 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 08:37:43 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 08:37:43 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 08:37:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:37:43 INFO - Return code: 0 08:37:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:37:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:37:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:37:43 INFO - ENV: RUST_BACKTRACE is now 1 08:37:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:37:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:37:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eJMMbl1FT968FVBWv0HPng/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 08:37:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Cedar --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eJMMbl1FT968FVBWv0HPng/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-007 --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 08:37:43 INFO - Using env: {'DISPLAY': ':0', 08:37:43 INFO - 'HOME': '/home/cltbld', 08:37:43 INFO - 'LANG': 'en_US.UTF-8', 08:37:43 INFO - 'LANGUAGE': 'en_US:en', 08:37:43 INFO - 'LOGNAME': 'cltbld', 08:37:43 INFO - 'MAIL': '/var/mail/cltbld', 08:37:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:37:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:37:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:43 INFO - 'MOZ_NO_REMOTE': '1', 08:37:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:37:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:43 INFO - 'NO_EM_RESTART': '1', 08:37:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:43 INFO - 'PWD': '/builds/slave/test', 08:37:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:37:43 INFO - 'RUST_BACKTRACE': '1', 08:37:43 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:37:43 INFO - 'SHELL': '/bin/bash', 08:37:43 INFO - 'SHLVL': '1', 08:37:43 INFO - 'TERM': 'linux', 08:37:43 INFO - 'TMOUT': '86400', 08:37:43 INFO - 'USER': 'cltbld', 08:37:43 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1501773957.580654-351862154', 08:37:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:43 INFO - '_': '/tools/buildbot/bin/python'} 08:37:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eJMMbl1FT968FVBWv0HPng/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 08:37:44 INFO - mozversion application_buildid: 20170803144623 08:37:44 INFO - mozversion application_changeset: ea2cff37acfa508d6d944e1773d8f474ee61cbb7 08:37:44 INFO - mozversion application_display_name: Nightly 08:37:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:37:44 INFO - mozversion application_name: Firefox 08:37:44 INFO - mozversion application_remotingname: firefox 08:37:44 INFO - mozversion application_repository: https://hg.mozilla.org/projects/cedar 08:37:44 INFO - mozversion application_vendor: Mozilla 08:37:44 INFO - mozversion application_version: 57.0a1 08:37:44 INFO - mozversion platform_buildid: 20170803144623 08:37:44 INFO - mozversion platform_changeset: ea2cff37acfa508d6d944e1773d8f474ee61cbb7 08:37:44 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/cedar 08:37:44 INFO - mozversion platform_version: 57.0a1 08:37:44 INFO - using testdate: 1501774664 08:37:44 INFO - actual date: 1501774664 08:37:44 INFO - starting webserver on 'localhost:42654' 08:37:44 INFO - SUITE-START | Running 2 tests 08:37:44 INFO - TEST-START | dromaeo_css 08:37:44 INFO - Initialising browser for dromaeo_css test... 08:37:44 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42654/getInfo.html -profile /tmp/tmpBznl9F/profile 08:37:44 INFO - TEST-INFO | started process 24833 (/builds/slave/test/build/application/firefox/firefox http://localhost:42654/getInfo.html) 08:37:49 INFO - TEST-INFO | 24833: exit 0 08:37:49 INFO - Browser initialized. 08:37:49 INFO - Running cycle 1/1 for dromaeo_css test... 08:37:49 INFO - TEST-INFO | started process 25039 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBznl9F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:37:50 INFO - PID 25039 | 08:37:50 INFO - PID 25039 | (/builds/slave/test/build/application/firefox/firefox:25087): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:37:50 INFO - PID 25039 | 08:38:01 INFO - PID 25039 | RSS: Main: 171347968 08:38:01 INFO - PID 25039 | 08:41:00 INFO - PID 25039 | Cycle 1(1): loaded http://localhost:42654/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42654/tests/dromaeo/cssquery-ext.html) 08:41:02 INFO - PID 25039 | RSS: Main: 173953024 08:41:02 INFO - PID 25039 | 08:44:04 INFO - PID 25039 | Cycle 1(1): loaded http://localhost:42654/tests/dromaeo/cssquery-ext.html (next: http://localhost:42654/tests/dromaeo/cssquery-jquery.html) 08:44:04 INFO - PID 25039 | RSS: Main: 169541632 08:44:04 INFO - PID 25039 | 08:47:06 INFO - PID 25039 | Cycle 1(1): loaded http://localhost:42654/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42654/tests/dromaeo/cssquery-mootools.html) 08:47:07 INFO - PID 25039 | RSS: Main: 173174784 08:47:07 INFO - PID 25039 | 08:50:09 INFO - PID 25039 | Cycle 1(1): loaded http://localhost:42654/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42654/tests/dromaeo/cssquery-prototype.html) 08:50:09 INFO - PID 25039 | RSS: Main: 171937792 08:50:09 INFO - PID 25039 | 08:53:13 INFO - PID 25039 | Cycle 1(1): loaded http://localhost:42654/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42654/tests/dromaeo/cssquery-yui.html) 08:53:14 INFO - PID 25039 | RSS: Main: 175185920 08:53:14 INFO - PID 25039 | 08:56:16 INFO - PID 25039 | Cycle 1(1): loaded http://localhost:42654/tests/dromaeo/cssquery-yui.html (next: http://localhost:42654/tests/dromaeo/cssquery-dojo.html) 08:56:16 INFO - PID 25039 | RSS: Main: 175861760 08:56:16 INFO - PID 25039 | 08:56:16 INFO - PID 25039 | __start_tp_report 08:56:16 INFO - PID 25039 | _x_x_mozilla_page_load 08:56:16 INFO - PID 25039 | _x_x_mozilla_page_load_details 08:56:16 INFO - PID 25039 | |i|pagename|runs| 08:56:16 INFO - PID 25039 | |0;dojo.html;3132.4988001919696;3161.225499752561;3191.138392633988;3197.8720851165954;3238.206639373354;6241.968790156048;6251.656158911258;6360.904586431201;6382.617042977425;6384.265809431917;6291.307956124834;6327.5570710050315;6330.746770129189;6393.0410438434255;6422.454091402236;5601.103823388259;5739.626924249931;5824.271966004249;5834.533237341003;5864.941350586503;5716.599838011341;5738.540916726652;5823.039198532237;5833.095870140114;5835.620684655505;5743.9712801435935;5777.19119323295;5803.390643982384;5814;5828.47543721065;5710.514606258473;5802.680852553108;5809.2447981762525;5815.680137592431;5826.213461182729;5548.889022219573;5636.04187288162;5659.377468478464;5678.630888992202;5731.340895796995;6211.87576248477;6246.6252024878195;6253.843653908689;6257;6267.2165979252595;6702.731890724365;6707.329267073303;6730.0577919091365;6801.251862295144;6805.353491418307;6727.932720672779;6771.796846094625;6801.523893327469;6813.4208592269715;6879.449644028516;6314.116023756632;6349.619022858597;6359.268684101387;6378.744850206032;6384;6856.520043597;6969.581825090409;6981.5461994970165;7056.682449289794;7096.254893236239;6520.152380190545;6628.237752658506;6628.867422651617;6632.900506492407;6633.336666333328;6631.436327912182;6750.35871592198;6762.594244345355;6765.05289259504;6765.627890466071;6696.263411024784;6699.430548403343;6793.762218322434;6799.082123913208;6801.523893327519;6573.474122070223;6723.462123030145;6725.4619630430425;6726;6760.763373281911;5336.733163341817;5341.973290133525;5359.115745901882;5363.490468405495;5372.301600791872;4636.5131661175765;4663.440387153495;4689.554492323224;4716.962268300968;4746.335513028179;5875.089361149029;5878.823635290948;5928.762849485972;5960.195373624505;5961.135635332939;6639.1037209977;6770.796876093725;6813.557118787362;6873.965630171817;6880.759173428906;5822.883542329129;5832.1834943108;5836.474717275466;5841.88316233673;5842.883142337129;5870.677112758839;5915.704214789243;5917.881642367129;5921.851953701192;5923.911141332884;6497.772577959749;6572.474202063823;6572.638504882182;6572.934270657232;6574.441172500296;6693.163354580677;6710.194776626836;6722.1261236039;6814.386705196556;6814.727410903707;6421.935780642134;6530.8040758777315;6539.378759017885;6552.3447655236005;6594.967025165035;6606.240282367397;6700.229473610597;6713.429358504386;6724.125863637696;6760.729570817112;6880.724771009103;6883.380495755406;6886.8622627548175;6888.965555172192;6902.792916212522;6532;6584.901226481511;6596.274409815012;6626.138601981712;6627.502937279627;6496.967515162394;6502.349765023459;6514.609123452608;6602.471802255904;6632.403083722488;6392.488600912009;6444.742210311535;6461.64460954652;6477.870442591027;6484.675766211765;6512.837179070561;6524.478041756743;6534.640594767334;6622.735090596322;6624.867502650017;6368.363163683594;6419.422251997343;6428.067930150009;6429.678516074084;6431.260405053479 08:56:16 INFO - PID 25039 | |1;ext.html;770.3259647808168;810.785141937387;850.6554845287658;875.5578432891391;887.5917078144054;40163.1967360653;40995;41188;41195.17609647809;41205.58794412063;37376.81311593438;37728.62271377286;37790.055248618795;37886.621133788656;37998.24003519928;6694.0962969999155;6841.828954276158;6855.794326170223;6856.2800905904905;6862.7598034068815;6804;6875.759348422806;6878.965605171992;6886.414654754327;6889.276625954278;6838.931610683904;7496.137944136412;7648.770536883902;7720.536767793922;7732.265434783687;7637.465377423582;7693.615319234016;7703.922960770405;7711.614419279013;7711.922880771177;7407.814804629874;7580.279873412017;7593.05086864142;7596.658150383246;7622.6188690565805;39267;39502.40746388806;39514.40728389077;39539.40690889639;39670;3559.359315323241;3585.748997570171;3606.549181352331;3615;3615.2950174715943;31582.842085789423;31649;31757.36485270305;31803.522947155812;32063.358732825214;4889.33993910821;4924.482929292444;4940.6294527910195;4948.8762780930765;5056.494350564951;197295;243209;249300;250170.99999999817;251063;50352.24471632928;50633.49366506288;50684;50694.239586406235;50709.492905071216;52251.21623175655;52566.474335256156;52772;53482.46517534852;53486.465135348924;16792.328306867832;16837.831621683872;16852.241649125575;16919;16950.40673576419;13891.097078689852;13961.860381396056;14063;14066.648333791738;14104.153750774987;13849.307534623229;14040.648983775487;14179.503717369842;14187.78718319226;14272.35774390155;5635.915461268084;5645.604807663506;5761.164631128463;5765.1928729977835;5880.941190588125;992.593036854886;1003.9698809035594;1016.832222683249;1019.6686077024848;1020.9081182693593;23023.654645180337;23237.76762232356;23540.7645923542;23694.88152559226;23893.7610623895;1095.9726006849892;1108.872479664849;1118.1613789657756;1122.848415463902;1129.4296380327883;12072.698182545506;12320.691982700326;12346.567870124503;12354.25874447518;12509.499620015098;242508;242967;244178;244220;244355;52852.735736321076;52945.470545294054;53138;57968;59167.70416147978;1465.4358072142088;1513.4627207341234;1514.1293756090072;1514.4775052606833;1516.9772453413207;27688.861555692092;27934;28037;28853.42293154167;29325.26686832846;45851.77074114608;47002.52997469981;47263.29105063496;47280.290795637404;47370.289445657654;208341;208729;209175;209205;210216;36740.816295919416;37174;37174.25651487009;37185.814070929475;37193.6280637201;43954.780226098665;44893.77553112344;45182.774086130674;45217.773911130236;45930.31104533368;32893.34213315672;32956.67043329536;33477.16307092342;33916;34010.489842651885;32266.35467290688;32442.513362299112;32604.673953261114;32943.83528082344;33160.834195828866;35799.82100089483;35884;35933;36044.27911441809;36178.8191059043;31611;31867.362652746353;31933.36133277368;31979;32434.35131297408;24206.273811785675;25085.87457062776;25883.870580646977;25994.220173394828;26065.348366290236 08:56:16 INFO - PID 25039 | |2;jquery.html;565.510833129343;579.3511267380535;580.457272450259;591.8076625096843;610.2341561340518;22629.773702262974;22905.656415153746;23315;23338.183163589278;23408.5318293634;26402.867985660094;26997.865010674966;27092;27168;27250.31874203141;6346.365363463639;6514.185726784152;6515.34846515347;6519.282878883319;6543.345665433466;5801.535877129841;6409.743610255584;6455.644939528324;6478.708458119372;6496.8050958471085;6386.425221730044;6423.100765892778;6424;6426.164598602175;6433.22801263849;6433.935660643404;6452.257990331125;6454.548181627288;6459.450946669492;6459.935400645981;6009;6009.369016253274;6010.819675409744;6015.0375939849855;6023.367546407608;29140;30209.244768880955;30763.538546921813;30984.8450757747;31077.22306942322;1876.2682553804027;1941.5728539721238;1943.1255934829383;1943.6695761720541;1943.7959014303435;18830.246790128378;19530.804691953042;19582.11880465368;19587.216511339528;19620.215191392326;2314.9768502315096;2322.837401381904;2377.583922813518;2406.157844754322;2420.5642984262827;147517;151044;151151.48848511485;151214;151405;14409.42362305517;14926.850731492763;15201.871737956695;15351.77826097832;15467.690646187013;23802;24016.39959001039;24029;24029;24047.879760601085;9666.468344240993;9940.353876997971;9965.152961998312;9980.750481237881;9982.650607228712;8950.552472376485;9009.504477253682;9057;9129.406588571854;9203.941546722079;7710.845783084419;11610;11833.763324733629;11969.700757480958;12175.0868684849;3806.219724956433;3904.921901561953;4108.958910410917;4176.58234176586;4314.511493534726;944.7354740672623;976.272676855747;983.3657291047234;984.2224642532319;989.5744829723288;19621.313254036326;19848.10683519245;19857.60284794296;20335.694964575545;20425.89787051085;1029.2126523209752;1046.8482070099944;1050.186105768036;1054.1250761867784;1055.8099542082498;10853.728656783485;11075.50160242791;11134.554617815358;11160.720981975515;11298.774024519464;465624;478196;523436;526807;533639;119551.40224298996;122158;123167;126463;127931.36034319954;1264.6395777203636;1267.714764178071;1307.5881097454271;1310.7181955879532;1312.566852938528;21033.15867365288;21256.681149783075;21352;21554.461138471037;21558.784412156307;61670.69164654148;61830.38169618426;62075;62777.372226277155;64101.038484423705;75900.24099758932;76021.61989190019;76167;77067.61466192633;77658;12460.563880264148;13030.4136313868;14571.85428145705;14625.634359141106;14970.625734356729;23815.285541433786;24082;24116.638250425905;24169.39576510531;24205.515889681756;18541.907290464;18806.905965470087;18828.905855470635;18953.905230474313;18962.905185473985;16326.102064386572;16591;17520.299188032335;18217.90891045589;18443.446696599123;19633.803661963768;20863.791362086184;20924.372268831958;20970.895145524173;21018.579628407653;14260.572182834532;14822.62943426423;15081.321340539482;15134.318955646802;15187.468438604596;18839;19297.51756206106;19443.319483818563;19606.509837254183;19662 08:56:16 INFO - PID 25039 | |3;mootools.html;1339.6583871112864;1405.1007355292616;1407.7466056109897;1417.7518934186508;1421.337035668268;13999.370028348723;14108.576742697709;14750.483733069344;14753.778693319582;14757.852421475782;14547.92726036371;14727.26363681817;14733.852661473382;14739.336729847157;14859.554213373616;2705.026190571398;2749.477599256135;2765.0875211180264;2772.8613569321556;2774.3202915285683;2494.5634513959985;2604.28382194897;2662.480816240824;2721.9591706124424;2735.124760076776;2751.2159034675124;2778.402643431662;2779.833210007396;2781.958270625942;2782.2627003844;2620.934476638099;2665.200439868032;2665.3869609989715;2698.3119304577303;2702.2568793581822;2582.0704546363295;2609.1389841352307;2640.2475294541155;2654.0843409023855;2658.720834312408;14105.858941410557;14265.714685706227;14292.499762508261;14298.928505357511;14305.57083287503;7445.181030086686;7707.344875685573;7709.575973321465;7711;7713.730019449293;5039.118154322979;5224.294720212761;5272.156454967187;5324.653897496651;5347.732613369355;1806.5935164587993;1822.3894995176631;1829.4785985993929;1864.3661155207294;1871.2889102141235;22804.201852935235;23119.537609247887;23147.421314467105;23201.53596928052;23338.64992025121;6481.546291759531;6541.6075035498025;6777.085093512313;6811.489138314646;6892.862142757117;15877.761833572506;15878.52364429069;15879.920600397156;15882.444114455939;15951.60120996961;7639.121501027342;7831.490953088031;7884.172161922916;7886.856405821124;7887.290143887078;7020.543664661781;7240.782776516713;7258.782236532912;7289.635518224068;7319.048523691886;5101.923471147936;5216.243644671577;5266.262723218752;5301.920471192935;5324.068288049653;1262.665393670678;1305.8367704036996;1499.1754535005703;1538.3154496249285;1579.968400631981;885.8139790643908;902.3503077783985;908.0919080919081;920.5949382271779;923.6813299411692;8175.059868115124;8299.95850020746;8329.208725171098;8654.524001179996;9036.277097832157;965.1458459263462;987.6493844685033;993.3295025857517;1000.3947611694965;1000.6647772995982;4840.110619689883;5017.84946451607;5205.973970130125;5209.958008398336;5255.894882102337;19167.52081197953;19460.416187514114;19782.802171978095;19802.60394792096;19825.801741982683;18561.628767424576;18992.905035474734;19184.71222931657;19222.8077719221;19265.13306901193;10657.401389791594;10736.624218152483;10775.137988961022;10800.243982921278;10851.620193293196;7286.125664920243;7521.401652232598;8044.718434854752;8059.113497515152;8080.757577272691;17089.230984605972;17096.230669620145;17320.480385588453;17438.82561174372;17618.91190544039;17025.48923532296;17326;17404.564885877953;17502.124893755008;17889.910550447163;10430.113440357654;10726.98093681099;10736.248462607855;10792.298500597437;10802.405867677353;11957.222780519238;12365;12494.562690305796;12515.87484125147;12529.122961392615;10420.531076101744;10699.465026748787;10751.086157676373;10876.18428617841;11037.889621103686;9971.700848974542;10117.08946194846;10165;10337.17302615804;10480.737981550523;9478.194353479756;9496.335256532253;9567.37812042215;9570.425774453555;9574.138327550554;6956.513044086865;7000.649967501707;7014.579125252297;7074.610896400747;7135.108111486064;6850.143732033496;6855.245922948372;6894.310568943066;6920.169579650475;7014.684339204646 08:56:16 INFO - PID 25039 | |4;prototype.html;493.5459377372818;507.6597781855901;528.1654985123505;530.4456842599484;533.4292307231265;6117.5717699761035;6181.28915174755;6205.379462053798;6291.854072963518;6326.715297811598;5934.5845790794665;6096.146539484475;6098.634081955075;6188.938110618892;6227.43953044226;5175.275461435402;5185.377754669426;5202.895942081156;5207.479252074791;5240.161574148137;5113.846584602468;5156.716380599066;5168.302279192299;5187.27378167055;5231.215317702337;4979.850604481871;5148.639595228336;5156.338999310494;5187.144121219994;5226.921596176041;5105.208692652626;5159.1229490986625;5205.973970130163;5210.166373380241;5211.557017653504;4814.522494080504;4840.685355451885;4844.128056949748;4859;4867.902641947141;5986.8503287417725;6121.265448146207;6171.783987560414;6173.81478555644;6197.442230199259;5951.256092988377;5959.731812068468;6037.611349389621;6084.452399284086;6130.601510901777;6501.219853617549;6629.535932484728;6641.93358066418;6658.536341553608;6661.233958094833;5323.627346085776;5349.598780091509;5363.141897296414;5376.946230537723;5409.2967914171295;6799.864002719918;6944.236134025253;6958.512904096715;6981.79054628362;6999.965000174967;5468.781248750085;5500.697461639648;5504.256925315111;5531.115021596605;5532.363778165482;5588.6646801192055;5612.158176273591;5644.943550564524;5648.15277708347;5680.77276908919;5945.167676525203;5964.7912323068485;6011.458968692838;6061.363556826558;6106.2061931948565;6544.967275163689;6563.556017676104;6564.868702626016;6602.2407423146;6667.266600673922;1858.1697028426988;1879.1355976251077;1888.8111188881276;1893.4982229709137;1968.1733671857853;1429.785532170162;1448.5364683301452;1450.6881020580627;1454.941802327916;1465.1282486920265;5608.046632072557;5655.321361436654;5705.515031222392;5714.685692286964;5726.398728133486;6435.935640643534;6682.699278532477;6683.766068187688;6735.932640673628;6783.830404239835;5728.742206600713;5803.65178089316;5812.941870581325;5836.212111364996;5859.648421094748;3530.7881527108457;3531.5762108547137;3581.588117366536;3587.9641203588153;3611.963880361163;6353.396427339396;6496.155499784998;6499.3175716549085;6509.479241660656;6548.3124271950755;6888.758893438706;6907.171139463297;6929.237783843773;6991.405730512862;6993.440524758007;6372.999999999907;6458.644774537445;6543;6578.513387904418;6595.4393876521035;6727.730890764315;6749.797506074826;6778.118844550374;6801.795946121624;6831.45348372139;6455.4512866405;6543.738250470118;6567.2447668516825;6587.736490540325;6670.298529095724;6424;6462.192225971754;6499.837504062436;6503.51223658237;6522.021696745336;4955.2567114933045;5036.597072234139;5054.848354549369;5057.949420505748;5077.238414237746;6748.932510675027;6756.729730810713;6772.729090836311;6802.965985170043;6816.147981502312;6468.353164683494;6491.48068154537;6510.73957041713;6527.412532872065;6534.803955881332;6463.709133088928;6469.5794773339585;6497.285298617243;6527.184101987252;6528.412442879973;6171.7531298749345;6330.525210609315;6351.904721429275;6384.585001974857;6435.650987389663;6602.042703808017;6610.438112760276;6623.834404139742;6630.635315057718;6651.204174872661;6331.309193592797;6336.904946425715;6339.9683001586545;6344.238691357066;6371.203599550056 08:56:16 INFO - PID 25039 | |5;yui.html;879.9780005499862;880.2341962492628;895.5835536475538;905.1039470923787;912.5710915869541;17718.1140942953;18754.2498300068;18755.15601797919;18767.530811729714;20064.49838754032;18526.536836579093;18670.626587468243;18675.906620466878;18711.3451029214;18734.344297949574;1015.6800607808517;1031.0617338222219;1040.8542804007445;1075.704181350131;1078.094400703409;1066.163061996333;1072.0619457974271;1072.4101744040786;1072.8873468285835;1073.1146803886786;1103.7902798468265;1106.1593189176203;1109.2124591540016;1109.678193323939;1111.9610813621525;1100.04845808376;1101.5924108080062;1105.607509334187;1107.363266121983;1110.2783190925882;805.0540614777672;806.6652339279192;807.6850028488894;810.1331575214464;814.2468216899404;18739.812601873942;19096.522586935298;19166.616667666567;19283.035848207674;19437.805621943742;20140.597188056156;20669.689954650694;20861;21138.26016089445;21186.894065529727;15906.284217210137;16060;16304.755428668579;16412.589685257844;16416.343346266134;3483.4600636901323;3504.316658251642;3506.7019303359243;3508.1405055761247;3509.5086687863463;127697;128091.35954320169;128520.35739821334;128704;129587;15871.20643967797;15980.840191598169;16044.598885027968;16116.838831611534;16335.428260010842;30162.396752064837;30249.243768905955;30279.848600757297;30323.848380758398;30786.692133078832;8360.790980225544;8366.205210504992;8409.117042710428;8414.074451810297;8415.579221038923;3452.188735647121;3680.5031320771886;3876.205377897524;4072.2873497137884;4102.610252026112;5146.845594632167;5229.163333866563;5229.267902493654;5240.895182096337;5261.842144735664;1012.4077414712476;1047.601911273711;1058.3808472043786;1090.095220966596;1107.4628805029554;498.4591717985953;614.5759425996048;631.504269148716;633.2749002392235;666.6899891550355;11353.432328383547;12004.51981920731;12010.33943133136;12329.630111096682;12850.728397525481;665.4543274514851;665.8535122273092;666.3702800853147;671.9227288861844;677.9423748981392;5382.165764306539;5564.304461942257;5663.773449062074;5669.574781891375;5695.288088988877;102239;103491.4825425868;103870.4806475978;106185;108966.45516772366;96426;96981.5150924255;97286.51356743171;99827.50086249667;100058;81945.18054819494;84931;86834.56582717173;88657.9999999987;90429.54785226032;11030.724231894266;11644.126690498077;11850;11914.880851191378;12142.575009874612;35103.64896351106;35596;35734.28531429409;36115.458268126524;37150;66166.33833661795;66932.665336673;68257;68764.31235687579;69865.30134698589;17950.91024544869;18121.90939045296;18217.362392316205;18223.726644100083;18248.543786405447;16585.25366358541;21539;22222.333330000125;22231.66652500246;22241.44396390103;17552.56118597045;19417;19542.902285488482;20085.59828803445;20100.497487562345;19113.426597202106;19273.22907083701;19302.13140408713;19614.509637258612;20068.19727210895;16688.165591720124;17590.56023599369;17687.73468398001;17871.195796188942;18247.54381140429;12825.358732063547;13365.799513007118;13381.866181338062;13565.253911034988;13810.447582096604;12919.095663303478;14690.11859288446;14796.038257513228;14988.2505874708;15200.923995379952 08:56:16 INFO - PID 25039 | __end_tp_report 08:56:16 INFO - PID 25039 | __start_cc_report 08:56:16 INFO - PID 25039 | _x_x_mozilla_cycle_collect,376 08:56:16 INFO - PID 25039 | __end_cc_report 08:56:16 INFO - PID 25039 | __startTimestamp1501775776421__endTimestamp 08:56:16 INFO - PID 25039 | 08:56:16 INFO - PID 25039 | ------- Summary: start ------- 08:56:16 INFO - PID 25039 | Number of tests: 6 08:56:16 INFO - PID 25039 | 08:56:16 INFO - PID 25039 | [#0] dojo.html Cycles:165 Average:6215.67 Median:6444.74 stddev:739.69 (11.5%) stddev-sans-first:701.30 08:56:16 INFO - PID 25039 | Values: 3132.5 3161.2 3191.1 3197.9 3238.2 6242.0 6251.7 6360.9 6382.6 6384.3 6291.3 6327.6 6330.7 6393.0 6422.5 5601.1 5739.6 5824.3 5834.5 5864.9 5716.6 5738.5 5823.0 5833.1 5835.6 5744.0 5777.2 5803.4 5814.0 5828.5 5710.5 5802.7 5809.2 5815.7 5826.2 5548.9 5636.0 5659.4 5678.6 5731.3 6211.9 6246.6 6253.8 6257.0 6267.2 6702.7 6707.3 6730.1 6801.3 6805.4 6727.9 6771.8 6801.5 6813.4 6879.4 6314.1 6349.6 6359.3 6378.7 6384.0 6856.5 6969.6 6981.5 7056.7 7096.3 6520.2 6628.2 6628.9 6632.9 6633.3 6631.4 6750.4 6762.6 6765.1 6765.6 6696.3 6699.4 6793.8 6799.1 6801.5 6573.5 6723.5 6725.5 6726.0 6760.8 5336.7 5342.0 5359.1 5363.5 5372.3 4636.5 4663.4 4689.6 4717.0 4746.3 5875.1 5878.8 5928.8 5960.2 5961.1 6639.1 6770.8 6813.6 6874.0 6880.8 5822.9 5832.2 5836.5 5841.9 5842.9 5870.7 5915.7 5917.9 5921.9 5923.9 6497.8 6572.5 6572.6 6572.9 6574.4 6693.2 6710.2 6722.1 6814.4 6814.7 6421.9 6530.8 6539.4 6552.3 6595.0 6606.2 6700.2 6713.4 6724.1 6760.7 6880.7 6883.4 6886.9 6889.0 6902.8 6532.0 6584.9 6596.3 6626.1 6627.5 6497.0 6502.3 6514.6 6602.5 6632.4 6392.5 6444.7 6461.6 6477.9 6484.7 6512.8 6524.5 6534.6 6622.7 6624.9 6368.4 6419.4 6428.1 6429.7 6431.3 08:56:16 INFO - PID 25039 | 08:56:16 INFO - PID 25039 | [#1] ext.html Cycles:180 Average:40351.24 Median:3610.77 stddev:60036.03 (1662.7%) stddev-sans-first:60130.89 08:56:16 INFO - PID 25039 | Values: 770.3 810.8 850.7 875.6 887.6 40163.2 40995.0 41188.0 41195.2 41205.6 37376.8 37728.6 37790.1 37886.6 37998.2 6694.1 6841.8 6855.8 6856.3 6862.8 6804.0 6875.8 6879.0 6886.4 6889.3 6838.9 7496.1 7648.8 7720.5 7732.3 7637.5 7693.6 7703.9 7711.6 7711.9 7407.8 7580.3 7593.1 7596.7 7622.6 39267.0 39502.4 39514.4 39539.4 39670.0 3559.4 3585.7 3606.5 3615.0 3615.3 31582.8 31649.0 31757.4 31803.5 32063.4 4889.3 4924.5 4940.6 4948.9 5056.5 197295.0 243209.0 249300.0 250171.0 251063.0 50352.2 50633.5 50684.0 50694.2 50709.5 52251.2 52566.5 52772.0 53482.5 53486.5 16792.3 16837.8 16852.2 16919.0 16950.4 13891.1 13961.9 14063.0 14066.6 14104.2 13849.3 14040.6 14179.5 14187.8 14272.4 5635.9 5645.6 5761.2 5765.2 5880.9 992.6 1004.0 1016.8 1019.7 1020.9 23023.7 23237.8 23540.8 23694.9 23893.8 1096.0 1108.9 1118.2 1122.8 1129.4 12072.7 12320.7 12346.6 12354.3 12509.5 242508.0 242967.0 244178.0 244220.0 244355.0 52852.7 52945.5 53138.0 57968.0 59167.7 1465.4 1513.5 1514.1 1514.5 1517.0 27688.9 27934.0 28037.0 28853.4 29325.3 45851.8 47002.5 47263.3 47280.3 47370.3 208341.0 208729.0 209175.0 209205.0 210216.0 36740.8 37174.0 37174.3 37185.8 37193.6 43954.8 44893.8 45182.8 45217.8 45930.3 32893.3 32956.7 33477.2 33916.0 34010.5 32266.4 32442.5 32604.7 32943.8 33160.8 35799.8 35884.0 35933.0 36044.3 36178.8 31611.0 31867.4 31933.4 31979.0 32434.4 24206.3 25085.9 25883.9 25994.2 26065.3 08:56:16 INFO - PID 25039 | 08:56:16 INFO - PID 25039 | [#2] jquery.html Cycles:180 Average:36489.09 Median:12893.06 stddev:85796.28 (665.4%) stddev-sans-first:85994.57 08:56:16 INFO - PID 25039 | Values: 565.5 579.4 580.5 591.8 610.2 22629.8 22905.7 23315.0 23338.2 23408.5 26402.9 26997.9 27092.0 27168.0 27250.3 6346.4 6514.2 6515.3 6519.3 6543.3 5801.5 6409.7 6455.6 6478.7 6496.8 6386.4 6423.1 6424.0 6426.2 6433.2 6433.9 6452.3 6454.5 6459.5 6459.9 6009.0 6009.4 6010.8 6015.0 6023.4 29140.0 30209.2 30763.5 30984.8 31077.2 1876.3 1941.6 1943.1 1943.7 1943.8 18830.2 19530.8 19582.1 19587.2 19620.2 2315.0 2322.8 2377.6 2406.2 2420.6 147517.0 151044.0 151151.5 151214.0 151405.0 14409.4 14926.9 15201.9 15351.8 15467.7 23802.0 24016.4 24029.0 24029.0 24047.9 9666.5 9940.4 9965.2 9980.8 9982.7 8950.6 9009.5 9057.0 9129.4 9203.9 7710.8 11610.0 11833.8 11969.7 12175.1 3806.2 3904.9 4109.0 4176.6 4314.5 944.7 976.3 983.4 984.2 989.6 19621.3 19848.1 19857.6 20335.7 20425.9 1029.2 1046.8 1050.2 1054.1 1055.8 10853.7 11075.5 11134.6 11160.7 11298.8 465624.0 478196.0 523436.0 526807.0 533639.0 119551.4 122158.0 123167.0 126463.0 127931.4 1264.6 1267.7 1307.6 1310.7 1312.6 21033.2 21256.7 21352.0 21554.5 21558.8 61670.7 61830.4 62075.0 62777.4 64101.0 75900.2 76021.6 76167.0 77067.6 77658.0 12460.6 13030.4 14571.9 14625.6 14970.6 23815.3 24082.0 24116.6 24169.4 24205.5 18541.9 18806.9 18828.9 18953.9 18962.9 16326.1 16591.0 17520.3 18217.9 18443.4 19633.8 20863.8 20924.4 20970.9 21018.6 14260.6 14822.6 15081.3 15134.3 15187.5 18839.0 19297.5 19443.3 19606.5 19662.0 08:56:16 INFO - PID 25039 | 08:56:16 INFO - PID 25039 | [#3] mootools.html Cycles:180 Average:8763.53 Median:2630.59 stddev:5960.02 (226.6%) stddev-sans-first:5950.63 08:56:16 INFO - PID 25039 | Values: 1339.7 1405.1 1407.7 1417.8 1421.3 13999.4 14108.6 14750.5 14753.8 14757.9 14547.9 14727.3 14733.9 14739.3 14859.6 2705.0 2749.5 2765.1 2772.9 2774.3 2494.6 2604.3 2662.5 2722.0 2735.1 2751.2 2778.4 2779.8 2782.0 2782.3 2620.9 2665.2 2665.4 2698.3 2702.3 2582.1 2609.1 2640.2 2654.1 2658.7 14105.9 14265.7 14292.5 14298.9 14305.6 7445.2 7707.3 7709.6 7711.0 7713.7 5039.1 5224.3 5272.2 5324.7 5347.7 1806.6 1822.4 1829.5 1864.4 1871.3 22804.2 23119.5 23147.4 23201.5 23338.6 6481.5 6541.6 6777.1 6811.5 6892.9 15877.8 15878.5 15879.9 15882.4 15951.6 7639.1 7831.5 7884.2 7886.9 7887.3 7020.5 7240.8 7258.8 7289.6 7319.0 5101.9 5216.2 5266.3 5301.9 5324.1 1262.7 1305.8 1499.2 1538.3 1580.0 885.8 902.4 908.1 920.6 923.7 8175.1 8300.0 8329.2 8654.5 9036.3 965.1 987.6 993.3 1000.4 1000.7 4840.1 5017.8 5206.0 5210.0 5255.9 19167.5 19460.4 19782.8 19802.6 19825.8 18561.6 18992.9 19184.7 19222.8 19265.1 10657.4 10736.6 10775.1 10800.2 10851.6 7286.1 7521.4 8044.7 8059.1 8080.8 17089.2 17096.2 17320.5 17438.8 17618.9 17025.5 17326.0 17404.6 17502.1 17889.9 10430.1 10727.0 10736.2 10792.3 10802.4 11957.2 12365.0 12494.6 12515.9 12529.1 10420.5 10699.5 10751.1 10876.2 11037.9 9971.7 10117.1 10165.0 10337.2 10480.7 9478.2 9496.3 9567.4 9570.4 9574.1 6956.5 7000.6 7014.6 7074.6 7135.1 6850.1 6855.2 6894.3 6920.2 7014.7 08:56:16 INFO - PID 25039 | 08:56:16 INFO - PID 25039 | [#4] prototype.html Cycles:180 Average:5615.91 Median:6151.18 stddev:1500.47 (24.4%) stddev-sans-first:1454.59 08:56:16 INFO - PID 25039 | Values: 493.5 507.7 528.2 530.4 533.4 6117.6 6181.3 6205.4 6291.9 6326.7 5934.6 6096.1 6098.6 6188.9 6227.4 5175.3 5185.4 5202.9 5207.5 5240.2 5113.8 5156.7 5168.3 5187.3 5231.2 4979.9 5148.6 5156.3 5187.1 5226.9 5105.2 5159.1 5206.0 5210.2 5211.6 4814.5 4840.7 4844.1 4859.0 4867.9 5986.9 6121.3 6171.8 6173.8 6197.4 5951.3 5959.7 6037.6 6084.5 6130.6 6501.2 6629.5 6641.9 6658.5 6661.2 5323.6 5349.6 5363.1 5376.9 5409.3 6799.9 6944.2 6958.5 6981.8 7000.0 5468.8 5500.7 5504.3 5531.1 5532.4 5588.7 5612.2 5644.9 5648.2 5680.8 5945.2 5964.8 6011.5 6061.4 6106.2 6545.0 6563.6 6564.9 6602.2 6667.3 1858.2 1879.1 1888.8 1893.5 1968.2 1429.8 1448.5 1450.7 1454.9 1465.1 5608.0 5655.3 5705.5 5714.7 5726.4 6435.9 6682.7 6683.8 6735.9 6783.8 5728.7 5803.7 5812.9 5836.2 5859.6 3530.8 3531.6 3581.6 3588.0 3612.0 6353.4 6496.2 6499.3 6509.5 6548.3 6888.8 6907.2 6929.2 6991.4 6993.4 6373.0 6458.6 6543.0 6578.5 6595.4 6727.7 6749.8 6778.1 6801.8 6831.5 6455.5 6543.7 6567.2 6587.7 6670.3 6424.0 6462.2 6499.8 6503.5 6522.0 4955.3 5036.6 5054.8 5057.9 5077.2 6748.9 6756.7 6772.7 6803.0 6816.1 6468.4 6491.5 6510.7 6527.4 6534.8 6463.7 6469.6 6497.3 6527.2 6528.4 6171.8 6330.5 6351.9 6384.6 6435.7 6602.0 6610.4 6623.8 6630.6 6651.2 6331.3 6336.9 6340.0 6344.2 6371.2 08:56:16 INFO - PID 25039 | 08:56:16 INFO - PID 25039 | [#5] yui.html Cycles:180 Average:23454.50 Median:19219.92 stddev:31888.93 (165.9%) stddev-sans-first:31933.33 08:56:16 INFO - PID 25039 | Values: 880.0 880.2 895.6 905.1 912.6 17718.1 18754.2 18755.2 18767.5 20064.5 18526.5 18670.6 18675.9 18711.3 18734.3 1015.7 1031.1 1040.9 1075.7 1078.1 1066.2 1072.1 1072.4 1072.9 1073.1 1103.8 1106.2 1109.2 1109.7 1112.0 1100.0 1101.6 1105.6 1107.4 1110.3 805.1 806.7 807.7 810.1 814.2 18739.8 19096.5 19166.6 19283.0 19437.8 20140.6 20669.7 20861.0 21138.3 21186.9 15906.3 16060.0 16304.8 16412.6 16416.3 3483.5 3504.3 3506.7 3508.1 3509.5 127697.0 128091.4 128520.4 128704.0 129587.0 15871.2 15980.8 16044.6 16116.8 16335.4 30162.4 30249.2 30279.8 30323.8 30786.7 8360.8 8366.2 8409.1 8414.1 8415.6 3452.2 3680.5 3876.2 4072.3 4102.6 5146.8 5229.2 5229.3 5240.9 5261.8 1012.4 1047.6 1058.4 1090.1 1107.5 498.5 614.6 631.5 633.3 666.7 11353.4 12004.5 12010.3 12329.6 12850.7 665.5 665.9 666.4 671.9 677.9 5382.2 5564.3 5663.8 5669.6 5695.3 102239.0 103491.5 103870.5 106185.0 108966.5 96426.0 96981.5 97286.5 99827.5 100058.0 81945.2 84931.0 86834.6 88658.0 90429.5 11030.7 11644.1 11850.0 11914.9 12142.6 35103.6 35596.0 35734.3 36115.5 37150.0 66166.3 66932.7 68257.0 68764.3 69865.3 17950.9 18121.9 18217.4 18223.7 18248.5 16585.3 21539.0 22222.3 22231.7 22241.4 17552.6 19417.0 19542.9 20085.6 20100.5 19113.4 19273.2 19302.1 19614.5 20068.2 16688.2 17590.6 17687.7 17871.2 18247.5 12825.4 13365.8 13381.9 13565.3 13810.4 12919.1 14690.1 14796.0 14988.3 15200.9 08:56:16 INFO - PID 25039 | -------- Summary: end -------- 08:56:16 INFO - PID 25039 | 08:56:17 INFO - TEST-INFO | 25039: exit 0 08:56:17 INFO - TEST-OK | dromaeo_css | took 1112967ms 08:56:17 INFO - TEST-START | kraken 08:56:17 INFO - Initialising browser for kraken test... 08:56:17 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42654/getInfo.html -profile /tmp/tmpUfpNcc/profile 08:56:17 INFO - TEST-INFO | started process 25407 (/builds/slave/test/build/application/firefox/firefox http://localhost:42654/getInfo.html) 08:56:22 INFO - TEST-INFO | 25407: exit 0 08:56:22 INFO - Browser initialized. 08:56:22 INFO - Running cycle 1/1 for kraken test... 08:56:22 INFO - TEST-INFO | started process 25618 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUfpNcc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:56:23 INFO - PID 25618 | 08:56:23 INFO - PID 25618 | (/builds/slave/test/build/application/firefox/firefox:25667): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:56:23 INFO - PID 25618 | 08:56:33 INFO - PID 25618 | RSS: Main: 172175360 08:56:33 INFO - PID 25618 | 08:56:36 INFO - PID 25618 | Cycle 1(1): loaded http://localhost:42654/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42654/tests/kraken/driver.html?testName=audio-beat-detection) 08:56:37 INFO - PID 25618 | RSS: Main: 177057792 08:56:37 INFO - PID 25618 | 08:56:40 INFO - PID 25618 | Cycle 1(1): loaded http://localhost:42654/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42654/tests/kraken/driver.html?testName=audio-dft) 08:56:40 INFO - PID 25618 | RSS: Main: 177901568 08:56:40 INFO - PID 25618 | 08:56:43 INFO - PID 25618 | Cycle 1(1): loaded http://localhost:42654/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42654/tests/kraken/driver.html?testName=audio-fft) 08:56:44 INFO - PID 25618 | RSS: Main: 172113920 08:56:44 INFO - PID 25618 | 08:56:46 INFO - PID 25618 | Cycle 1(1): loaded http://localhost:42654/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42654/tests/kraken/driver.html?testName=audio-oscillator) 08:56:47 INFO - PID 25618 | RSS: Main: 171962368 08:56:47 INFO - PID 25618 | 08:56:49 INFO - PID 25618 | Cycle 1(1): loaded http://localhost:42654/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42654/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:56:49 INFO - PID 25618 | RSS: Main: 172916736 08:56:49 INFO - PID 25618 | 08:56:52 INFO - PID 25618 | Cycle 1(1): loaded http://localhost:42654/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42654/tests/kraken/driver.html?testName=imaging-darkroom) 08:56:53 INFO - PID 25618 | RSS: Main: 175435776 08:56:53 INFO - PID 25618 | 08:56:57 INFO - PID 25618 | Cycle 1(1): loaded http://localhost:42654/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42654/tests/kraken/driver.html?testName=imaging-desaturate) 08:56:57 INFO - PID 25618 | RSS: Main: 175603712 08:56:57 INFO - PID 25618 | 08:57:00 INFO - PID 25618 | Cycle 1(1): loaded http://localhost:42654/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42654/tests/kraken/driver.html?testName=json-parse-financial) 08:57:01 INFO - PID 25618 | RSS: Main: 176005120 08:57:01 INFO - PID 25618 | 08:57:02 INFO - PID 25618 | Cycle 1(1): loaded http://localhost:42654/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42654/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:57:03 INFO - PID 25618 | RSS: Main: 175915008 08:57:03 INFO - PID 25618 | 08:57:05 INFO - PID 25618 | Cycle 1(1): loaded http://localhost:42654/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42654/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:57:05 INFO - PID 25618 | RSS: Main: 175984640 08:57:05 INFO - PID 25618 | 08:57:08 INFO - PID 25618 | Cycle 1(1): loaded http://localhost:42654/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42654/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:57:08 INFO - PID 25618 | RSS: Main: 172990464 08:57:08 INFO - PID 25618 | 08:57:11 INFO - PID 25618 | Cycle 1(1): loaded http://localhost:42654/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42654/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:57:12 INFO - PID 25618 | RSS: Main: 173174784 08:57:12 INFO - PID 25618 | 08:57:15 INFO - PID 25618 | Cycle 1(1): loaded http://localhost:42654/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42654/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:57:15 INFO - PID 25618 | RSS: Main: 173490176 08:57:15 INFO - PID 25618 | 08:57:17 INFO - PID 25618 | Cycle 1(1): loaded http://localhost:42654/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42654/tests/kraken/driver.html?testName=ai-astar) 08:57:17 INFO - PID 25618 | RSS: Main: 174821376 08:57:17 INFO - PID 25618 | 08:57:17 INFO - PID 25618 | __start_tp_report 08:57:17 INFO - PID 25618 | _x_x_mozilla_page_load 08:57:17 INFO - PID 25618 | _x_x_mozilla_page_load_details 08:57:17 INFO - PID 25618 | |i|pagename|runs| 08:57:17 INFO - PID 25618 | |0;ai-astar;99;108;100;108;108;109;111;103;109;111 08:57:17 INFO - PID 25618 | |1;audio-beat-detection;151;116;140;170;120;148;149;118;173;117 08:57:17 INFO - PID 25618 | |2;audio-dft;165;164;165;162;163;162;162;176;168;166 08:57:17 INFO - PID 25618 | |3;audio-fft;76;75;75;167;79;75;75;74;147;75 08:57:17 INFO - PID 25618 | |4;audio-oscillator;79;78;128;79;79;78;144;79;79;139 08:57:17 INFO - PID 25618 | |5;imaging-gaussian-blur;115;114;114;114;115;115;113;114;114;114 08:57:17 INFO - PID 25618 | |6;imaging-darkroom;155;151;151;152;151;150;150;153;153;151 08:57:17 INFO - PID 25618 | |7;imaging-desaturate;94;94;94;95;95;95;94;95;94;99 08:57:17 INFO - PID 25618 | |8;json-parse-financial;56;56;56;56;56;55;56;60;58;56 08:57:17 INFO - PID 25618 | |9;json-stringify-tinderbox;54;54;53;54;54;54;54;54;54;54 08:57:17 INFO - PID 25618 | |10;stanford-crypto-aes;78;77;79;88;89;88;79;78;85;79 08:57:17 INFO - PID 25618 | |11;stanford-crypto-ccm;135;126;150;125;136;142;128;126;127;176 08:57:17 INFO - PID 25618 | |12;stanford-crypto-pbkdf2;189;172;181;172;188;173;170;171;178;176 08:57:17 INFO - PID 25618 | |13;stanford-crypto-sha256-iterative;72;70;66;71;67;66;67;66;65;65 08:57:17 INFO - PID 25618 | __end_tp_report 08:57:17 INFO - PID 25618 | __start_cc_report 08:57:17 INFO - PID 25618 | _x_x_mozilla_cycle_collect,961 08:57:17 INFO - PID 25618 | __end_cc_report 08:57:17 INFO - PID 25618 | __startTimestamp1501775837838__endTimestamp 08:57:17 INFO - PID 25618 | 08:57:17 INFO - PID 25618 | ------- Summary: start ------- 08:57:17 INFO - PID 25618 | Number of tests: 14 08:57:17 INFO - PID 25618 | 08:57:17 INFO - PID 25618 | [#0] ai-astar Cycles:10 Average:106.60 Median:109.00 stddev:4.35 (4.0%) stddev-sans-first:3.64 08:57:17 INFO - PID 25618 | Values: 99.0 108.0 100.0 108.0 108.0 109.0 111.0 103.0 109.0 111.0 08:57:17 INFO - PID 25618 | 08:57:17 INFO - PID 25618 | [#1] audio-beat-detection Cycles:10 Average:140.20 Median:148.50 stddev:21.71 (14.6%) stddev-sans-first:22.68 08:57:17 INFO - PID 25618 | Values: 151.0 116.0 140.0 170.0 120.0 148.0 149.0 118.0 173.0 117.0 08:57:17 INFO - PID 25618 | 08:57:17 INFO - PID 25618 | [#2] audio-dft Cycles:10 Average:165.30 Median:165.00 stddev:4.24 (2.6%) stddev-sans-first:4.50 08:57:17 INFO - PID 25618 | Values: 165.0 164.0 165.0 162.0 163.0 162.0 162.0 176.0 168.0 166.0 08:57:17 INFO - PID 25618 | 08:57:17 INFO - PID 25618 | [#3] audio-fft Cycles:10 Average:91.80 Median:75.00 stddev:34.71 (46.3%) stddev-sans-first:36.34 08:57:17 INFO - PID 25618 | Values: 76.0 75.0 75.0 167.0 79.0 75.0 75.0 74.0 147.0 75.0 08:57:17 INFO - PID 25618 | 08:57:17 INFO - PID 25618 | [#4] audio-oscillator Cycles:10 Average:96.20 Median:79.00 stddev:28.42 (36.0%) stddev-sans-first:29.46 08:57:17 INFO - PID 25618 | Values: 79.0 78.0 128.0 79.0 79.0 78.0 144.0 79.0 79.0 139.0 08:57:17 INFO - PID 25618 | 08:57:17 INFO - PID 25618 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 08:57:17 INFO - PID 25618 | Values: 115.0 114.0 114.0 114.0 115.0 115.0 113.0 114.0 114.0 114.0 08:57:17 INFO - PID 25618 | 08:57:17 INFO - PID 25618 | [#6] imaging-darkroom Cycles:10 Average:151.70 Median:151.50 stddev:1.57 (1.0%) stddev-sans-first:1.12 08:57:17 INFO - PID 25618 | Values: 155.0 151.0 151.0 152.0 151.0 150.0 150.0 153.0 153.0 151.0 08:57:17 INFO - PID 25618 | 08:57:17 INFO - PID 25618 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:1.52 (1.6%) stddev-sans-first:1.58 08:57:17 INFO - PID 25618 | Values: 94.0 94.0 94.0 95.0 95.0 95.0 94.0 95.0 94.0 99.0 08:57:17 INFO - PID 25618 | 08:57:17 INFO - PID 25618 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:56.00 stddev:1.43 (2.6%) stddev-sans-first:1.51 08:57:17 INFO - PID 25618 | Values: 56.0 56.0 56.0 56.0 56.0 55.0 56.0 60.0 58.0 56.0 08:57:17 INFO - PID 25618 | 08:57:17 INFO - PID 25618 | [#9] json-stringify-tinderbox Cycles:10 Average:53.90 Median:54.00 stddev:0.32 (0.6%) stddev-sans-first:0.33 08:57:17 INFO - PID 25618 | Values: 54.0 54.0 53.0 54.0 54.0 54.0 54.0 54.0 54.0 54.0 08:57:17 INFO - PID 25618 | 08:57:17 INFO - PID 25618 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:82.00 stddev:4.88 (5.9%) stddev-sans-first:4.95 08:57:17 INFO - PID 25618 | Values: 78.0 77.0 79.0 88.0 89.0 88.0 79.0 78.0 85.0 79.0 08:57:17 INFO - PID 25618 | 08:57:17 INFO - PID 25618 | [#11] stanford-crypto-ccm Cycles:10 Average:137.10 Median:135.50 stddev:15.94 (11.8%) stddev-sans-first:16.89 08:57:17 INFO - PID 25618 | Values: 135.0 126.0 150.0 125.0 136.0 142.0 128.0 126.0 127.0 176.0 08:57:17 INFO - PID 25618 | 08:57:17 INFO - PID 25618 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.00 Median:177.00 stddev:6.94 (3.9%) stddev-sans-first:5.85 08:57:17 INFO - PID 25618 | Values: 189.0 172.0 181.0 172.0 188.0 173.0 170.0 171.0 178.0 176.0 08:57:17 INFO - PID 25618 | 08:57:17 INFO - PID 25618 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.00 stddev:2.55 (3.8%) stddev-sans-first:2.12 08:57:17 INFO - PID 25618 | Values: 72.0 70.0 66.0 71.0 67.0 66.0 67.0 66.0 65.0 65.0 08:57:17 INFO - PID 25618 | -------- Summary: end -------- 08:57:17 INFO - PID 25618 | 08:57:18 INFO - PID 25618 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 08:57:18 INFO - TEST-INFO | 25618: exit 0 08:57:18 INFO - TEST-OK | kraken | took 61409ms 08:57:18 INFO - SUITE-END | took 1174s 08:57:19 INFO - Completed test suite (00:19:34) 08:57:19 INFO - javascript benchmark 08:57:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8613.875345770683, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3132.4988001919696, 3161.225499752561, 3191.138392633988, 3197.8720851165954, 3238.206639373354, 6241.968790156048, 6251.656158911258, 6360.904586431201, 6382.617042977425, 6384.265809431917, 6291.307956124834, 6327.5570710050315, 6330.746770129189, 6393.0410438434255, 6422.454091402236, 5601.103823388259, 5739.626924249931, 5824.271966004249, 5834.533237341003, 5864.941350586503, 5716.599838011341, 5738.540916726652, 5823.039198532237, 5833.095870140114, 5835.620684655505, 5743.9712801435935, 5777.19119323295, 5803.390643982384, 5814.0, 5828.47543721065, 5710.514606258473, 5802.680852553108, 5809.2447981762525, 5815.680137592431, 5826.213461182729, 5548.889022219573, 5636.04187288162, 5659.377468478464, 5678.630888992202, 5731.340895796995, 6211.87576248477, 6246.6252024878195, 6253.843653908689, 6257.0, 6267.2165979252595, 6702.731890724365, 6707.329267073303, 6730.0577919091365, 6801.251862295144, 6805.353491418307, 6727.932720672779, 6771.796846094625, 6801.523893327469, 6813.4208592269715, 6879.449644028516, 6314.116023756632, 6349.619022858597, 6359.268684101387, 6378.744850206032, 6384.0, 6856.520043597, 6969.581825090409, 6981.5461994970165, 7056.682449289794, 7096.254893236239, 6520.152380190545, 6628.237752658506, 6628.867422651617, 6632.900506492407, 6633.336666333328, 6631.436327912182, 6750.35871592198, 6762.594244345355, 6765.05289259504, 6765.627890466071, 6696.263411024784, 6699.430548403343, 6793.762218322434, 6799.082123913208, 6801.523893327519, 6573.474122070223, 6723.462123030145, 6725.4619630430425, 6726.0, 6760.763373281911, 5336.733163341817, 5341.973290133525, 5359.115745901882, 5363.490468405495, 5372.301600791872, 4636.5131661175765, 4663.440387153495, 4689.554492323224, 4716.962268300968, 4746.335513028179, 5875.089361149029, 5878.823635290948, 5928.762849485972, 5960.195373624505, 5961.135635332939, 6639.1037209977, 6770.796876093725, 6813.557118787362, 6873.965630171817, 6880.759173428906, 5822.883542329129, 5832.1834943108, 5836.474717275466, 5841.88316233673, 5842.883142337129, 5870.677112758839, 5915.704214789243, 5917.881642367129, 5921.851953701192, 5923.911141332884, 6497.772577959749, 6572.474202063823, 6572.638504882182, 6572.934270657232, 6574.441172500296, 6693.163354580677, 6710.194776626836, 6722.1261236039, 6814.386705196556, 6814.727410903707, 6421.935780642134, 6530.8040758777315, 6539.378759017885, 6552.3447655236005, 6594.967025165035, 6606.240282367397, 6700.229473610597, 6713.429358504386, 6724.125863637696, 6760.729570817112, 6880.724771009103, 6883.380495755406, 6886.8622627548175, 6888.965555172192, 6902.792916212522, 6532.0, 6584.901226481511, 6596.274409815012, 6626.138601981712, 6627.502937279627, 6496.967515162394, 6502.349765023459, 6514.609123452608, 6602.471802255904, 6632.403083722488, 6392.488600912009, 6444.742210311535, 6461.64460954652, 6477.870442591027, 6484.675766211765, 6512.837179070561, 6524.478041756743, 6534.640594767334, 6622.735090596322, 6624.867502650017, 6368.363163683594, 6419.422251997343, 6428.067930150009, 6429.678516074084, 6431.260405053479], "value": 6159.730914447089, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [770.3259647808168, 810.785141937387, 850.6554845287658, 875.5578432891391, 887.5917078144054, 40163.1967360653, 40995.0, 41188.0, 41195.17609647809, 41205.58794412063, 37376.81311593438, 37728.62271377286, 37790.055248618795, 37886.621133788656, 37998.24003519928, 6694.0962969999155, 6841.828954276158, 6855.794326170223, 6856.2800905904905, 6862.7598034068815, 6804.0, 6875.759348422806, 6878.965605171992, 6886.414654754327, 6889.276625954278, 6838.931610683904, 7496.137944136412, 7648.770536883902, 7720.536767793922, 7732.265434783687, 7637.465377423582, 7693.615319234016, 7703.922960770405, 7711.614419279013, 7711.922880771177, 7407.814804629874, 7580.279873412017, 7593.05086864142, 7596.658150383246, 7622.6188690565805, 39267.0, 39502.40746388806, 39514.40728389077, 39539.40690889639, 39670.0, 3559.359315323241, 3585.748997570171, 3606.549181352331, 3615.0, 3615.2950174715943, 31582.842085789423, 31649.0, 31757.36485270305, 31803.522947155812, 32063.358732825214, 4889.33993910821, 4924.482929292444, 4940.6294527910195, 4948.8762780930765, 5056.494350564951, 197295.0, 243209.0, 249300.0, 250170.99999999817, 251063.0, 50352.24471632928, 50633.49366506288, 50684.0, 50694.239586406235, 50709.492905071216, 52251.21623175655, 52566.474335256156, 52772.0, 53482.46517534852, 53486.465135348924, 16792.328306867832, 16837.831621683872, 16852.241649125575, 16919.0, 16950.40673576419, 13891.097078689852, 13961.860381396056, 14063.0, 14066.648333791738, 14104.153750774987, 13849.307534623229, 14040.648983775487, 14179.503717369842, 14187.78718319226, 14272.35774390155, 5635.915461268084, 5645.604807663506, 5761.164631128463, 5765.1928729977835, 5880.941190588125, 992.593036854886, 1003.9698809035594, 1016.832222683249, 1019.6686077024848, 1020.9081182693593, 23023.654645180337, 23237.76762232356, 23540.7645923542, 23694.88152559226, 23893.7610623895, 1095.9726006849892, 1108.872479664849, 1118.1613789657756, 1122.848415463902, 1129.4296380327883, 12072.698182545506, 12320.691982700326, 12346.567870124503, 12354.25874447518, 12509.499620015098, 242508.0, 242967.0, 244178.0, 244220.0, 244355.0, 52852.735736321076, 52945.470545294054, 53138.0, 57968.0, 59167.70416147978, 1465.4358072142088, 1513.4627207341234, 1514.1293756090072, 1514.4775052606833, 1516.9772453413207, 27688.861555692092, 27934.0, 28037.0, 28853.42293154167, 29325.26686832846, 45851.77074114608, 47002.52997469981, 47263.29105063496, 47280.290795637404, 47370.289445657654, 208341.0, 208729.0, 209175.0, 209205.0, 210216.0, 36740.816295919416, 37174.0, 37174.25651487009, 37185.814070929475, 37193.6280637201, 43954.780226098665, 44893.77553112344, 45182.774086130674, 45217.773911130236, 45930.31104533368, 32893.34213315672, 32956.67043329536, 33477.16307092342, 33916.0, 34010.489842651885, 32266.35467290688, 32442.513362299112, 32604.673953261114, 32943.83528082344, 33160.834195828866, 35799.82100089483, 35884.0, 35933.0, 36044.27911441809, 36178.8191059043, 31611.0, 31867.362652746353, 31933.36133277368, 31979.0, 32434.35131297408, 24206.273811785675, 25085.87457062776, 25883.870580646977, 25994.220173394828, 26065.348366290236], "value": 17615.812687243033, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.510833129343, 579.3511267380535, 580.457272450259, 591.8076625096843, 610.2341561340518, 22629.773702262974, 22905.656415153746, 23315.0, 23338.183163589278, 23408.5318293634, 26402.867985660094, 26997.865010674966, 27092.0, 27168.0, 27250.31874203141, 6346.365363463639, 6514.185726784152, 6515.34846515347, 6519.282878883319, 6543.345665433466, 5801.535877129841, 6409.743610255584, 6455.644939528324, 6478.708458119372, 6496.8050958471085, 6386.425221730044, 6423.100765892778, 6424.0, 6426.164598602175, 6433.22801263849, 6433.935660643404, 6452.257990331125, 6454.548181627288, 6459.450946669492, 6459.935400645981, 6009.0, 6009.369016253274, 6010.819675409744, 6015.0375939849855, 6023.367546407608, 29140.0, 30209.244768880955, 30763.538546921813, 30984.8450757747, 31077.22306942322, 1876.2682553804027, 1941.5728539721238, 1943.1255934829383, 1943.6695761720541, 1943.7959014303435, 18830.246790128378, 19530.804691953042, 19582.11880465368, 19587.216511339528, 19620.215191392326, 2314.9768502315096, 2322.837401381904, 2377.583922813518, 2406.157844754322, 2420.5642984262827, 147517.0, 151044.0, 151151.48848511485, 151214.0, 151405.0, 14409.42362305517, 14926.850731492763, 15201.871737956695, 15351.77826097832, 15467.690646187013, 23802.0, 24016.39959001039, 24029.0, 24029.0, 24047.879760601085, 9666.468344240993, 9940.353876997971, 9965.152961998312, 9980.750481237881, 9982.650607228712, 8950.552472376485, 9009.504477253682, 9057.0, 9129.406588571854, 9203.941546722079, 7710.845783084419, 11610.0, 11833.763324733629, 11969.700757480958, 12175.0868684849, 3806.219724956433, 3904.921901561953, 4108.958910410917, 4176.58234176586, 4314.511493534726, 944.7354740672623, 976.272676855747, 983.3657291047234, 984.2224642532319, 989.5744829723288, 19621.313254036326, 19848.10683519245, 19857.60284794296, 20335.694964575545, 20425.89787051085, 1029.2126523209752, 1046.8482070099944, 1050.186105768036, 1054.1250761867784, 1055.8099542082498, 10853.728656783485, 11075.50160242791, 11134.554617815358, 11160.720981975515, 11298.774024519464, 465624.0, 478196.0, 523436.0, 526807.0, 533639.0, 119551.40224298996, 122158.0, 123167.0, 126463.0, 127931.36034319954, 1264.6395777203636, 1267.714764178071, 1307.5881097454271, 1310.7181955879532, 1312.566852938528, 21033.15867365288, 21256.681149783075, 21352.0, 21554.461138471037, 21558.784412156307, 61670.69164654148, 61830.38169618426, 62075.0, 62777.372226277155, 64101.038484423705, 75900.24099758932, 76021.61989190019, 76167.0, 77067.61466192633, 77658.0, 12460.563880264148, 13030.4136313868, 14571.85428145705, 14625.634359141106, 14970.625734356729, 23815.285541433786, 24082.0, 24116.638250425905, 24169.39576510531, 24205.515889681756, 18541.907290464, 18806.905965470087, 18828.905855470635, 18953.905230474313, 18962.905185473985, 16326.102064386572, 16591.0, 17520.299188032335, 18217.90891045589, 18443.446696599123, 19633.803661963768, 20863.791362086184, 20924.372268831958, 20970.895145524173, 21018.579628407653, 14260.572182834532, 14822.62943426423, 15081.321340539482, 15134.318955646802, 15187.468438604596, 18839.0, 19297.51756206106, 19443.319483818563, 19606.509837254183, 19662.0], "value": 12459.8130834026, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.6583871112864, 1405.1007355292616, 1407.7466056109897, 1417.7518934186508, 1421.337035668268, 13999.370028348723, 14108.576742697709, 14750.483733069344, 14753.778693319582, 14757.852421475782, 14547.92726036371, 14727.26363681817, 14733.852661473382, 14739.336729847157, 14859.554213373616, 2705.026190571398, 2749.477599256135, 2765.0875211180264, 2772.8613569321556, 2774.3202915285683, 2494.5634513959985, 2604.28382194897, 2662.480816240824, 2721.9591706124424, 2735.124760076776, 2751.2159034675124, 2778.402643431662, 2779.833210007396, 2781.958270625942, 2782.2627003844, 2620.934476638099, 2665.200439868032, 2665.3869609989715, 2698.3119304577303, 2702.2568793581822, 2582.0704546363295, 2609.1389841352307, 2640.2475294541155, 2654.0843409023855, 2658.720834312408, 14105.858941410557, 14265.714685706227, 14292.499762508261, 14298.928505357511, 14305.57083287503, 7445.181030086686, 7707.344875685573, 7709.575973321465, 7711.0, 7713.730019449293, 5039.118154322979, 5224.294720212761, 5272.156454967187, 5324.653897496651, 5347.732613369355, 1806.5935164587993, 1822.3894995176631, 1829.4785985993929, 1864.3661155207294, 1871.2889102141235, 22804.201852935235, 23119.537609247887, 23147.421314467105, 23201.53596928052, 23338.64992025121, 6481.546291759531, 6541.6075035498025, 6777.085093512313, 6811.489138314646, 6892.862142757117, 15877.761833572506, 15878.52364429069, 15879.920600397156, 15882.444114455939, 15951.60120996961, 7639.121501027342, 7831.490953088031, 7884.172161922916, 7886.856405821124, 7887.290143887078, 7020.543664661781, 7240.782776516713, 7258.782236532912, 7289.635518224068, 7319.048523691886, 5101.923471147936, 5216.243644671577, 5266.262723218752, 5301.920471192935, 5324.068288049653, 1262.665393670678, 1305.8367704036996, 1499.1754535005703, 1538.3154496249285, 1579.968400631981, 885.8139790643908, 902.3503077783985, 908.0919080919081, 920.5949382271779, 923.6813299411692, 8175.059868115124, 8299.95850020746, 8329.208725171098, 8654.524001179996, 9036.277097832157, 965.1458459263462, 987.6493844685033, 993.3295025857517, 1000.3947611694965, 1000.6647772995982, 4840.110619689883, 5017.84946451607, 5205.973970130125, 5209.958008398336, 5255.894882102337, 19167.52081197953, 19460.416187514114, 19782.802171978095, 19802.60394792096, 19825.801741982683, 18561.628767424576, 18992.905035474734, 19184.71222931657, 19222.8077719221, 19265.13306901193, 10657.401389791594, 10736.624218152483, 10775.137988961022, 10800.243982921278, 10851.620193293196, 7286.125664920243, 7521.401652232598, 8044.718434854752, 8059.113497515152, 8080.757577272691, 17089.230984605972, 17096.230669620145, 17320.480385588453, 17438.82561174372, 17618.91190544039, 17025.48923532296, 17326.0, 17404.564885877953, 17502.124893755008, 17889.910550447163, 10430.113440357654, 10726.98093681099, 10736.248462607855, 10792.298500597437, 10802.405867677353, 11957.222780519238, 12365.0, 12494.562690305796, 12515.87484125147, 12529.122961392615, 10420.531076101744, 10699.465026748787, 10751.086157676373, 10876.18428617841, 11037.889621103686, 9971.700848974542, 10117.08946194846, 10165.0, 10337.17302615804, 10480.737981550523, 9478.194353479756, 9496.335256532253, 9567.37812042215, 9570.425774453555, 9574.138327550554, 6956.513044086865, 7000.649967501707, 7014.579125252297, 7074.610896400747, 7135.108111486064, 6850.143732033496, 6855.245922948372, 6894.310568943066, 6920.169579650475, 7014.684339204646], "value": 6417.629249949217, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [493.5459377372818, 507.6597781855901, 528.1654985123505, 530.4456842599484, 533.4292307231265, 6117.5717699761035, 6181.28915174755, 6205.379462053798, 6291.854072963518, 6326.715297811598, 5934.5845790794665, 6096.146539484475, 6098.634081955075, 6188.938110618892, 6227.43953044226, 5175.275461435402, 5185.377754669426, 5202.895942081156, 5207.479252074791, 5240.161574148137, 5113.846584602468, 5156.716380599066, 5168.302279192299, 5187.27378167055, 5231.215317702337, 4979.850604481871, 5148.639595228336, 5156.338999310494, 5187.144121219994, 5226.921596176041, 5105.208692652626, 5159.1229490986625, 5205.973970130163, 5210.166373380241, 5211.557017653504, 4814.522494080504, 4840.685355451885, 4844.128056949748, 4859.0, 4867.902641947141, 5986.8503287417725, 6121.265448146207, 6171.783987560414, 6173.81478555644, 6197.442230199259, 5951.256092988377, 5959.731812068468, 6037.611349389621, 6084.452399284086, 6130.601510901777, 6501.219853617549, 6629.535932484728, 6641.93358066418, 6658.536341553608, 6661.233958094833, 5323.627346085776, 5349.598780091509, 5363.141897296414, 5376.946230537723, 5409.2967914171295, 6799.864002719918, 6944.236134025253, 6958.512904096715, 6981.79054628362, 6999.965000174967, 5468.781248750085, 5500.697461639648, 5504.256925315111, 5531.115021596605, 5532.363778165482, 5588.6646801192055, 5612.158176273591, 5644.943550564524, 5648.15277708347, 5680.77276908919, 5945.167676525203, 5964.7912323068485, 6011.458968692838, 6061.363556826558, 6106.2061931948565, 6544.967275163689, 6563.556017676104, 6564.868702626016, 6602.2407423146, 6667.266600673922, 1858.1697028426988, 1879.1355976251077, 1888.8111188881276, 1893.4982229709137, 1968.1733671857853, 1429.785532170162, 1448.5364683301452, 1450.6881020580627, 1454.941802327916, 1465.1282486920265, 5608.046632072557, 5655.321361436654, 5705.515031222392, 5714.685692286964, 5726.398728133486, 6435.935640643534, 6682.699278532477, 6683.766068187688, 6735.932640673628, 6783.830404239835, 5728.742206600713, 5803.65178089316, 5812.941870581325, 5836.212111364996, 5859.648421094748, 3530.7881527108457, 3531.5762108547137, 3581.588117366536, 3587.9641203588153, 3611.963880361163, 6353.396427339396, 6496.155499784998, 6499.3175716549085, 6509.479241660656, 6548.3124271950755, 6888.758893438706, 6907.171139463297, 6929.237783843773, 6991.405730512862, 6993.440524758007, 6372.999999999907, 6458.644774537445, 6543.0, 6578.513387904418, 6595.4393876521035, 6727.730890764315, 6749.797506074826, 6778.118844550374, 6801.795946121624, 6831.45348372139, 6455.4512866405, 6543.738250470118, 6567.2447668516825, 6587.736490540325, 6670.298529095724, 6424.0, 6462.192225971754, 6499.837504062436, 6503.51223658237, 6522.021696745336, 4955.2567114933045, 5036.597072234139, 5054.848354549369, 5057.949420505748, 5077.238414237746, 6748.932510675027, 6756.729730810713, 6772.729090836311, 6802.965985170043, 6816.147981502312, 6468.353164683494, 6491.48068154537, 6510.73957041713, 6527.412532872065, 6534.803955881332, 6463.709133088928, 6469.5794773339585, 6497.285298617243, 6527.184101987252, 6528.412442879973, 6171.7531298749345, 6330.525210609315, 6351.904721429275, 6384.585001974857, 6435.650987389663, 6602.042703808017, 6610.438112760276, 6623.834404139742, 6630.635315057718, 6651.204174872661, 6331.309193592797, 6336.904946425715, 6339.9683001586545, 6344.238691357066, 6371.203599550056], "value": 5185.098611414305, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [879.9780005499862, 880.2341962492628, 895.5835536475538, 905.1039470923787, 912.5710915869541, 17718.1140942953, 18754.2498300068, 18755.15601797919, 18767.530811729714, 20064.49838754032, 18526.536836579093, 18670.626587468243, 18675.906620466878, 18711.3451029214, 18734.344297949574, 1015.6800607808517, 1031.0617338222219, 1040.8542804007445, 1075.704181350131, 1078.094400703409, 1066.163061996333, 1072.0619457974271, 1072.4101744040786, 1072.8873468285835, 1073.1146803886786, 1103.7902798468265, 1106.1593189176203, 1109.2124591540016, 1109.678193323939, 1111.9610813621525, 1100.04845808376, 1101.5924108080062, 1105.607509334187, 1107.363266121983, 1110.2783190925882, 805.0540614777672, 806.6652339279192, 807.6850028488894, 810.1331575214464, 814.2468216899404, 18739.812601873942, 19096.522586935298, 19166.616667666567, 19283.035848207674, 19437.805621943742, 20140.597188056156, 20669.689954650694, 20861.0, 21138.26016089445, 21186.894065529727, 15906.284217210137, 16060.0, 16304.755428668579, 16412.589685257844, 16416.343346266134, 3483.4600636901323, 3504.316658251642, 3506.7019303359243, 3508.1405055761247, 3509.5086687863463, 127697.0, 128091.35954320169, 128520.35739821334, 128704.0, 129587.0, 15871.20643967797, 15980.840191598169, 16044.598885027968, 16116.838831611534, 16335.428260010842, 30162.396752064837, 30249.243768905955, 30279.848600757297, 30323.848380758398, 30786.692133078832, 8360.790980225544, 8366.205210504992, 8409.117042710428, 8414.074451810297, 8415.579221038923, 3452.188735647121, 3680.5031320771886, 3876.205377897524, 4072.2873497137884, 4102.610252026112, 5146.845594632167, 5229.163333866563, 5229.267902493654, 5240.895182096337, 5261.842144735664, 1012.4077414712476, 1047.601911273711, 1058.3808472043786, 1090.095220966596, 1107.4628805029554, 498.4591717985953, 614.5759425996048, 631.504269148716, 633.2749002392235, 666.6899891550355, 11353.432328383547, 12004.51981920731, 12010.33943133136, 12329.630111096682, 12850.728397525481, 665.4543274514851, 665.8535122273092, 666.3702800853147, 671.9227288861844, 677.9423748981392, 5382.165764306539, 5564.304461942257, 5663.773449062074, 5669.574781891375, 5695.288088988877, 102239.0, 103491.4825425868, 103870.4806475978, 106185.0, 108966.45516772366, 96426.0, 96981.5150924255, 97286.51356743171, 99827.50086249667, 100058.0, 81945.18054819494, 84931.0, 86834.56582717173, 88657.9999999987, 90429.54785226032, 11030.724231894266, 11644.126690498077, 11850.0, 11914.880851191378, 12142.575009874612, 35103.64896351106, 35596.0, 35734.28531429409, 36115.458268126524, 37150.0, 66166.33833661795, 66932.665336673, 68257.0, 68764.31235687579, 69865.30134698589, 17950.91024544869, 18121.90939045296, 18217.362392316205, 18223.726644100083, 18248.543786405447, 16585.25366358541, 21539.0, 22222.333330000125, 22231.66652500246, 22241.44396390103, 17552.56118597045, 19417.0, 19542.902285488482, 20085.59828803445, 20100.497487562345, 19113.426597202106, 19273.22907083701, 19302.13140408713, 19614.509637258612, 20068.19727210895, 16688.165591720124, 17590.56023599369, 17687.73468398001, 17871.195796188942, 18247.54381140429, 12825.358732063547, 13365.799513007118, 13381.866181338062, 13565.253911034988, 13810.447582096604, 12919.095663303478, 14690.11859288446, 14796.038257513228, 14988.2505874708, 15200.923995379952], "value": 9079.399720739213, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1534.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 108.0, 100.0, 108.0, 108.0, 109.0, 111.0, 103.0, 109.0, 111.0], "value": 106.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 116.0, 140.0, 170.0, 120.0, 148.0, 149.0, 118.0, 173.0, 117.0], "value": 140.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 165.0, 162.0, 163.0, 162.0, 162.0, 176.0, 168.0, 166.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 167.0, 79.0, 75.0, 75.0, 74.0, 147.0, 75.0], "value": 91.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 128.0, 79.0, 79.0, 78.0, 144.0, 79.0, 79.0, 139.0], "value": 96.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 114.0, 115.0, 115.0, 113.0, 114.0, 114.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 151.0, 151.0, 152.0, 151.0, 150.0, 150.0, 153.0, 153.0, 151.0], "value": 151.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 99.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 56.0, 56.0, 55.0, 56.0, 60.0, 58.0, 56.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0], "value": 53.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 79.0, 88.0, 89.0, 88.0, 79.0, 78.0, 85.0, 79.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 126.0, 150.0, 125.0, 136.0, 142.0, 128.0, 126.0, 127.0, 176.0], "value": 137.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 172.0, 181.0, 172.0, 188.0, 173.0, 170.0, 171.0, 178.0, 176.0], "value": 177.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 70.0, 66.0, 71.0, 67.0, 66.0, 67.0, 66.0, 65.0, 65.0], "value": 67.5, "unit": "score"}]}]} 08:57:19 INFO - Return code: 0 08:57:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:57:19 INFO - # TBPL SUCCESS # 08:57:19 INFO - Running post-action listener: _package_coverage_data 08:57:19 INFO - Running post-action listener: _resource_record_post_action 08:57:19 INFO - [mozharness: 2017-08-03 15:57:19.127777Z] Finished run-tests step (success) 08:57:19 INFO - Running post-run listener: _resource_record_post_run 08:57:19 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 0; Write bytes: 439099392; Read time: 0; Write time: 320004 08:57:19 INFO - TinderboxPrint: CPU usage
13.2% 08:57:19 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:57:19 INFO - TinderboxPrint: I/O write bytes / time
439,099,392 / 320,004 08:57:19 INFO - TinderboxPrint: CPU idle
8,265.2 (86.8%) 08:57:19 INFO - TinderboxPrint: CPU user
1,205.0 (12.7%) 08:57:19 INFO - TinderboxPrint: Swap in / out
0 / 0 08:57:19 INFO - install - Wall time: 19s; CPU: 13.0%; Read bytes: 0; Write bytes: 112787456; Read time: 0; Write time: 109624 08:57:19 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 08:57:19 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 325787648; Read time: 0; Write time: 210340 08:57:19 INFO - Running post-run listener: _upload_blobber_files 08:57:19 INFO - Blob upload gear active. 08:57:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:57:19 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:57:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Cedar', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:57:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Cedar -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:57:20 INFO - (blobuploader) - INFO - Open directory for files ... 08:57:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:57:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:57:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:57:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:57:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:57:20 INFO - (blobuploader) - INFO - Done attempting. 08:57:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:57:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:57:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:57:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:57:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:57:27 INFO - (blobuploader) - INFO - Done attempting. 08:57:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:57:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:57:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:57:28 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:57:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:57:28 INFO - (blobuploader) - INFO - Done attempting. 08:57:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:57:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:57:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:57:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:57:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:57:29 INFO - (blobuploader) - INFO - Done attempting. 08:57:29 INFO - (blobuploader) - INFO - Iteration through files over. 08:57:29 INFO - Return code: 0 08:57:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:57:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:57:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/05dc6f9213587988a5356191a23f54e2c9ae5ce082a105bb121d5efdadd721e0fdf8c5abc2bd1926530630181f39350410b0ff6f725a7e3bc7f237dd097a4004", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/d3f6826ab49646f664b64b2f00d03309ebf2ece0420e2e9e071e82e4dc0ddb447475920c9121be1173d2373c101053c3c4144c8a2fc66a8d5a0b5a5039412475", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/4873ab412cca132b643de7e7f0da322ee25d9912dc840e256f3fd37d42939813191a9804b5312f604b0413e80d42c73f7c8976c6c6df71a6584e006c21ecae11", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/be57faea3eb051a3b48b7f70e2775a57387a23a03b075ec0173fad91eb64548432ffcd0697b7016e795a97178c7a79b9d5eca5203d36440e11a09da29f8fda4f"} 08:57:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:57:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:57:29 INFO - Contents: 08:57:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/05dc6f9213587988a5356191a23f54e2c9ae5ce082a105bb121d5efdadd721e0fdf8c5abc2bd1926530630181f39350410b0ff6f725a7e3bc7f237dd097a4004", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/d3f6826ab49646f664b64b2f00d03309ebf2ece0420e2e9e071e82e4dc0ddb447475920c9121be1173d2373c101053c3c4144c8a2fc66a8d5a0b5a5039412475", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/4873ab412cca132b643de7e7f0da322ee25d9912dc840e256f3fd37d42939813191a9804b5312f604b0413e80d42c73f7c8976c6c6df71a6584e006c21ecae11", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/be57faea3eb051a3b48b7f70e2775a57387a23a03b075ec0173fad91eb64548432ffcd0697b7016e795a97178c7a79b9d5eca5203d36440e11a09da29f8fda4f"} 08:57:29 INFO - Running post-run listener: copy_logs_to_upload_dir 08:57:29 INFO - Copying logs to upload dir... 08:57:29 INFO - mkdir: /builds/slave/test/build/upload/logs 08:57:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.896536 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-08-03 08:57:29.550053) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-03 08:57:29.553917) ========= 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=923d835db2ba3686ebe126b700000192-1501773957.580654-351862154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/05dc6f9213587988a5356191a23f54e2c9ae5ce082a105bb121d5efdadd721e0fdf8c5abc2bd1926530630181f39350410b0ff6f725a7e3bc7f237dd097a4004", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/d3f6826ab49646f664b64b2f00d03309ebf2ece0420e2e9e071e82e4dc0ddb447475920c9121be1173d2373c101053c3c4144c8a2fc66a8d5a0b5a5039412475", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/4873ab412cca132b643de7e7f0da322ee25d9912dc840e256f3fd37d42939813191a9804b5312f604b0413e80d42c73f7c8976c6c6df71a6584e006c21ecae11", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/be57faea3eb051a3b48b7f70e2775a57387a23a03b075ec0173fad91eb64548432ffcd0697b7016e795a97178c7a79b9d5eca5203d36440e11a09da29f8fda4f"} build_url:https://queue.taskcluster.net/v1/task/eJMMbl1FT968FVBWv0HPng/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011274 build_url: 'https://queue.taskcluster.net/v1/task/eJMMbl1FT968FVBWv0HPng/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/05dc6f9213587988a5356191a23f54e2c9ae5ce082a105bb121d5efdadd721e0fdf8c5abc2bd1926530630181f39350410b0ff6f725a7e3bc7f237dd097a4004", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/d3f6826ab49646f664b64b2f00d03309ebf2ece0420e2e9e071e82e4dc0ddb447475920c9121be1173d2373c101053c3c4144c8a2fc66a8d5a0b5a5039412475", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/4873ab412cca132b643de7e7f0da322ee25d9912dc840e256f3fd37d42939813191a9804b5312f604b0413e80d42c73f7c8976c6c6df71a6584e006c21ecae11", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/be57faea3eb051a3b48b7f70e2775a57387a23a03b075ec0173fad91eb64548432ffcd0697b7016e795a97178c7a79b9d5eca5203d36440e11a09da29f8fda4f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-03 08:57:29.582770) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 08:57:29.583160) ========= 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=923d835db2ba3686ebe126b700000192-1501773957.580654-351862154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004432 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 08:57:29.668475) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-03 08:57:29.668846) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-03 08:57:29.669193) ========= ========= Total master_lag: 0.18 =========